builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1485799049.28 results: success (0) buildid: 20170130064642 builduid: 71838092e3cd470a9836605bcd5b67d7 revision: 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.275718) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.276175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.276460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.302464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.302847) ========= 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.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-30 09:57:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2017-01-30 09:57:29 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.446344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.446657) ========= 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.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.025758 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:29.495050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 09:57:29.495482) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-30 09:57:29,601 truncating revision to first 12 chars 2017-01-30 09:57:29,601 Setting DEBUG logging. 2017-01-30 09:57:29,601 attempt 1/10 2017-01-30 09:57:29,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ddd53a5d530?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 09:57:30,328 unpacking tar archive at: mozilla-beta-4ddd53a5d530/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 09:57:30.515339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:30.515661) ========= script_repo_revision: 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:30.516050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:30.516327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 09:57:30.535659) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-30 09:57:30.536045) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:57:30 INFO - MultiFileLogger online at 20170130 09:57:30 in /builds/slave/test 09:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:57:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:30 INFO - {'append_to_log': False, 09:57:30 INFO - 'base_work_dir': '/builds/slave/test', 09:57:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:30 INFO - 'branch': 'Mozilla-Beta', 09:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:30 INFO - 'config_files': ('talos/mac_config.py',), 09:57:30 INFO - 'default_actions': ('clobber', 09:57:30 INFO - 'read-buildbot-config', 09:57:30 INFO - 'download-and-extract', 09:57:30 INFO - 'populate-webroot', 09:57:30 INFO - 'create-virtualenv', 09:57:30 INFO - 'install', 09:57:30 INFO - 'run-tests'), 09:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:30 INFO - 'download_minidump_stackwalk': True, 09:57:30 INFO - 'download_symbols': 'ondemand', 09:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:30 INFO - 'installer_path': 'installer.exe', 09:57:30 INFO - 'log_level': 'info', 09:57:30 INFO - 'log_name': 'talos', 09:57:30 INFO - 'log_to_console': True, 09:57:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:57:30 INFO - 'opt_config_files': (), 09:57:30 INFO - 'pip_index': False, 09:57:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:30 INFO - 'cmd': ('bash', 09:57:30 INFO - '-c', 09:57:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:30 INFO - 'enabled': True, 09:57:30 INFO - 'halt_on_failure': False, 09:57:30 INFO - 'name': 'check_screen_resolution'},), 09:57:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:30 INFO - 'cmd': ('bash', 09:57:30 INFO - '-c', 09:57:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:30 INFO - 'enabled': True, 09:57:30 INFO - 'halt_on_failure': False, 09:57:30 INFO - 'name': 'check_screen_resolution'},), 09:57:30 INFO - 'run_cmd_checks_enabled': True, 09:57:30 INFO - 'sps_profile': False, 09:57:30 INFO - 'sps_profile_interval': 0, 09:57:30 INFO - 'suite': 'dromaeojs-e10s', 09:57:30 INFO - 'system_bits': '32', 09:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:30 INFO - 'title': 't-yosemite-r7-0314', 09:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:30 INFO - 'use_talos_json': True, 09:57:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:30 INFO - 'work_dir': 'build'} 09:57:30 INFO - [mozharness: 2017-01-30 17:57:30.746590Z] Running clobber step. 09:57:30 INFO - Running pre-action listener: _resource_record_pre_action 09:57:30 INFO - Running main action method: clobber 09:57:30 INFO - rmtree: /builds/slave/test/build 09:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:33 INFO - Running post-action listener: _resource_record_post_action 09:57:33 INFO - [mozharness: 2017-01-30 17:57:33.097572Z] Finished clobber step (success) 09:57:33 INFO - [mozharness: 2017-01-30 17:57:33.097698Z] Running read-buildbot-config step. 09:57:33 INFO - Running pre-action listener: _resource_record_pre_action 09:57:33 INFO - Running main action method: read_buildbot_config 09:57:33 INFO - Using buildbot properties: 09:57:33 INFO - { 09:57:33 INFO - "project": "", 09:57:33 INFO - "product": "firefox", 09:57:33 INFO - "script_repo_revision": "production", 09:57:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:57:33 INFO - "repository": "", 09:57:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:57:33 INFO - "buildid": "20170130064642", 09:57:33 INFO - "pgo_build": "False", 09:57:33 INFO - "basedir": "/builds/slave/test", 09:57:33 INFO - "buildnumber": 0, 09:57:33 INFO - "slavename": "t-yosemite-r7-0314", 09:57:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:57:33 INFO - "platform": "yosemite_r7", 09:57:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:57:33 INFO - "branch": "mozilla-beta", 09:57:33 INFO - "repo_path": "releases/mozilla-beta", 09:57:33 INFO - "revision": "4ddd53a5d53033cf03d3ab027f0b58e5fda96216", 09:57:33 INFO - "stage_platform": "macosx64", 09:57:33 INFO - "builduid": "71838092e3cd470a9836605bcd5b67d7", 09:57:33 INFO - "slavebuilddir": "test" 09:57:33 INFO - } 09:57:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:57:33 INFO - Running post-action listener: _resource_record_post_action 09:57:33 INFO - [mozharness: 2017-01-30 17:57:33.101039Z] Finished read-buildbot-config step (success) 09:57:33 INFO - [mozharness: 2017-01-30 17:57:33.101176Z] Running download-and-extract step. 09:57:33 INFO - Running pre-action listener: _resource_record_pre_action 09:57:33 INFO - Running main action method: download_and_extract 09:57:33 INFO - mkdir: /builds/slave/test/build/tests 09:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:33 INFO - trying https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:57:34 INFO - Downloaded 1165 bytes. 09:57:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:57:34 INFO - Using the following test package requirements: 09:57:34 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:57:34 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:57:34 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:57:34 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:57:34 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:57:34 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:57:34 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:57:34 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:57:34 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:57:34 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:57:34 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:57:34 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:57:34 INFO - Http code: 200 09:57:34 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:57:34 INFO - x-amz-cf-id: 3IXA97nRUpso78TF3QbaZRxwyqQRd9w6Tj_S3c1s-MVQKKpOincFMQ== 09:57:34 INFO - x-amz-version-id: yn35CucRgslLFAt3BFLMhxlV2wVE.j39 09:57:35 INFO - Expected file size: 16087637 09:57:35 INFO - Obtained file size: 16087637 09:57:41 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:57:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:57:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:41 INFO - Fetch https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:57:42 INFO - Http code: 200 09:57:42 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 09:57:42 INFO - x-amz-cf-id: HpnsrNGdTSnKYWKN48nUxsO8R36lJp650edqxn_Mnvm8ZEUM4jyong== 09:57:42 INFO - x-amz-version-id: yn35CucRgslLFAt3BFLMhxlV2wVE.j39 09:57:42 INFO - Expected file size: 16087637 09:57:42 INFO - Obtained file size: 16087637 09:57:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:57:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:57:49 INFO - Fetch https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:57:49 INFO - Http code: 200 09:57:49 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 09:57:49 INFO - x-amz-cf-id: lZEgeg4CyH4uw6YL4Cz-XpXNW92CO7SsQ8VAUAee8B1n5H5eUh_ZDg== 09:57:49 INFO - x-amz-version-id: hGvHVLKUOJbdWtABXWlVHJ07XkUNFoKL 09:57:50 INFO - Expected file size: 14402992 09:57:50 INFO - Obtained file size: 14402992 09:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:50 INFO - trying https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:57:50 INFO - Downloading https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:57:52 INFO - Downloaded 82145643 bytes. 09:57:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:57:52 INFO - mkdir: /builds/slave/test/properties 09:57:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:52 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:52 INFO - Contents: 09:57:52 INFO - build_url:https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - Running post-action listener: set_extra_try_arguments 09:57:53 INFO - [mozharness: 2017-01-30 17:57:53.495398Z] Finished download-and-extract step (success) 09:57:53 INFO - [mozharness: 2017-01-30 17:57:53.495558Z] Running populate-webroot step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: populate_webroot 09:57:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:53 INFO - '--tppagecycles', 09:57:53 INFO - '7'], 09:57:53 INFO - 'tests': ['tsvgm']}}, 09:57:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['damp', 'tps']}, 09:57:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['damp', 'tps']}, 09:57:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['dromaeo_dom']}, 09:57:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['basic_compositor_video']}, 09:57:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['a11yr', 09:57:53 INFO - 'ts_paint', 09:57:53 INFO - 'tpaint', 09:57:53 INFO - 'sessionrestore', 09:57:53 INFO - 'sessionrestore_no_auto_restore', 09:57:53 INFO - 'tabpaint']}, 09:57:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tsvgx', 09:57:53 INFO - 'tsvgr_opacity', 09:57:53 INFO - 'tart', 09:57:53 INFO - 'tscrollx', 09:57:53 INFO - 'cart']}, 09:57:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:53 INFO - 'tsvgr_opacity', 09:57:53 INFO - 'tart', 09:57:53 INFO - 'tscrollx', 09:57:53 INFO - 'cart']}, 09:57:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s'], 09:57:53 INFO - 'tests': ['tp5o']}, 09:57:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'tests': ['tp5o']}, 09:57:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--disable-e10s', 09:57:53 INFO - '--xperf_path', 09:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:53 INFO - 'tests': ['tp5n']}, 09:57:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:53 INFO - 'talos_options': ['--xperf_path', 09:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:53 INFO - 'tests': ['tp5n']}}, 09:57:53 INFO - 'talos.zip': {'path': '', 09:57:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - [mozharness: 2017-01-30 17:57:53.514444Z] Finished populate-webroot step (success) 09:57:53 INFO - [mozharness: 2017-01-30 17:57:53.514562Z] Running create-virtualenv step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: create_virtualenv 09:57:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:53 INFO - Using real prefix '/tools/python27' 09:57:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:57 INFO - Installing pip.................done. 09:57:57 INFO - Return code: 0 09:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:57 INFO - Reading from file tmpfile_stdout 09:57:57 INFO - Output received: 09:57:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:57:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:57 INFO - 'HOME': '/Users/cltbld', 09:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:57 INFO - 'LOGNAME': 'cltbld', 09:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:57 INFO - 'MOZ_NO_REMOTE': '1', 09:57:57 INFO - 'NO_EM_RESTART': '1', 09:57:57 INFO - 'PAGER': '/bin/cat', 09:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:57 INFO - 'PWD': '/builds/slave/test', 09:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:57 INFO - 'SHELL': '/bin/bash', 09:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:57:57 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:57 INFO - 'USER': 'cltbld', 09:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:57 INFO - 'XPC_FLAGS': '0x0', 09:57:57 INFO - 'XPC_SERVICE_NAME': '0', 09:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:57 INFO - Cleaning up... 09:57:57 INFO - Return code: 0 09:57:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:57 INFO - 'HOME': '/Users/cltbld', 09:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:57 INFO - 'LOGNAME': 'cltbld', 09:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:57 INFO - 'MOZ_NO_REMOTE': '1', 09:57:57 INFO - 'NO_EM_RESTART': '1', 09:57:57 INFO - 'PAGER': '/bin/cat', 09:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:57 INFO - 'PWD': '/builds/slave/test', 09:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:57 INFO - 'SHELL': '/bin/bash', 09:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:57:57 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:57 INFO - 'USER': 'cltbld', 09:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:57 INFO - 'XPC_FLAGS': '0x0', 09:57:57 INFO - 'XPC_SERVICE_NAME': '0', 09:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:58 INFO - Downloading/unpacking psutil>=3.1.1 09:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:01 INFO - Installing collected packages: psutil 09:58:01 INFO - Running setup.py install for psutil 09:58:01 INFO - building 'psutil._psutil_osx' extension 09:58:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:58:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:58:02 INFO - building 'psutil._psutil_posix' extension 09:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:58:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:58:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:58:02 INFO - ^ 09:58:02 INFO - 1 warning generated. 09:58:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:58:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:02 INFO - Successfully installed psutil 09:58:02 INFO - Cleaning up... 09:58:02 INFO - Return code: 0 09:58:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:02 INFO - 'HOME': '/Users/cltbld', 09:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:02 INFO - 'LOGNAME': 'cltbld', 09:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:02 INFO - 'MOZ_NO_REMOTE': '1', 09:58:02 INFO - 'NO_EM_RESTART': '1', 09:58:02 INFO - 'PAGER': '/bin/cat', 09:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:02 INFO - 'PWD': '/builds/slave/test', 09:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:02 INFO - 'SHELL': '/bin/bash', 09:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:02 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:02 INFO - 'USER': 'cltbld', 09:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:02 INFO - 'XPC_FLAGS': '0x0', 09:58:02 INFO - 'XPC_SERVICE_NAME': '0', 09:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:05 INFO - Installing collected packages: mozsystemmonitor 09:58:05 INFO - Running setup.py install for mozsystemmonitor 09:58:05 INFO - Successfully installed mozsystemmonitor 09:58:05 INFO - Cleaning up... 09:58:05 INFO - Return code: 0 09:58:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:05 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 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:05 INFO - 'HOME': '/Users/cltbld', 09:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:05 INFO - 'LOGNAME': 'cltbld', 09:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:05 INFO - 'MOZ_NO_REMOTE': '1', 09:58:05 INFO - 'NO_EM_RESTART': '1', 09:58:05 INFO - 'PAGER': '/bin/cat', 09:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:05 INFO - 'PWD': '/builds/slave/test', 09:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:05 INFO - 'SHELL': '/bin/bash', 09:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:05 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:05 INFO - 'USER': 'cltbld', 09:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:05 INFO - 'XPC_FLAGS': '0x0', 09:58:05 INFO - 'XPC_SERVICE_NAME': '0', 09:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:09 INFO - warning: no files found matching '*.txt' 09:58:09 INFO - no previously-included directories found matching 'build' 09:58:09 INFO - no previously-included directories found matching 'dist' 09:58:09 INFO - no previously-included directories found matching '.git*' 09:58:09 INFO - Installing collected packages: jsonschema, functools32 09:58:09 INFO - Running setup.py install for functools32 09:58:09 INFO - warning: no files found matching '*.txt' 09:58:09 INFO - no previously-included directories found matching 'build' 09:58:09 INFO - no previously-included directories found matching 'dist' 09:58:09 INFO - no previously-included directories found matching '.git*' 09:58:09 INFO - Successfully installed jsonschema functools32 09:58:09 INFO - Cleaning up... 09:58:09 INFO - Return code: 0 09:58:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:09 INFO - 'HOME': '/Users/cltbld', 09:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:09 INFO - 'LOGNAME': 'cltbld', 09:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:09 INFO - 'MOZ_NO_REMOTE': '1', 09:58:09 INFO - 'NO_EM_RESTART': '1', 09:58:09 INFO - 'PAGER': '/bin/cat', 09:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:09 INFO - 'PWD': '/builds/slave/test', 09:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:09 INFO - 'SHELL': '/bin/bash', 09:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:09 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:09 INFO - 'USER': 'cltbld', 09:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:09 INFO - 'XPC_FLAGS': '0x0', 09:58:09 INFO - 'XPC_SERVICE_NAME': '0', 09:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:09 INFO - Cleaning up... 09:58:09 INFO - Return code: 0 09:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:09 INFO - 'HOME': '/Users/cltbld', 09:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:09 INFO - 'LOGNAME': 'cltbld', 09:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:09 INFO - 'MOZ_NO_REMOTE': '1', 09:58:09 INFO - 'NO_EM_RESTART': '1', 09:58:09 INFO - 'PAGER': '/bin/cat', 09:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:09 INFO - 'PWD': '/builds/slave/test', 09:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:09 INFO - 'SHELL': '/bin/bash', 09:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:09 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:09 INFO - 'USER': 'cltbld', 09:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:09 INFO - 'XPC_FLAGS': '0x0', 09:58:09 INFO - 'XPC_SERVICE_NAME': '0', 09:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:13 INFO - Downloading docopt-0.6.1.tar.gz 09:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:13 INFO - Running setup.py install for blobuploader 09:58:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:14 INFO - Running setup.py install for requests 09:58:14 INFO - Running setup.py install for docopt 09:58:14 INFO - Successfully installed blobuploader requests docopt 09:58:14 INFO - Cleaning up... 09:58:14 INFO - Return code: 0 09:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:14 INFO - 'HOME': '/Users/cltbld', 09:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:14 INFO - 'LOGNAME': 'cltbld', 09:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:14 INFO - 'MOZ_NO_REMOTE': '1', 09:58:14 INFO - 'NO_EM_RESTART': '1', 09:58:14 INFO - 'PAGER': '/bin/cat', 09:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:14 INFO - 'PWD': '/builds/slave/test', 09:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:14 INFO - 'SHELL': '/bin/bash', 09:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:14 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:14 INFO - 'USER': 'cltbld', 09:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:14 INFO - 'XPC_FLAGS': '0x0', 09:58:14 INFO - 'XPC_SERVICE_NAME': '0', 09:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SUv610-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-_KkULd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9IN1oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zyOIyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-clkMTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-dZ45FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-3R9B1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-btPnRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-B0nRRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-BeYcNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-oVhmKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JLwDYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-X_YwJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vCSJN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-TKy3XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qq0kwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ciSMWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:16 INFO - Running setup.py install for manifestparser 09:58:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:17 INFO - Running setup.py install for mozcrash 09:58:17 INFO - Running setup.py install for mozdebug 09:58:17 INFO - Running setup.py install for mozdevice 09:58:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:17 INFO - Running setup.py install for mozfile 09:58:17 INFO - Running setup.py install for mozhttpd 09:58:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:17 INFO - Running setup.py install for mozinfo 09:58:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:17 INFO - Running setup.py install for mozInstall 09:58:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Running setup.py install for mozleak 09:58:18 INFO - Running setup.py install for mozlog 09:58:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Running setup.py install for moznetwork 09:58:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Running setup.py install for mozprocess 09:58:18 INFO - Running setup.py install for mozprofile 09:58:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:18 INFO - Running setup.py install for mozrunner 09:58:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:19 INFO - Running setup.py install for mozscreenshot 09:58:19 INFO - Running setup.py install for moztest 09:58:19 INFO - Running setup.py install for mozversion 09:58:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:19 INFO - Cleaning up... 09:58:19 INFO - Return code: 0 09:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:19 INFO - 'HOME': '/Users/cltbld', 09:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:19 INFO - 'LOGNAME': 'cltbld', 09:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:19 INFO - 'MOZ_NO_REMOTE': '1', 09:58:19 INFO - 'NO_EM_RESTART': '1', 09:58:19 INFO - 'PAGER': '/bin/cat', 09:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:19 INFO - 'PWD': '/builds/slave/test', 09:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:19 INFO - 'SHELL': '/bin/bash', 09:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:19 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:19 INFO - 'USER': 'cltbld', 09:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:19 INFO - 'XPC_FLAGS': '0x0', 09:58:19 INFO - 'XPC_SERVICE_NAME': '0', 09:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Z6rNLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rBKNZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-7CPPXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-narXgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Lx14ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Xx5p7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tYxcMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-iMeETd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-x4ZtEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-mdHorK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-W1DKVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-B3r07m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZOzr3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-7xU71p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-LuDsDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-chZLnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Q7N3KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:24 INFO - Downloading blessings-1.6.tar.gz 09:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:24 INFO - Installing collected packages: blessings 09:58:24 INFO - Running setup.py install for blessings 09:58:24 INFO - Successfully installed blessings 09:58:24 INFO - Cleaning up... 09:58:24 INFO - Return code: 0 09:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:24 INFO - Reading from file tmpfile_stdout 09:58:24 INFO - Current package versions: 09:58:24 INFO - blessings == 1.6 09:58:24 INFO - blobuploader == 1.2.4 09:58:24 INFO - docopt == 0.6.1 09:58:24 INFO - functools32 == 3.2.3-2 09:58:24 INFO - jsonschema == 2.5.1 09:58:24 INFO - manifestparser == 1.1 09:58:24 INFO - mozInstall == 1.12 09:58:24 INFO - mozcrash == 1.0 09:58:24 INFO - mozdebug == 0.1 09:58:24 INFO - mozdevice == 0.48 09:58:24 INFO - mozfile == 1.2 09:58:24 INFO - mozhttpd == 0.7 09:58:24 INFO - mozinfo == 0.9 09:58:24 INFO - mozleak == 0.1 09:58:24 INFO - mozlog == 3.4 09:58:24 INFO - moznetwork == 0.27 09:58:24 INFO - mozprocess == 0.23 09:58:24 INFO - mozprofile == 0.28 09:58:24 INFO - mozrunner == 6.13 09:58:24 INFO - mozscreenshot == 0.1 09:58:24 INFO - mozsystemmonitor == 0.3 09:58:24 INFO - moztest == 0.8 09:58:24 INFO - mozversion == 1.4 09:58:24 INFO - psutil == 3.1.1 09:58:24 INFO - requests == 1.2.3 09:58:24 INFO - wsgiref == 0.1.2 09:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:24 INFO - 'HOME': '/Users/cltbld', 09:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:24 INFO - 'LOGNAME': 'cltbld', 09:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:24 INFO - 'MOZ_NO_REMOTE': '1', 09:58:24 INFO - 'NO_EM_RESTART': '1', 09:58:24 INFO - 'PAGER': '/bin/cat', 09:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:24 INFO - 'PWD': '/builds/slave/test', 09:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:24 INFO - 'SHELL': '/bin/bash', 09:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:24 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:24 INFO - 'USER': 'cltbld', 09:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:24 INFO - 'XPC_FLAGS': '0x0', 09:58:24 INFO - 'XPC_SERVICE_NAME': '0', 09:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:25 INFO - Cleaning up... 09:58:25 INFO - Return code: 0 09:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:25 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 0x1029df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102955570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5bd738f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, '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.arLMfymaD1/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.Qghq1a6GwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:25 INFO - 'HOME': '/Users/cltbld', 09:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:25 INFO - 'LOGNAME': 'cltbld', 09:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:25 INFO - 'MOZ_NO_REMOTE': '1', 09:58:25 INFO - 'NO_EM_RESTART': '1', 09:58:25 INFO - 'PAGER': '/bin/cat', 09:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:25 INFO - 'PWD': '/builds/slave/test', 09:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:25 INFO - 'SHELL': '/bin/bash', 09:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:25 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:25 INFO - 'USER': 'cltbld', 09:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:25 INFO - 'XPC_FLAGS': '0x0', 09:58:25 INFO - 'XPC_SERVICE_NAME': '0', 09:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:25 INFO - Cleaning up... 09:58:25 INFO - Return code: 0 09:58:25 INFO - Running post-action listener: _resource_record_post_action 09:58:25 INFO - Running post-action listener: _start_resource_monitoring 09:58:25 INFO - Starting resource monitoring. 09:58:25 INFO - [mozharness: 2017-01-30 17:58:25.534125Z] Finished create-virtualenv step (success) 09:58:25 INFO - [mozharness: 2017-01-30 17:58:25.535157Z] Running install step. 09:58:25 INFO - Running pre-action listener: _resource_record_pre_action 09:58:25 INFO - Running main action method: install 09:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:25 INFO - Reading from file tmpfile_stdout 09:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:25 INFO - Reading from file tmpfile_stdout 09:58:25 INFO - Output received: 09:58:25 INFO - Usage: mozinstall [options] installer 09:58:25 INFO - Options: 09:58:25 INFO - -h, --help show this help message and exit 09:58:25 INFO - -d DEST, --destination=DEST 09:58:25 INFO - Directory to install application into. [default: 09:58:25 INFO - "/builds/slave/test"] 09:58:25 INFO - --app=APP Application being installed. [default: firefox] 09:58:25 INFO - mkdir: /builds/slave/test/build/application 09:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:58:47 INFO - Reading from file tmpfile_stdout 09:58:47 INFO - Output received: 09:58:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:58:47 INFO - Running post-action listener: _resource_record_post_action 09:58:47 INFO - [mozharness: 2017-01-30 17:58:47.845270Z] Finished install step (success) 09:58:47 INFO - [mozharness: 2017-01-30 17:58:47.845459Z] Running run-tests step. 09:58:47 INFO - Running pre-action listener: _resource_record_pre_action 09:58:47 INFO - Running main action method: run_tests 09:58:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:47 INFO - 2017-01-30 09:58:47.860 screenresolution[1637:7329] starting screenresolution argv=screenresolution get 09:58:47 INFO - 2017-01-30 09:58:47.863 screenresolution[1637:7329] Display 0: 1600x1200x32@60 09:58:47 INFO - 2017-01-30 09:58:47.868 screenresolution[1638:7331] starting screenresolution argv=screenresolution list 09:58:47 INFO - Available Modes on Display 0 09:58:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:48 INFO - Intel Iris: 09:58:48 INFO - Chipset Model: Intel Iris 09:58:48 INFO - Type: GPU 09:58:48 INFO - Bus: Built-In 09:58:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:48 INFO - Vendor: Intel (0x8086) 09:58:48 INFO - Device ID: 0x0a2e 09:58:48 INFO - Revision ID: 0x0009 09:58:48 INFO - Displays: 09:58:48 INFO - Display: 09:58:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:48 INFO - Display Serial Number: 1600x1200 60 09:58:48 INFO - Main Display: Yes 09:58:48 INFO - Mirror: Off 09:58:48 INFO - Online: Yes 09:58:48 INFO - Rotation: Supported 09:58:48 INFO - Return code: 0 09:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:48 INFO - Python 2.7.3 09:58:48 INFO - Return code: 0 09:58:48 INFO - grabbing minidump binary from tooltool 09:58: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')]} 09:58:48 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 0x1027f3d30>, '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 0x102659db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:58:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:58:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:58:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:48 INFO - Return code: 0 09:58:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.arLMfymaD1/Render', 09:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:48 INFO - 'HOME': '/Users/cltbld', 09:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:48 INFO - 'LOGNAME': 'cltbld', 09:58:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:48 INFO - 'MOZ_NO_REMOTE': '1', 09:58:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:48 INFO - 'NO_EM_RESTART': '1', 09:58:48 INFO - 'PAGER': '/bin/cat', 09:58:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:48 INFO - 'PWD': '/builds/slave/test', 09:58:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:48 INFO - 'SHELL': '/bin/bash', 09:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qghq1a6GwY/Listeners', 09:58:48 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 09:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:48 INFO - 'USER': 'cltbld', 09:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:48 INFO - 'XPC_FLAGS': '0x0', 09:58:48 INFO - 'XPC_SERVICE_NAME': '0', 09:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:58:48 INFO - mozversion application_buildid: 20170130064642 09:58:48 INFO - mozversion application_changeset: 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 09:58:48 INFO - mozversion application_display_name: Firefox 09:58:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:48 INFO - mozversion application_name: Firefox 09:58:48 INFO - mozversion application_remotingname: firefox 09:58:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:48 INFO - mozversion application_vendor: Mozilla 09:58:48 INFO - mozversion application_version: 52.0 09:58:48 INFO - mozversion platform_buildid: 20170130064642 09:58:48 INFO - mozversion platform_changeset: 4ddd53a5d53033cf03d3ab027f0b58e5fda96216 09:58:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:48 INFO - mozversion platform_version: 52.0 09:58:48 INFO - using testdate: 1485799128 09:58:48 INFO - actual date: 1485799128 09:58:48 INFO - starting webserver on 'localhost:49241' 09:58:48 INFO - SUITE-START | Running 2 tests 09:58:48 INFO - TEST-START | dromaeo_css 09:58:48 INFO - operating with platform_type : mac_ 09:58:48 INFO - Initialising browser for dromaeo_css test... 09:58:48 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp0q05Yo/profile http://localhost:49241/getInfo.html) 09:58:51 INFO - PROCESS | 1648 | 2017-01-30 09:58:51.554 plugin-container[1651:7507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d3b, name = 'com.apple.tsm.portname' 09:58:51 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:58:51 INFO - PROCESS | 1648 | 2017-01-30 09:58:51.554 plugin-container[1651:7507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c0b, name = 'com.apple.CFPasteboardClient' 09:58:51 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:58:51 INFO - PROCESS | 1648 | 2017-01-30 09:58:51.554 plugin-container[1651:7507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:58:51 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:58:51 INFO - PROCESS | 1648 | colorDepth:24 09:58:51 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:58:51 INFO - PROCESS | 1648 | __metrics 09:58:51 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:58:52 INFO - TEST-INFO | 1648: exit 0 09:58:52 INFO - Browser initialized. 09:58:52 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:52 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp0q05Yo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:54 INFO - PROCESS | 1652 | 2017-01-30 09:58:54.823 plugin-container[1654:7632] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 09:58:54 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:58:54 INFO - PROCESS | 1652 | 2017-01-30 09:58:54.824 plugin-container[1654:7632] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 09:58:54 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:58:54 INFO - PROCESS | 1652 | 2017-01-30 09:58:54.824 plugin-container[1654:7632] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:59:04 INFO - PROCESS | 1652 | RSS: Main: 177205248 09:59:04 INFO - PROCESS | 1652 | 10:02:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:02:08 INFO - PROCESS | 1652 | RSS: Main: 183169024 10:02:08 INFO - PROCESS | 1652 | 10:05:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:05:10 INFO - PROCESS | 1652 | RSS: Main: 192004096 10:05:10 INFO - PROCESS | 1652 | 10:08:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:08:13 INFO - PROCESS | 1652 | RSS: Main: 198238208 10:08:13 INFO - PROCESS | 1652 | 10:11:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:11:15 INFO - PROCESS | 1652 | RSS: Main: 201342976 10:11:15 INFO - PROCESS | 1652 | 10:14:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:14:18 INFO - PROCESS | 1652 | RSS: Main: 202563584 10:14:18 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:17:21 INFO - PROCESS | 1652 | RSS: Main: 204546048 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | __start_tp_report 10:17:21 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:17:21 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:17:21 INFO - PROCESS | 1652 | |i|pagename|runs| 10:17:21 INFO - PROCESS | 1652 | |0;dojo.html;3155.952660710089;3598.568171819382;3606.080449485381;3612.584552776431;3642.581103173134;5860.413958604143;5918.348981612019;5949.560680121152;5956.791512297071;5962.522998160148;5872.559558033154;5936.821895343136;5971.850703732409;5976.163337132794;5980.1328807323025;5291.074062039157;5362.570994320465;5372.597055220874;5408.972955135238;5442.374126975389;4548.795304211319;5142.768575414116;5318.813841515548;5413.377461591928;5438;5278.47215278473;5343.011542864582;5382.946170538284;5399.946000540003;5416.377116631598;5342.2253773202865;5344.652597581165;5397.27136836526;5428.131498960187;5459.181122831567;5264.0261551613075;5361.919571206435;5363.892722145574;5387.542058924996;5406.91889621656;5717.542596592262;5872.383399743051;5873.735681894283;6017.789377371771;6024.036154215349;6160.014397696347;6199.504039676815;6225.408586184305;6226.128342032119;6249.437550620421;6207.4723648489935;6309.842253943642;6325.588836725598;6336.366363363627;6336.904946425761;5919.644821310692;5961.493273071794;5964.194833697482;5970.611910225822;6001.159837622737;6201.317855035943;6222;6281.246250449975;6295.055741638791;6303.747850086037;6263.31103578606;6296.275928268216;6296.527760417987;6297.149884765589;6305.4009869062365;5136.255242989746;6102.816915492543;6305.936940630535;6309.287006587211;6320.273168585672;6221.595596286227;6231.844203894848;6253.6560489172625;6268.780592679234;6275.1842260506755;5194.844154675366;6227.6263424193785;6273.654948977759;6307.148534947815;6324;4214.726042807269;4291.6137547620865;5089.898202035939;5091.287219789232;5095.439501654815;4454.109178164315;4485.102979404132;4500.729956202638;4518.502964673883;4520.683552151318;5998.310194327621;6144.003198960356;6178.6601736904;6194.163787888578;6197.318294987548;6280.120783090371;6321.620702757849;6325.936740632626;6327.58870673414;6337.366263373718;5911.261092363455;6058.363871793398;6078.3617720138745;6084.452399284086;6116.67056464255;5539.639923404966;5598.964191624563;5608.719564021782;5627.634203776742;5655.0386434306265;6459.104795984985;6478.190226221723;6481.5138864584405;6486.772962946275;6527.11883895668;6133.487685122479;6313.305536390902;6328.46208072319;6334.796388686135;6344.175257216532;6332.968335158294;6370.872582548416;6384.808455746149;6410.294867564658;6509.804705858832;6322.968385158045;6327.3356297589935;6337.397947195009;6354.301026886947;6363.236411630634;6229.53278504123;6300.338464461165;6329.208848893888;6331.778387756406;6346.174997250328;6156.384361563808;6201.782937597162;6204.658743769136;6237.563370564017;6247.625142491465;6122.672617327995;6258.718357674006;6307.873842523216;6321.810345689637;6337.96831015842;6110.175126358063;6203.348648391854;6214.254289485109;6219.160413344141;6235.501159907106;6112.572119951561;6155.47678447337;6184.103305020837;6219.284782250099;6269;6125.388069147376;6197.597156185014;6202.968985155046;6210.130581718473;6239.0953311768635 10:17:21 INFO - PROCESS | 1652 | |1;ext.html;484.87635652908506;492.91127597032533;519.9766010529528;522.5479959834744;538.9705662185224;37332;38839.41740873885;39815.402768958455;43052.138957220835;43084.78457607715;42810.14379712404;43216.78391608038;43351.56648433515;43393;43517.7824110879;9686.225101991842;9732.562034708455;9842.065003824626;9887.159591434736;9906.603735850558;8407.663693452285;9798.510074496282;9816.558254878548;9854.310198286123;9886.060824221724;9098.272138228958;9141.817163656757;9814.46020468874;9845.55694993727;9864.654737084204;8358;9831.655892043816;9836.016398360178;9875.2099832014;9884.901150988542;9750.219982401391;9811.460369679664;9826.361286516354;9838;9862.50687465631;40773.59226407728;40920;41335.379969300484;41349.79325103355;41568.37647435291;3576.356255873942;3583.677469027774;3633.454981752732;4007.6393124618635;4199.181159673864;30111;30785.692143078508;31109;31259.687403126132;31660.208494787585;3227.4351988402173;3270.427675156862;3302.091924720721;3326.2682209914024;3411.675890790396;497208;502838;504124;504198;504767;58575;58928.41071589229;58945.41054589485;59023;59117;59896;60837;60839;60960;60973.08540371898;16163.757543636855;16215.675686486204;16427.425040123537;16475;16511;12912.483500660057;12931.935340323238;13062.673433164247;13068.215907045607;13070.738585228242;15040.62398440026;15295.847041529665;15304.617384565476;15315.387384504718;15455.845441545665;6506.60960342381;6554.80335589933;6628.966855165693;6632.008429842029;6706.865862682719;899.8740176375313;978.3102912446708;997.5860018092555;1035.9689209323733;1095.2169199022737;25851.87074064655;26550;30844;31306;32112;869.7738587967174;999.3654029691053;1036.429963520061;1054.9947250263854;1077.1221454514546;12399.442025108892;14066.2966851657;15053.774193387108;15304.387824486896;15543.378264869505;474782;557916;562233;562571;564126;55161.44838551563;55992.72003639956;56219.43780562142;56267;56279;1398.3707331700775;1401.1663060479;1432.10493441599;1435.3612642374253;1438.6475313548249;28794.712052879204;29452.558211626416;29624.407511850073;29670.813167473058;30133.547996779627;48728;50001.249981251036;50230.497695024045;50313;50368.74815625898;473478;479208;483211;484859;486421;25484.043163529866;25719.742802571735;25807.741922580535;26037.21888343353;26052.478950421264;43336;44319.556804431544;44803;44935.77532112318;45370.54629453663;35463.645363546035;36156.81921590375;38101.42847857229;38848;39102.217955641296;37402.43896341503;37669.434958475096;38434.42348364833;38440.80779596084;38594.80702596469;36223.551057958444;36634;37149.44275835919;37166.44250336301;37556.248875022895;31912;33321;33735.66264337325;33796.662033379354;33872.983810485726;25283.620745688462;25394.492110158062;25440.618390723783;25626.87186564055;25864.482710346063 10:17:21 INFO - PROCESS | 1652 | |2;jquery.html;319.2449856090346;366.58941984976826;391.1433959628415;393.38238964825234;403.3626869546117;10036;12130.090243231749;12248;12265.816012759815;19489.902550487244;21678.89160554199;21716.80557569337;22459.87700614967;22702.318930432113;23039.654405183937;6418.839529011789;6633.734650613982;6875.381215690587;6878.965605171968;6962.164540255177;6736.225334086569;6900.137482814648;6934.47991400647;6965.33829286217;6974.302569743036;6655.900161497581;6881.621510816903;6903.516753827234;6914.446844252448;6969.512134150612;6505.93494065058;6623.23832759234;6693.832654183636;6749.12261406019;6905.827354316132;6660.500462465335;6718.966405167943;6724.092247546568;6724.731010759613;6736.865262694719;28532.429351413062;28562.85718571394;28751.712482875322;29191.85404072987;29239.85380073086;2413.879306034709;2474.406142525781;2479.938001549958;2571.2928944540213;3259.6088469383826;17212.655746884993;17409.216585253693;17536.91231543847;17724;17912.731309030376;2083.447886310129;2112.355731501891;2178.041661668861;2208.933731988027;2235.7205349331334;119035.4048229762;132326.63028581472;135821;138694;139782;17694.646107077788;18270.725939110926;22521.43696407603;22628.660570091462;22663.320100397013;35218.82390588031;35260.47109293363;35824.82087589546;35875.64124358723;36072;10920.726981825359;11045.613403530839;11086;11212.719682008015;11355;9039.91521017469;9045.592948317342;9079.137481939206;9188.8621670675;9226.40028398152;9722.076402741728;9838.395483819637;10075.395476271447;10269.229807764297;10270.948645256725;3649.142451523943;3703.629637036329;4013.678905687538;4042.91914161721;4055.7566546007333;841.6212704283097;895.901450840407;940.6754669638964;949.1457688080644;1007.8337074382645;20421.285255016002;21266.2556810514;21407.892960535097;21413.036413361435;21417.357479275648;979.456401697065;979.7942432089341;1000.0899181744722;1004.5881188712739;1006.6225165562914;8707.390482666153;10704.678859634223;11144.794575189437;11180.944095279472;11267.323960562393;604243;606935;607282.963585188;616075;617105;130226;135083;136075;138729;141012;996.4370130876032;1029.6705054382526;1045.4406892312577;1049.0663309654567;1051.1853313681959;18488.815111849246;19251.4224573263;19708.802911970695;19711.507212319808;19763.80236197677;51554.968900621025;53862.922741544164;53990.19014714861;54102.72948635231;56267;66702;78380.04049898798;79162.20837791548;82508;85237.57381213055;7131.431085161256;7784.377249820114;8107;8277.710280140407;8465.111163327761;11680.182387232811;12700;12727.363631818558;12790.488380464678;12845.036622253556;11087;11121.721956951142;11255.099592032453;11311.943440282746;11369.54521819118;8955.820883582423;10230.311998520161;10658.573657053632;11018.063464605279;11046;11077.833832492357;11345.943270283597;11406.885931140583;11525.88474115248;11685.474153662935;7997.960010199912;8030.980637101811;8186.836263274582;8360.916390836257;8362.790930226549;8245.093039765741;9899.406035637885;11173.72065698364;11378.772424551296;11566.768664626828 10:17:21 INFO - PROCESS | 1652 | |3;mootools.html;1352.8444228913675;1550.1241798383912;1726.2231995601983;1842.39201063649;1897.9051047447624;7771.805704857381;8010.679572817095;8214.75355739328;8671.826563468734;8682.175193356628;8150.9592452037805;8462.323014158868;8470.068292487822;8574.614142363593;8590;2378.9643155352683;2394.724606670238;2397.328747950568;2406.133791834938;2407.145463360508;2369.34842918198;2436.135172013936;2466.580681284177;2471.789897858684;2481.888315025828;2395.8203134764876;2408.2654790288957;2422.8667423291713;2423.1761201191593;2437.1591800828687;2391.1033362489065;2394.7485514021128;2404.2426635609727;2416.734159242482;2422.0675040109595;2054.3939537836227;2420.697412823397;2434.5739495588377;2437.768412000857;2442.3283597010786;8437.704680336159;8514.531700756455;8551.401401901869;8570.442921210102;8645.394822362437;4560.931586026212;5208;5347.304850369427;5349;5362.008028514698;3589.0668426209113;3623.166671665532;3627.8730244441317;3678.834452449646;3682.613325600827;1001.689476262361;1080.7460246841986;1107.5846557540922;1135.0635725526474;1145.2441388683428;10217.131543818785;10236;10304.433256170907;11002.559897604086;11236.269642473213;4581.496035436099;4684.110019096429;4757.09615173116;4839.41926968766;4869.610431165498;9709.563069661883;9778.119969202664;9785.951070244602;9801.068898454636;9801.607935682492;5372.623916325898;5384.380796208487;5398.64908780928;5398.8920221595345;5404.540614047772;4433.645308375387;4501.212287849613;4867.902641947141;4939.036887806843;4980.900381992412;3906.941395879064;3957.6635985940943;4008.158286759813;4079.3676980068135;4090.6318431341324;1285.254552359629;1291.2381694799926;1298.7532368850077;1301.0502333296747;1311.5999620115765;917.3028498341308;918.9248579162396;919.9264058875274;926.9860952085725;937.6249500199838;5710.7430165642645;5867.090600956859;5966.373530779292;5980.461758441761;6272.937270627326;867.2368315881984;945.1871390604075;955.9563048305706;967.4775621164633;972.8297547929226;3791.1280405506886;3943.3887747398626;3993.600639935983;4026.4564283821896;4050.5544390117066;10146.847797283046;10322.22583306255;10462.424566648755;10509.054185123376;10510.211734119972;10152.23858210637;10164.644237451654;10339.844902326471;10413.791724165474;10435.217358698128;8031.7992050198045;8040.195980401913;8092.028956525254;8158.061822890325;8179.509229446252;5607.523360514402;5711.971440142939;5746.224259725051;5772;5883.35283118848;9350.859737103812;9353.625854965725;9463.148316651534;9483.28875334339;9623.518824058629;9292.767680807763;9542.188913942393;9698.806023879624;9778.119969202806;9897.950510247403;6801.829954251183;7036.859262814817;7156.499045067004;7351.926480735124;7492.175860655432;7997.8400431992195;8137.918620813953;8215.507069575844;8233.79415514617;8252.917470825216;7203.459740519377;7324.377427918686;7372.557646541225;7436.144843343085;7451.552906825391;6086.239220097488;6999.580025198505;7000.684969176297;7012.509124361246;7030.543014704028;6792;6914.412274956685;6930.549514281555;6932.064171336805;6936.306369363023;4631.490536040966;4893.510648935078;4905.23968784839;4914.459409465027;4941.802327906844;4608.88477788058;4852.369192005017;4936.654434189572;5014.52362025607;5029.698218106925 10:17:21 INFO - PROCESS | 1652 | |4;prototype.html;232.68006491074772;291.94598999185155;302.5643073973478;311.6384993407648;313.0514540940948;4860.198067318888;5130;5649.983003059448;5659.981203383394;5716.656585702362;4941.813964648485;5208.843734687956;5373.892522149565;5551.056320425528;5658.7170641467865;3562.340966921115;4236.809343579546;4242.490901091858;4246.7027308088445;4296.205202037618;3073.431415188197;4163.7293575917465;4294.26997410441;4303.139372125587;4328.06946506501;3789.2610940866543;3875.7286989910717;4162.938450695084;4194.727342722728;4198.391233271173;4170.103427763031;4189.937150942738;4204.264253755596;4210.410542524049;4245.80893859777;3631.981840090809;3638.435472746718;3643.8724644637578;3654.798986055766;3657.487951686766;4223.66210703143;4722.913729842156;5300.0459917214885;5341.412444631087;5458;4671.85984420468;4751.524847515256;4786.736729479877;4796.136695394827;4801.615870730368;5074.771635276422;5215.895682086375;5624.803131890405;5845.269341332333;5898.7640494380175;3163.6678148794276;3285.8849940252217;3867;3950.703697222691;3960.1881614269005;5793.797217097382;6151.354107818659;6199.791040747056;6226.844328891769;6246.500279977637;3562.931120663842;3871.806409679561;3978.1844721831953;3998.4801975742967;4010.1779135277197;3377.6995856594895;3676.4117741161285;3979.900502487461;4023.637872591481;4083.7753923533896;4035.0228388089627;4269.658427325807;4603.872051347441;4606.424196975378;4783.330333753277;5727.5990680652785;5906.911396329058;5970.611910225822;5974.522038236931;6002.489788368038;1187.281694574787;1202.4649031181216;1254.4166962362544;1303.843538775353;1317.4598414649947;717.8779607466744;782.9608519573999;873.6025108575583;875.8657538487673;893.4275674812247;4442.955570444319;4465.687401881837;5253.842384728464;5457.181422786613;5484.561235101182;5138.691678499302;5751.85620359486;5844.912326315109;5888.793892213752;5967.492763115184;4918.631102667243;5014.6431177346585;5144.897102058013;5419.783208671609;5444.156155795858;2699.379142797168;2730.877110529991;2920.518114511124;2978.4043191361816;3020.0939718084487;5516.972415137899;5665.750686984761;6043.220118745338;6051.972589182673;6150.769846030812;4484.910301793946;4605.585497305258;5222.9216561750845;5902.4097590240635;6007.335525329546;5505.614606977553;5559.191299525881;5715.8571035724435;5934.851628709317;6039.818805435844;4726.409198850144;5130.768615532171;5370.415727360516;5743.511801496752;5784.149072296825;5024.341967150905;5025;5606.308971693528;5768.596198266081;5842.130518234124;4724.976375118103;5464.781408743605;5877.059670452707;5923.259592550931;5987.161797348462;3337.6829201226815;3561.893143205708;3791.5071040764524;3799.8290076947155;3806.980965095157;4704.92942605868;5297.231901374356;5697.971510142423;5741.741621626953;5743.712814359349;4774.7851346688785;5740.306609550109;5764.942350576441;5886.352501224947;5970.462658360769;4934.8766280843265;5021.07110184617;5160.587153027824;5870.88648086697;5893.970530147493;5058.494150584912;5442.510174084351;5704.11586204139;5746.281714785652;5831.300243970751;5013.1675603285485;5684.459976302244;6074.453299203093;6112.908306375497;6152.200213972155;4837.661363704648;5840.620359676607;5857.47282744555;5869.413058694096;5949.185498423022 10:17:21 INFO - PROCESS | 1652 | |5;yui.html;661.1075048684273;719.6293908637051;739.1278291615895;788.562347896917;832.2634468495384;14127.576172714822;14366.640833979156;14665.706685866277;14675.706485870276;14740.410383584656;12061.21602095863;13878.583642490741;13927.37326820293;13957.651058723537;14046.01677882546;836.4939211776879;847.4618617178105;851.9914800852005;873.9825203495926;875.6453636277317;867.5532100968006;873.026575368466;875.3347455933505;875.6234819027816;877.6708734224666;931.3852857114306;934.028610245344;935.9672411465566;936.6019441737268;937.2970272295778;919.7194855569048;920.204023519654;929.4330458420358;930.02812061396;933.5332333833084;668.1481111582723;670.8289386206535;678.5318130489995;681.0839420978775;691.920429150644;14405.351759170862;14431.567052988426;14446.205458699767;14453;14460.85539144616;11740.823887641693;14212.147271163763;14417.423303067864;14429.927850360786;14522.927385363006;11603.767924641545;11904.345261010641;11925.761484770343;11927.582534611247;12032.27806331623;3734.589195188527;3783.633123961032;3847.057470919615;3888.4556162137324;3903.7852918089493;86691.56654216752;90611;93177.60233596433;94915.10169796566;95571.52214238954;10320.587176512856;10839;10981.890181098086;11069.612563560398;11128.109751219883;17554.473365798793;21392.78607213939;21583.56832863334;21662.458438538848;21688.783112168992;7986.520808751494;8111.472754270953;8141.1451797561585;8246;8250.876236856451;4428.269335559661;4526.456825180933;4586.289125185534;4638.397008388955;4688.413948256468;3044.6194225721783;3515.3320869035315;3625.836837342326;3653.342398368319;3653.8721144759807;630.1555915073823;631.6273398694792;634.6287421858265;652.3704625036862;659.1924892007253;552.7899398228648;581.2385774635242;588.6674029173589;679.0934102972489;683.0744341417408;10219.254534582478;10268.589256429808;10384.273100883016;10758.515866786014;10985;606.2755007765678;619.9566030377921;689.4449967775988;690.6615758278508;693.5214701855704;4318.892027699333;4335.891602709958;4731.929021064687;4869.975650121727;5190.766415511311;113911;114587;115602.42198788952;116069;118272.40863795798;72036;75713.24286757062;85571.57214213889;88255.55872220598;101419;88392.23215535653;89534.55232723795;92632.07367926235;92663;94096;9770.560324785543;10263.897361026295;10333.741656458347;10344.534495947852;10374.792504150026;36016.819915900254;43501.56498435102;52232;53551.46448535465;55906.44093559012;72227;73944.63027684827;74960;75963.62018189873;80830.59584702039;12984.976101727858;13037.348132593143;13369.384110387105;13489.325533723471;13504.594862154152;13998.300084995506;14279.357428915517;14529.709405811613;14530.709385812435;14734.26328683583;12878.356082195665;13297.069205155547;13968.231747253998;13974.231417272147;14065.578032659037;14036.017478776388;14149.36327865269;14166.645833854236;14783.852161478679;14787.482438114614;13470.93264533671;13542.119762215425;13649.931750341184;13817.516386926409;14214.076085054437;10995.945020274847;11204.775904482029;11786.116041296766;11907.940460297643;12065.939670301943;11400.714982125513;11629.127815413709;11716.70708232301;11764.35296058725;11766.941165294118 10:17:21 INFO - PROCESS | 1652 | __end_tp_report 10:17:21 INFO - PROCESS | 1652 | __start_cc_report 10:17:21 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,356 10:17:21 INFO - PROCESS | 1652 | __end_cc_report 10:17:21 INFO - PROCESS | 1652 | __startTimestamp1485800241568__endTimestamp 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:17:21 INFO - PROCESS | 1652 | Number of tests: 6 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5866.73 Median:6160.01 stddev:652.78 (10.6%) stddev-sans-first:619.18 10:17:21 INFO - PROCESS | 1652 | Values: 3156.0 3598.6 3606.1 3612.6 3642.6 5860.4 5918.3 5949.6 5956.8 5962.5 5872.6 5936.8 5971.9 5976.2 5980.1 5291.1 5362.6 5372.6 5409.0 5442.4 4548.8 5142.8 5318.8 5413.4 5438.0 5278.5 5343.0 5382.9 5399.9 5416.4 5342.2 5344.7 5397.3 5428.1 5459.2 5264.0 5361.9 5363.9 5387.5 5406.9 5717.5 5872.4 5873.7 6017.8 6024.0 6160.0 6199.5 6225.4 6226.1 6249.4 6207.5 6309.8 6325.6 6336.4 6336.9 5919.6 5961.5 5964.2 5970.6 6001.2 6201.3 6222.0 6281.2 6295.1 6303.7 6263.3 6296.3 6296.5 6297.1 6305.4 5136.3 6102.8 6305.9 6309.3 6320.3 6221.6 6231.8 6253.7 6268.8 6275.2 5194.8 6227.6 6273.7 6307.1 6324.0 4214.7 4291.6 5089.9 5091.3 5095.4 4454.1 4485.1 4500.7 4518.5 4520.7 5998.3 6144.0 6178.7 6194.2 6197.3 6280.1 6321.6 6325.9 6327.6 6337.4 5911.3 6058.4 6078.4 6084.5 6116.7 5539.6 5599.0 5608.7 5627.6 5655.0 6459.1 6478.2 6481.5 6486.8 6527.1 6133.5 6313.3 6328.5 6334.8 6344.2 6333.0 6370.9 6384.8 6410.3 6509.8 6323.0 6327.3 6337.4 6354.3 6363.2 6229.5 6300.3 6329.2 6331.8 6346.2 6156.4 6201.8 6204.7 6237.6 6247.6 6122.7 6258.7 6307.9 6321.8 6338.0 6110.2 6203.3 6214.3 6219.2 6235.5 6112.6 6155.5 6184.1 6219.3 6269.0 6125.4 6197.6 6203.0 6210.1 6239.1 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:64875.73 Median:41459.08 stddev:135900.13 (327.8%) stddev-sans-first:136195.37 10:17:21 INFO - PROCESS | 1652 | Values: 484.9 492.9 520.0 522.5 539.0 37332.0 38839.4 39815.4 43052.1 43084.8 42810.1 43216.8 43351.6 43393.0 43517.8 9686.2 9732.6 9842.1 9887.2 9906.6 8407.7 9798.5 9816.6 9854.3 9886.1 9098.3 9141.8 9814.5 9845.6 9864.7 8358.0 9831.7 9836.0 9875.2 9884.9 9750.2 9811.5 9826.4 9838.0 9862.5 40773.6 40920.0 41335.4 41349.8 41568.4 3576.4 3583.7 3633.5 4007.6 4199.2 30111.0 30785.7 31109.0 31259.7 31660.2 3227.4 3270.4 3302.1 3326.3 3411.7 497208.0 502838.0 504124.0 504198.0 504767.0 58575.0 58928.4 58945.4 59023.0 59117.0 59896.0 60837.0 60839.0 60960.0 60973.1 16163.8 16215.7 16427.4 16475.0 16511.0 12912.5 12931.9 13062.7 13068.2 13070.7 15040.6 15295.8 15304.6 15315.4 15455.8 6506.6 6554.8 6629.0 6632.0 6706.9 899.9 978.3 997.6 1036.0 1095.2 25851.9 26550.0 30844.0 31306.0 32112.0 869.8 999.4 1036.4 1055.0 1077.1 12399.4 14066.3 15053.8 15304.4 15543.4 474782.0 557916.0 562233.0 562571.0 564126.0 55161.4 55992.7 56219.4 56267.0 56279.0 1398.4 1401.2 1432.1 1435.4 1438.6 28794.7 29452.6 29624.4 29670.8 30133.5 48728.0 50001.2 50230.5 50313.0 50368.7 473478.0 479208.0 483211.0 484859.0 486421.0 25484.0 25719.7 25807.7 26037.2 26052.5 43336.0 44319.6 44803.0 44935.8 45370.5 35463.6 36156.8 38101.4 38848.0 39102.2 37402.4 37669.4 38434.4 38440.8 38594.8 36223.6 36634.0 37149.4 37166.4 37556.2 31912.0 33321.0 33735.7 33796.7 33873.0 25283.6 25394.5 25440.6 25626.9 25864.5 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:37499.37 Median:15551.86 stddev:102095.04 (656.5%) stddev-sans-first:102343.28 10:17:21 INFO - PROCESS | 1652 | Values: 319.2 366.6 391.1 393.4 403.4 10036.0 12130.1 12248.0 12265.8 19489.9 21678.9 21716.8 22459.9 22702.3 23039.7 6418.8 6633.7 6875.4 6879.0 6962.2 6736.2 6900.1 6934.5 6965.3 6974.3 6655.9 6881.6 6903.5 6914.4 6969.5 6505.9 6623.2 6693.8 6749.1 6905.8 6660.5 6719.0 6724.1 6724.7 6736.9 28532.4 28562.9 28751.7 29191.9 29239.9 2413.9 2474.4 2479.9 2571.3 3259.6 17212.7 17409.2 17536.9 17724.0 17912.7 2083.4 2112.4 2178.0 2208.9 2235.7 119035.4 132326.6 135821.0 138694.0 139782.0 17694.6 18270.7 22521.4 22628.7 22663.3 35218.8 35260.5 35824.8 35875.6 36072.0 10920.7 11045.6 11086.0 11212.7 11355.0 9039.9 9045.6 9079.1 9188.9 9226.4 9722.1 9838.4 10075.4 10269.2 10270.9 3649.1 3703.6 4013.7 4042.9 4055.8 841.6 895.9 940.7 949.1 1007.8 20421.3 21266.3 21407.9 21413.0 21417.4 979.5 979.8 1000.1 1004.6 1006.6 8707.4 10704.7 11144.8 11180.9 11267.3 604243.0 606935.0 607283.0 616075.0 617105.0 130226.0 135083.0 136075.0 138729.0 141012.0 996.4 1029.7 1045.4 1049.1 1051.2 18488.8 19251.4 19708.8 19711.5 19763.8 51555.0 53862.9 53990.2 54102.7 56267.0 66702.0 78380.0 79162.2 82508.0 85237.6 7131.4 7784.4 8107.0 8277.7 8465.1 11680.2 12700.0 12727.4 12790.5 12845.0 11087.0 11121.7 11255.1 11311.9 11369.5 8955.8 10230.3 10658.6 11018.1 11046.0 11077.8 11345.9 11406.9 11525.9 11685.5 7998.0 8031.0 8186.8 8360.9 8362.8 8245.1 9899.4 11173.7 11378.8 11566.8 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5583.58 Median:5118.85 stddev:3017.39 (58.9%) stddev-sans-first:3009.10 10:17:21 INFO - PROCESS | 1652 | Values: 1352.8 1550.1 1726.2 1842.4 1897.9 7771.8 8010.7 8214.8 8671.8 8682.2 8151.0 8462.3 8470.1 8574.6 8590.0 2379.0 2394.7 2397.3 2406.1 2407.1 2369.3 2436.1 2466.6 2471.8 2481.9 2395.8 2408.3 2422.9 2423.2 2437.2 2391.1 2394.7 2404.2 2416.7 2422.1 2054.4 2420.7 2434.6 2437.8 2442.3 8437.7 8514.5 8551.4 8570.4 8645.4 4560.9 5208.0 5347.3 5349.0 5362.0 3589.1 3623.2 3627.9 3678.8 3682.6 1001.7 1080.7 1107.6 1135.1 1145.2 10217.1 10236.0 10304.4 11002.6 11236.3 4581.5 4684.1 4757.1 4839.4 4869.6 9709.6 9778.1 9786.0 9801.1 9801.6 5372.6 5384.4 5398.6 5398.9 5404.5 4433.6 4501.2 4867.9 4939.0 4980.9 3906.9 3957.7 4008.2 4079.4 4090.6 1285.3 1291.2 1298.8 1301.1 1311.6 917.3 918.9 919.9 927.0 937.6 5710.7 5867.1 5966.4 5980.5 6272.9 867.2 945.2 956.0 967.5 972.8 3791.1 3943.4 3993.6 4026.5 4050.6 10146.8 10322.2 10462.4 10509.1 10510.2 10152.2 10164.6 10339.8 10413.8 10435.2 8031.8 8040.2 8092.0 8158.1 8179.5 5607.5 5712.0 5746.2 5772.0 5883.4 9350.9 9353.6 9463.1 9483.3 9623.5 9292.8 9542.2 9698.8 9778.1 9898.0 6801.8 7036.9 7156.5 7351.9 7492.2 7997.8 8137.9 8215.5 8233.8 8252.9 7203.5 7324.4 7372.6 7436.1 7451.6 6086.2 6999.6 7000.7 7012.5 7030.5 6792.0 6914.4 6930.5 6932.1 6936.3 4631.5 4893.5 4905.2 4914.5 4941.8 4608.9 4852.4 4936.7 5014.5 5029.7 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4598.33 Median:5066.63 stddev:1448.11 (28.6%) stddev-sans-first:1414.62 10:17:21 INFO - PROCESS | 1652 | Values: 232.7 291.9 302.6 311.6 313.1 4860.2 5130.0 5650.0 5660.0 5716.7 4941.8 5208.8 5373.9 5551.1 5658.7 3562.3 4236.8 4242.5 4246.7 4296.2 3073.4 4163.7 4294.3 4303.1 4328.1 3789.3 3875.7 4162.9 4194.7 4198.4 4170.1 4189.9 4204.3 4210.4 4245.8 3632.0 3638.4 3643.9 3654.8 3657.5 4223.7 4722.9 5300.0 5341.4 5458.0 4671.9 4751.5 4786.7 4796.1 4801.6 5074.8 5215.9 5624.8 5845.3 5898.8 3163.7 3285.9 3867.0 3950.7 3960.2 5793.8 6151.4 6199.8 6226.8 6246.5 3562.9 3871.8 3978.2 3998.5 4010.2 3377.7 3676.4 3979.9 4023.6 4083.8 4035.0 4269.7 4603.9 4606.4 4783.3 5727.6 5906.9 5970.6 5974.5 6002.5 1187.3 1202.5 1254.4 1303.8 1317.5 717.9 783.0 873.6 875.9 893.4 4443.0 4465.7 5253.8 5457.2 5484.6 5138.7 5751.9 5844.9 5888.8 5967.5 4918.6 5014.6 5144.9 5419.8 5444.2 2699.4 2730.9 2920.5 2978.4 3020.1 5517.0 5665.8 6043.2 6052.0 6150.8 4484.9 4605.6 5222.9 5902.4 6007.3 5505.6 5559.2 5715.9 5934.9 6039.8 4726.4 5130.8 5370.4 5743.5 5784.1 5024.3 5025.0 5606.3 5768.6 5842.1 4725.0 5464.8 5877.1 5923.3 5987.2 3337.7 3561.9 3791.5 3799.8 3807.0 4704.9 5297.2 5698.0 5741.7 5743.7 4774.8 5740.3 5764.9 5886.4 5970.5 4934.9 5021.1 5160.6 5870.9 5894.0 5058.5 5442.5 5704.1 5746.3 5831.3 5013.2 5684.5 6074.5 6112.9 6152.2 4837.7 5840.6 5857.5 5869.4 5949.2 10:17:21 INFO - PROCESS | 1652 | 10:17:21 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:20911.27 Median:3694.23 stddev:30350.17 (821.6%) stddev-sans-first:30397.22 10:17:21 INFO - PROCESS | 1652 | Values: 661.1 719.6 739.1 788.6 832.3 14127.6 14366.6 14665.7 14675.7 14740.4 12061.2 13878.6 13927.4 13957.7 14046.0 836.5 847.5 852.0 874.0 875.6 867.6 873.0 875.3 875.6 877.7 931.4 934.0 936.0 936.6 937.3 919.7 920.2 929.4 930.0 933.5 668.1 670.8 678.5 681.1 691.9 14405.4 14431.6 14446.2 14453.0 14460.9 11740.8 14212.1 14417.4 14429.9 14522.9 11603.8 11904.3 11925.8 11927.6 12032.3 3734.6 3783.6 3847.1 3888.5 3903.8 86691.6 90611.0 93177.6 94915.1 95571.5 10320.6 10839.0 10981.9 11069.6 11128.1 17554.5 21392.8 21583.6 21662.5 21688.8 7986.5 8111.5 8141.1 8246.0 8250.9 4428.3 4526.5 4586.3 4638.4 4688.4 3044.6 3515.3 3625.8 3653.3 3653.9 630.2 631.6 634.6 652.4 659.2 552.8 581.2 588.7 679.1 683.1 10219.3 10268.6 10384.3 10758.5 10985.0 606.3 620.0 689.4 690.7 693.5 4318.9 4335.9 4731.9 4870.0 5190.8 113911.0 114587.0 115602.4 116069.0 118272.4 72036.0 75713.2 85571.6 88255.6 101419.0 88392.2 89534.6 92632.1 92663.0 94096.0 9770.6 10263.9 10333.7 10344.5 10374.8 36016.8 43501.6 52232.0 53551.5 55906.4 72227.0 73944.6 74960.0 75963.6 80830.6 12985.0 13037.3 13369.4 13489.3 13504.6 13998.3 14279.4 14529.7 14530.7 14734.3 12878.4 13297.1 13968.2 13974.2 14065.6 14036.0 14149.4 14166.6 14783.9 14787.5 13470.9 13542.1 13649.9 13817.5 14214.1 10995.9 11204.8 11786.1 11907.9 12065.9 11400.7 11629.1 11716.7 11764.4 11766.9 10:17:21 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:17:21 INFO - PROCESS | 1652 | 10:17:22 INFO - TEST-INFO | 1652: exit 0 10:17:22 INFO - TEST-OK | dromaeo_css | took 1113687ms 10:17:22 INFO - TEST-START | kraken 10:17:22 INFO - operating with platform_type : mac_ 10:17:22 INFO - Initialising browser for kraken test... 10:17:22 INFO - TEST-INFO | started process 1776 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpe_soBF/profile http://localhost:49241/getInfo.html) 10:17:24 INFO - PROCESS | 1776 | 2017-01-30 10:17:24.853 plugin-container[1778:10130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 10:17:24 INFO - PROCESS | 1776 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:24 INFO - PROCESS | 1776 | 2017-01-30 10:17:24.854 plugin-container[1778:10130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 10:17:24 INFO - PROCESS | 1776 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:24 INFO - PROCESS | 1776 | 2017-01-30 10:17:24.854 plugin-container[1778:10130] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:17:24 INFO - PROCESS | 1776 | __metrics Screen width/height:1600/1200 10:17:24 INFO - PROCESS | 1776 | colorDepth:24 10:17:24 INFO - PROCESS | 1776 | Browser inner width/height: 1024/689 10:17:24 INFO - PROCESS | 1776 | __metrics 10:17:25 ERROR - PROCESS | 1776 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:17:25 INFO - TEST-INFO | 1776: exit 0 10:17:25 INFO - Browser initialized. 10:17:25 INFO - Running cycle 1/1 for kraken test... 10:17:25 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpe_soBF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:28 INFO - PROCESS | 1780 | 2017-01-30 10:17:28.374 plugin-container[1781:10254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 10:17:28 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:28 INFO - PROCESS | 1780 | 2017-01-30 10:17:28.374 plugin-container[1781:10254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 10:17:28 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:28 INFO - PROCESS | 1780 | 2017-01-30 10:17:28.374 plugin-container[1781:10254] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:17:38 INFO - PROCESS | 1780 | RSS: Main: 177037312 10:17:38 INFO - PROCESS | 1780 | 10:17:41 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:42 INFO - PROCESS | 1780 | RSS: Main: 190197760 10:17:42 INFO - PROCESS | 1780 | 10:17:44 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:17:45 INFO - PROCESS | 1780 | RSS: Main: 197980160 10:17:45 INFO - PROCESS | 1780 | 10:17:48 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:17:49 INFO - PROCESS | 1780 | RSS: Main: 201678848 10:17:49 INFO - PROCESS | 1780 | 10:17:51 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:17:51 INFO - PROCESS | 1780 | RSS: Main: 203579392 10:17:51 INFO - PROCESS | 1780 | 10:17:53 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:54 INFO - PROCESS | 1780 | RSS: Main: 203317248 10:17:54 INFO - PROCESS | 1780 | 10:17:57 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:57 INFO - PROCESS | 1780 | RSS: Main: 207233024 10:17:57 INFO - PROCESS | 1780 | 10:18:00 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:01 INFO - PROCESS | 1780 | RSS: Main: 207097856 10:18:01 INFO - PROCESS | 1780 | 10:18:04 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:18:04 INFO - PROCESS | 1780 | RSS: Main: 206548992 10:18:04 INFO - PROCESS | 1780 | 10:18:06 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:07 INFO - PROCESS | 1780 | RSS: Main: 206290944 10:18:07 INFO - PROCESS | 1780 | 10:18:08 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:09 INFO - PROCESS | 1780 | RSS: Main: 205750272 10:18:09 INFO - PROCESS | 1780 | 10:18:11 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:12 INFO - PROCESS | 1780 | RSS: Main: 205733888 10:18:12 INFO - PROCESS | 1780 | 10:18:15 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:15 INFO - PROCESS | 1780 | RSS: Main: 205762560 10:18:15 INFO - PROCESS | 1780 | 10:18:18 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:19 INFO - PROCESS | 1780 | RSS: Main: 206036992 10:18:19 INFO - PROCESS | 1780 | 10:18:20 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:18:21 INFO - PROCESS | 1780 | RSS: Main: 208068608 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | __start_tp_report 10:18:21 INFO - PROCESS | 1780 | _x_x_mozilla_page_load 10:18:21 INFO - PROCESS | 1780 | _x_x_mozilla_page_load_details 10:18:21 INFO - PROCESS | 1780 | |i|pagename|runs| 10:18:21 INFO - PROCESS | 1780 | |0;ai-astar;123;136;140;170;119;123;102;147;171;171 10:18:21 INFO - PROCESS | 1780 | |1;audio-beat-detection;145;112;112;145;107;111;111;110;149;141 10:18:21 INFO - PROCESS | 1780 | |2;audio-dft;202;200;199;189;196;195;199;196;199;195 10:18:21 INFO - PROCESS | 1780 | |3;audio-fft;82;67;80;107;84;62;53;80;103;82 10:18:21 INFO - PROCESS | 1780 | |4;audio-oscillator;84;68;89;73;72;70;85;70;67;87 10:18:21 INFO - PROCESS | 1780 | |5;imaging-gaussian-blur;92;83;93;91;93;91;107;91;93;89 10:18:21 INFO - PROCESS | 1780 | |6;imaging-darkroom;145;97;119;125;97;97;98;98;98;98 10:18:21 INFO - PROCESS | 1780 | |7;imaging-desaturate;90;91;86;112;89;142;146;88;87;88 10:18:21 INFO - PROCESS | 1780 | |8;json-parse-financial;58;58;57;60;61;60;60;59;59;60 10:18:21 INFO - PROCESS | 1780 | |9;json-stringify-tinderbox;67;70;75;74;72;69;68;95;58;84 10:18:21 INFO - PROCESS | 1780 | |10;stanford-crypto-aes;83;83;86;82;84;83;82;87;85;83 10:18:21 INFO - PROCESS | 1780 | |11;stanford-crypto-ccm;138;137;139;152;143;141;130;158;199;168 10:18:21 INFO - PROCESS | 1780 | |12;stanford-crypto-pbkdf2;165;162;165;162;162;160;164;165;165;162 10:18:21 INFO - PROCESS | 1780 | |13;stanford-crypto-sha256-iterative;63;67;68;65;72;65;66;68;66;67 10:18:21 INFO - PROCESS | 1780 | __end_tp_report 10:18:21 INFO - PROCESS | 1780 | __start_cc_report 10:18:21 INFO - PROCESS | 1780 | _x_x_mozilla_cycle_collect,924 10:18:21 INFO - PROCESS | 1780 | __end_cc_report 10:18:21 INFO - PROCESS | 1780 | __startTimestamp1485800301202__endTimestamp 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | ------- Summary: start ------- 10:18:21 INFO - PROCESS | 1780 | Number of tests: 14 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#0] ai-astar Cycles:10 Average:140.20 Median:143.50 stddev:24.38 (17.0%) stddev-sans-first:25.05 10:18:21 INFO - PROCESS | 1780 | Values: 123.0 136.0 140.0 170.0 119.0 123.0 102.0 147.0 171.0 171.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:126.50 stddev:17.97 (14.2%) stddev-sans-first:17.43 10:18:21 INFO - PROCESS | 1780 | Values: 145.0 112.0 112.0 145.0 107.0 111.0 111.0 110.0 149.0 141.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#2] audio-dft Cycles:10 Average:197.00 Median:199.00 stddev:3.65 (1.8%) stddev-sans-first:3.40 10:18:21 INFO - PROCESS | 1780 | Values: 202.0 200.0 199.0 189.0 196.0 195.0 199.0 196.0 199.0 195.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#3] audio-fft Cycles:10 Average:80.00 Median:80.00 stddev:16.68 (20.8%) stddev-sans-first:17.68 10:18:21 INFO - PROCESS | 1780 | Values: 82.0 67.0 80.0 107.0 84.0 62.0 53.0 80.0 103.0 82.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:78.50 stddev:8.66 (11.0%) stddev-sans-first:8.75 10:18:21 INFO - PROCESS | 1780 | Values: 84.0 68.0 89.0 73.0 72.0 70.0 85.0 70.0 67.0 87.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:91.50 stddev:5.96 (6.5%) stddev-sans-first:6.32 10:18:21 INFO - PROCESS | 1780 | Values: 92.0 83.0 93.0 91.0 93.0 91.0 107.0 91.0 93.0 89.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:97.50 stddev:16.78 (17.2%) stddev-sans-first:10.89 10:18:21 INFO - PROCESS | 1780 | Values: 145.0 97.0 119.0 125.0 97.0 97.0 98.0 98.0 98.0 98.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:88.00 stddev:23.44 (26.6%) stddev-sans-first:24.46 10:18:21 INFO - PROCESS | 1780 | Values: 90.0 91.0 86.0 112.0 89.0 142.0 146.0 88.0 87.0 88.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:60.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 10:18:21 INFO - PROCESS | 1780 | Values: 58.0 58.0 57.0 60.0 61.0 60.0 60.0 59.0 59.0 60.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:10.12 (13.9%) stddev-sans-first:10.48 10:18:21 INFO - PROCESS | 1780 | Values: 67.0 70.0 75.0 74.0 72.0 69.0 68.0 95.0 58.0 84.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.69 (2.0%) stddev-sans-first:1.76 10:18:21 INFO - PROCESS | 1780 | Values: 83.0 83.0 86.0 82.0 84.0 83.0 82.0 87.0 85.0 83.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:147.50 stddev:20.42 (13.8%) stddev-sans-first:21.16 10:18:21 INFO - PROCESS | 1780 | Values: 138.0 137.0 139.0 152.0 143.0 141.0 130.0 158.0 199.0 168.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.50 stddev:1.81 (1.1%) stddev-sans-first:1.80 10:18:21 INFO - PROCESS | 1780 | Values: 165.0 162.0 165.0 162.0 162.0 160.0 164.0 165.0 165.0 162.0 10:18:21 INFO - PROCESS | 1780 | 10:18:21 INFO - PROCESS | 1780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.15 10:18:21 INFO - PROCESS | 1780 | Values: 63.0 67.0 68.0 65.0 72.0 65.0 66.0 68.0 66.0 67.0 10:18:21 INFO - PROCESS | 1780 | -------- Summary: end -------- 10:18:21 INFO - PROCESS | 1780 | 10:18:22 INFO - TEST-INFO | 1780: exit 0 10:18:22 INFO - TEST-OK | kraken | took 60068ms 10:18:22 INFO - SUITE-END | took 1173s 10:18:22 INFO - Completed test suite (00:19:33) 10:18:22 INFO - javascript benchmark 10:18:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7503.848110236927, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.952660710089, 3598.568171819382, 3606.080449485381, 3612.584552776431, 3642.581103173134, 5860.413958604143, 5918.348981612019, 5949.560680121152, 5956.791512297071, 5962.522998160148, 5872.559558033154, 5936.821895343136, 5971.850703732409, 5976.163337132794, 5980.1328807323025, 5291.074062039157, 5362.570994320465, 5372.597055220874, 5408.972955135238, 5442.374126975389, 4548.795304211319, 5142.768575414116, 5318.813841515548, 5413.377461591928, 5438.0, 5278.47215278473, 5343.011542864582, 5382.946170538284, 5399.946000540003, 5416.377116631598, 5342.2253773202865, 5344.652597581165, 5397.27136836526, 5428.131498960187, 5459.181122831567, 5264.0261551613075, 5361.919571206435, 5363.892722145574, 5387.542058924996, 5406.91889621656, 5717.542596592262, 5872.383399743051, 5873.735681894283, 6017.789377371771, 6024.036154215349, 6160.014397696347, 6199.504039676815, 6225.408586184305, 6226.128342032119, 6249.437550620421, 6207.4723648489935, 6309.842253943642, 6325.588836725598, 6336.366363363627, 6336.904946425761, 5919.644821310692, 5961.493273071794, 5964.194833697482, 5970.611910225822, 6001.159837622737, 6201.317855035943, 6222.0, 6281.246250449975, 6295.055741638791, 6303.747850086037, 6263.31103578606, 6296.275928268216, 6296.527760417987, 6297.149884765589, 6305.4009869062365, 5136.255242989746, 6102.816915492543, 6305.936940630535, 6309.287006587211, 6320.273168585672, 6221.595596286227, 6231.844203894848, 6253.6560489172625, 6268.780592679234, 6275.1842260506755, 5194.844154675366, 6227.6263424193785, 6273.654948977759, 6307.148534947815, 6324.0, 4214.726042807269, 4291.6137547620865, 5089.898202035939, 5091.287219789232, 5095.439501654815, 4454.109178164315, 4485.102979404132, 4500.729956202638, 4518.502964673883, 4520.683552151318, 5998.310194327621, 6144.003198960356, 6178.6601736904, 6194.163787888578, 6197.318294987548, 6280.120783090371, 6321.620702757849, 6325.936740632626, 6327.58870673414, 6337.366263373718, 5911.261092363455, 6058.363871793398, 6078.3617720138745, 6084.452399284086, 6116.67056464255, 5539.639923404966, 5598.964191624563, 5608.719564021782, 5627.634203776742, 5655.0386434306265, 6459.104795984985, 6478.190226221723, 6481.5138864584405, 6486.772962946275, 6527.11883895668, 6133.487685122479, 6313.305536390902, 6328.46208072319, 6334.796388686135, 6344.175257216532, 6332.968335158294, 6370.872582548416, 6384.808455746149, 6410.294867564658, 6509.804705858832, 6322.968385158045, 6327.3356297589935, 6337.397947195009, 6354.301026886947, 6363.236411630634, 6229.53278504123, 6300.338464461165, 6329.208848893888, 6331.778387756406, 6346.174997250328, 6156.384361563808, 6201.782937597162, 6204.658743769136, 6237.563370564017, 6247.625142491465, 6122.672617327995, 6258.718357674006, 6307.873842523216, 6321.810345689637, 6337.96831015842, 6110.175126358063, 6203.348648391854, 6214.254289485109, 6219.160413344141, 6235.501159907106, 6112.572119951561, 6155.47678447337, 6184.103305020837, 6219.284782250099, 6269.0, 6125.388069147376, 6197.597156185014, 6202.968985155046, 6210.130581718473, 6239.0953311768635], "value": 5826.058695318432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.87635652908506, 492.91127597032533, 519.9766010529528, 522.5479959834744, 538.9705662185224, 37332.0, 38839.41740873885, 39815.402768958455, 43052.138957220835, 43084.78457607715, 42810.14379712404, 43216.78391608038, 43351.56648433515, 43393.0, 43517.7824110879, 9686.225101991842, 9732.562034708455, 9842.065003824626, 9887.159591434736, 9906.603735850558, 8407.663693452285, 9798.510074496282, 9816.558254878548, 9854.310198286123, 9886.060824221724, 9098.272138228958, 9141.817163656757, 9814.46020468874, 9845.55694993727, 9864.654737084204, 8358.0, 9831.655892043816, 9836.016398360178, 9875.2099832014, 9884.901150988542, 9750.219982401391, 9811.460369679664, 9826.361286516354, 9838.0, 9862.50687465631, 40773.59226407728, 40920.0, 41335.379969300484, 41349.79325103355, 41568.37647435291, 3576.356255873942, 3583.677469027774, 3633.454981752732, 4007.6393124618635, 4199.181159673864, 30111.0, 30785.692143078508, 31109.0, 31259.687403126132, 31660.208494787585, 3227.4351988402173, 3270.427675156862, 3302.091924720721, 3326.2682209914024, 3411.675890790396, 497208.0, 502838.0, 504124.0, 504198.0, 504767.0, 58575.0, 58928.41071589229, 58945.41054589485, 59023.0, 59117.0, 59896.0, 60837.0, 60839.0, 60960.0, 60973.08540371898, 16163.757543636855, 16215.675686486204, 16427.425040123537, 16475.0, 16511.0, 12912.483500660057, 12931.935340323238, 13062.673433164247, 13068.215907045607, 13070.738585228242, 15040.62398440026, 15295.847041529665, 15304.617384565476, 15315.387384504718, 15455.845441545665, 6506.60960342381, 6554.80335589933, 6628.966855165693, 6632.008429842029, 6706.865862682719, 899.8740176375313, 978.3102912446708, 997.5860018092555, 1035.9689209323733, 1095.2169199022737, 25851.87074064655, 26550.0, 30844.0, 31306.0, 32112.0, 869.7738587967174, 999.3654029691053, 1036.429963520061, 1054.9947250263854, 1077.1221454514546, 12399.442025108892, 14066.2966851657, 15053.774193387108, 15304.387824486896, 15543.378264869505, 474782.0, 557916.0, 562233.0, 562571.0, 564126.0, 55161.44838551563, 55992.72003639956, 56219.43780562142, 56267.0, 56279.0, 1398.3707331700775, 1401.1663060479, 1432.10493441599, 1435.3612642374253, 1438.6475313548249, 28794.712052879204, 29452.558211626416, 29624.407511850073, 29670.813167473058, 30133.547996779627, 48728.0, 50001.249981251036, 50230.497695024045, 50313.0, 50368.74815625898, 473478.0, 479208.0, 483211.0, 484859.0, 486421.0, 25484.043163529866, 25719.742802571735, 25807.741922580535, 26037.21888343353, 26052.478950421264, 43336.0, 44319.556804431544, 44803.0, 44935.77532112318, 45370.54629453663, 35463.645363546035, 36156.81921590375, 38101.42847857229, 38848.0, 39102.217955641296, 37402.43896341503, 37669.434958475096, 38434.42348364833, 38440.80779596084, 38594.80702596469, 36223.551057958444, 36634.0, 37149.44275835919, 37166.44250336301, 37556.248875022895, 31912.0, 33321.0, 33735.66264337325, 33796.662033379354, 33872.983810485726, 25283.620745688462, 25394.492110158062, 25440.618390723783, 25626.87186564055, 25864.482710346063], "value": 19577.717204784603, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2449856090346, 366.58941984976826, 391.1433959628415, 393.38238964825234, 403.3626869546117, 10036.0, 12130.090243231749, 12248.0, 12265.816012759815, 19489.902550487244, 21678.89160554199, 21716.80557569337, 22459.87700614967, 22702.318930432113, 23039.654405183937, 6418.839529011789, 6633.734650613982, 6875.381215690587, 6878.965605171968, 6962.164540255177, 6736.225334086569, 6900.137482814648, 6934.47991400647, 6965.33829286217, 6974.302569743036, 6655.900161497581, 6881.621510816903, 6903.516753827234, 6914.446844252448, 6969.512134150612, 6505.93494065058, 6623.23832759234, 6693.832654183636, 6749.12261406019, 6905.827354316132, 6660.500462465335, 6718.966405167943, 6724.092247546568, 6724.731010759613, 6736.865262694719, 28532.429351413062, 28562.85718571394, 28751.712482875322, 29191.85404072987, 29239.85380073086, 2413.879306034709, 2474.406142525781, 2479.938001549958, 2571.2928944540213, 3259.6088469383826, 17212.655746884993, 17409.216585253693, 17536.91231543847, 17724.0, 17912.731309030376, 2083.447886310129, 2112.355731501891, 2178.041661668861, 2208.933731988027, 2235.7205349331334, 119035.4048229762, 132326.63028581472, 135821.0, 138694.0, 139782.0, 17694.646107077788, 18270.725939110926, 22521.43696407603, 22628.660570091462, 22663.320100397013, 35218.82390588031, 35260.47109293363, 35824.82087589546, 35875.64124358723, 36072.0, 10920.726981825359, 11045.613403530839, 11086.0, 11212.719682008015, 11355.0, 9039.91521017469, 9045.592948317342, 9079.137481939206, 9188.8621670675, 9226.40028398152, 9722.076402741728, 9838.395483819637, 10075.395476271447, 10269.229807764297, 10270.948645256725, 3649.142451523943, 3703.629637036329, 4013.678905687538, 4042.91914161721, 4055.7566546007333, 841.6212704283097, 895.901450840407, 940.6754669638964, 949.1457688080644, 1007.8337074382645, 20421.285255016002, 21266.2556810514, 21407.892960535097, 21413.036413361435, 21417.357479275648, 979.456401697065, 979.7942432089341, 1000.0899181744722, 1004.5881188712739, 1006.6225165562914, 8707.390482666153, 10704.678859634223, 11144.794575189437, 11180.944095279472, 11267.323960562393, 604243.0, 606935.0, 607282.963585188, 616075.0, 617105.0, 130226.0, 135083.0, 136075.0, 138729.0, 141012.0, 996.4370130876032, 1029.6705054382526, 1045.4406892312577, 1049.0663309654567, 1051.1853313681959, 18488.815111849246, 19251.4224573263, 19708.802911970695, 19711.507212319808, 19763.80236197677, 51554.968900621025, 53862.922741544164, 53990.19014714861, 54102.72948635231, 56267.0, 66702.0, 78380.04049898798, 79162.20837791548, 82508.0, 85237.57381213055, 7131.431085161256, 7784.377249820114, 8107.0, 8277.710280140407, 8465.111163327761, 11680.182387232811, 12700.0, 12727.363631818558, 12790.488380464678, 12845.036622253556, 11087.0, 11121.721956951142, 11255.099592032453, 11311.943440282746, 11369.54521819118, 8955.820883582423, 10230.311998520161, 10658.573657053632, 11018.063464605279, 11046.0, 11077.833832492357, 11345.943270283597, 11406.885931140583, 11525.88474115248, 11685.474153662935, 7997.960010199912, 8030.980637101811, 8186.836263274582, 8360.916390836257, 8362.790930226549, 8245.093039765741, 9899.406035637885, 11173.72065698364, 11378.772424551296, 11566.768664626828], "value": 10990.732124266977, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.8444228913675, 1550.1241798383912, 1726.2231995601983, 1842.39201063649, 1897.9051047447624, 7771.805704857381, 8010.679572817095, 8214.75355739328, 8671.826563468734, 8682.175193356628, 8150.9592452037805, 8462.323014158868, 8470.068292487822, 8574.614142363593, 8590.0, 2378.9643155352683, 2394.724606670238, 2397.328747950568, 2406.133791834938, 2407.145463360508, 2369.34842918198, 2436.135172013936, 2466.580681284177, 2471.789897858684, 2481.888315025828, 2395.8203134764876, 2408.2654790288957, 2422.8667423291713, 2423.1761201191593, 2437.1591800828687, 2391.1033362489065, 2394.7485514021128, 2404.2426635609727, 2416.734159242482, 2422.0675040109595, 2054.3939537836227, 2420.697412823397, 2434.5739495588377, 2437.768412000857, 2442.3283597010786, 8437.704680336159, 8514.531700756455, 8551.401401901869, 8570.442921210102, 8645.394822362437, 4560.931586026212, 5208.0, 5347.304850369427, 5349.0, 5362.008028514698, 3589.0668426209113, 3623.166671665532, 3627.8730244441317, 3678.834452449646, 3682.613325600827, 1001.689476262361, 1080.7460246841986, 1107.5846557540922, 1135.0635725526474, 1145.2441388683428, 10217.131543818785, 10236.0, 10304.433256170907, 11002.559897604086, 11236.269642473213, 4581.496035436099, 4684.110019096429, 4757.09615173116, 4839.41926968766, 4869.610431165498, 9709.563069661883, 9778.119969202664, 9785.951070244602, 9801.068898454636, 9801.607935682492, 5372.623916325898, 5384.380796208487, 5398.64908780928, 5398.8920221595345, 5404.540614047772, 4433.645308375387, 4501.212287849613, 4867.902641947141, 4939.036887806843, 4980.900381992412, 3906.941395879064, 3957.6635985940943, 4008.158286759813, 4079.3676980068135, 4090.6318431341324, 1285.254552359629, 1291.2381694799926, 1298.7532368850077, 1301.0502333296747, 1311.5999620115765, 917.3028498341308, 918.9248579162396, 919.9264058875274, 926.9860952085725, 937.6249500199838, 5710.7430165642645, 5867.090600956859, 5966.373530779292, 5980.461758441761, 6272.937270627326, 867.2368315881984, 945.1871390604075, 955.9563048305706, 967.4775621164633, 972.8297547929226, 3791.1280405506886, 3943.3887747398626, 3993.600639935983, 4026.4564283821896, 4050.5544390117066, 10146.847797283046, 10322.22583306255, 10462.424566648755, 10509.054185123376, 10510.211734119972, 10152.23858210637, 10164.644237451654, 10339.844902326471, 10413.791724165474, 10435.217358698128, 8031.7992050198045, 8040.195980401913, 8092.028956525254, 8158.061822890325, 8179.509229446252, 5607.523360514402, 5711.971440142939, 5746.224259725051, 5772.0, 5883.35283118848, 9350.859737103812, 9353.625854965725, 9463.148316651534, 9483.28875334339, 9623.518824058629, 9292.767680807763, 9542.188913942393, 9698.806023879624, 9778.119969202806, 9897.950510247403, 6801.829954251183, 7036.859262814817, 7156.499045067004, 7351.926480735124, 7492.175860655432, 7997.8400431992195, 8137.918620813953, 8215.507069575844, 8233.79415514617, 8252.917470825216, 7203.459740519377, 7324.377427918686, 7372.557646541225, 7436.144843343085, 7451.552906825391, 6086.239220097488, 6999.580025198505, 7000.684969176297, 7012.509124361246, 7030.543014704028, 6792.0, 6914.412274956685, 6930.549514281555, 6932.064171336805, 6936.306369363023, 4631.490536040966, 4893.510648935078, 4905.23968784839, 4914.459409465027, 4941.802327906844, 4608.88477788058, 4852.369192005017, 4936.654434189572, 5014.52362025607, 5029.698218106925], "value": 4549.800913823755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [232.68006491074772, 291.94598999185155, 302.5643073973478, 311.6384993407648, 313.0514540940948, 4860.198067318888, 5130.0, 5649.983003059448, 5659.981203383394, 5716.656585702362, 4941.813964648485, 5208.843734687956, 5373.892522149565, 5551.056320425528, 5658.7170641467865, 3562.340966921115, 4236.809343579546, 4242.490901091858, 4246.7027308088445, 4296.205202037618, 3073.431415188197, 4163.7293575917465, 4294.26997410441, 4303.139372125587, 4328.06946506501, 3789.2610940866543, 3875.7286989910717, 4162.938450695084, 4194.727342722728, 4198.391233271173, 4170.103427763031, 4189.937150942738, 4204.264253755596, 4210.410542524049, 4245.80893859777, 3631.981840090809, 3638.435472746718, 3643.8724644637578, 3654.798986055766, 3657.487951686766, 4223.66210703143, 4722.913729842156, 5300.0459917214885, 5341.412444631087, 5458.0, 4671.85984420468, 4751.524847515256, 4786.736729479877, 4796.136695394827, 4801.615870730368, 5074.771635276422, 5215.895682086375, 5624.803131890405, 5845.269341332333, 5898.7640494380175, 3163.6678148794276, 3285.8849940252217, 3867.0, 3950.703697222691, 3960.1881614269005, 5793.797217097382, 6151.354107818659, 6199.791040747056, 6226.844328891769, 6246.500279977637, 3562.931120663842, 3871.806409679561, 3978.1844721831953, 3998.4801975742967, 4010.1779135277197, 3377.6995856594895, 3676.4117741161285, 3979.900502487461, 4023.637872591481, 4083.7753923533896, 4035.0228388089627, 4269.658427325807, 4603.872051347441, 4606.424196975378, 4783.330333753277, 5727.5990680652785, 5906.911396329058, 5970.611910225822, 5974.522038236931, 6002.489788368038, 1187.281694574787, 1202.4649031181216, 1254.4166962362544, 1303.843538775353, 1317.4598414649947, 717.8779607466744, 782.9608519573999, 873.6025108575583, 875.8657538487673, 893.4275674812247, 4442.955570444319, 4465.687401881837, 5253.842384728464, 5457.181422786613, 5484.561235101182, 5138.691678499302, 5751.85620359486, 5844.912326315109, 5888.793892213752, 5967.492763115184, 4918.631102667243, 5014.6431177346585, 5144.897102058013, 5419.783208671609, 5444.156155795858, 2699.379142797168, 2730.877110529991, 2920.518114511124, 2978.4043191361816, 3020.0939718084487, 5516.972415137899, 5665.750686984761, 6043.220118745338, 6051.972589182673, 6150.769846030812, 4484.910301793946, 4605.585497305258, 5222.9216561750845, 5902.4097590240635, 6007.335525329546, 5505.614606977553, 5559.191299525881, 5715.8571035724435, 5934.851628709317, 6039.818805435844, 4726.409198850144, 5130.768615532171, 5370.415727360516, 5743.511801496752, 5784.149072296825, 5024.341967150905, 5025.0, 5606.308971693528, 5768.596198266081, 5842.130518234124, 4724.976375118103, 5464.781408743605, 5877.059670452707, 5923.259592550931, 5987.161797348462, 3337.6829201226815, 3561.893143205708, 3791.5071040764524, 3799.8290076947155, 3806.980965095157, 4704.92942605868, 5297.231901374356, 5697.971510142423, 5741.741621626953, 5743.712814359349, 4774.7851346688785, 5740.306609550109, 5764.942350576441, 5886.352501224947, 5970.462658360769, 4934.8766280843265, 5021.07110184617, 5160.587153027824, 5870.88648086697, 5893.970530147493, 5058.494150584912, 5442.510174084351, 5704.11586204139, 5746.281714785652, 5831.300243970751, 5013.1675603285485, 5684.459976302244, 6074.453299203093, 6112.908306375497, 6152.200213972155, 4837.661363704648, 5840.620359676607, 5857.47282744555, 5869.413058694096, 5949.185498423022], "value": 4124.165537073367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.1075048684273, 719.6293908637051, 739.1278291615895, 788.562347896917, 832.2634468495384, 14127.576172714822, 14366.640833979156, 14665.706685866277, 14675.706485870276, 14740.410383584656, 12061.21602095863, 13878.583642490741, 13927.37326820293, 13957.651058723537, 14046.01677882546, 836.4939211776879, 847.4618617178105, 851.9914800852005, 873.9825203495926, 875.6453636277317, 867.5532100968006, 873.026575368466, 875.3347455933505, 875.6234819027816, 877.6708734224666, 931.3852857114306, 934.028610245344, 935.9672411465566, 936.6019441737268, 937.2970272295778, 919.7194855569048, 920.204023519654, 929.4330458420358, 930.02812061396, 933.5332333833084, 668.1481111582723, 670.8289386206535, 678.5318130489995, 681.0839420978775, 691.920429150644, 14405.351759170862, 14431.567052988426, 14446.205458699767, 14453.0, 14460.85539144616, 11740.823887641693, 14212.147271163763, 14417.423303067864, 14429.927850360786, 14522.927385363006, 11603.767924641545, 11904.345261010641, 11925.761484770343, 11927.582534611247, 12032.27806331623, 3734.589195188527, 3783.633123961032, 3847.057470919615, 3888.4556162137324, 3903.7852918089493, 86691.56654216752, 90611.0, 93177.60233596433, 94915.10169796566, 95571.52214238954, 10320.587176512856, 10839.0, 10981.890181098086, 11069.612563560398, 11128.109751219883, 17554.473365798793, 21392.78607213939, 21583.56832863334, 21662.458438538848, 21688.783112168992, 7986.520808751494, 8111.472754270953, 8141.1451797561585, 8246.0, 8250.876236856451, 4428.269335559661, 4526.456825180933, 4586.289125185534, 4638.397008388955, 4688.413948256468, 3044.6194225721783, 3515.3320869035315, 3625.836837342326, 3653.342398368319, 3653.8721144759807, 630.1555915073823, 631.6273398694792, 634.6287421858265, 652.3704625036862, 659.1924892007253, 552.7899398228648, 581.2385774635242, 588.6674029173589, 679.0934102972489, 683.0744341417408, 10219.254534582478, 10268.589256429808, 10384.273100883016, 10758.515866786014, 10985.0, 606.2755007765678, 619.9566030377921, 689.4449967775988, 690.6615758278508, 693.5214701855704, 4318.892027699333, 4335.891602709958, 4731.929021064687, 4869.975650121727, 5190.766415511311, 113911.0, 114587.0, 115602.42198788952, 116069.0, 118272.40863795798, 72036.0, 75713.24286757062, 85571.57214213889, 88255.55872220598, 101419.0, 88392.23215535653, 89534.55232723795, 92632.07367926235, 92663.0, 94096.0, 9770.560324785543, 10263.897361026295, 10333.741656458347, 10344.534495947852, 10374.792504150026, 36016.819915900254, 43501.56498435102, 52232.0, 53551.46448535465, 55906.44093559012, 72227.0, 73944.63027684827, 74960.0, 75963.62018189873, 80830.59584702039, 12984.976101727858, 13037.348132593143, 13369.384110387105, 13489.325533723471, 13504.594862154152, 13998.300084995506, 14279.357428915517, 14529.709405811613, 14530.709385812435, 14734.26328683583, 12878.356082195665, 13297.069205155547, 13968.231747253998, 13974.231417272147, 14065.578032659037, 14036.017478776388, 14149.36327865269, 14166.645833854236, 14783.852161478679, 14787.482438114614, 13470.93264533671, 13542.119762215425, 13649.931750341184, 13817.516386926409, 14214.076085054437, 10995.945020274847, 11204.775904482029, 11786.116041296766, 11907.940460297643, 12065.939670301943, 11400.714982125513, 11629.127815413709, 11716.70708232301, 11764.35296058725, 11766.941165294118], "value": 7588.662478390475, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 136.0, 140.0, 170.0, 119.0, 123.0, 102.0, 147.0, 171.0, 171.0], "value": 140.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 112.0, 145.0, 107.0, 111.0, 111.0, 110.0, 149.0, 141.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 200.0, 199.0, 189.0, 196.0, 195.0, 199.0, 196.0, 199.0, 195.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 67.0, 80.0, 107.0, 84.0, 62.0, 53.0, 80.0, 103.0, 82.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 89.0, 73.0, 72.0, 70.0, 85.0, 70.0, 67.0, 87.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 93.0, 91.0, 93.0, 91.0, 107.0, 91.0, 93.0, 89.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 97.0, 119.0, 125.0, 97.0, 97.0, 98.0, 98.0, 98.0, 98.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 86.0, 112.0, 89.0, 142.0, 146.0, 88.0, 87.0, 88.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 60.0, 61.0, 60.0, 60.0, 59.0, 59.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 75.0, 74.0, 72.0, 69.0, 68.0, 95.0, 58.0, 84.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 82.0, 84.0, 83.0, 82.0, 87.0, 85.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 139.0, 152.0, 143.0, 141.0, 130.0, 158.0, 199.0, 168.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 165.0, 162.0, 162.0, 160.0, 164.0, 165.0, 165.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 68.0, 65.0, 72.0, 65.0, 66.0, 68.0, 66.0, 67.0], "value": 66.7, "unit": "score"}]}]} 10:18:22 INFO - Return code: 0 10:18:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:22 ERROR - # TBPL SUCCESS # 10:18:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:22 INFO - 2017-01-30 10:18:22.532 screenresolution[1790:10638] starting screenresolution argv=screenresolution get 10:18:22 INFO - 2017-01-30 10:18:22.535 screenresolution[1790:10638] Display 0: 1600x1200x32@60 10:18:22 INFO - 2017-01-30 10:18:22.541 screenresolution[1791:10641] starting screenresolution argv=screenresolution list 10:18:22 INFO - Available Modes on Display 0 10:18:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:22 INFO - Intel Iris: 10:18:22 INFO - Chipset Model: Intel Iris 10:18:22 INFO - Type: GPU 10:18:22 INFO - Bus: Built-In 10:18:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:22 INFO - Vendor: Intel (0x8086) 10:18:22 INFO - Device ID: 0x0a2e 10:18:22 INFO - Revision ID: 0x0009 10:18:22 INFO - Displays: 10:18:22 INFO - Display: 10:18:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:22 INFO - Display Serial Number: 1600x1200 60 10:18:22 INFO - Main Display: Yes 10:18:22 INFO - Mirror: Off 10:18:22 INFO - Online: Yes 10:18:22 INFO - Rotation: Supported 10:18:22 INFO - Return code: 0 10:18:22 INFO - Running post-action listener: _resource_record_post_action 10:18:22 INFO - [mozharness: 2017-01-30 18:18:22.786898Z] Finished run-tests step (success) 10:18:22 INFO - Running post-run listener: _resource_record_post_run 10:18:22 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39430144; Write bytes: 501380096; Read time: 259; Write time: 1671 10:18:22 INFO - TinderboxPrint: CPU usage
54.2% 10:18:22 INFO - TinderboxPrint: I/O read bytes / time
39,430,144 / 259 10:18:22 INFO - TinderboxPrint: I/O write bytes / time
501,380,096 / 1,671 10:18:22 INFO - TinderboxPrint: CPU idle
2,191.2 (45.8%) 10:18:22 INFO - TinderboxPrint: CPU system
968.1 (20.2%) 10:18:22 INFO - TinderboxPrint: CPU user
1,626.3 (34.0%) 10:18:22 INFO - TinderboxPrint: Swap in / out
230,883,328 / 0 10:18:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 188611072; Write bytes: 187791360; Read time: 17731; Write time: 431 10:18:22 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37337088; Write bytes: 306408448; Read time: 237; Write time: 1211 10:18:23 INFO - Running post-run listener: _upload_blobber_files 10:18:23 INFO - Blob upload gear active. 10:18:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:23 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 10:18:23 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:23 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:24 INFO - (blobuploader) - INFO - Done attempting. 10:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:25 INFO - (blobuploader) - INFO - Done attempting. 10:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:28 INFO - (blobuploader) - INFO - Done attempting. 10:18:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:28 INFO - Return code: 0 10:18:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbd111a86bc32a498fe8194aafea61ddb32c2828837bff4cf105b3916eaad3d459c536d27ea4cb561296e1ca8009195e8a6cd0ae26b0a806144d8ff687a33269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79bfd81512a0741d22b0fbc576eeb83af5057cb47195df360a1a270dd6d919f191c556859f44d1d0b2ee9eddb1bed8a1d318e9cb949fed9c00b02769ba29a79a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c33de83c46162b2438e85f626baf26b58bd65ee92d5c2aa8faa8a0392224c5189ce9d8856426f178287b15884c8ed8122317b5cc5dcee1ec5a04fb73b7fbd7"} 10:18:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:28 INFO - Contents: 10:18:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbd111a86bc32a498fe8194aafea61ddb32c2828837bff4cf105b3916eaad3d459c536d27ea4cb561296e1ca8009195e8a6cd0ae26b0a806144d8ff687a33269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79bfd81512a0741d22b0fbc576eeb83af5057cb47195df360a1a270dd6d919f191c556859f44d1d0b2ee9eddb1bed8a1d318e9cb949fed9c00b02769ba29a79a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c33de83c46162b2438e85f626baf26b58bd65ee92d5c2aa8faa8a0392224c5189ce9d8856426f178287b15884c8ed8122317b5cc5dcee1ec5a04fb73b7fbd7"} 10:18:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:28 INFO - Copying logs to upload dir... 10:18:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.759315 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-30 10:18:28.616813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 10:18:28.620775) ========= 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.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbd111a86bc32a498fe8194aafea61ddb32c2828837bff4cf105b3916eaad3d459c536d27ea4cb561296e1ca8009195e8a6cd0ae26b0a806144d8ff687a33269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79bfd81512a0741d22b0fbc576eeb83af5057cb47195df360a1a270dd6d919f191c556859f44d1d0b2ee9eddb1bed8a1d318e9cb949fed9c00b02769ba29a79a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c33de83c46162b2438e85f626baf26b58bd65ee92d5c2aa8faa8a0392224c5189ce9d8856426f178287b15884c8ed8122317b5cc5dcee1ec5a04fb73b7fbd7"} build_url:https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010499 build_url: 'https://queue.taskcluster.net/v1/task/BVfSx08xTtupjOs-SCvIjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbd111a86bc32a498fe8194aafea61ddb32c2828837bff4cf105b3916eaad3d459c536d27ea4cb561296e1ca8009195e8a6cd0ae26b0a806144d8ff687a33269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79bfd81512a0741d22b0fbc576eeb83af5057cb47195df360a1a270dd6d919f191c556859f44d1d0b2ee9eddb1bed8a1d318e9cb949fed9c00b02769ba29a79a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c33de83c46162b2438e85f626baf26b58bd65ee92d5c2aa8faa8a0392224c5189ce9d8856426f178287b15884c8ed8122317b5cc5dcee1ec5a04fb73b7fbd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 10:18:28.654495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:18:28.654821) ========= 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.arLMfymaD1/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.Qghq1a6GwY/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005115 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:18:28.703295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 10:18:28.703622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 10:18:28.703968) ========= ========= Total master_lag: 0.46 =========