builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1478386151.36 results: success (0) buildid: 20161105134127 builduid: de2e991e1fcb4cacb45b73d916a105b4 revision: c44c01dfd264370c1558b747525d220a9a89b51c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.357501) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.363404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.363723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.465509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.465853) ========= 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.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-11-05 15:49:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-11-05 15:49:11 (15.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.502973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.992489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:11.992766) ========= 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.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.026738 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:12.043393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 15:49:12.044016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c44c01dfd264370c1558b747525d220a9a89b51c --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 c44c01dfd264370c1558b747525d220a9a89b51c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-11-05 15:49:12,129 truncating revision to first 12 chars 2016-11-05 15:49:12,130 Setting DEBUG logging. 2016-11-05 15:49:12,130 attempt 1/10 2016-11-05 15:49:12,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c44c01dfd264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 15:49:13,112 unpacking tar archive at: mozilla-central-c44c01dfd264/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 15:49:13.314726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:13.315089) ========= script_repo_revision: c44c01dfd264370c1558b747525d220a9a89b51c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:13.315533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:13.315866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 15:49:13.335057) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-05 15:49:13.335404) ========= /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.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:13 INFO - MultiFileLogger online at 20161105 15:49:13 in /builds/slave/test 15:49:13 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 15:49:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:13 INFO - {'append_to_log': False, 15:49:13 INFO - 'base_work_dir': '/builds/slave/test', 15:49:13 INFO - 'blob_upload_branch': 'Firefox', 15:49:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:13 INFO - 'branch': 'Firefox', 15:49:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:13 INFO - 'config_files': ('talos/mac_config.py',), 15:49:13 INFO - 'default_actions': ('clobber', 15:49:13 INFO - 'read-buildbot-config', 15:49:13 INFO - 'download-and-extract', 15:49:13 INFO - 'populate-webroot', 15:49:13 INFO - 'create-virtualenv', 15:49:13 INFO - 'install', 15:49:13 INFO - 'run-tests'), 15:49:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:13 INFO - 'download_minidump_stackwalk': True, 15:49:13 INFO - 'download_symbols': 'ondemand', 15:49:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:13 INFO - 'installer_path': 'installer.exe', 15:49:13 INFO - 'log_level': 'info', 15:49:13 INFO - 'log_name': 'talos', 15:49:13 INFO - 'log_to_console': True, 15:49:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:49:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:49:13 INFO - 'opt_config_files': (), 15:49:13 INFO - 'pip_index': False, 15:49:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:49:13 INFO - 'cmd': ('bash', 15:49:13 INFO - '-c', 15:49:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:49:13 INFO - 'enabled': True, 15:49:13 INFO - 'halt_on_failure': False, 15:49:13 INFO - 'name': 'check_screen_resolution'},), 15:49:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:49:13 INFO - 'cmd': ('bash', 15:49:13 INFO - '-c', 15:49:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:49:13 INFO - 'enabled': True, 15:49:13 INFO - 'halt_on_failure': False, 15:49:13 INFO - 'name': 'check_screen_resolution'},), 15:49:13 INFO - 'run_cmd_checks_enabled': True, 15:49:13 INFO - 'sps_profile': False, 15:49:13 INFO - 'sps_profile_interval': 0, 15:49:13 INFO - 'suite': 'dromaeojs', 15:49:13 INFO - 'system_bits': '32', 15:49:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:13 INFO - 'title': 't-yosemite-r7-0034', 15:49:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:13 INFO - 'use_talos_json': True, 15:49:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:13 INFO - 'work_dir': 'build'} 15:49:13 INFO - [mozharness: 2016-11-05 22:49:13.558223Z] Running clobber step. 15:49:13 INFO - Running pre-action listener: _resource_record_pre_action 15:49:13 INFO - Running main action method: clobber 15:49:13 INFO - rmtree: /builds/slave/test/build 15:49:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:15 INFO - Running post-action listener: _resource_record_post_action 15:49:15 INFO - [mozharness: 2016-11-05 22:49:15.949520Z] Finished clobber step (success) 15:49:15 INFO - [mozharness: 2016-11-05 22:49:15.949784Z] Running read-buildbot-config step. 15:49:15 INFO - Running pre-action listener: _resource_record_pre_action 15:49:15 INFO - Running main action method: read_buildbot_config 15:49:15 INFO - Using buildbot properties: 15:49:15 INFO - { 15:49:15 INFO - "project": "", 15:49:15 INFO - "product": "firefox", 15:49:15 INFO - "script_repo_revision": "production", 15:49:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:49:15 INFO - "repository": "", 15:49:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:49:15 INFO - "buildid": "20161105134127", 15:49:15 INFO - "pgo_build": "False", 15:49:15 INFO - "basedir": "/builds/slave/test", 15:49:15 INFO - "buildnumber": 7, 15:49:15 INFO - "slavename": "t-yosemite-r7-0034", 15:49:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:49:15 INFO - "platform": "yosemite_r7", 15:49:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:49:15 INFO - "branch": "mozilla-central", 15:49:15 INFO - "repo_path": "mozilla-central", 15:49:15 INFO - "revision": "c44c01dfd264370c1558b747525d220a9a89b51c", 15:49:15 INFO - "stage_platform": "macosx64", 15:49:15 INFO - "builduid": "de2e991e1fcb4cacb45b73d916a105b4", 15:49:15 INFO - "slavebuilddir": "test" 15:49:15 INFO - } 15:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:49:15 INFO - Running post-action listener: _resource_record_post_action 15:49:15 INFO - [mozharness: 2016-11-05 22:49:15.955803Z] Finished read-buildbot-config step (success) 15:49:15 INFO - [mozharness: 2016-11-05 22:49:15.956034Z] Running download-and-extract step. 15:49:15 INFO - Running pre-action listener: _resource_record_pre_action 15:49:15 INFO - Running main action method: download_and_extract 15:49:15 INFO - mkdir: /builds/slave/test/build/tests 15:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:15 INFO - trying https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:49:15 INFO - Downloading https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/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 15:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/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 15:49:17 INFO - Downloaded 1199 bytes. 15:49:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:49:17 INFO - Using the following test package requirements: 15:49:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:49:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:49:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:49:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'jsshell-mac.zip'], 15:49:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:49:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:49:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:49:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:49:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:49:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:49:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:49:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:49:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:49:17 INFO - Fetch https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:49:17 INFO - Http code: 200 15:49:17 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 15:49:17 INFO - x-amz-cf-id: m2Qi01uNje7uw42XYpyCfTX7_wm7yyC_u3hF5XobTAAIRY4uSF-BJA== 15:49:17 INFO - x-amz-version-id: 0MN6xD_D8zimS2cr5WWYnFa_4QfGdmME 15:49:18 INFO - Expected file size: 16308056 15:49:18 INFO - Obtained file size: 16308056 15:49:25 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 15:49:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:49:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:49:25 INFO - Fetch https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:49:25 INFO - Http code: 200 15:49:25 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:49:25 INFO - x-amz-cf-id: 5cjJmc-SIX3xHVk_6Z2pEcHUB8RP3Tw3Ekli7UkTMzXqDL4tkjjhUQ== 15:49:25 INFO - x-amz-version-id: 0MN6xD_D8zimS2cr5WWYnFa_4QfGdmME 15:49:26 INFO - Expected file size: 16308056 15:49:26 INFO - Obtained file size: 16308056 15:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:49:34 INFO - Http code: 200 15:49:34 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:49:34 INFO - x-amz-cf-id: 6aqkl9YfJq8Ajchqw6VnoAFnabU6kATFwQWTzvZW4Pqy8vNfp_GyBg== 15:49:34 INFO - x-amz-version-id: 1pisJGBRsc6Q4RS04.PhRftvsd3EH8Iy 15:49:34 INFO - Expected file size: 14409038 15:49:34 INFO - Obtained file size: 14409038 15:49:34 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')]} 15:49:34 INFO - trying https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/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 15:49:37 INFO - Downloaded 111509225 bytes. 15:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:49:37 INFO - mkdir: /builds/slave/test/properties 15:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:37 INFO - Contents: 15:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:49:38 INFO - Running post-action listener: _resource_record_post_action 15:49:38 INFO - Running post-action listener: set_extra_try_arguments 15:49:38 INFO - [mozharness: 2016-11-05 22:49:38.492396Z] Finished download-and-extract step (success) 15:49:38 INFO - [mozharness: 2016-11-05 22:49:38.492571Z] Running populate-webroot step. 15:49:38 INFO - Running pre-action listener: _resource_record_pre_action 15:49:38 INFO - Running main action method: populate_webroot 15:49:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:38 INFO - '--tppagecycles', 15:49:38 INFO - '7'], 15:49:38 INFO - 'tests': ['tsvgm']}}, 15:49:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['damp', 'tps']}, 15:49:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'tests': ['damp', 'tps']}, 15:49:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['dromaeo_dom']}, 15:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['basic_compositor_video']}, 15:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['a11yr', 15:49:38 INFO - 'ts_paint', 15:49:38 INFO - 'tpaint', 15:49:38 INFO - 'sessionrestore', 15:49:38 INFO - 'sessionrestore_no_auto_restore', 15:49:38 INFO - 'tabpaint']}, 15:49:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['tsvgx', 15:49:38 INFO - 'tsvgr_opacity', 15:49:38 INFO - 'tart', 15:49:38 INFO - 'tscrollx', 15:49:38 INFO - 'cart']}, 15:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:38 INFO - 'tsvgr_opacity', 15:49:38 INFO - 'tart', 15:49:38 INFO - 'tscrollx', 15:49:38 INFO - 'cart']}, 15:49:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'talos_options': ['--disable-e10s'], 15:49:38 INFO - 'tests': ['tp5o']}, 15:49:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'tests': ['tp5o']}, 15:49:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'talos_options': ['--disable-e10s', 15:49:38 INFO - '--xperf_path', 15:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:38 INFO - 'tests': ['tp5n']}, 15:49:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:38 INFO - 'talos_options': ['--xperf_path', 15:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:38 INFO - 'tests': ['tp5n']}}, 15:49:38 INFO - 'talos.zip': {'path': '', 15:49:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:38 INFO - Running post-action listener: _resource_record_post_action 15:49:38 INFO - [mozharness: 2016-11-05 22:49:38.512199Z] Finished populate-webroot step (success) 15:49:38 INFO - [mozharness: 2016-11-05 22:49:38.512321Z] Running create-virtualenv step. 15:49:38 INFO - Running pre-action listener: _resource_record_pre_action 15:49:38 INFO - Running main action method: create_virtualenv 15:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:38 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 15:49:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:38 INFO - Using real prefix '/tools/python27' 15:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:42 INFO - Installing pip.................done. 15:49:42 INFO - Return code: 0 15:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:42 INFO - Reading from file tmpfile_stdout 15:49:42 INFO - Output received: 15:49:42 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) 15:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:42 INFO - 'HOME': '/Users/cltbld', 15:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PAGER': '/bin/cat', 15:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:42 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - 'XPC_FLAGS': '0x0', 15:49:42 INFO - 'XPC_SERVICE_NAME': '0', 15:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:42 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 15:49:42 INFO - Cleaning up... 15:49:42 INFO - Return code: 0 15:49:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:42 INFO - 'HOME': '/Users/cltbld', 15:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PAGER': '/bin/cat', 15:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:42 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - 'XPC_FLAGS': '0x0', 15:49:42 INFO - 'XPC_SERVICE_NAME': '0', 15:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:43 INFO - Downloading/unpacking psutil>=3.1.1 15:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:47 INFO - Installing collected packages: psutil 15:49:47 INFO - Running setup.py install for psutil 15:49:47 INFO - building 'psutil._psutil_osx' extension 15:49:47 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 15:49:47 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 15:49:48 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 15:49:48 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 15:49:48 INFO - building 'psutil._psutil_posix' extension 15:49:48 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 15:49:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:49:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:49:48 INFO - ^ 15:49:48 INFO - 1 warning generated. 15:49:48 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 15:49:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:48 INFO - Successfully installed psutil 15:49:48 INFO - Cleaning up... 15:49:48 INFO - Return code: 0 15:49:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:48 INFO - 'HOME': '/Users/cltbld', 15:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:48 INFO - 'LOGNAME': 'cltbld', 15:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:48 INFO - 'MOZ_NO_REMOTE': '1', 15:49:48 INFO - 'NO_EM_RESTART': '1', 15:49:48 INFO - 'PAGER': '/bin/cat', 15:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:48 INFO - 'PWD': '/builds/slave/test', 15:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:48 INFO - 'SHELL': '/bin/bash', 15:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:48 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:48 INFO - 'USER': 'cltbld', 15:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:48 INFO - 'XPC_FLAGS': '0x0', 15:49:48 INFO - 'XPC_SERVICE_NAME': '0', 15:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:48 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 15:49:48 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 15:49:48 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 15:49:48 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 15:49:48 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 15:49:48 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 15:49:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:51 INFO - Installing collected packages: mozsystemmonitor 15:49:51 INFO - Running setup.py install for mozsystemmonitor 15:49:51 INFO - Successfully installed mozsystemmonitor 15:49:51 INFO - Cleaning up... 15:49:51 INFO - Return code: 0 15:49:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:51 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')]} 15:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:51 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')]} 15:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:51 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:51 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 15:49:51 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 15:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:51 INFO - 'HOME': '/Users/cltbld', 15:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:51 INFO - 'LOGNAME': 'cltbld', 15:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:51 INFO - 'MOZ_NO_REMOTE': '1', 15:49:51 INFO - 'NO_EM_RESTART': '1', 15:49:51 INFO - 'PAGER': '/bin/cat', 15:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:51 INFO - 'PWD': '/builds/slave/test', 15:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:51 INFO - 'SHELL': '/bin/bash', 15:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:51 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:51 INFO - 'USER': 'cltbld', 15:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:51 INFO - 'XPC_FLAGS': '0x0', 15:49:51 INFO - 'XPC_SERVICE_NAME': '0', 15:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:52 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:52 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 15:49:52 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 15:49:52 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 15:49:52 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 15:49:52 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 15:49:52 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 15:49:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:54 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 15:49:54 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 15:49:54 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 15:49:54 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 15:49:54 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 15:49:54 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 15:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:55 INFO - warning: no files found matching '*.txt' 15:49:55 INFO - no previously-included directories found matching 'build' 15:49:55 INFO - no previously-included directories found matching 'dist' 15:49:55 INFO - no previously-included directories found matching '.git*' 15:49:55 INFO - Installing collected packages: jsonschema, functools32 15:49:55 INFO - Running setup.py install for functools32 15:49:55 INFO - warning: no files found matching '*.txt' 15:49:55 INFO - no previously-included directories found matching 'build' 15:49:55 INFO - no previously-included directories found matching 'dist' 15:49:55 INFO - no previously-included directories found matching '.git*' 15:49:55 INFO - Successfully installed jsonschema functools32 15:49:55 INFO - Cleaning up... 15:49:55 INFO - Return code: 0 15:49:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:55 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:55 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 15:49:55 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 15:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:55 INFO - 'HOME': '/Users/cltbld', 15:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:55 INFO - 'LOGNAME': 'cltbld', 15:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:55 INFO - 'MOZ_NO_REMOTE': '1', 15:49:55 INFO - 'NO_EM_RESTART': '1', 15:49:55 INFO - 'PAGER': '/bin/cat', 15:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:55 INFO - 'PWD': '/builds/slave/test', 15:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:55 INFO - 'SHELL': '/bin/bash', 15:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:55 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:55 INFO - 'USER': 'cltbld', 15:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:55 INFO - 'XPC_FLAGS': '0x0', 15:49:55 INFO - 'XPC_SERVICE_NAME': '0', 15:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:55 INFO - Cleaning up... 15:49:55 INFO - Return code: 0 15:49:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:55 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:49:55 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 15:49:55 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 15:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:55 INFO - 'HOME': '/Users/cltbld', 15:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:55 INFO - 'LOGNAME': 'cltbld', 15:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:55 INFO - 'MOZ_NO_REMOTE': '1', 15:49:55 INFO - 'NO_EM_RESTART': '1', 15:49:55 INFO - 'PAGER': '/bin/cat', 15:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:55 INFO - 'PWD': '/builds/slave/test', 15:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:55 INFO - 'SHELL': '/bin/bash', 15:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:49:55 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:55 INFO - 'USER': 'cltbld', 15:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:55 INFO - 'XPC_FLAGS': '0x0', 15:49:55 INFO - 'XPC_SERVICE_NAME': '0', 15:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:56 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 15:49:56 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 15:49:56 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 15:49:56 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 15:49:56 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 15:49:56 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 15:49:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:59 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 15:49:59 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 15:49:59 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 15:49:59 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 15:49:59 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 15:49:59 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 15:49:59 INFO - Downloading docopt-0.6.1.tar.gz 15:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:00 INFO - Running setup.py install for blobuploader 15:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:00 INFO - Running setup.py install for requests 15:50:00 INFO - Running setup.py install for docopt 15:50:00 INFO - Successfully installed blobuploader requests docopt 15:50:00 INFO - Cleaning up... 15:50:00 INFO - Return code: 0 15:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:00 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:50:00 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 15:50:00 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 15:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:00 INFO - 'HOME': '/Users/cltbld', 15:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:00 INFO - 'LOGNAME': 'cltbld', 15:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:00 INFO - 'MOZ_NO_REMOTE': '1', 15:50:00 INFO - 'NO_EM_RESTART': '1', 15:50:00 INFO - 'PAGER': '/bin/cat', 15:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:00 INFO - 'PWD': '/builds/slave/test', 15:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:00 INFO - 'SHELL': '/bin/bash', 15:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:50:00 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:00 INFO - 'USER': 'cltbld', 15:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:00 INFO - 'XPC_FLAGS': '0x0', 15:50:00 INFO - 'XPC_SERVICE_NAME': '0', 15:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-TVdqJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-nbJmS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ZopxQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-pWOeMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-yu3iK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cgE8SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-aS43JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ErwnMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-z0OqAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-VQRbuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ak4lIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hSl1C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-pjsOd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-lG9LYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ucNVwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Z0D5hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hO69d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:03 INFO - Running setup.py install for manifestparser 15:50:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:03 INFO - Running setup.py install for mozcrash 15:50:03 INFO - Running setup.py install for mozdebug 15:50:03 INFO - Running setup.py install for mozdevice 15:50:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:03 INFO - Running setup.py install for mozfile 15:50:03 INFO - Running setup.py install for mozhttpd 15:50:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Running setup.py install for mozinfo 15:50:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Running setup.py install for mozInstall 15:50:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Running setup.py install for mozleak 15:50:04 INFO - Running setup.py install for mozlog 15:50:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Running setup.py install for moznetwork 15:50:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:04 INFO - Running setup.py install for mozprocess 15:50:04 INFO - Running setup.py install for mozprofile 15:50:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:05 INFO - Running setup.py install for mozrunner 15:50:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:05 INFO - Running setup.py install for mozscreenshot 15:50:05 INFO - Running setup.py install for moztest 15:50:05 INFO - Running setup.py install for mozversion 15:50:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:05 INFO - Cleaning up... 15:50:05 INFO - Return code: 0 15:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:05 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')]} 15:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:05 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')]} 15:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:05 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:50:05 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 15:50:05 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 15:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:05 INFO - 'HOME': '/Users/cltbld', 15:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:05 INFO - 'LOGNAME': 'cltbld', 15:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:05 INFO - 'MOZ_NO_REMOTE': '1', 15:50:05 INFO - 'NO_EM_RESTART': '1', 15:50:05 INFO - 'PAGER': '/bin/cat', 15:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:05 INFO - 'PWD': '/builds/slave/test', 15:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:05 INFO - 'SHELL': '/bin/bash', 15:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:50:05 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:05 INFO - 'USER': 'cltbld', 15:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:05 INFO - 'XPC_FLAGS': '0x0', 15:50:05 INFO - 'XPC_SERVICE_NAME': '0', 15:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-EMma0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-I7s85j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-8XL8Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ySqYiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-N4JPUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-RLFnyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hz8N6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:06 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)) 15:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-X8c0j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-z2HSRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xKckcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-BxDJwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-yRFqSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-7Gx0ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-4EMQ8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-BYbNLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-8OGQ50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:07 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)) 15:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-FSZX95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:08 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)) 15:50:08 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)) 15:50:08 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)) 15:50:08 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)) 15:50:08 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)) 15:50:08 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)) 15:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:10 INFO - Downloading blessings-1.6.tar.gz 15:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:10 INFO - Installing collected packages: blessings 15:50:10 INFO - Running setup.py install for blessings 15:50:10 INFO - Successfully installed blessings 15:50:10 INFO - Cleaning up... 15:50:11 INFO - Return code: 0 15:50:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:11 INFO - Reading from file tmpfile_stdout 15:50:11 INFO - Current package versions: 15:50:11 INFO - blessings == 1.6 15:50:11 INFO - blobuploader == 1.2.4 15:50:11 INFO - docopt == 0.6.1 15:50:11 INFO - functools32 == 3.2.3-2 15:50:11 INFO - jsonschema == 2.5.1 15:50:11 INFO - manifestparser == 1.1 15:50:11 INFO - mozInstall == 1.12 15:50:11 INFO - mozcrash == 0.17 15:50:11 INFO - mozdebug == 0.1 15:50:11 INFO - mozdevice == 0.48 15:50:11 INFO - mozfile == 1.2 15:50:11 INFO - mozhttpd == 0.7 15:50:11 INFO - mozinfo == 0.9 15:50:11 INFO - mozleak == 0.1 15:50:11 INFO - mozlog == 3.4 15:50:11 INFO - moznetwork == 0.27 15:50:11 INFO - mozprocess == 0.23 15:50:11 INFO - mozprofile == 0.28 15:50:11 INFO - mozrunner == 6.12 15:50:11 INFO - mozscreenshot == 0.1 15:50:11 INFO - mozsystemmonitor == 0.3 15:50:11 INFO - moztest == 0.7 15:50:11 INFO - mozversion == 1.4 15:50:11 INFO - psutil == 3.1.1 15:50:11 INFO - requests == 1.2.3 15:50:11 INFO - wsgiref == 0.1.2 15:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:11 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:50:11 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 15:50:11 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 15:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:11 INFO - 'HOME': '/Users/cltbld', 15:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:11 INFO - 'LOGNAME': 'cltbld', 15:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:11 INFO - 'MOZ_NO_REMOTE': '1', 15:50:11 INFO - 'NO_EM_RESTART': '1', 15:50:11 INFO - 'PAGER': '/bin/cat', 15:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:11 INFO - 'PWD': '/builds/slave/test', 15:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:11 INFO - 'SHELL': '/bin/bash', 15:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:50:11 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:11 INFO - 'USER': 'cltbld', 15:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:11 INFO - 'XPC_FLAGS': '0x0', 15:50:11 INFO - 'XPC_SERVICE_NAME': '0', 15:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 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)) 15:50:11 INFO - Cleaning up... 15:50:11 INFO - Return code: 0 15:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:11 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 0x1104bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110432570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab2471210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, '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.bRcjptSQ4K/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.OFsByQQpU3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 15:50:11 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 15:50:11 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 15:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:11 INFO - 'HOME': '/Users/cltbld', 15:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:11 INFO - 'LOGNAME': 'cltbld', 15:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:11 INFO - 'MOZ_NO_REMOTE': '1', 15:50:11 INFO - 'NO_EM_RESTART': '1', 15:50:11 INFO - 'PAGER': '/bin/cat', 15:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:11 INFO - 'PWD': '/builds/slave/test', 15:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:11 INFO - 'SHELL': '/bin/bash', 15:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:50:11 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:11 INFO - 'USER': 'cltbld', 15:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:11 INFO - 'XPC_FLAGS': '0x0', 15:50:11 INFO - 'XPC_SERVICE_NAME': '0', 15:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:11 INFO - Cleaning up... 15:50:11 INFO - Return code: 0 15:50:11 INFO - Running post-action listener: _resource_record_post_action 15:50:11 INFO - Running post-action listener: _start_resource_monitoring 15:50:11 INFO - Starting resource monitoring. 15:50:11 INFO - [mozharness: 2016-11-05 22:50:11.907081Z] Finished create-virtualenv step (success) 15:50:11 INFO - [mozharness: 2016-11-05 22:50:11.908197Z] Running install step. 15:50:11 INFO - Running pre-action listener: _resource_record_pre_action 15:50:11 INFO - Running main action method: install 15:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:12 INFO - Reading from file tmpfile_stdout 15:50:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:12 INFO - Reading from file tmpfile_stdout 15:50:12 INFO - Output received: 15:50:12 INFO - Usage: mozinstall [options] installer 15:50:12 INFO - Options: 15:50:12 INFO - -h, --help show this help message and exit 15:50:12 INFO - -d DEST, --destination=DEST 15:50:12 INFO - Directory to install application into. [default: 15:50:12 INFO - "/builds/slave/test"] 15:50:12 INFO - --app=APP Application being installed. [default: firefox] 15:50:12 INFO - mkdir: /builds/slave/test/build/application 15:50:12 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'] 15:50:12 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 15:50:47 INFO - Reading from file tmpfile_stdout 15:50:47 INFO - Output received: 15:50:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - [mozharness: 2016-11-05 22:50:47.530531Z] Finished install step (success) 15:50:47 INFO - [mozharness: 2016-11-05 22:50:47.530711Z] Running run-tests step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: run_tests 15:50:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:50:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:50:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:50:47 INFO - 2016-11-05 15:50:47.547 screenresolution[1649:8303] starting screenresolution argv=screenresolution get 15:50:47 INFO - 2016-11-05 15:50:47.549 screenresolution[1649:8303] Display 0: 1600x1200x32@60 15:50:47 INFO - 2016-11-05 15:50:47.555 screenresolution[1650:8305] starting screenresolution argv=screenresolution list 15:50:47 INFO - Available Modes on Display 0 15:50:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:50:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:50:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:50:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:50:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:50:47 INFO - Intel Iris: 15:50:47 INFO - Chipset Model: Intel Iris 15:50:47 INFO - Type: GPU 15:50:47 INFO - Bus: Built-In 15:50:47 INFO - VRAM (Dynamic, Max): 1536 MB 15:50:47 INFO - Vendor: Intel (0x8086) 15:50:47 INFO - Device ID: 0x0a2e 15:50:47 INFO - Revision ID: 0x0009 15:50:47 INFO - Displays: 15:50:47 INFO - Display: 15:50:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:50:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:50:47 INFO - Display Serial Number: 1600x1200 60 15:50:47 INFO - Main Display: Yes 15:50:47 INFO - Mirror: Off 15:50:47 INFO - Online: Yes 15:50:47 INFO - Rotation: Supported 15:50:47 INFO - Return code: 0 15:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:47 INFO - Python 2.7.3 15:50:47 INFO - Return code: 0 15:50:47 INFO - grabbing minidump binary from tooltool 15:50:47 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')]} 15:50:47 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 0x1102d0d30>, '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 0x1100f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102c8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:47 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 15:50:47 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 15:50:47 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 15:50:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:47 INFO - Return code: 0 15:50:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:50:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:47 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/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 15:50:47 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/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 15:50:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRcjptSQ4K/Render', 15:50:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:47 INFO - 'HOME': '/Users/cltbld', 15:50:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:47 INFO - 'LOGNAME': 'cltbld', 15:50:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:47 INFO - 'MOZ_NO_REMOTE': '1', 15:50:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:47 INFO - 'NO_EM_RESTART': '1', 15:50:47 INFO - 'PAGER': '/bin/cat', 15:50:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:47 INFO - 'PWD': '/builds/slave/test', 15:50:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:47 INFO - 'SHELL': '/bin/bash', 15:50:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFsByQQpU3/Listeners', 15:50:47 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 15:50:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:47 INFO - 'USER': 'cltbld', 15:50:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:47 INFO - 'XPC_FLAGS': '0x0', 15:50:47 INFO - 'XPC_SERVICE_NAME': '0', 15:50:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:47 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/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 15:50:48 INFO - mozversion application_buildid: 20161105134127 15:50:48 INFO - mozversion application_changeset: c44c01dfd264370c1558b747525d220a9a89b51c 15:50:48 INFO - mozversion application_display_name: Nightly 15:50:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:48 INFO - mozversion application_name: Firefox 15:50:48 INFO - mozversion application_remotingname: firefox 15:50:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:50:48 INFO - mozversion application_vendor: Mozilla 15:50:48 INFO - mozversion application_version: 52.0a1 15:50:48 INFO - mozversion platform_buildid: 20161105134127 15:50:48 INFO - mozversion platform_changeset: c44c01dfd264370c1558b747525d220a9a89b51c 15:50:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:50:48 INFO - mozversion platform_version: 52.0a1 15:50:48 INFO - using testdate: 1478386248 15:50:48 INFO - actual date: 1478386248 15:50:48 INFO - starting webserver on 'localhost:49271' 15:50:48 INFO - SUITE-START | Running 2 tests 15:50:48 INFO - TEST-START | dromaeo_css 15:50:48 INFO - operating with platform_type : mac_ 15:50:48 INFO - Initialising browser for dromaeo_css test... 15:50:48 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpK1IpTE/profile http://localhost:49271/getInfo.html) 15:50:50 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:50:50 INFO - PROCESS | 1660 | colorDepth:24 15:50:50 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:50:50 INFO - PROCESS | 1660 | __metrics 15:50:50 INFO - PROCESS | 1660 | 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" 15:50:50 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:51 INFO - TEST-INFO | 1660: exit 0 15:50:51 INFO - Browser initialized. 15:50:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:51 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpK1IpTE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:03 INFO - PROCESS | 1663 | RSS: Main: 239280128 15:51:03 INFO - PROCESS | 1663 | 15:51:55 INFO - PROCESS | 1663 | 1478386315380 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] 15:54:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 15:54:07 INFO - PROCESS | 1663 | RSS: Main: 364523520 15:54:07 INFO - PROCESS | 1663 | 15:57:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 15:57:11 INFO - PROCESS | 1663 | RSS: Main: 370425856 15:57:11 INFO - PROCESS | 1663 | 16:00:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:00:14 INFO - PROCESS | 1663 | RSS: Main: 359219200 16:00:14 INFO - PROCESS | 1663 | 16:03:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:03:18 INFO - PROCESS | 1663 | RSS: Main: 365563904 16:03:18 INFO - PROCESS | 1663 | 16:06:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:06:22 INFO - PROCESS | 1663 | RSS: Main: 326361088 16:06:22 INFO - PROCESS | 1663 | 16:09:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:09:26 INFO - PROCESS | 1663 | RSS: Main: 449040384 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | __start_tp_report 16:09:26 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:09:26 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:09:26 INFO - PROCESS | 1663 | |i|pagename|runs| 16:09:26 INFO - PROCESS | 1663 | |0;dojo.html;2786.4705705915876;2808.648918885139;2845.900393486227;2846.601475793388;2900.08647276108;4595.080983803236;4600.5629465200755;4776.235802271637;4786.353842231298;4807.182778927587;4670.743109128996;4672.369230153929;4679.227927391985;4692.249240121581;4709.340692303081;4292.077203401261;4307.483102027761;4338;4358.673099517533;4387.1225754849;4366.214081465335;4395.120975804836;4411.911761764779;4412.183746006983;4413.205622987861;4275.679324050693;4372.934405983913;4376.912461750763;4395.846145384912;4427.158839820424;4474.0380818124095;4524.68327217095;4550.7724613769515;4561.7491037992895;4576.473705523874;4248.9150216995795;4312.935305970413;4344.956550434518;4386.824527018915;4442.555744425564;3813.9237215255816;4540.86377408675;4636.629069674418;4672.0889426561835;4690.507496712864;5085.771140298695;5158.613104017214;5163.870903227412;5172.689638621695;5185.118529849935;4320.416743739618;5051.166557518005;5190.2214667800135;5247.580193584504;5266.052110620087;4828.227483602606;4913.508649135058;4950.282209079699;4961.553460188528;4975.4278258000795;5329.094054010828;5347.652402593819;5349.946500534945;5352.4915133062295;5388.838334849961;4951.034548263054;5102.591792656579;5103.18349064148;5114.616403769732;5126;5087.956968821382;5190.8183213587345;5196;5207;5209;5065;5118.97440512795;5148;5185.922211166836;5256.658317209446;4207.600277973587;5156.4070131935305;5220.582353411718;5223.373195216598;5228;4183.728057676241;4322.827086916551;4325.243082460557;4339.696221264481;4342.6308763754805;3763.284975854579;3871.070942973666;3893.493845800028;3899.3371126907928;3903.941440878389;4579.816807327737;4646.977664913714;4661;4706.199946009118;4729.266963620645;5143.331366922276;5144;5160.7419629018395;5168.560672342818;5192.766325515361;3936.3111455495173;4267.445232119804;4436.401085853433;4660.720356778605;4714.198586240279;3806.885793426202;4446.110777844444;4541.999999999934;4543.204939135638;4543.977280113579;5462.399136094947;5496.230527726041;5515.61390702647;5519.668819870741;5522.392536821027;5177.715225662474;5191.480851914778;5199.246109314204;5200.557952573922;5250.527452529291;5310.415854255952;5310.468953104659;5371.650842695212;5471.179323101566;5471.6169868108855;4468.972136408579;4875.463698993037;5030.84907452777;5140.203268493389;5185.533302002837;4153.356229784388;5175.353080864892;5181.896362072813;5196.896062078813;5198.74006299676;4895.951040489549;5041.974790126026;5069.822556210515;5074.771635276347;5096.286519887293;4949.7030178189425;4957.380327459067;5009.749512524287;5023.146065168857;5035.84892453227;4964.429090654621;4993.325901003318;5000.1749711297225;5002.124628189979;5015.924761128659;5013.974930125326;5028.547430731105;5030.974845125751;5043.470435604356;5054.494550544916;4699.201135806853;4810.350602668735;4812.181929072136;4873.1959226727195;4946.15915294408 16:09:26 INFO - PROCESS | 1663 | |1;ext.html;440.645280549158;462.21654295968324;471.77590644443916;474.3761953031763;479.6163069544366;28722;30201.244968875788;36688.08279793003;38017.61982380175;38134.237315253675;38791.224175516545;39160.60839391605;39238.21523569534;39252.01869953253;39322.0169495762;8988.370814043019;9141.634334626608;9170.312226582999;9170.44977301364;9173.312001599874;8085.908402365693;8282.710105146321;8336.70821521247;9042.457452552835;10611.3102648328;10655.467226638675;10838.566457341736;10855.077318427942;10868.347899126078;10876.67369978898;10773.784524309509;10820;10822.512986915568;10840.295380800222;10844.078253348474;7951.9204807951755;8201;10405.635802746943;10652.573897044109;10784.622538211124;36047.738329158616;37702.05744856373;37808.81095594532;37846.81076594627;37918.620813791786;3131.170239886432;3139.230888432326;3175.491921292582;3239.5464634951127;3569.9825549718207;27091.322716932038;28232.717672823215;29149.41701165986;29164.708352916412;29248.41503169946;2997.955030674542;3072.9078127655985;3094.3965926644314;3170.5402716606195;3172.873085076594;320976;323370;323502;324188;324733.3763331192;53345.733271333396;53478.73260633672;53544.393668190016;53636.73181634067;53775.73112134414;53753.731231344376;54715.45284547183;55706.442935570936;55749.72125139349;55815.720921395136;14812.629684257765;15032.323545440482;15036.173010484528;15043.774343384857;15066.246687665573;11562.95933366001;11650.41747912601;11656.125790565742;11675;11693;12490.625281241577;12826.55107071248;12864.678383040498;14478.276086195649;14597.635059123606;5443.618946673695;6146.385361463817;6316.905246421307;6359.682015899187;6412.839679007969;718.7314390101475;807.7036356647496;829.2619568583965;905.2079430498314;926.4395041000232;26788.464230715275;28301.811586981854;28418.00536981196;28642.71357286442;28829.135125946254;886.5389997201419;929.5909799688116;940.4216406909701;978.5645387802359;1017.5014243020867;14007.08953917992;14362.640933976734;14615.634609134857;14726.876474587132;14803.259837008321;495947;817761;825071.746412677;826301;827360;46288;47185;50588.241176382384;51206;51209.48790512047;1127.2729089737074;1199.316389657904;1250.499800079939;1274.9872501275054;1275.9872401276054;25579.744202557737;25929.83315750758;25942.221733347276;26455.94176233006;26529.469410612066;45565.77217113893;46094;46109;46186.07627847492;46245.07509849851;464191;468454.3091381806;586578;597459;604620;22949.54100917939;23192.4201894954;23192.652110218023;23275.88362058179;23325.41686457852;41288.38067428931;41559.545415910296;41963;42125.789371052946;42837;34756.30487390289;35000.12499687528;35227.82386088053;35826.92519224427;36020.4596931041;34657.65342346544;34753.826230869694;35798.28403431969;36007.63992360148;36059.7379091741;34112;34228.657713422544;34724;35108.824455877555;35213.64786352104;30151;31119.688803112585;31272.374552509278;31325.843370783;31428;23034.424139396648;23483.17808876681;23826;23899.641505377782;23910.88044559766 16:09:26 INFO - PROCESS | 1663 | |2;jquery.html;289.7841108374261;297.90169244149433;318.40140535792705;346.2538182784071;356.23231935179683;13934.954878384124;14186;14809.11145331281;18758.53103672409;19307.613847723038;17754;18530.629387412242;18622.53443663909;18812.529686757836;19633.705494417558;4269.5943885331;4945.1840446326405;5024.9246261305925;5630.746616402252;5706.28671416073;5564.10974244121;5656.066748986413;5662.17898404731;5663.943360566383;5664.348599911001;4952.87617809554;5055.494450554952;5105.795768169269;5192.584593232551;5481.890362192754;5062.873428164288;5069.543741063285;5110.207917772733;5133.307003554547;5143.254228136899;3808.9428658570146;4948.777305021283;4965.702057876539;4979.278004689336;5001.799928002875;12378.319192444502;12612.621621351282;12729.236245825281;20011.699239549383;20448.488787780276;1799.8110198429108;2121.3954023103342;2259.9435014124615;2315.247544548012;2723.5687317573647;8324.417290789646;8811.867821982676;9080.364374493787;9420.434773913586;10068.848967265498;1747.4408189379403;1800.5858652509864;1820.417466410749;1831.7893442254178;1856.2389420337731;107791;113518.37779466434;115597;116252;117297;9498.715038548855;10707.839382409271;10884.61903833362;11061.115110791117;11100;13558.86441135576;13902.51341203053;13914.652133696738;13919.860801391857;13962.860371396157;7729.227077292338;7999.400044996532;8004.51972881629;8100.878486822702;8111.3916456266015;6422.293547709748;7552.546847189186;7711.884321735179;7853.057633083952;8010.279074883289;3546.6985306248744;4272.252355837716;4276.070891439374;4304.227936593415;4377.277749171415;1804.6751584714614;1869.3831035758167;1871.4385684294657;1872.4757068020976;1913.158210387425;543.9447471904572;589.7080944932286;612.7763366371242;639.5011890725149;742.1984257002424;18471.90764046171;19475.92882391454;19649.115789789495;19667.21331146767;19986.70019949702;788.3995489157021;823.5923218007005;826.5536610230529;844.3371953016853;868.8305780372893;9818.361806482555;10247.436390998417;10344.637937672145;10365.896341036643;10504.579816807242;538197;541596;550450;559321.4067859269;561655;115672.42163789127;120164;121012.34432106318;122431;123022.38488807678;778.8481246157058;897.210454799772;920.061537232033;923.0584803500392;927.675313640234;15914;17140.628749699743;17594.208260628046;18103.456896293133;18502.907485463023;47280.05439891114;48307;50541;51019;52409;49533.25700114429;65810;74737.6263118681;75269;75927.62036190004;6257.624542527463;7263.34629883313;7687.231276872268;7797.493162944391;7834.1382447929545;9830.950845245728;12020.519179232733;12196.329201893626;12327.9383603085;12407.627771166879;9106.861642294713;10169.89830101719;10447.05976462122;10720.946395267974;10722.24944253926;10106.797864042825;10527.94736026315;10541.051305382553;10581.735456613646;10794.136469082612;9223.631054757734;10551.314164579278;10756.93427373195;10965.122790176607;11032.393218373067;5474.932388184425;7553.357964573072;7624.351930086005;7929.841403172019;10455.94772026135;8336.291415229773;9958.302918795904;10745.850829833907;10752.623658171926;11069.059129974043 16:09:26 INFO - PROCESS | 1663 | |3;mootools.html;1234.6172686467196;1406.296851574213;1497.7977972973652;1721.7331313646373;1770.8406243438087;6379.52153588481;8259;8262.33901287897;8262.669493220279;8264.628091735878;7245.384142347893;7560.92439075609;7570.77287681369;7873.960630196855;8131.390145739064;2207.3708992937018;2230.0968107916237;2231.241377931503;2243.798058174764;2249.392663980724;2205.3935167828813;2245.057076028064;2258.062903894882;2262.2195342606774;2268.3988742983124;1923.7306777051224;2024.564718585504;2028.4928767808049;2116.9788302117013;2199.461132022657;2195.9890200548975;2204.691343211952;2206.1396055538353;2209.7127373441513;2219.5782801267787;2169.8806565638884;2201.9119235230573;2223.2552095048177;2235.608768465512;2237.6084185267514;8095;8151.429399941947;8214.507129572185;8224.588770561448;8259.132791056973;4714.175019371596;4863.27050942358;4865.270209468573;4869.099216644932;4887.535684110004;3205.9198520036953;3352.0614228016193;3360.9159771005675;3434.6737059979264;3435.347284016029;948.132458800197;1007.7581380468635;1055.3615062886997;1056.2289528644133;1060.3743791163251;10782.0296173344;10810.783784324349;10810.972957569096;10826.72933176669;10841.970012848768;4124.628783409507;4364.236258654786;4473.114840927648;4473.575010374009;4516.458025037016;9239.815203695889;9242.72271831846;9249.861252081224;9257.074292570824;9289.210417114486;4946.332245146931;5038.5969122470115;5039.193729003415;5049.823256186016;5060.418051924076;4407.515173330931;4567.862964111082;4595.172868883633;4646;4648.721076735406;2997.775166862494;3433.914152146216;3466.341395134916;3473.3053389322235;3527.5943266524678;1016.1464369929147;1028.475477506462;1029.6550655530482;1034.04350975349;1035.880873699519;720.3948683106216;743.6133210730499;762.7826069570145;775.2673723331397;804.7384600005022;5007.248912663057;5124.282600435942;5174.896502069938;5223.5559977402345;5354.196870469383;388.18093822035485;391.41288067898154;395.89508780173276;395.98614048508165;397.9383195604686;3034.9226024761333;3256.8734015345535;3298.10951043217;3320.7841490303053;3332.616749073839;9652.710418687451;9908;10053.597856085675;10054.447005414626;10075.697729068139;9961.601535938626;10024.047715467019;10024.899751002542;10028.548715307828;10039.598416063422;6489.539853532918;7171.067761191011;7480.551166930001;7619.961900190575;7634.045744281965;5076.746162691925;5125.538701516882;5179.974100129475;5300.2049692546425;5405.108157154183;9098.681546145854;9191.218746406363;9192.908070919206;9209.079092090737;9230.907690923004;8780.473171609723;9260.212881905114;9304.348695591243;9334.386371815903;9415;6861.725530978705;7011.088558487568;7016.789496315118;7019.19279282889;7038.2961703829205;7492.838610015457;7590.354819840155;7667.539947603162;7671.616419178907;7677.5777332245025;6013.30846952606;6741.561798483083;6781.525293229427;6819.386255237053;6929.203141638776;5801.1878337032;6677.866442671217;6687;6709.832254193489;6767.695453704497;5990.64056156632;6135.07973803933;6185.8144255672405;6295.433410993032;6363.395477429637;4494.842680506166;4518.502964673818;4549.476810166873;4585.403897493305;4617.330487079422;4048.797560121923;4460.553944605644;4580.244259697112;4629.166749985035;4717.528247175255 16:09:26 INFO - PROCESS | 1663 | |4;prototype.html;257.83627396603174;258.35669183732506;274.42371020856206;281.3135948286181;285.69430709141216;3479.80861052642;3673.687736542394;3823.636754508321;4026.9529922220213;4164.375343698447;4034.6685593754064;4045.3656004153213;4057;4077.4699289092378;4108.753474791514;2713.755761981421;3107.5027995520722;3127.9502485077096;3183.808971461708;3223.8226897520626;2677.6920654124733;2789.8186617869874;3035.2243937296707;3239.9352012959725;3245.610526736795;2626.924729463721;2664;3097.5286738799005;3147.0244224290545;3211.807291562502;2920.6641236257888;2933.8239705617516;3024.6672865984724;3191.521271809224;3229.1765599772025;2274.7611500792345;2790.9860450697615;2796.286946828566;2806.6070750095005;2814.901478448265;3181.109289398972;3196.6643502432375;3517.5251341068883;3714.2014466889477;3853.3256680081154;3282.983585082083;3566.805120284682;3580.3018411409785;3609.4405367168133;3615.1504396466808;3576.856925722968;4087.814533785199;4094.303968325392;4261.169072030955;4280.614744672995;2749.5463248563965;2815.6761972373233;3049.0395525409426;3098.4732595458827;3117.173948903542;3490.9650903491147;4217.536071032184;4465.834070475817;4483.574060464251;4495.505494395614;2648.7153730440723;3116.065180445857;3119.814470501195;3128.6089238845143;3133.185371803302;2692.474967381381;3002.6246719160104;3142.7686342696943;3154.511050787132;3173.5715678383585;2990.3271763853395;3034.3779525197283;3570.357335679603;3588.7129029677562;3611.422172452395;4021.597840215955;4083.8774836754947;4167.5832416758685;4182.372644103409;4323;955.8709574207533;1018.8573599696049;1021.4637315409469;1034.6895931220604;1035.1511760356586;648.9422241745924;676.8409423785406;678.2403707847144;722.9047992291682;728.7194430144433;3455.447128459434;3684.171061511192;3737.66396002493;3870.761356365936;3890.299746045739;3761.3482494841073;4101.241270364992;4409.911801763947;4456.5239113491525;4463.308187230984;3562.87529936451;3857.691384689218;3869.187470631199;3902.863399780994;3910.530736311661;1812.7763759462573;1828.579426731859;1977.7231187633743;2037.5109973606525;2149.4948687058527;3423.7432192585156;3668.79821609814;3805.7821497120653;4228.4080228768;4268.210381079511;3409.9659003410143;3516.841742121611;3857.498525191707;4058.898527536835;4215.451991241119;4148.253314403436;4237.915241695149;4242.384854196124;4250.489941207075;4252.744835309892;3611.214078077194;3672.577653569767;3839.1745774658584;4014.1735510343306;4073.938890916698;3706.684931780721;4082.2447847148374;4087.56789710122;4094;4169.874903752892;3515.595706493684;3732.42147467143;4215.473065866767;4233.576642335742;4239.300515415045;2890.5375139977505;2911.7525010374356;2912.140918429026;2915.7375836174847;2923.985380073086;3737.1572178284114;3996.7002474815085;4043.81802818868;4108.383742438658;4133.441985332062;3714.192952223992;3784.962150378461;3811.6569508744346;3876.3290235267;3967.6032396761248;3435.896923092311;3938.15329704115;4117.929338371985;4145.108801607548;4225.429567008415;3657.4330978698345;3816.3893776996656;4032.2620920417803;4173.770442625685;4176.728512646669;3933.1877707439317;4253.000544871891;4271.914561708811;4281.657467402662;4324.308110702398;3829.476881269183;4151.667866570607;4164.729292595972;4207.474065741782;4221.2190744712325 16:09:26 INFO - PROCESS | 1663 | |5;yui.html;630.8549033722243;640.6252342379707;665.8580534383532;715.6421789105448;740.518662869135;13492.392842322095;13798.962529110151;14089.647758806035;14181.290935453238;14418.639534011654;12685.429155687993;12709.872901270985;12887.162334448254;12904.290264035497;12972.351382430865;790.6560646118957;791.8614242507552;812.2811311988874;815.042325267811;815.0789607743242;785.4776573578592;806.4717609965483;808.6078252047752;821.3265122599471;826.8139668574553;833.1834801894147;855.5807654249435;856.6744637037917;857.0015931439865;857.1642648417806;849.3332733803965;849.6813694864426;851.4848516647401;851.5103815306193;853.5646820121783;538.9892202155935;604.0938592111833;629.3014753623474;630.8612105336819;631.2298995225817;13331.066825322232;13692.931535342259;13696.109752866032;13720.93139534296;13733.931330343385;12747.107702460831;12767.248065869779;12771.744565108738;12792.744145117138;12825.679358016125;10692.09117225029;10812.891871081267;10928.726781830439;11136.443177841076;11305.773884522263;3415.163284995167;3436.7766095203733;3463.445848664227;3497.9475307870403;3561;72715;81476.77784833172;84067;84169;84285;9820.803583928424;9877.901220987842;10183.283101667837;10311.48442577868;10458.533470998143;18940.43178704641;18955.81044189568;18958;18996;18996;7206.603636799921;7415.703371865173;7516.467260387609;7569.356604688553;7584;3948.269570129535;4116.300228961084;4140.254754144223;4177.373393990925;4309.956900431018;2685.9194224173307;3232.8221947792626;3292.588426446694;3293.226091868409;3296.1924328539662;580.692233116449;597.8983572792636;598.1207624791549;610.7129649064932;614.3641331222163;509.9082165210298;561.7444062951347;564.1847530318732;588.5791658963861;594.3135678291494;8292.419530632918;8363.28912042471;8512.829743405096;8514.276286515715;8548.957255213683;488.333424875043;553.1647212708839;569.6952130610103;598.0729868703493;600.6246096189882;4059.7312095569937;4182.435371224907;4216.367544868294;4243.618074373321;4253.851115210953;91784.54107729418;105873;106689.46655266674;106741.93258067475;113592;59949.40050599438;65303.673481632286;67270;84918.5754071238;89546;71956;79141;81412.59293703493;81531.59234203791;83058.58470707729;7545.6981720730555;7773;8009.799755006172;8107.71622993216;8194.713185038496;47359.28961065518;48904.75547622239;49843.25235121403;50277;52413.47586524086;72567;73052;73366.63316683382;74759;75300;8666.436681615674;10294.742631434274;10298.897011029794;10309.587616495257;10539.473026348498;10570.788584228427;11199.649388421616;11542.538298467967;11574.768504629692;11891.76216475683;10717.35695858251;11074.833877491683;11185.272957257752;11268.887311127111;11363.886361136283;10444.477776111013;11087.05760010408;11113;11243.381614010981;11397.829032564685;10661.360318380923;11000.339979601249;11168.274062185932;11247.325160490396;11365.374904380338;8841;9282.72151835446;9380.57787399555;9551.952240238754;9753.170980466455;8660.307175426076;9211;9310.487923164292;9314.534273286445;9492.477913714813 16:09:26 INFO - PROCESS | 1663 | __end_tp_report 16:09:26 INFO - PROCESS | 1663 | __start_cc_report 16:09:26 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1398 16:09:26 INFO - PROCESS | 1663 | __end_cc_report 16:09:26 INFO - PROCESS | 1663 | __startTimestamp1478387366002__endTimestamp 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:09:26 INFO - PROCESS | 1663 | Number of tests: 6 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:4764.97 Median:4946.16 stddev:534.42 (10.8%) stddev-sans-first:513.02 16:09:26 INFO - PROCESS | 1663 | Values: 2786.5 2808.6 2845.9 2846.6 2900.1 4595.1 4600.6 4776.2 4786.4 4807.2 4670.7 4672.4 4679.2 4692.2 4709.3 4292.1 4307.5 4338.0 4358.7 4387.1 4366.2 4395.1 4411.9 4412.2 4413.2 4275.7 4372.9 4376.9 4395.8 4427.2 4474.0 4524.7 4550.8 4561.7 4576.5 4248.9 4312.9 4345.0 4386.8 4442.6 3813.9 4540.9 4636.6 4672.1 4690.5 5085.8 5158.6 5163.9 5172.7 5185.1 4320.4 5051.2 5190.2 5247.6 5266.1 4828.2 4913.5 4950.3 4961.6 4975.4 5329.1 5347.7 5349.9 5352.5 5388.8 4951.0 5102.6 5103.2 5114.6 5126.0 5088.0 5190.8 5196.0 5207.0 5209.0 5065.0 5119.0 5148.0 5185.9 5256.7 4207.6 5156.4 5220.6 5223.4 5228.0 4183.7 4322.8 4325.2 4339.7 4342.6 3763.3 3871.1 3893.5 3899.3 3903.9 4579.8 4647.0 4661.0 4706.2 4729.3 5143.3 5144.0 5160.7 5168.6 5192.8 3936.3 4267.4 4436.4 4660.7 4714.2 3806.9 4446.1 4542.0 4543.2 4544.0 5462.4 5496.2 5515.6 5519.7 5522.4 5177.7 5191.5 5199.2 5200.6 5250.5 5310.4 5310.5 5371.7 5471.2 5471.6 4469.0 4875.5 5030.8 5140.2 5185.5 4153.4 5175.4 5181.9 5196.9 5198.7 4896.0 5042.0 5069.8 5074.8 5096.3 4949.7 4957.4 5009.7 5023.1 5035.8 4964.4 4993.3 5000.2 5002.1 5015.9 5014.0 5028.5 5031.0 5043.5 5054.5 4699.2 4810.4 4812.2 4873.2 4946.2 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:65808.66 Median:34755.07 stddev:155641.77 (447.8%) stddev-sans-first:156001.00 16:09:26 INFO - PROCESS | 1663 | Values: 440.6 462.2 471.8 474.4 479.6 28722.0 30201.2 36688.1 38017.6 38134.2 38791.2 39160.6 39238.2 39252.0 39322.0 8988.4 9141.6 9170.3 9170.4 9173.3 8085.9 8282.7 8336.7 9042.5 10611.3 10655.5 10838.6 10855.1 10868.3 10876.7 10773.8 10820.0 10822.5 10840.3 10844.1 7951.9 8201.0 10405.6 10652.6 10784.6 36047.7 37702.1 37808.8 37846.8 37918.6 3131.2 3139.2 3175.5 3239.5 3570.0 27091.3 28232.7 29149.4 29164.7 29248.4 2998.0 3072.9 3094.4 3170.5 3172.9 320976.0 323370.0 323502.0 324188.0 324733.4 53345.7 53478.7 53544.4 53636.7 53775.7 53753.7 54715.5 55706.4 55749.7 55815.7 14812.6 15032.3 15036.2 15043.8 15066.2 11563.0 11650.4 11656.1 11675.0 11693.0 12490.6 12826.6 12864.7 14478.3 14597.6 5443.6 6146.4 6316.9 6359.7 6412.8 718.7 807.7 829.3 905.2 926.4 26788.5 28301.8 28418.0 28642.7 28829.1 886.5 929.6 940.4 978.6 1017.5 14007.1 14362.6 14615.6 14726.9 14803.3 495947.0 817761.0 825071.7 826301.0 827360.0 46288.0 47185.0 50588.2 51206.0 51209.5 1127.3 1199.3 1250.5 1275.0 1276.0 25579.7 25929.8 25942.2 26455.9 26529.5 45565.8 46094.0 46109.0 46186.1 46245.1 464191.0 468454.3 586578.0 597459.0 604620.0 22949.5 23192.4 23192.7 23275.9 23325.4 41288.4 41559.5 41963.0 42125.8 42837.0 34756.3 35000.1 35227.8 35826.9 36020.5 34657.7 34753.8 35798.3 36007.6 36059.7 34112.0 34228.7 34724.0 35108.8 35213.6 30151.0 31119.7 31272.4 31325.8 31428.0 23034.4 23483.2 23826.0 23899.6 23910.9 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:32128.50 Median:2082.59 stddev:92077.57 (4421.3%) stddev-sans-first:92304.83 16:09:26 INFO - PROCESS | 1663 | Values: 289.8 297.9 318.4 346.3 356.2 13935.0 14186.0 14809.1 18758.5 19307.6 17754.0 18530.6 18622.5 18812.5 19633.7 4269.6 4945.2 5024.9 5630.7 5706.3 5564.1 5656.1 5662.2 5663.9 5664.3 4952.9 5055.5 5105.8 5192.6 5481.9 5062.9 5069.5 5110.2 5133.3 5143.3 3808.9 4948.8 4965.7 4979.3 5001.8 12378.3 12612.6 12729.2 20011.7 20448.5 1799.8 2121.4 2259.9 2315.2 2723.6 8324.4 8811.9 9080.4 9420.4 10068.8 1747.4 1800.6 1820.4 1831.8 1856.2 107791.0 113518.4 115597.0 116252.0 117297.0 9498.7 10707.8 10884.6 11061.1 11100.0 13558.9 13902.5 13914.7 13919.9 13962.9 7729.2 7999.4 8004.5 8100.9 8111.4 6422.3 7552.5 7711.9 7853.1 8010.3 3546.7 4272.3 4276.1 4304.2 4377.3 1804.7 1869.4 1871.4 1872.5 1913.2 543.9 589.7 612.8 639.5 742.2 18471.9 19475.9 19649.1 19667.2 19986.7 788.4 823.6 826.6 844.3 868.8 9818.4 10247.4 10344.6 10365.9 10504.6 538197.0 541596.0 550450.0 559321.4 561655.0 115672.4 120164.0 121012.3 122431.0 123022.4 778.8 897.2 920.1 923.1 927.7 15914.0 17140.6 17594.2 18103.5 18502.9 47280.1 48307.0 50541.0 51019.0 52409.0 49533.3 65810.0 74737.6 75269.0 75927.6 6257.6 7263.3 7687.2 7797.5 7834.1 9831.0 12020.5 12196.3 12327.9 12407.6 9106.9 10169.9 10447.1 10720.9 10722.2 10106.8 10527.9 10541.1 10581.7 10794.1 9223.6 10551.3 10756.9 10965.1 11032.4 5474.9 7553.4 7624.4 7929.8 10455.9 8336.3 9958.3 10745.9 10752.6 11069.1 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5205.68 Median:4715.85 stddev:2974.44 (63.1%) stddev-sans-first:2967.81 16:09:26 INFO - PROCESS | 1663 | Values: 1234.6 1406.3 1497.8 1721.7 1770.8 6379.5 8259.0 8262.3 8262.7 8264.6 7245.4 7560.9 7570.8 7874.0 8131.4 2207.4 2230.1 2231.2 2243.8 2249.4 2205.4 2245.1 2258.1 2262.2 2268.4 1923.7 2024.6 2028.5 2117.0 2199.5 2196.0 2204.7 2206.1 2209.7 2219.6 2169.9 2201.9 2223.3 2235.6 2237.6 8095.0 8151.4 8214.5 8224.6 8259.1 4714.2 4863.3 4865.3 4869.1 4887.5 3205.9 3352.1 3360.9 3434.7 3435.3 948.1 1007.8 1055.4 1056.2 1060.4 10782.0 10810.8 10811.0 10826.7 10842.0 4124.6 4364.2 4473.1 4473.6 4516.5 9239.8 9242.7 9249.9 9257.1 9289.2 4946.3 5038.6 5039.2 5049.8 5060.4 4407.5 4567.9 4595.2 4646.0 4648.7 2997.8 3433.9 3466.3 3473.3 3527.6 1016.1 1028.5 1029.7 1034.0 1035.9 720.4 743.6 762.8 775.3 804.7 5007.2 5124.3 5174.9 5223.6 5354.2 388.2 391.4 395.9 396.0 397.9 3034.9 3256.9 3298.1 3320.8 3332.6 9652.7 9908.0 10053.6 10054.4 10075.7 9961.6 10024.0 10024.9 10028.5 10039.6 6489.5 7171.1 7480.6 7620.0 7634.0 5076.7 5125.5 5180.0 5300.2 5405.1 9098.7 9191.2 9192.9 9209.1 9230.9 8780.5 9260.2 9304.3 9334.4 9415.0 6861.7 7011.1 7016.8 7019.2 7038.3 7492.8 7590.4 7667.5 7671.6 7677.6 6013.3 6741.6 6781.5 6819.4 6929.2 5801.2 6677.9 6687.0 6709.8 6767.7 5990.6 6135.1 6185.8 6295.4 6363.4 4494.8 4518.5 4549.5 4585.4 4617.3 4048.8 4460.6 4580.2 4629.2 4717.5 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:3362.41 Median:3723.31 stddev:999.93 (26.9%) stddev-sans-first:975.21 16:09:26 INFO - PROCESS | 1663 | Values: 257.8 258.4 274.4 281.3 285.7 3479.8 3673.7 3823.6 4027.0 4164.4 4034.7 4045.4 4057.0 4077.5 4108.8 2713.8 3107.5 3128.0 3183.8 3223.8 2677.7 2789.8 3035.2 3239.9 3245.6 2626.9 2664.0 3097.5 3147.0 3211.8 2920.7 2933.8 3024.7 3191.5 3229.2 2274.8 2791.0 2796.3 2806.6 2814.9 3181.1 3196.7 3517.5 3714.2 3853.3 3283.0 3566.8 3580.3 3609.4 3615.2 3576.9 4087.8 4094.3 4261.2 4280.6 2749.5 2815.7 3049.0 3098.5 3117.2 3491.0 4217.5 4465.8 4483.6 4495.5 2648.7 3116.1 3119.8 3128.6 3133.2 2692.5 3002.6 3142.8 3154.5 3173.6 2990.3 3034.4 3570.4 3588.7 3611.4 4021.6 4083.9 4167.6 4182.4 4323.0 955.9 1018.9 1021.5 1034.7 1035.2 648.9 676.8 678.2 722.9 728.7 3455.4 3684.2 3737.7 3870.8 3890.3 3761.3 4101.2 4409.9 4456.5 4463.3 3562.9 3857.7 3869.2 3902.9 3910.5 1812.8 1828.6 1977.7 2037.5 2149.5 3423.7 3668.8 3805.8 4228.4 4268.2 3410.0 3516.8 3857.5 4058.9 4215.5 4148.3 4237.9 4242.4 4250.5 4252.7 3611.2 3672.6 3839.2 4014.2 4073.9 3706.7 4082.2 4087.6 4094.0 4169.9 3515.6 3732.4 4215.5 4233.6 4239.3 2890.5 2911.8 2912.1 2915.7 2924.0 3737.2 3996.7 4043.8 4108.4 4133.4 3714.2 3785.0 3811.7 3876.3 3967.6 3435.9 3938.2 4117.9 4145.1 4225.4 3657.4 3816.4 4032.3 4173.8 4176.7 3933.2 4253.0 4271.9 4281.7 4324.3 3829.5 4151.7 4164.7 4207.5 4221.2 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18730.93 Median:562.96 stddev:27542.56 (4892.4%) stddev-sans-first:27586.30 16:09:26 INFO - PROCESS | 1663 | Values: 630.9 640.6 665.9 715.6 740.5 13492.4 13799.0 14089.6 14181.3 14418.6 12685.4 12709.9 12887.2 12904.3 12972.4 790.7 791.9 812.3 815.0 815.1 785.5 806.5 808.6 821.3 826.8 833.2 855.6 856.7 857.0 857.2 849.3 849.7 851.5 851.5 853.6 539.0 604.1 629.3 630.9 631.2 13331.1 13692.9 13696.1 13720.9 13733.9 12747.1 12767.2 12771.7 12792.7 12825.7 10692.1 10812.9 10928.7 11136.4 11305.8 3415.2 3436.8 3463.4 3497.9 3561.0 72715.0 81476.8 84067.0 84169.0 84285.0 9820.8 9877.9 10183.3 10311.5 10458.5 18940.4 18955.8 18958.0 18996.0 18996.0 7206.6 7415.7 7516.5 7569.4 7584.0 3948.3 4116.3 4140.3 4177.4 4310.0 2685.9 3232.8 3292.6 3293.2 3296.2 580.7 597.9 598.1 610.7 614.4 509.9 561.7 564.2 588.6 594.3 8292.4 8363.3 8512.8 8514.3 8549.0 488.3 553.2 569.7 598.1 600.6 4059.7 4182.4 4216.4 4243.6 4253.9 91784.5 105873.0 106689.5 106741.9 113592.0 59949.4 65303.7 67270.0 84918.6 89546.0 71956.0 79141.0 81412.6 81531.6 83058.6 7545.7 7773.0 8009.8 8107.7 8194.7 47359.3 48904.8 49843.3 50277.0 52413.5 72567.0 73052.0 73366.6 74759.0 75300.0 8666.4 10294.7 10298.9 10309.6 10539.5 10570.8 11199.6 11542.5 11574.8 11891.8 10717.4 11074.8 11185.3 11268.9 11363.9 10444.5 11087.1 11113.0 11243.4 11397.8 10661.4 11000.3 11168.3 11247.3 11365.4 8841.0 9282.7 9380.6 9552.0 9753.2 8660.3 9211.0 9310.5 9314.5 9492.5 16:09:26 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:09:26 INFO - PROCESS | 1663 | 16:09:26 INFO - TEST-INFO | 1663: exit 0 16:09:26 INFO - TEST-OK | dromaeo_css | took 1118514ms 16:09:26 INFO - TEST-START | kraken 16:09:26 INFO - operating with platform_type : mac_ 16:09:26 INFO - Initialising browser for kraken test... 16:09:26 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0y3ANw/profile http://localhost:49271/getInfo.html) 16:09:29 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 16:09:29 INFO - PROCESS | 1670 | colorDepth:24 16:09:29 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 16:09:29 INFO - PROCESS | 1670 | __metrics 16:09:29 INFO - PROCESS | 1670 | 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" 16:09:29 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:30 INFO - TEST-INFO | 1670: exit 0 16:09:30 INFO - Browser initialized. 16:09:30 INFO - Running cycle 1/1 for kraken test... 16:09:30 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0y3ANw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:42 INFO - PROCESS | 1671 | RSS: Main: 239091712 16:09:42 INFO - PROCESS | 1671 | 16:09:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:46 INFO - PROCESS | 1671 | RSS: Main: 290275328 16:09:46 INFO - PROCESS | 1671 | 16:09:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:09:49 INFO - PROCESS | 1671 | RSS: Main: 291180544 16:09:49 INFO - PROCESS | 1671 | 16:09:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:09:53 INFO - PROCESS | 1671 | RSS: Main: 386617344 16:09:53 INFO - PROCESS | 1671 | 16:09:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:09:56 INFO - PROCESS | 1671 | RSS: Main: 285614080 16:09:56 INFO - PROCESS | 1671 | 16:09:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:59 INFO - PROCESS | 1671 | RSS: Main: 290074624 16:09:59 INFO - PROCESS | 1671 | 16:10:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:02 INFO - PROCESS | 1671 | RSS: Main: 326123520 16:10:02 INFO - PROCESS | 1671 | 16:10:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:06 INFO - PROCESS | 1671 | RSS: Main: 328331264 16:10:06 INFO - PROCESS | 1671 | 16:10:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:10:10 INFO - PROCESS | 1671 | RSS: Main: 324972544 16:10:10 INFO - PROCESS | 1671 | 16:10:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:12 INFO - PROCESS | 1671 | RSS: Main: 302915584 16:10:12 INFO - PROCESS | 1671 | 16:10:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:15 INFO - PROCESS | 1671 | RSS: Main: 305164288 16:10:15 INFO - PROCESS | 1671 | 16:10:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:18 INFO - PROCESS | 1671 | RSS: Main: 311992320 16:10:18 INFO - PROCESS | 1671 | 16:10:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:21 INFO - PROCESS | 1671 | RSS: Main: 323993600 16:10:21 INFO - PROCESS | 1671 | 16:10:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:25 INFO - PROCESS | 1671 | RSS: Main: 317984768 16:10:25 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:10:27 INFO - PROCESS | 1671 | RSS: Main: 361377792 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | __start_tp_report 16:10:27 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 16:10:27 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 16:10:27 INFO - PROCESS | 1671 | |i|pagename|runs| 16:10:27 INFO - PROCESS | 1671 | |0;ai-astar;119;117;117;118;118;118;117;118;117;118 16:10:27 INFO - PROCESS | 1671 | |1;audio-beat-detection;160;119;115;155;118;119;121;121;150;119 16:10:27 INFO - PROCESS | 1671 | |2;audio-dft;216;211;213;211;212;213;210;208;210;209 16:10:27 INFO - PROCESS | 1671 | |3;audio-fft;82;66;87;121;114;63;61;61;75;61 16:10:27 INFO - PROCESS | 1671 | |4;audio-oscillator;92;73;94;71;70;72;93;70;70;95 16:10:27 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;92;89;92;90;91;90;93;89;92;89 16:10:27 INFO - PROCESS | 1671 | |6;imaging-darkroom;98;98;98;99;104;151;98;98;97;97 16:10:27 INFO - PROCESS | 1671 | |7;imaging-desaturate;100;100;98;96;101;105;103;105;105;99 16:10:27 INFO - PROCESS | 1671 | |8;json-parse-financial;57;56;56;55;58;57;57;56;55;57 16:10:27 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;79;74;78;82;78;78;81;78;80;79 16:10:27 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;89;91;93;93;95;92;95;94;106;114 16:10:27 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;158;155;155;153;155;153;156;155;194;168 16:10:27 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;182;183;184;182;181;182;183;183;183;181 16:10:27 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;72;69;70;71;72;71;69;70;70;70 16:10:27 INFO - PROCESS | 1671 | __end_tp_report 16:10:27 INFO - PROCESS | 1671 | __start_cc_report 16:10:27 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2093 16:10:27 INFO - PROCESS | 1671 | __end_cc_report 16:10:27 INFO - PROCESS | 1671 | __startTimestamp1478387427512__endTimestamp 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | ------- Summary: start ------- 16:10:27 INFO - PROCESS | 1671 | Number of tests: 14 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:10:27 INFO - PROCESS | 1671 | Values: 119.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:121.00 stddev:17.70 (14.6%) stddev-sans-first:14.99 16:10:27 INFO - PROCESS | 1671 | Values: 160.0 119.0 115.0 155.0 118.0 119.0 121.0 121.0 150.0 119.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:211.30 Median:211.50 stddev:2.31 (1.1%) stddev-sans-first:1.72 16:10:27 INFO - PROCESS | 1671 | Values: 216.0 211.0 213.0 211.0 212.0 213.0 210.0 208.0 210.0 209.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:79.10 Median:64.50 stddev:22.30 (34.6%) stddev-sans-first:23.63 16:10:27 INFO - PROCESS | 1671 | Values: 82.0 66.0 87.0 121.0 114.0 63.0 61.0 61.0 75.0 61.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:82.50 stddev:11.68 (14.2%) stddev-sans-first:11.55 16:10:27 INFO - PROCESS | 1671 | Values: 92.0 73.0 94.0 71.0 70.0 72.0 93.0 70.0 70.0 95.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:91.50 stddev:1.49 (1.6%) stddev-sans-first:1.51 16:10:27 INFO - PROCESS | 1671 | Values: 92.0 89.0 92.0 90.0 91.0 90.0 93.0 89.0 92.0 89.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:98.00 stddev:16.71 (17.0%) stddev-sans-first:17.59 16:10:27 INFO - PROCESS | 1671 | Values: 98.0 98.0 98.0 99.0 104.0 151.0 98.0 98.0 97.0 97.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:105.00 stddev:3.19 (3.0%) stddev-sans-first:3.35 16:10:27 INFO - PROCESS | 1671 | Values: 100.0 100.0 98.0 96.0 101.0 105.0 103.0 105.0 105.0 99.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:0.97 (1.7%) stddev-sans-first:1.00 16:10:27 INFO - PROCESS | 1671 | Values: 57.0 56.0 56.0 55.0 58.0 57.0 57.0 56.0 55.0 57.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:78.70 Median:79.00 stddev:2.16 (2.7%) stddev-sans-first:2.29 16:10:27 INFO - PROCESS | 1671 | Values: 79.0 74.0 78.0 82.0 78.0 78.0 81.0 78.0 80.0 79.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:93.00 stddev:7.73 (8.3%) stddev-sans-first:7.75 16:10:27 INFO - PROCESS | 1671 | Values: 89.0 91.0 93.0 93.0 95.0 92.0 95.0 94.0 106.0 114.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:155.50 stddev:12.64 (8.1%) stddev-sans-first:13.38 16:10:27 INFO - PROCESS | 1671 | Values: 158.0 155.0 155.0 153.0 155.0 153.0 156.0 155.0 194.0 168.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.40 Median:183.00 stddev:0.97 (0.5%) stddev-sans-first:1.01 16:10:27 INFO - PROCESS | 1671 | Values: 182.0 183.0 184.0 182.0 181.0 182.0 183.0 183.0 183.0 181.0 16:10:27 INFO - PROCESS | 1671 | 16:10:27 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.07 (1.5%) stddev-sans-first:0.97 16:10:27 INFO - PROCESS | 1671 | Values: 72.0 69.0 70.0 71.0 72.0 71.0 69.0 70.0 70.0 70.0 16:10:27 INFO - PROCESS | 1671 | -------- Summary: end -------- 16:10:27 INFO - PROCESS | 1671 | 16:10:28 INFO - TEST-INFO | 1671: exit 0 16:10:28 INFO - TEST-OK | kraken | took 61784ms 16:10:28 INFO - SUITE-END | took 1180s 16:10:28 INFO - Completed test suite (00:19:40) 16:10:28 INFO - javascript benchmark 16:10:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2786.4705705915876, 2808.648918885139, 2845.900393486227, 2846.601475793388, 2900.08647276108, 4595.080983803236, 4600.5629465200755, 4776.235802271637, 4786.353842231298, 4807.182778927587, 4670.743109128996, 4672.369230153929, 4679.227927391985, 4692.249240121581, 4709.340692303081, 4292.077203401261, 4307.483102027761, 4338.0, 4358.673099517533, 4387.1225754849, 4366.214081465335, 4395.120975804836, 4411.911761764779, 4412.183746006983, 4413.205622987861, 4275.679324050693, 4372.934405983913, 4376.912461750763, 4395.846145384912, 4427.158839820424, 4474.0380818124095, 4524.68327217095, 4550.7724613769515, 4561.7491037992895, 4576.473705523874, 4248.9150216995795, 4312.935305970413, 4344.956550434518, 4386.824527018915, 4442.555744425564, 3813.9237215255816, 4540.86377408675, 4636.629069674418, 4672.0889426561835, 4690.507496712864, 5085.771140298695, 5158.613104017214, 5163.870903227412, 5172.689638621695, 5185.118529849935, 4320.416743739618, 5051.166557518005, 5190.2214667800135, 5247.580193584504, 5266.052110620087, 4828.227483602606, 4913.508649135058, 4950.282209079699, 4961.553460188528, 4975.4278258000795, 5329.094054010828, 5347.652402593819, 5349.946500534945, 5352.4915133062295, 5388.838334849961, 4951.034548263054, 5102.591792656579, 5103.18349064148, 5114.616403769732, 5126.0, 5087.956968821382, 5190.8183213587345, 5196.0, 5207.0, 5209.0, 5065.0, 5118.97440512795, 5148.0, 5185.922211166836, 5256.658317209446, 4207.600277973587, 5156.4070131935305, 5220.582353411718, 5223.373195216598, 5228.0, 4183.728057676241, 4322.827086916551, 4325.243082460557, 4339.696221264481, 4342.6308763754805, 3763.284975854579, 3871.070942973666, 3893.493845800028, 3899.3371126907928, 3903.941440878389, 4579.816807327737, 4646.977664913714, 4661.0, 4706.199946009118, 4729.266963620645, 5143.331366922276, 5144.0, 5160.7419629018395, 5168.560672342818, 5192.766325515361, 3936.3111455495173, 4267.445232119804, 4436.401085853433, 4660.720356778605, 4714.198586240279, 3806.885793426202, 4446.110777844444, 4541.999999999934, 4543.204939135638, 4543.977280113579, 5462.399136094947, 5496.230527726041, 5515.61390702647, 5519.668819870741, 5522.392536821027, 5177.715225662474, 5191.480851914778, 5199.246109314204, 5200.557952573922, 5250.527452529291, 5310.415854255952, 5310.468953104659, 5371.650842695212, 5471.179323101566, 5471.6169868108855, 4468.972136408579, 4875.463698993037, 5030.84907452777, 5140.203268493389, 5185.533302002837, 4153.356229784388, 5175.353080864892, 5181.896362072813, 5196.896062078813, 5198.74006299676, 4895.951040489549, 5041.974790126026, 5069.822556210515, 5074.771635276347, 5096.286519887293, 4949.7030178189425, 4957.380327459067, 5009.749512524287, 5023.146065168857, 5035.84892453227, 4964.429090654621, 4993.325901003318, 5000.1749711297225, 5002.124628189979, 5015.924761128659, 5013.974930125326, 5028.547430731105, 5030.974845125751, 5043.470435604356, 5054.494550544916, 4699.201135806853, 4810.350602668735, 4812.181929072136, 4873.1959226727195, 4946.15915294408], "value": 4733.336010621874, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.645280549158, 462.21654295968324, 471.77590644443916, 474.3761953031763, 479.6163069544366, 28722.0, 30201.244968875788, 36688.08279793003, 38017.61982380175, 38134.237315253675, 38791.224175516545, 39160.60839391605, 39238.21523569534, 39252.01869953253, 39322.0169495762, 8988.370814043019, 9141.634334626608, 9170.312226582999, 9170.44977301364, 9173.312001599874, 8085.908402365693, 8282.710105146321, 8336.70821521247, 9042.457452552835, 10611.3102648328, 10655.467226638675, 10838.566457341736, 10855.077318427942, 10868.347899126078, 10876.67369978898, 10773.784524309509, 10820.0, 10822.512986915568, 10840.295380800222, 10844.078253348474, 7951.9204807951755, 8201.0, 10405.635802746943, 10652.573897044109, 10784.622538211124, 36047.738329158616, 37702.05744856373, 37808.81095594532, 37846.81076594627, 37918.620813791786, 3131.170239886432, 3139.230888432326, 3175.491921292582, 3239.5464634951127, 3569.9825549718207, 27091.322716932038, 28232.717672823215, 29149.41701165986, 29164.708352916412, 29248.41503169946, 2997.955030674542, 3072.9078127655985, 3094.3965926644314, 3170.5402716606195, 3172.873085076594, 320976.0, 323370.0, 323502.0, 324188.0, 324733.3763331192, 53345.733271333396, 53478.73260633672, 53544.393668190016, 53636.73181634067, 53775.73112134414, 53753.731231344376, 54715.45284547183, 55706.442935570936, 55749.72125139349, 55815.720921395136, 14812.629684257765, 15032.323545440482, 15036.173010484528, 15043.774343384857, 15066.246687665573, 11562.95933366001, 11650.41747912601, 11656.125790565742, 11675.0, 11693.0, 12490.625281241577, 12826.55107071248, 12864.678383040498, 14478.276086195649, 14597.635059123606, 5443.618946673695, 6146.385361463817, 6316.905246421307, 6359.682015899187, 6412.839679007969, 718.7314390101475, 807.7036356647496, 829.2619568583965, 905.2079430498314, 926.4395041000232, 26788.464230715275, 28301.811586981854, 28418.00536981196, 28642.71357286442, 28829.135125946254, 886.5389997201419, 929.5909799688116, 940.4216406909701, 978.5645387802359, 1017.5014243020867, 14007.08953917992, 14362.640933976734, 14615.634609134857, 14726.876474587132, 14803.259837008321, 495947.0, 817761.0, 825071.746412677, 826301.0, 827360.0, 46288.0, 47185.0, 50588.241176382384, 51206.0, 51209.48790512047, 1127.2729089737074, 1199.316389657904, 1250.499800079939, 1274.9872501275054, 1275.9872401276054, 25579.744202557737, 25929.83315750758, 25942.221733347276, 26455.94176233006, 26529.469410612066, 45565.77217113893, 46094.0, 46109.0, 46186.07627847492, 46245.07509849851, 464191.0, 468454.3091381806, 586578.0, 597459.0, 604620.0, 22949.54100917939, 23192.4201894954, 23192.652110218023, 23275.88362058179, 23325.41686457852, 41288.38067428931, 41559.545415910296, 41963.0, 42125.789371052946, 42837.0, 34756.30487390289, 35000.12499687528, 35227.82386088053, 35826.92519224427, 36020.4596931041, 34657.65342346544, 34753.826230869694, 35798.28403431969, 36007.63992360148, 36059.7379091741, 34112.0, 34228.657713422544, 34724.0, 35108.824455877555, 35213.64786352104, 30151.0, 31119.688803112585, 31272.374552509278, 31325.843370783, 31428.0, 23034.424139396648, 23483.17808876681, 23826.0, 23899.641505377782, 23910.88044559766], "value": 18257.101179023648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.7841108374261, 297.90169244149433, 318.40140535792705, 346.2538182784071, 356.23231935179683, 13934.954878384124, 14186.0, 14809.11145331281, 18758.53103672409, 19307.613847723038, 17754.0, 18530.629387412242, 18622.53443663909, 18812.529686757836, 19633.705494417558, 4269.5943885331, 4945.1840446326405, 5024.9246261305925, 5630.746616402252, 5706.28671416073, 5564.10974244121, 5656.066748986413, 5662.17898404731, 5663.943360566383, 5664.348599911001, 4952.87617809554, 5055.494450554952, 5105.795768169269, 5192.584593232551, 5481.890362192754, 5062.873428164288, 5069.543741063285, 5110.207917772733, 5133.307003554547, 5143.254228136899, 3808.9428658570146, 4948.777305021283, 4965.702057876539, 4979.278004689336, 5001.799928002875, 12378.319192444502, 12612.621621351282, 12729.236245825281, 20011.699239549383, 20448.488787780276, 1799.8110198429108, 2121.3954023103342, 2259.9435014124615, 2315.247544548012, 2723.5687317573647, 8324.417290789646, 8811.867821982676, 9080.364374493787, 9420.434773913586, 10068.848967265498, 1747.4408189379403, 1800.5858652509864, 1820.417466410749, 1831.7893442254178, 1856.2389420337731, 107791.0, 113518.37779466434, 115597.0, 116252.0, 117297.0, 9498.715038548855, 10707.839382409271, 10884.61903833362, 11061.115110791117, 11100.0, 13558.86441135576, 13902.51341203053, 13914.652133696738, 13919.860801391857, 13962.860371396157, 7729.227077292338, 7999.400044996532, 8004.51972881629, 8100.878486822702, 8111.3916456266015, 6422.293547709748, 7552.546847189186, 7711.884321735179, 7853.057633083952, 8010.279074883289, 3546.6985306248744, 4272.252355837716, 4276.070891439374, 4304.227936593415, 4377.277749171415, 1804.6751584714614, 1869.3831035758167, 1871.4385684294657, 1872.4757068020976, 1913.158210387425, 543.9447471904572, 589.7080944932286, 612.7763366371242, 639.5011890725149, 742.1984257002424, 18471.90764046171, 19475.92882391454, 19649.115789789495, 19667.21331146767, 19986.70019949702, 788.3995489157021, 823.5923218007005, 826.5536610230529, 844.3371953016853, 868.8305780372893, 9818.361806482555, 10247.436390998417, 10344.637937672145, 10365.896341036643, 10504.579816807242, 538197.0, 541596.0, 550450.0, 559321.4067859269, 561655.0, 115672.42163789127, 120164.0, 121012.34432106318, 122431.0, 123022.38488807678, 778.8481246157058, 897.210454799772, 920.061537232033, 923.0584803500392, 927.675313640234, 15914.0, 17140.628749699743, 17594.208260628046, 18103.456896293133, 18502.907485463023, 47280.05439891114, 48307.0, 50541.0, 51019.0, 52409.0, 49533.25700114429, 65810.0, 74737.6263118681, 75269.0, 75927.62036190004, 6257.624542527463, 7263.34629883313, 7687.231276872268, 7797.493162944391, 7834.1382447929545, 9830.950845245728, 12020.519179232733, 12196.329201893626, 12327.9383603085, 12407.627771166879, 9106.861642294713, 10169.89830101719, 10447.05976462122, 10720.946395267974, 10722.24944253926, 10106.797864042825, 10527.94736026315, 10541.051305382553, 10581.735456613646, 10794.136469082612, 9223.631054757734, 10551.314164579278, 10756.93427373195, 10965.122790176607, 11032.393218373067, 5474.932388184425, 7553.357964573072, 7624.351930086005, 7929.841403172019, 10455.94772026135, 8336.291415229773, 9958.302918795904, 10745.850829833907, 10752.623658171926, 11069.059129974043], "value": 8608.048758757455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.6172686467196, 1406.296851574213, 1497.7977972973652, 1721.7331313646373, 1770.8406243438087, 6379.52153588481, 8259.0, 8262.33901287897, 8262.669493220279, 8264.628091735878, 7245.384142347893, 7560.92439075609, 7570.77287681369, 7873.960630196855, 8131.390145739064, 2207.3708992937018, 2230.0968107916237, 2231.241377931503, 2243.798058174764, 2249.392663980724, 2205.3935167828813, 2245.057076028064, 2258.062903894882, 2262.2195342606774, 2268.3988742983124, 1923.7306777051224, 2024.564718585504, 2028.4928767808049, 2116.9788302117013, 2199.461132022657, 2195.9890200548975, 2204.691343211952, 2206.1396055538353, 2209.7127373441513, 2219.5782801267787, 2169.8806565638884, 2201.9119235230573, 2223.2552095048177, 2235.608768465512, 2237.6084185267514, 8095.0, 8151.429399941947, 8214.507129572185, 8224.588770561448, 8259.132791056973, 4714.175019371596, 4863.27050942358, 4865.270209468573, 4869.099216644932, 4887.535684110004, 3205.9198520036953, 3352.0614228016193, 3360.9159771005675, 3434.6737059979264, 3435.347284016029, 948.132458800197, 1007.7581380468635, 1055.3615062886997, 1056.2289528644133, 1060.3743791163251, 10782.0296173344, 10810.783784324349, 10810.972957569096, 10826.72933176669, 10841.970012848768, 4124.628783409507, 4364.236258654786, 4473.114840927648, 4473.575010374009, 4516.458025037016, 9239.815203695889, 9242.72271831846, 9249.861252081224, 9257.074292570824, 9289.210417114486, 4946.332245146931, 5038.5969122470115, 5039.193729003415, 5049.823256186016, 5060.418051924076, 4407.515173330931, 4567.862964111082, 4595.172868883633, 4646.0, 4648.721076735406, 2997.775166862494, 3433.914152146216, 3466.341395134916, 3473.3053389322235, 3527.5943266524678, 1016.1464369929147, 1028.475477506462, 1029.6550655530482, 1034.04350975349, 1035.880873699519, 720.3948683106216, 743.6133210730499, 762.7826069570145, 775.2673723331397, 804.7384600005022, 5007.248912663057, 5124.282600435942, 5174.896502069938, 5223.5559977402345, 5354.196870469383, 388.18093822035485, 391.41288067898154, 395.89508780173276, 395.98614048508165, 397.9383195604686, 3034.9226024761333, 3256.8734015345535, 3298.10951043217, 3320.7841490303053, 3332.616749073839, 9652.710418687451, 9908.0, 10053.597856085675, 10054.447005414626, 10075.697729068139, 9961.601535938626, 10024.047715467019, 10024.899751002542, 10028.548715307828, 10039.598416063422, 6489.539853532918, 7171.067761191011, 7480.551166930001, 7619.961900190575, 7634.045744281965, 5076.746162691925, 5125.538701516882, 5179.974100129475, 5300.2049692546425, 5405.108157154183, 9098.681546145854, 9191.218746406363, 9192.908070919206, 9209.079092090737, 9230.907690923004, 8780.473171609723, 9260.212881905114, 9304.348695591243, 9334.386371815903, 9415.0, 6861.725530978705, 7011.088558487568, 7016.789496315118, 7019.19279282889, 7038.2961703829205, 7492.838610015457, 7590.354819840155, 7667.539947603162, 7671.616419178907, 7677.5777332245025, 6013.30846952606, 6741.561798483083, 6781.525293229427, 6819.386255237053, 6929.203141638776, 5801.1878337032, 6677.866442671217, 6687.0, 6709.832254193489, 6767.695453704497, 5990.64056156632, 6135.07973803933, 6185.8144255672405, 6295.433410993032, 6363.395477429637, 4494.842680506166, 4518.502964673818, 4549.476810166873, 4585.403897493305, 4617.330487079422, 4048.797560121923, 4460.553944605644, 4580.244259697112, 4629.166749985035, 4717.528247175255], "value": 4091.184698169713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.83627396603174, 258.35669183732506, 274.42371020856206, 281.3135948286181, 285.69430709141216, 3479.80861052642, 3673.687736542394, 3823.636754508321, 4026.9529922220213, 4164.375343698447, 4034.6685593754064, 4045.3656004153213, 4057.0, 4077.4699289092378, 4108.753474791514, 2713.755761981421, 3107.5027995520722, 3127.9502485077096, 3183.808971461708, 3223.8226897520626, 2677.6920654124733, 2789.8186617869874, 3035.2243937296707, 3239.9352012959725, 3245.610526736795, 2626.924729463721, 2664.0, 3097.5286738799005, 3147.0244224290545, 3211.807291562502, 2920.6641236257888, 2933.8239705617516, 3024.6672865984724, 3191.521271809224, 3229.1765599772025, 2274.7611500792345, 2790.9860450697615, 2796.286946828566, 2806.6070750095005, 2814.901478448265, 3181.109289398972, 3196.6643502432375, 3517.5251341068883, 3714.2014466889477, 3853.3256680081154, 3282.983585082083, 3566.805120284682, 3580.3018411409785, 3609.4405367168133, 3615.1504396466808, 3576.856925722968, 4087.814533785199, 4094.303968325392, 4261.169072030955, 4280.614744672995, 2749.5463248563965, 2815.6761972373233, 3049.0395525409426, 3098.4732595458827, 3117.173948903542, 3490.9650903491147, 4217.536071032184, 4465.834070475817, 4483.574060464251, 4495.505494395614, 2648.7153730440723, 3116.065180445857, 3119.814470501195, 3128.6089238845143, 3133.185371803302, 2692.474967381381, 3002.6246719160104, 3142.7686342696943, 3154.511050787132, 3173.5715678383585, 2990.3271763853395, 3034.3779525197283, 3570.357335679603, 3588.7129029677562, 3611.422172452395, 4021.597840215955, 4083.8774836754947, 4167.5832416758685, 4182.372644103409, 4323.0, 955.8709574207533, 1018.8573599696049, 1021.4637315409469, 1034.6895931220604, 1035.1511760356586, 648.9422241745924, 676.8409423785406, 678.2403707847144, 722.9047992291682, 728.7194430144433, 3455.447128459434, 3684.171061511192, 3737.66396002493, 3870.761356365936, 3890.299746045739, 3761.3482494841073, 4101.241270364992, 4409.911801763947, 4456.5239113491525, 4463.308187230984, 3562.87529936451, 3857.691384689218, 3869.187470631199, 3902.863399780994, 3910.530736311661, 1812.7763759462573, 1828.579426731859, 1977.7231187633743, 2037.5109973606525, 2149.4948687058527, 3423.7432192585156, 3668.79821609814, 3805.7821497120653, 4228.4080228768, 4268.210381079511, 3409.9659003410143, 3516.841742121611, 3857.498525191707, 4058.898527536835, 4215.451991241119, 4148.253314403436, 4237.915241695149, 4242.384854196124, 4250.489941207075, 4252.744835309892, 3611.214078077194, 3672.577653569767, 3839.1745774658584, 4014.1735510343306, 4073.938890916698, 3706.684931780721, 4082.2447847148374, 4087.56789710122, 4094.0, 4169.874903752892, 3515.595706493684, 3732.42147467143, 4215.473065866767, 4233.576642335742, 4239.300515415045, 2890.5375139977505, 2911.7525010374356, 2912.140918429026, 2915.7375836174847, 2923.985380073086, 3737.1572178284114, 3996.7002474815085, 4043.81802818868, 4108.383742438658, 4133.441985332062, 3714.192952223992, 3784.962150378461, 3811.6569508744346, 3876.3290235267, 3967.6032396761248, 3435.896923092311, 3938.15329704115, 4117.929338371985, 4145.108801607548, 4225.429567008415, 3657.4330978698345, 3816.3893776996656, 4032.2620920417803, 4173.770442625685, 4176.728512646669, 3933.1877707439317, 4253.000544871891, 4271.914561708811, 4281.657467402662, 4324.308110702398, 3829.476881269183, 4151.667866570607, 4164.729292595972, 4207.474065741782, 4221.2190744712325], "value": 3058.0893370843874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.8549033722243, 640.6252342379707, 665.8580534383532, 715.6421789105448, 740.518662869135, 13492.392842322095, 13798.962529110151, 14089.647758806035, 14181.290935453238, 14418.639534011654, 12685.429155687993, 12709.872901270985, 12887.162334448254, 12904.290264035497, 12972.351382430865, 790.6560646118957, 791.8614242507552, 812.2811311988874, 815.042325267811, 815.0789607743242, 785.4776573578592, 806.4717609965483, 808.6078252047752, 821.3265122599471, 826.8139668574553, 833.1834801894147, 855.5807654249435, 856.6744637037917, 857.0015931439865, 857.1642648417806, 849.3332733803965, 849.6813694864426, 851.4848516647401, 851.5103815306193, 853.5646820121783, 538.9892202155935, 604.0938592111833, 629.3014753623474, 630.8612105336819, 631.2298995225817, 13331.066825322232, 13692.931535342259, 13696.109752866032, 13720.93139534296, 13733.931330343385, 12747.107702460831, 12767.248065869779, 12771.744565108738, 12792.744145117138, 12825.679358016125, 10692.09117225029, 10812.891871081267, 10928.726781830439, 11136.443177841076, 11305.773884522263, 3415.163284995167, 3436.7766095203733, 3463.445848664227, 3497.9475307870403, 3561.0, 72715.0, 81476.77784833172, 84067.0, 84169.0, 84285.0, 9820.803583928424, 9877.901220987842, 10183.283101667837, 10311.48442577868, 10458.533470998143, 18940.43178704641, 18955.81044189568, 18958.0, 18996.0, 18996.0, 7206.603636799921, 7415.703371865173, 7516.467260387609, 7569.356604688553, 7584.0, 3948.269570129535, 4116.300228961084, 4140.254754144223, 4177.373393990925, 4309.956900431018, 2685.9194224173307, 3232.8221947792626, 3292.588426446694, 3293.226091868409, 3296.1924328539662, 580.692233116449, 597.8983572792636, 598.1207624791549, 610.7129649064932, 614.3641331222163, 509.9082165210298, 561.7444062951347, 564.1847530318732, 588.5791658963861, 594.3135678291494, 8292.419530632918, 8363.28912042471, 8512.829743405096, 8514.276286515715, 8548.957255213683, 488.333424875043, 553.1647212708839, 569.6952130610103, 598.0729868703493, 600.6246096189882, 4059.7312095569937, 4182.435371224907, 4216.367544868294, 4243.618074373321, 4253.851115210953, 91784.54107729418, 105873.0, 106689.46655266674, 106741.93258067475, 113592.0, 59949.40050599438, 65303.673481632286, 67270.0, 84918.5754071238, 89546.0, 71956.0, 79141.0, 81412.59293703493, 81531.59234203791, 83058.58470707729, 7545.6981720730555, 7773.0, 8009.799755006172, 8107.71622993216, 8194.713185038496, 47359.28961065518, 48904.75547622239, 49843.25235121403, 50277.0, 52413.47586524086, 72567.0, 73052.0, 73366.63316683382, 74759.0, 75300.0, 8666.436681615674, 10294.742631434274, 10298.897011029794, 10309.587616495257, 10539.473026348498, 10570.788584228427, 11199.649388421616, 11542.538298467967, 11574.768504629692, 11891.76216475683, 10717.35695858251, 11074.833877491683, 11185.272957257752, 11268.887311127111, 11363.886361136283, 10444.477776111013, 11087.05760010408, 11113.0, 11243.381614010981, 11397.829032564685, 10661.360318380923, 11000.339979601249, 11168.274062185932, 11247.325160490396, 11365.374904380338, 8841.0, 9282.72151835446, 9380.57787399555, 9551.952240238754, 9753.170980466455, 8660.307175426076, 9211.0, 9310.487923164292, 9314.534273286445, 9492.477913714813], "value": 6708.565002325623, "unit": "score"}], "name": "dromaeo_css", "value": 6298.681619656605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 119.0, 115.0, 155.0, 118.0, 119.0, 121.0, 121.0, 150.0, 119.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 211.0, 213.0, 211.0, 212.0, 213.0, 210.0, 208.0, 210.0, 209.0], "value": 211.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 66.0, 87.0, 121.0, 114.0, 63.0, 61.0, 61.0, 75.0, 61.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 94.0, 71.0, 70.0, 72.0, 93.0, 70.0, 70.0, 95.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 90.0, 91.0, 90.0, 93.0, 89.0, 92.0, 89.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 99.0, 104.0, 151.0, 98.0, 98.0, 97.0, 97.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 98.0, 96.0, 101.0, 105.0, 103.0, 105.0, 105.0, 99.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 58.0, 57.0, 57.0, 56.0, 55.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 78.0, 82.0, 78.0, 78.0, 81.0, 78.0, 80.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 93.0, 93.0, 95.0, 92.0, 95.0, 94.0, 106.0, 114.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 155.0, 153.0, 155.0, 153.0, 156.0, 155.0, 194.0, 168.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 182.0, 181.0, 182.0, 183.0, 183.0, 183.0, 181.0], "value": 182.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 71.0, 72.0, 71.0, 69.0, 70.0, 70.0, 70.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1557.8000000000002, "alertThreshold": 2.0}]} 16:10:28 INFO - Return code: 0 16:10:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:28 INFO - # TBPL SUCCESS # 16:10:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:10:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:10:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:10:28 INFO - 2016-11-05 16:10:28.838 screenresolution[1675:10573] starting screenresolution argv=screenresolution get 16:10:28 INFO - 2016-11-05 16:10:28.841 screenresolution[1675:10573] Display 0: 1600x1200x32@60 16:10:28 INFO - 2016-11-05 16:10:28.847 screenresolution[1676:10576] starting screenresolution argv=screenresolution list 16:10:28 INFO - Available Modes on Display 0 16:10:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:10:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:10:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:10:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:10:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:10:29 INFO - Intel Iris: 16:10:29 INFO - Chipset Model: Intel Iris 16:10:29 INFO - Type: GPU 16:10:29 INFO - Bus: Built-In 16:10:29 INFO - VRAM (Dynamic, Max): 1536 MB 16:10:29 INFO - Vendor: Intel (0x8086) 16:10:29 INFO - Device ID: 0x0a2e 16:10:29 INFO - Revision ID: 0x0009 16:10:29 INFO - Displays: 16:10:29 INFO - Display: 16:10:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:10:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:10:29 INFO - Display Serial Number: 1600x1200 60 16:10:29 INFO - Main Display: Yes 16:10:29 INFO - Mirror: Off 16:10:29 INFO - Online: Yes 16:10:29 INFO - Rotation: Supported 16:10:29 INFO - Return code: 0 16:10:29 INFO - Running post-action listener: _resource_record_post_action 16:10:29 INFO - [mozharness: 2016-11-05 23:10:29.092109Z] Finished run-tests step (success) 16:10:29 INFO - Running post-run listener: _resource_record_post_run 16:10:29 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 32594944; Write bytes: 706094080; Read time: 322; Write time: 1990 16:10:29 INFO - TinderboxPrint: CPU usage
53.7% 16:10:29 INFO - TinderboxPrint: I/O read bytes / time
32,594,944 / 322 16:10:29 INFO - TinderboxPrint: I/O write bytes / time
706,094,080 / 1,990 16:10:29 INFO - TinderboxPrint: CPU idle
2,253.0 (46.3%) 16:10:29 INFO - TinderboxPrint: CPU system
978.0 (20.1%) 16:10:29 INFO - TinderboxPrint: CPU user
1,634.8 (33.6%) 16:10:29 INFO - TinderboxPrint: Swap in / out
432,295,936 / 0 16:10:29 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 392428032; Write bytes: 387676160; Read time: 30448; Write time: 776 16:10:29 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30809088; Write bytes: 298265600; Read time: 305; Write time: 1141 16:10:29 INFO - Running post-run listener: _upload_blobber_files 16:10:29 INFO - Blob upload gear active. 16:10:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:29 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 16:10:29 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'] 16:10:29 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 16:10:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:10:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:31 INFO - (blobuploader) - INFO - Done attempting. 16:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:31 INFO - (blobuploader) - INFO - Done attempting. 16:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:34 INFO - (blobuploader) - INFO - Done attempting. 16:10:34 INFO - (blobuploader) - INFO - Iteration through files over. 16:10:34 INFO - Return code: 0 16:10:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:10:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:10:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7318c05c07d38bcda4baa0e9845bb6d6fdb2e376e770318589fbc1851954e898fbc4c6c3cf57b71024a975f6c226e192519193c25b2f16d14687a7282c45f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d6a8b76ed1f85422790885d101d49d61c284a26db906ecc8fbb5f383dcc2426cd5bc3c07f9af1d481e939a67c6f553cf22c0466db058d96ca4168cbaddfc2b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c954ea9969fbb626742034267a7005b08fa47af5604bc32b3619d1b14b4a950585c015b63141671b6462910a6db0e7a81f8bd9966eeab207c6210b94576724"} 16:10:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:10:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:10:34 INFO - Contents: 16:10:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7318c05c07d38bcda4baa0e9845bb6d6fdb2e376e770318589fbc1851954e898fbc4c6c3cf57b71024a975f6c226e192519193c25b2f16d14687a7282c45f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d6a8b76ed1f85422790885d101d49d61c284a26db906ecc8fbb5f383dcc2426cd5bc3c07f9af1d481e939a67c6f553cf22c0466db058d96ca4168cbaddfc2b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c954ea9969fbb626742034267a7005b08fa47af5604bc32b3619d1b14b4a950585c015b63141671b6462910a6db0e7a81f8bd9966eeab207c6210b94576724"} 16:10:34 INFO - Running post-run listener: copy_logs_to_upload_dir 16:10:34 INFO - Copying logs to upload dir... 16:10:34 INFO - mkdir: /builds/slave/test/build/upload/logs 16:10:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.118734 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-05 16:10:34.511406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:10:34.516243) ========= 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.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/91d7318c05c07d38bcda4baa0e9845bb6d6fdb2e376e770318589fbc1851954e898fbc4c6c3cf57b71024a975f6c226e192519193c25b2f16d14687a7282c45f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d6a8b76ed1f85422790885d101d49d61c284a26db906ecc8fbb5f383dcc2426cd5bc3c07f9af1d481e939a67c6f553cf22c0466db058d96ca4168cbaddfc2b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c954ea9969fbb626742034267a7005b08fa47af5604bc32b3619d1b14b4a950585c015b63141671b6462910a6db0e7a81f8bd9966eeab207c6210b94576724"} build_url:https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011630 build_url: 'https://queue.taskcluster.net/v1/task/INfzpT0AS7-0vIXWomzqIw/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/91d7318c05c07d38bcda4baa0e9845bb6d6fdb2e376e770318589fbc1851954e898fbc4c6c3cf57b71024a975f6c226e192519193c25b2f16d14687a7282c45f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d6a8b76ed1f85422790885d101d49d61c284a26db906ecc8fbb5f383dcc2426cd5bc3c07f9af1d481e939a67c6f553cf22c0466db058d96ca4168cbaddfc2b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c954ea9969fbb626742034267a7005b08fa47af5604bc32b3619d1b14b4a950585c015b63141671b6462910a6db0e7a81f8bd9966eeab207c6210b94576724"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:10:34.549757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:10:34.550089) ========= 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.bRcjptSQ4K/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.OFsByQQpU3/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005577 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:10:34.602689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:10:34.603408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:10:34.603721) ========= ========= Total master_lag: 0.20 =========