builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1475901294.08 results: success (0) buildid: 20161007195722 builduid: 0b0c430461154a90bfed7b3b36f43c5f revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.080847) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.081245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.081518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.105676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.106027) ========= 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.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-07 21:34:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-10-07 21:34:54 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.248537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.251901) ========= 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.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.026711 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:54.300507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:34:54.303891) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-07 21:34:54,380 truncating revision to first 12 chars 2016-10-07 21:34:54,380 Setting DEBUG logging. 2016-10-07 21:34:54,380 attempt 1/10 2016-10-07 21:34:54,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efa3b654aa77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 21:34:55,887 unpacking tar archive at: mozilla-central-efa3b654aa77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.771557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:34:56.096523) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:56.096853) ========= script_repo_revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:56.097226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:56.097487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:56.115550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-10-07 21:34:56.115941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:34:56 INFO - MultiFileLogger online at 20161007 21:34:56 in /builds/slave/test 21:34:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:34:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:56 INFO - {'append_to_log': False, 21:34:56 INFO - 'base_work_dir': '/builds/slave/test', 21:34:56 INFO - 'blob_upload_branch': 'Firefox', 21:34:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:56 INFO - 'branch': 'Firefox', 21:34:56 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:56 INFO - 'config_files': ('talos/mac_config.py',), 21:34:56 INFO - 'default_actions': ('clobber', 21:34:56 INFO - 'read-buildbot-config', 21:34:56 INFO - 'download-and-extract', 21:34:56 INFO - 'populate-webroot', 21:34:56 INFO - 'create-virtualenv', 21:34:56 INFO - 'install', 21:34:56 INFO - 'run-tests'), 21:34:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:56 INFO - 'download_minidump_stackwalk': True, 21:34:56 INFO - 'download_symbols': 'ondemand', 21:34:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:56 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:56 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:56 INFO - 'installer_path': 'installer.exe', 21:34:56 INFO - 'log_level': 'info', 21:34:56 INFO - 'log_name': 'talos', 21:34:56 INFO - 'log_to_console': True, 21:34:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:34:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:34:56 INFO - 'opt_config_files': (), 21:34:56 INFO - 'pip_index': False, 21:34:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:34:56 INFO - 'cmd': ('bash', 21:34:56 INFO - '-c', 21:34:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:34:56 INFO - 'enabled': True, 21:34:56 INFO - 'halt_on_failure': False, 21:34:56 INFO - 'name': 'check_screen_resolution'},), 21:34:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:34:56 INFO - 'cmd': ('bash', 21:34:56 INFO - '-c', 21:34:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:34:56 INFO - 'enabled': True, 21:34:56 INFO - 'halt_on_failure': False, 21:34:56 INFO - 'name': 'check_screen_resolution'},), 21:34:56 INFO - 'run_cmd_checks_enabled': True, 21:34:56 INFO - 'sps_profile': False, 21:34:56 INFO - 'sps_profile_interval': 0, 21:34:56 INFO - 'suite': 'dromaeojs-e10s', 21:34:56 INFO - 'system_bits': '32', 21:34:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:56 INFO - 'title': 't-yosemite-r7-0312', 21:34:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:56 INFO - 'use_talos_json': True, 21:34:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:56 INFO - 'work_dir': 'build'} 21:34:56 INFO - [mozharness: 2016-10-08 04:34:56.314825Z] Running clobber step. 21:34:56 INFO - Running pre-action listener: _resource_record_pre_action 21:34:56 INFO - Running main action method: clobber 21:34:56 INFO - rmtree: /builds/slave/test/build 21:34:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:58 INFO - Running post-action listener: _resource_record_post_action 21:34:58 INFO - [mozharness: 2016-10-08 04:34:58.469350Z] Finished clobber step (success) 21:34:58 INFO - [mozharness: 2016-10-08 04:34:58.469602Z] Running read-buildbot-config step. 21:34:58 INFO - Running pre-action listener: _resource_record_pre_action 21:34:58 INFO - Running main action method: read_buildbot_config 21:34:58 INFO - Using buildbot properties: 21:34:58 INFO - { 21:34:58 INFO - "project": "", 21:34:58 INFO - "product": "firefox", 21:34:58 INFO - "script_repo_revision": "production", 21:34:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:34:58 INFO - "repository": "", 21:34:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:34:58 INFO - "buildid": "20161007195722", 21:34:58 INFO - "pgo_build": "False", 21:34:58 INFO - "basedir": "/builds/slave/test", 21:34:58 INFO - "buildnumber": 45, 21:34:58 INFO - "slavename": "t-yosemite-r7-0312", 21:34:58 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:34:58 INFO - "platform": "yosemite_r7", 21:34:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:34:58 INFO - "branch": "mozilla-central", 21:34:58 INFO - "repo_path": "mozilla-central", 21:34:58 INFO - "revision": "efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6", 21:34:58 INFO - "stage_platform": "macosx64", 21:34:58 INFO - "builduid": "0b0c430461154a90bfed7b3b36f43c5f", 21:34:58 INFO - "slavebuilddir": "test" 21:34:58 INFO - } 21:34:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:34:58 INFO - Running post-action listener: _resource_record_post_action 21:34:58 INFO - [mozharness: 2016-10-08 04:34:58.475144Z] Finished read-buildbot-config step (success) 21:34:58 INFO - [mozharness: 2016-10-08 04:34:58.475386Z] Running download-and-extract step. 21:34:58 INFO - Running pre-action listener: _resource_record_pre_action 21:34:58 INFO - Running main action method: download_and_extract 21:34:58 INFO - mkdir: /builds/slave/test/build/tests 21:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:58 INFO - trying https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:34:58 INFO - Downloading https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:34:59 INFO - Downloaded 1199 bytes. 21:34:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:34:59 INFO - Using the following test package requirements: 21:34:59 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:34:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:34:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:34:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'jsshell-mac.zip'], 21:34:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:34:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:34:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:34:59 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:34:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:34:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:59 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:34:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:34:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:34:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:34:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:35:10 INFO - Http code: 200 21:35:10 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 21:35:10 INFO - x-amz-cf-id: eRaXKzm1muqAxd1N9Ry-HbIG3WNNuWwqWUn5rrBdVc5FDLGSf-Mnrg== 21:35:10 INFO - x-amz-version-id: Bs66FhjIm4hi_.9woYF5Lk1yW_uXq6pN 21:35:11 INFO - Expected file size: 16483145 21:35:11 INFO - Obtained file size: 16483145 21:35:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:35:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:35:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:35:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:35:18 INFO - Http code: 200 21:35:18 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 21:35:18 INFO - x-amz-cf-id: 0gXNpjAYhNA_7v1twYPuWPnBkASHk0w0Bns5mXJeBn8BCEr_NAqrLw== 21:35:18 INFO - x-amz-version-id: Bs66FhjIm4hi_.9woYF5Lk1yW_uXq6pN 21:35:19 INFO - Expected file size: 16483145 21:35:19 INFO - Obtained file size: 16483145 21:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:35:25 INFO - Http code: 200 21:35:25 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 21:35:25 INFO - x-amz-cf-id: t2OQSUOfi6WxBNaAGLungnTn3AZ_PuYshaqZnKKA072TDX3y9cRnxA== 21:35:25 INFO - x-amz-version-id: qMvNjkGUe0djLmp042lgZ_4N.m4Grecv 21:35:26 INFO - Expected file size: 14409006 21:35:26 INFO - Obtained file size: 14409006 21:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:26 INFO - trying https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:26 INFO - Downloading https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:35:29 INFO - Downloaded 111651942 bytes. 21:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:29 INFO - mkdir: /builds/slave/test/properties 21:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:29 INFO - Contents: 21:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:30 INFO - Running post-action listener: _resource_record_post_action 21:35:30 INFO - Running post-action listener: set_extra_try_arguments 21:35:30 INFO - [mozharness: 2016-10-08 04:35:30.020174Z] Finished download-and-extract step (success) 21:35:30 INFO - [mozharness: 2016-10-08 04:35:30.020342Z] Running populate-webroot step. 21:35:30 INFO - Running pre-action listener: _resource_record_pre_action 21:35:30 INFO - Running main action method: populate_webroot 21:35:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:35:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:35:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:35:30 INFO - '--tppagecycles', 21:35:30 INFO - '7'], 21:35:30 INFO - 'tests': ['tsvgm']}}, 21:35:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:35:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:35:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['damp', 'tps']}, 21:35:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'tests': ['damp', 'tps']}, 21:35:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['dromaeo_dom']}, 21:35:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['basic_compositor_video']}, 21:35:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:35:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['a11yr', 21:35:30 INFO - 'ts_paint', 21:35:30 INFO - 'tpaint', 21:35:30 INFO - 'sessionrestore', 21:35:30 INFO - 'sessionrestore_no_auto_restore', 21:35:30 INFO - 'tabpaint']}, 21:35:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['tsvgx', 21:35:30 INFO - 'tsvgr_opacity', 21:35:30 INFO - 'tart', 21:35:30 INFO - 'tscrollx', 21:35:30 INFO - 'cart']}, 21:35:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:30 INFO - 'tsvgr_opacity', 21:35:30 INFO - 'tart', 21:35:30 INFO - 'tscrollx', 21:35:30 INFO - 'cart']}, 21:35:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'talos_options': ['--disable-e10s'], 21:35:30 INFO - 'tests': ['tp5o']}, 21:35:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'tests': ['tp5o']}, 21:35:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'talos_options': ['--disable-e10s', 21:35:30 INFO - '--xperf_path', 21:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:30 INFO - 'tests': ['tp5n']}, 21:35:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:30 INFO - 'talos_options': ['--xperf_path', 21:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:30 INFO - 'tests': ['tp5n']}}, 21:35:30 INFO - 'talos.zip': {'path': '', 21:35:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:35:30 INFO - Running post-action listener: _resource_record_post_action 21:35:30 INFO - [mozharness: 2016-10-08 04:35:30.039443Z] Finished populate-webroot step (success) 21:35:30 INFO - [mozharness: 2016-10-08 04:35:30.039573Z] Running create-virtualenv step. 21:35:30 INFO - Running pre-action listener: _resource_record_pre_action 21:35:30 INFO - Running main action method: create_virtualenv 21:35:30 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:30 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 21:35:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:35:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:30 INFO - Using real prefix '/tools/python27' 21:35:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:30 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:33 INFO - Installing pip.................done. 21:35:33 INFO - Return code: 0 21:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:34 INFO - Reading from file tmpfile_stdout 21:35:34 INFO - Output received: 21:35:34 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) 21:35:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:34 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 21:35:34 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 21:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:34 INFO - 'HOME': '/Users/cltbld', 21:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:34 INFO - 'LOGNAME': 'cltbld', 21:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:34 INFO - 'MOZ_NO_REMOTE': '1', 21:35:34 INFO - 'NO_EM_RESTART': '1', 21:35:34 INFO - 'PAGER': '/bin/cat', 21:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:34 INFO - 'PWD': '/builds/slave/test', 21:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:34 INFO - 'SHELL': '/bin/bash', 21:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:34 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:34 INFO - 'USER': 'cltbld', 21:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:34 INFO - 'XPC_FLAGS': '0x0', 21:35:34 INFO - 'XPC_SERVICE_NAME': '0', 21:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:34 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 21:35:34 INFO - Cleaning up... 21:35:34 INFO - Return code: 0 21:35:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:34 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:34 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 21:35:34 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 21:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:34 INFO - 'HOME': '/Users/cltbld', 21:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:34 INFO - 'LOGNAME': 'cltbld', 21:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:34 INFO - 'MOZ_NO_REMOTE': '1', 21:35:34 INFO - 'NO_EM_RESTART': '1', 21:35:34 INFO - 'PAGER': '/bin/cat', 21:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:34 INFO - 'PWD': '/builds/slave/test', 21:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:34 INFO - 'SHELL': '/bin/bash', 21:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:34 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:34 INFO - 'USER': 'cltbld', 21:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:34 INFO - 'XPC_FLAGS': '0x0', 21:35:34 INFO - 'XPC_SERVICE_NAME': '0', 21:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:34 INFO - Downloading/unpacking psutil>=3.1.1 21:35:34 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 21:35:34 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 21:35:34 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 21:35:34 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 21:35:34 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 21:35:34 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 21:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:37 INFO - Installing collected packages: psutil 21:35:37 INFO - Running setup.py install for psutil 21:35:37 INFO - building 'psutil._psutil_osx' extension 21:35:37 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 21:35:38 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 21:35:38 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 21:35:38 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 21:35:38 INFO - building 'psutil._psutil_posix' extension 21:35:38 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 21:35:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:35:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:35:38 INFO - ^ 21:35:38 INFO - 1 warning generated. 21:35:38 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 21:35:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:38 INFO - Successfully installed psutil 21:35:38 INFO - Cleaning up... 21:35:38 INFO - Return code: 0 21:35:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:38 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')]} 21:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:38 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')]} 21:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:38 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:38 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 21:35:38 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 21:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:38 INFO - 'HOME': '/Users/cltbld', 21:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:38 INFO - 'LOGNAME': 'cltbld', 21:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:38 INFO - 'MOZ_NO_REMOTE': '1', 21:35:38 INFO - 'NO_EM_RESTART': '1', 21:35:38 INFO - 'PAGER': '/bin/cat', 21:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:38 INFO - 'PWD': '/builds/slave/test', 21:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:38 INFO - 'SHELL': '/bin/bash', 21:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:38 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:38 INFO - 'USER': 'cltbld', 21:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:38 INFO - 'XPC_FLAGS': '0x0', 21:35:38 INFO - 'XPC_SERVICE_NAME': '0', 21:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:39 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 21:35:39 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 21:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:41 INFO - Installing collected packages: mozsystemmonitor 21:35:41 INFO - Running setup.py install for mozsystemmonitor 21:35:41 INFO - Successfully installed mozsystemmonitor 21:35:41 INFO - Cleaning up... 21:35:42 INFO - Return code: 0 21:35:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:42 INFO - 'HOME': '/Users/cltbld', 21:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:42 INFO - 'LOGNAME': 'cltbld', 21:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:42 INFO - 'MOZ_NO_REMOTE': '1', 21:35:42 INFO - 'NO_EM_RESTART': '1', 21:35:42 INFO - 'PAGER': '/bin/cat', 21:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:42 INFO - 'PWD': '/builds/slave/test', 21:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:42 INFO - 'SHELL': '/bin/bash', 21:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:42 INFO - 'USER': 'cltbld', 21:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:42 INFO - 'XPC_FLAGS': '0x0', 21:35:42 INFO - 'XPC_SERVICE_NAME': '0', 21:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:42 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:44 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 21:35:44 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 21:35:44 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 21:35:44 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 21:35:44 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 21:35:44 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 21:35:45 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:45 INFO - warning: no files found matching '*.txt' 21:35:45 INFO - no previously-included directories found matching 'build' 21:35:45 INFO - no previously-included directories found matching 'dist' 21:35:45 INFO - no previously-included directories found matching '.git*' 21:35:45 INFO - Installing collected packages: jsonschema, functools32 21:35:45 INFO - Running setup.py install for functools32 21:35:45 INFO - warning: no files found matching '*.txt' 21:35:45 INFO - no previously-included directories found matching 'build' 21:35:45 INFO - no previously-included directories found matching 'dist' 21:35:45 INFO - no previously-included directories found matching '.git*' 21:35:45 INFO - Successfully installed jsonschema functools32 21:35:45 INFO - Cleaning up... 21:35:45 INFO - Return code: 0 21:35:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:45 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')]} 21:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:45 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')]} 21:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:45 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:45 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 21:35:45 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 21:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:45 INFO - 'HOME': '/Users/cltbld', 21:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:45 INFO - 'LOGNAME': 'cltbld', 21:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:45 INFO - 'MOZ_NO_REMOTE': '1', 21:35:45 INFO - 'NO_EM_RESTART': '1', 21:35:45 INFO - 'PAGER': '/bin/cat', 21:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:45 INFO - 'PWD': '/builds/slave/test', 21:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:45 INFO - 'SHELL': '/bin/bash', 21:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:45 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:45 INFO - 'USER': 'cltbld', 21:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:45 INFO - 'XPC_FLAGS': '0x0', 21:35:45 INFO - 'XPC_SERVICE_NAME': '0', 21:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:45 INFO - Cleaning up... 21:35:45 INFO - Return code: 0 21:35:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:45 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')]} 21:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:45 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')]} 21:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:45 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:45 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 21:35:45 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 21:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:45 INFO - 'HOME': '/Users/cltbld', 21:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:45 INFO - 'LOGNAME': 'cltbld', 21:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:45 INFO - 'MOZ_NO_REMOTE': '1', 21:35:45 INFO - 'NO_EM_RESTART': '1', 21:35:45 INFO - 'PAGER': '/bin/cat', 21:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:45 INFO - 'PWD': '/builds/slave/test', 21:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:45 INFO - 'SHELL': '/bin/bash', 21:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:45 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:45 INFO - 'USER': 'cltbld', 21:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:45 INFO - 'XPC_FLAGS': '0x0', 21:35:45 INFO - 'XPC_SERVICE_NAME': '0', 21:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:46 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:46 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 21:35:46 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 21:35:46 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 21:35:46 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 21:35:46 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 21:35:46 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 21:35:49 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:49 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 21:35:49 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 21:35:49 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 21:35:49 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 21:35:49 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 21:35:49 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 21:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:50 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 21:35:50 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 21:35:50 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 21:35:50 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 21:35:50 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 21:35:50 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 21:35:50 INFO - Downloading docopt-0.6.1.tar.gz 21:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:50 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:50 INFO - Running setup.py install for blobuploader 21:35:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:51 INFO - Running setup.py install for requests 21:35:51 INFO - Running setup.py install for docopt 21:35:51 INFO - Successfully installed blobuploader requests docopt 21:35:51 INFO - Cleaning up... 21:35:51 INFO - Return code: 0 21:35:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:52 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')]} 21:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:52 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:52 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 21:35:52 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 21:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:52 INFO - 'HOME': '/Users/cltbld', 21:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:52 INFO - 'LOGNAME': 'cltbld', 21:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:52 INFO - 'MOZ_NO_REMOTE': '1', 21:35:52 INFO - 'NO_EM_RESTART': '1', 21:35:52 INFO - 'PAGER': '/bin/cat', 21:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:52 INFO - 'PWD': '/builds/slave/test', 21:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:52 INFO - 'SHELL': '/bin/bash', 21:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:52 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:52 INFO - 'USER': 'cltbld', 21:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:52 INFO - 'XPC_FLAGS': '0x0', 21:35:52 INFO - 'XPC_SERVICE_NAME': '0', 21:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:52 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3VDuML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:52 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-DfMmq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ErMdAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-R_2Goi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ysx41m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KiwRe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lcDxLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tchnTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Iv_S43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZMyAcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:53 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-U2A63X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-M1GRzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wbr8JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-s9mmbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Fu0QAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-7otv76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1QXal0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:54 INFO - Running setup.py install for manifestparser 21:35:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:54 INFO - Running setup.py install for mozcrash 21:35:54 INFO - Running setup.py install for mozdebug 21:35:55 INFO - Running setup.py install for mozdevice 21:35:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Running setup.py install for mozfile 21:35:55 INFO - Running setup.py install for mozhttpd 21:35:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Running setup.py install for mozinfo 21:35:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Running setup.py install for mozInstall 21:35:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:55 INFO - Running setup.py install for mozleak 21:35:55 INFO - Running setup.py install for mozlog 21:35:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Running setup.py install for moznetwork 21:35:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Running setup.py install for mozprocess 21:35:56 INFO - Running setup.py install for mozprofile 21:35:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Running setup.py install for mozrunner 21:35:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:56 INFO - Running setup.py install for mozscreenshot 21:35:56 INFO - Running setup.py install for moztest 21:35:57 INFO - Running setup.py install for mozversion 21:35:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:57 INFO - Cleaning up... 21:35:57 INFO - Return code: 0 21:35:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:57 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:35:57 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 21:35:57 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 21:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:57 INFO - 'HOME': '/Users/cltbld', 21:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:57 INFO - 'LOGNAME': 'cltbld', 21:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:57 INFO - 'MOZ_NO_REMOTE': '1', 21:35:57 INFO - 'NO_EM_RESTART': '1', 21:35:57 INFO - 'PAGER': '/bin/cat', 21:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:57 INFO - 'PWD': '/builds/slave/test', 21:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:57 INFO - 'SHELL': '/bin/bash', 21:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:35:57 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:57 INFO - 'USER': 'cltbld', 21:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:57 INFO - 'XPC_FLAGS': '0x0', 21:35:57 INFO - 'XPC_SERVICE_NAME': '0', 21:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:57 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-a0sxJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:57 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)) 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:57 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-pH1bev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Lg6WC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZxluBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2NeGz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-idLvTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2nODBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Xg2Nu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tXImiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nWAnCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:58 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)) 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:58 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0oSWPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:59 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)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Yb2Z7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:59 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)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Y0F_6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:59 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)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9DV8kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KYwu4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:59 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)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-dzS8M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UyqyVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:59 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)) 21:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:59 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)) 21:35:59 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)) 21:35:59 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)) 21:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:02 INFO - Downloading blessings-1.6.tar.gz 21:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:36:02 INFO - Installing collected packages: blessings 21:36:02 INFO - Running setup.py install for blessings 21:36:02 INFO - Successfully installed blessings 21:36:02 INFO - Cleaning up... 21:36:02 INFO - Return code: 0 21:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:03 INFO - Reading from file tmpfile_stdout 21:36:03 INFO - Current package versions: 21:36:03 INFO - blessings == 1.6 21:36:03 INFO - blobuploader == 1.2.4 21:36:03 INFO - docopt == 0.6.1 21:36:03 INFO - functools32 == 3.2.3-2 21:36:03 INFO - jsonschema == 2.5.1 21:36:03 INFO - manifestparser == 1.1 21:36:03 INFO - mozInstall == 1.12 21:36:03 INFO - mozcrash == 0.17 21:36:03 INFO - mozdebug == 0.1 21:36:03 INFO - mozdevice == 0.48 21:36:03 INFO - mozfile == 1.2 21:36:03 INFO - mozhttpd == 0.7 21:36:03 INFO - mozinfo == 0.9 21:36:03 INFO - mozleak == 0.1 21:36:03 INFO - mozlog == 3.4 21:36:03 INFO - moznetwork == 0.27 21:36:03 INFO - mozprocess == 0.23 21:36:03 INFO - mozprofile == 0.28 21:36:03 INFO - mozrunner == 6.12 21:36:03 INFO - mozscreenshot == 0.1 21:36:03 INFO - mozsystemmonitor == 0.3 21:36:03 INFO - moztest == 0.7 21:36:03 INFO - mozversion == 1.4 21:36:03 INFO - psutil == 3.1.1 21:36:03 INFO - requests == 1.2.3 21:36:03 INFO - wsgiref == 0.1.2 21:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:03 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')]} 21:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:03 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')]} 21:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:03 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:36:03 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 21:36:03 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 21:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:03 INFO - 'HOME': '/Users/cltbld', 21:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:03 INFO - 'LOGNAME': 'cltbld', 21:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:03 INFO - 'MOZ_NO_REMOTE': '1', 21:36:03 INFO - 'NO_EM_RESTART': '1', 21:36:03 INFO - 'PAGER': '/bin/cat', 21:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:03 INFO - 'PWD': '/builds/slave/test', 21:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:03 INFO - 'SHELL': '/bin/bash', 21:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:36:03 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:03 INFO - 'USER': 'cltbld', 21:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:03 INFO - 'XPC_FLAGS': '0x0', 21:36:03 INFO - 'XPC_SERVICE_NAME': '0', 21:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 INFO - Cleaning up... 21:36:03 INFO - Return code: 0 21:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:36:03 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')]} 21:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:03 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')]} 21:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:03 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 0x10b9bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b933570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90d248ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, '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.TZh8bkXmq8/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.jTuAREaJVR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 21:36:03 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 21:36:03 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 21:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:03 INFO - 'HOME': '/Users/cltbld', 21:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:03 INFO - 'LOGNAME': 'cltbld', 21:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:03 INFO - 'MOZ_NO_REMOTE': '1', 21:36:03 INFO - 'NO_EM_RESTART': '1', 21:36:03 INFO - 'PAGER': '/bin/cat', 21:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:03 INFO - 'PWD': '/builds/slave/test', 21:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:03 INFO - 'SHELL': '/bin/bash', 21:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:36:03 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:03 INFO - 'USER': 'cltbld', 21:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:03 INFO - 'XPC_FLAGS': '0x0', 21:36:03 INFO - 'XPC_SERVICE_NAME': '0', 21:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:36:03 INFO - Cleaning up... 21:36:03 INFO - Return code: 0 21:36:03 INFO - Running post-action listener: _resource_record_post_action 21:36:03 INFO - Running post-action listener: _start_resource_monitoring 21:36:03 INFO - Starting resource monitoring. 21:36:03 INFO - [mozharness: 2016-10-08 04:36:03.724116Z] Finished create-virtualenv step (success) 21:36:03 INFO - [mozharness: 2016-10-08 04:36:03.724942Z] Running install step. 21:36:03 INFO - Running pre-action listener: _resource_record_pre_action 21:36:03 INFO - Running main action method: install 21:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:03 INFO - Reading from file tmpfile_stdout 21:36:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:36:04 INFO - Reading from file tmpfile_stdout 21:36:04 INFO - Output received: 21:36:04 INFO - Usage: mozinstall [options] installer 21:36:04 INFO - Options: 21:36:04 INFO - -h, --help show this help message and exit 21:36:04 INFO - -d DEST, --destination=DEST 21:36:04 INFO - Directory to install application into. [default: 21:36:04 INFO - "/builds/slave/test"] 21:36:04 INFO - --app=APP Application being installed. [default: firefox] 21:36:04 INFO - mkdir: /builds/slave/test/build/application 21:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:36:38 INFO - Reading from file tmpfile_stdout 21:36:38 INFO - Output received: 21:36:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:36:38 INFO - Running post-action listener: _resource_record_post_action 21:36:38 INFO - [mozharness: 2016-10-08 04:36:38.940396Z] Finished install step (success) 21:36:38 INFO - [mozharness: 2016-10-08 04:36:38.940522Z] Running run-tests step. 21:36:38 INFO - Running pre-action listener: _resource_record_pre_action 21:36:38 INFO - Running main action method: run_tests 21:36:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:38 INFO - 2016-10-07 21:36:38.955 screenresolution[1641:7564] starting screenresolution argv=screenresolution get 21:36:38 INFO - 2016-10-07 21:36:38.957 screenresolution[1641:7564] Display 0: 1600x1200x32@60 21:36:38 INFO - 2016-10-07 21:36:38.964 screenresolution[1642:7566] starting screenresolution argv=screenresolution list 21:36:38 INFO - Available Modes on Display 0 21:36:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:39 INFO - Intel Iris: 21:36:39 INFO - Chipset Model: Intel Iris 21:36:39 INFO - Type: GPU 21:36:39 INFO - Bus: Built-In 21:36:39 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:39 INFO - Vendor: Intel (0x8086) 21:36:39 INFO - Device ID: 0x0a2e 21:36:39 INFO - Revision ID: 0x0009 21:36:39 INFO - Displays: 21:36:39 INFO - Display: 21:36:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:39 INFO - Display Serial Number: 1600x1200 60 21:36:39 INFO - Main Display: Yes 21:36:39 INFO - Mirror: Off 21:36:39 INFO - Online: Yes 21:36:39 INFO - Rotation: Supported 21:36:39 INFO - Return code: 0 21:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:36:39 INFO - Python 2.7.3 21:36:39 INFO - Return code: 0 21:36:39 INFO - grabbing minidump binary from tooltool 21:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:39 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 0x10b7d1d30>, '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 0x10b5f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:36:39 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 21:36:39 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 21:36:39 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 21:36:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:36:39 INFO - Return code: 0 21:36:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:36:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:36:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:36:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:36:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 21:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 21:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZh8bkXmq8/Render', 21:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:39 INFO - 'HOME': '/Users/cltbld', 21:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:39 INFO - 'LOGNAME': 'cltbld', 21:36:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:39 INFO - 'MOZ_NO_REMOTE': '1', 21:36:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:39 INFO - 'NO_EM_RESTART': '1', 21:36:39 INFO - 'PAGER': '/bin/cat', 21:36:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:39 INFO - 'PWD': '/builds/slave/test', 21:36:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:39 INFO - 'SHELL': '/bin/bash', 21:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTuAREaJVR/Listeners', 21:36:39 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 21:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:39 INFO - 'USER': 'cltbld', 21:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:39 INFO - 'XPC_FLAGS': '0x0', 21:36:39 INFO - 'XPC_SERVICE_NAME': '0', 21:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 21:36:39 INFO - mozversion application_buildid: 20161007195722 21:36:39 INFO - mozversion application_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:36:39 INFO - mozversion application_display_name: Nightly 21:36:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:36:39 INFO - mozversion application_name: Firefox 21:36:39 INFO - mozversion application_remotingname: firefox 21:36:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:36:39 INFO - mozversion application_vendor: Mozilla 21:36:39 INFO - mozversion application_version: 52.0a1 21:36:39 INFO - mozversion platform_buildid: 20161007195722 21:36:39 INFO - mozversion platform_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:36:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:36:39 INFO - mozversion platform_version: 52.0a1 21:36:39 INFO - using testdate: 1475901399 21:36:39 INFO - actual date: 1475901399 21:36:39 INFO - starting webserver on 'localhost:49267' 21:36:39 INFO - SUITE-START | Running 2 tests 21:36:39 INFO - TEST-START | dromaeo_css 21:36:39 INFO - operating with platform_type : mac_ 21:36:39 INFO - Initialising browser for dromaeo_css test... 21:36:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpZUAUBO/profile http://localhost:49267/getInfo.html) 21:36:42 INFO - PROCESS | 1652 | 2016-10-07 21:36:42.579 plugin-container[1654:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3b, name = 'com.apple.tsm.portname' 21:36:42 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:36:42 INFO - PROCESS | 1652 | 2016-10-07 21:36:42.582 plugin-container[1654:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 21:36:42 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:36:42 INFO - PROCESS | 1652 | 2016-10-07 21:36:42.582 plugin-container[1654:7716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:36:42 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:36:42 INFO - PROCESS | 1652 | colorDepth:24 21:36:42 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:36:42 INFO - PROCESS | 1652 | __metrics 21:36:42 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:36:43 INFO - TEST-INFO | 1652: exit 0 21:36:43 INFO - Browser initialized. 21:36:43 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:43 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpZUAUBO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:45 INFO - PROCESS | 1655 | 2016-10-07 21:36:45.615 plugin-container[1656:7836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.tsm.portname' 21:36:45 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:36:45 INFO - PROCESS | 1655 | 2016-10-07 21:36:45.620 plugin-container[1656:7836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 21:36:45 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:36:45 INFO - PROCESS | 1655 | 2016-10-07 21:36:45.620 plugin-container[1656:7836] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:36:55 INFO - PROCESS | 1655 | RSS: Main: 239448064 21:36:55 INFO - PROCESS | 1655 | 21:37:44 INFO - PROCESS | 1655 | 1475901464982 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:39:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 21:39:59 INFO - PROCESS | 1655 | RSS: Main: 252522496 21:39:59 INFO - PROCESS | 1655 | 21:43:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 21:43:02 INFO - PROCESS | 1655 | RSS: Main: 264818688 21:43:02 INFO - PROCESS | 1655 | 21:46:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 21:46:04 INFO - PROCESS | 1655 | RSS: Main: 269479936 21:46:04 INFO - PROCESS | 1655 | 21:49:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 21:49:07 INFO - PROCESS | 1655 | RSS: Main: 270180352 21:49:07 INFO - PROCESS | 1655 | 21:52:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 21:52:11 INFO - PROCESS | 1655 | RSS: Main: 275542016 21:52:11 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 21:55:13 INFO - PROCESS | 1655 | RSS: Main: 278302720 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | __start_tp_report 21:55:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 21:55:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 21:55:13 INFO - PROCESS | 1655 | |i|pagename|runs| 21:55:13 INFO - PROCESS | 1655 | |0;dojo.html;2793.3156376687703;3391.5082313064604;3411.044907425922;3431.227973705918;3434.8626054957804;4547.931781023287;5607.243022192003;5712.4573165549255;5724.542036637069;5776.220210271623;4540.7502587357685;5633.6338138021;5657.547396208303;5722.828315150542;5758;4339.457567804025;4415.403920470743;4590.334401511779;5197.194434862593;5201.895962080756;4261;4480.619147372461;5123.51326623972;5386.461353864602;5427.592930530206;4110.506739191286;5199.064168449678;5292.841214763564;5308.309919710451;5414.269073675043;4258.723182993095;5171.198464238011;5200.843974680765;5289.761960711778;5319.388270348921;5181.35233095863;5206.895862082775;5219.582433405319;5231.764570594332;5243.685378877241;5657.971710141423;5693.259876216065;5767.711614419262;5816.214811000503;5817.621854579481;6117.66352850593;6146.139540464339;6172.660503672296;6177.073438984144;6260.436560709558;6231.719572619198;6243.469305109071;6244.9687751561405;6252.406021427957;6277.403646653561;5867.207926929853;5883.764649413975;5891.764329426818;5900.1149827526215;5948.048312270016;5390.811321603804;6105.975331700744;6167.537434692416;6181.134641150243;6265.248170219512;6185.948388773919;6197.101420294122;6197.845053873599;6218.720157592919;6240.251169859555;6253.1245625612455;6285.308616052231;6297.338779428185;6302.1492098566105;6318.147050148263;6107.84730381744;6111.40942266768;6123.418275263843;6163.260408750979;6213.5339849511465;6198.659073750897;6235.906461403082;6245.406686364788;6251.937480625226;6261.499080073583;4155.792210389468;4930.235813448921;4931.580815630711;4937.136001199848;4963.70217786934;3172.0483854843455;4317.784110794448;4362.345648152803;4392.714473559208;4426.690131690751;5875.41245875409;5921.526277897758;5928.584999050025;5939.46544810969;5970.104484327386;5247.632665713363;6244.968775156095;6245.437910588069;6266.937330626635;6269.905951410732;5720.685362305113;5814.592978491465;5836.328822185418;5885.61743486672;5910.615809972338;5406.648567843156;5458.945410545924;5470.617056806065;5502.752376143083;5505.944940550623;6396.680165991775;6403.519736019724;6430.614163150132;6440.420362167428;6667.833304167435;6128.900367973304;6218.347073557211;6268.153799237045;6268.153799237227;6285.214348206474;6329.968350158219;6342.334054924167;6362.23653161605;6453.193350831146;6465.482761379172;4796.9280460792415;5010.423801262901;5128.333316668809;5932.792352267823;6251.906221406592;6174.166487524127;6252.5935814171935;6253.343398943045;6254.8123556293385;6266.717997690023;6098.159935307505;6102.115193297036;6115.331611966083;6131.662758548323;6138.1738283688655;5585.5531557476115;5991.820245392645;6165.445109940127;6219.720112595034;6225.501959843111;4844.636652251166;5902.852428689317;5969.432903874125;5994;6004.339522652417;6097.329293777592;6136.110264011604;6146.371211629012;6202.255729312511;6203.31763506005;6047.758089676364;6072.240969878765;6074.514038876968;6098.573099882966;6100.298465676504 21:55:13 INFO - PROCESS | 1655 | |1;ext.html;499.29599265036296;513.6147889083188;520.6901893373441;555.272592903297;576.85290250986;37598;40187.39718904219;40232.39651405228;40307;40309.59690403099;40490;41271.76184714456;41350.58649413505;41388.75833724993;41426.17147657045;9544.90455095447;9861.852072218922;9865.358751681119;9868.90131098687;9892.208623310118;9731;9741.220702343831;9795.412275263472;9800.656977005807;9820.263480239011;9714.174295184883;9744.56149473272;9745.805083898318;9807.70576882691;9826.656067037655;9729.464879431629;9748;9786.266030047775;9787.217022638171;9817.312788104835;9728.513574321327;9802.607895684165;9850.655227067089;9854.655087071918;9870.25973052024;39935.40096898549;40117.398239026144;40258.59741402607;40264.194716105514;40391.192176156605;3179.7933134346194;3309.238875058726;3313.7680362374645;3337.332533493287;3420.880269190566;30293;31353.37293254145;31436.21409464759;31558.842205789053;32401;3219.098652377338;3228.983855080733;3249.5125731140283;3336.7497437692027;3342.19787251058;498727;503438;504104.4794776039;504491;506899;59883.700581496814;60185.39814601885;60459.697701512094;60661.69669151626;60741;62056.689716551125;62883;62937.37062629315;63069.68465157645;63263.05105423422;16236.269367878474;16302.266398012118;16409.753853692204;16442.588935276715;16454.75317870233;12583.93708031454;12727.554535591209;12787.744245115231;12790.488380464863;12815.551455699006;13210.73578528424;14991.076740035589;16383.36166383352;17304.394346197823;17346.392876249523;3151.101935948244;6329.303776584572;6377.054998225586;6385.776497822554;6402.9359706403275;837.6188834080479;925.509479975614;962.8844538655406;1009.9242556808268;1026.7741096958657;29740;29752.85123574368;30270.84864575663;30772.076837694905;30982.69017309798;998.5456617239139;1094.6497120921229;1117.3184357542054;1138.117958582089;1156.929839898091;14511.1293322401;15007.724343430713;15436.459723909833;15911.681766364607;16101.19494025294;669128;671371;677602;678100;679506;50829.220977266355;55520.88958220813;58082;58340.708296458244;58744;1312.586535241396;1349.811026456297;1365.9590212293647;1372.5196181336253;1377.6900197455493;24420.755792441847;29933.70066299309;29991.550126748552;30154.84922575373;30589.694103058686;40652;50982.49017509926;51421.9999999985;51430.22854657258;51441.97116057733;613586;616225;616882;616893;617335;26577.7342226583;26609.201723948314;26913.596296055966;26921.192364229104;26962.191134266002;46167.76916115398;47086;47742.761286193345;48060.27909581289;48227.75886120547;39146.804265978484;39663.40504892371;40337.79831100826;40592;41019.384709229984;29861.55207671843;39149.2170156601;39405.01487462837;40245;40362.39456408215;38256.80871595624;38822.61177388303;38852.222955540165;38916.83249502519;39199.41200881932;33285.00144995654;34894.65105348914;35443.82278088593;35559;35614.465783012754;24584.262472125865;25495.23514294574;25880;25934.87032564825;26293 21:55:13 INFO - PROCESS | 1655 | |2;jquery.html;327.4449807576158;375.27571786452137;380.6117759884917;388.36890053662796;402.8529586700855;17997.37009204678;20337.898310508444;20498.282560110398;20654;20780.8960955195;20135.899320503377;20166.991650417494;20335.49161270969;20397.59204815903;20647.483812904684;5518.613697041189;5610.849775795952;5728.455796699328;5832.533397328214;6117.785877494289;5709.314882214119;6048.3649216832255;6129.988551888955;6132;6135.202423684915;5716.599838011341;6013.1581578579035;6040.96979515104;6057.878842423149;6081.939180608181;5769.653820770767;5986.940130598704;6032.27612686476;6053.697315134225;6080.574359794794;4474.373587697725;4762.5712286313965;5025.924611130799;5197.584193264567;5225.790968361261;19192.424227273204;24357.391065223335;25186.622200667003;25356;25378.238652840446;2123.723915890924;2138.807507324348;2273.1362082408746;2392.964105538418;2428.7571242875747;12590.68523286916;15272.770908436383;15545.766813497807;15630.296636651377;15815.446459373867;1634.2237437217345;1914.4830895658095;1931.8164774346415;1953.9609207815906;1955.2276850643916;113197.43401282941;114154;115283.42358288154;115415;115763;9160.534314509647;10097.848532272023;10789.730256743644;11117.27737697047;11318.660440186808;13387.756725448671;13456.663583410493;13466.057375983783;13480.5281815136;13493.190408575321;8272.131426200283;8333.374996875258;8564.700235491728;8572.185642363966;8752.474851508803;8516.190961858614;8594.226519613265;8602.569871506399;8824.823503530022;8827.69103081389;6483.3192514786215;6586.538942274091;6616.86766264672;6636.435902948207;6732.629705366252;1870.8971006594495;1894.1571000904742;1897.383350411122;1899.7720273566983;1900.2019151956213;734.4344854462034;843.7763992541982;935.373299889076;944.5230158769778;965.280865755017;20779.272725454837;21248.893755531124;21365.46586335323;21498;21656.458588535414;860.3590325207635;932.5849996751516;935.7099299217128;942.1520631431766;953.8855337359561;9153.77115572116;9367.718968430958;11393.772124557463;11542.249753765978;11578.710532236593;581328.0933595389;597835;601544;601643;605541.9722901445;103273.96726032793;107594.46202768935;124812;128090;134312;435.58401726351894;451.45374097342585;453.4037740371467;454.44784586727286;456.940597722294;10923.890761092287;11137.665870023913;11213.327200368005;11465.713357166138;11502.367369794742;42519.7874010628;45019.549804501534;52951.73524132355;55591.722041389534;56120.15819762788;79864.80202796847;81008;82226.43263861396;82446;83700.58149709212;7851.882221766564;8034.236747508978;8047.961392074383;8161.755147345589;8407.873881891654;11172.497237624164;12955.093143479866;13020.218786872818;13399;13428.992825538318;9009.864852027094;11149.163812713916;11152.944235278772;11215.887841121485;11374.20380573352;10046.296759226783;10742.657167854019;11259.605913792979;11339.659810205707;11349.716257093638;11354.148438867283;11514.021308188563;11597.942010290231;11705.590304339306;11941.283522988648;8371.790705232417;8432.409731318749;8443.577821108796;8506.234438900528;8514.318854491501;9037.864432033657;11358;11375.658730238107;11452.656420307405;11638.941805290919 21:55:13 INFO - PROCESS | 1655 | |3;mootools.html;1534.562649644851;1558.8674962628177;1749.8512626426752;1769.7876254849411;1816.1827177770008;8121;8353.457025293366;8586.570671466425;9201.355905086655;9250.306227032974;6895.65521723913;7715.112762032368;8635.481871087739;8829.381943263958;8900.955495222532;2329.8369114162015;2343.297010896733;2377.0491803278655;2378.1914149189274;2381.630847218684;2346.718393792747;2357.5520651076326;2359.480914198882;2384.391980045095;2384.4158181245534;2347.225415612844;2367.266147494274;2369.668246445499;2372.7627237276306;2412.421018955447;2273.8408311418207;2295.9655605165935;2308.7575804540534;2312.8496647717843;2369.052379048377;1962.7252184694155;2327.988360058189;2331.1258278145697;2333.265021518216;2344.179537161997;8235;8635.525046122524;8993.235574976135;9061.229795467394;9100.726978190665;5229.738513074369;5245.580353571705;5310.36275646921;5319.813806516792;5411.431799661058;3128.7015888406286;3521.6126226115107;3543.94684079739;3666.1018050577513;3679.1354031802507;1014.1849499240141;1048.580567772897;1053.3100818963592;1065.9200559957956;1087.9673609791719;11934;11981.46083426248;12054.337011464366;12074.094442916728;12108;4559.430071241095;4643.674942753974;4825.782839772219;4830.806767729322;4836.95163048365;10157.9492102539;10216.131628811485;10246.180305575535;10254.743631409274;10322.690319290434;5399.487048730364;5418.756155972991;5421.566274698014;5449.3188351456065;5475.959567682127;4445.222086134913;4577.56513131252;4766.523347665206;4892.755362231874;4956.603471722254;3889.844406223776;3913.158670885773;3985.501812273466;4039.333509970822;4039.555648878621;1095.9287646302964;1271.5295340723806;1277.5337001994392;1284.9720223820907;1288.845338559379;789.4947233770391;875.5928493250669;887.8446271902392;922.7416323429451;934.761635782871;5778.075507918713;5942.64344139353;5959.225300710967;6102.359252278536;6271.090691849657;867.7917299847991;892.6340200517757;909.3952521573212;913.3743385780762;955.7658373698488;3710.591834898159;3783.3000894834545;3797.525309336333;3800.809959502069;3893.124047089382;10669.573217071385;11126.833097503544;11148.108151347873;11148.554057837759;11173.664790056311;10983.780324393627;11080.667579972614;11092.1126309895;11115.166362522843;11119.55521779136;7832.316052048837;8175.018997720193;8274.917250827535;8458.534780587004;8497.617607207567;5688.345840228427;5809.186713860147;5845;5900.822975310747;5926.496247818984;9588.520573971413;9837.95081024619;9976.05227503386;9992.350497217658;10012.949935250277;9979;10035.949820250851;10042;10056.69829905104;10211.285210035227;7026.2271150174465;7097.432205423451;7571.734989275349;7611.809704757426;7729.961350193213;6759.628220447923;7112.288771122846;8462.238398544161;8547.316214702932;8550.1449855014;7426.777196684108;7532.736354227576;7715.267049630276;7770.689172433039;7796.844063118592;7326.084239470067;7531.284527969834;7562.168161502121;7672.350444654426;7722.189170137055;6016.42843929826;7001.684924178322;7092.822679433056;7099.07711997437;7139.535930164523;4862.6839255448285;4936.333594964633;4980.601551875914;5017;5019.222020586815;4867.41591009067;4894.167991441393;5015.172496538176;5116.590672746246;5117.5394214520875 21:55:13 INFO - PROCESS | 1655 | |4;prototype.html;286.14157527417746;287.6864218002378;317.07414350097713;320.9149575362531;321.0656988164442;4339.5009573899015;4600.389863547756;4628.05124949385;5350.314650884969;5548.86127846804;5169.707573106723;5294.920576191351;5513.228148059275;5538.240230160638;5554.222408862763;4252.638525725317;4289.383476079589;4306.397104405386;4321.82712691492;4329.935050974223;3416.470447080694;3573.2317551726373;3734.365157923146;4153.833846646131;4315.633171180453;3616.8734094306706;4095.9590404096025;4161.667066634662;4176;4194.412782210493;3444.810535420551;4173.895652608679;4186;4216.57834216579;4250.553691862372;2989.61135052444;3602.9911624745114;3627.7279204059537;3628.129248980252;3637.781733096023;4410.360497727844;4517.847948773075;4553.567411095941;5287.942411517712;5409.164213111606;3905.8828235152705;4759.4764575896625;4778.450478195017;4796.824777929395;4801.8079276828885;4767.425590181298;5795.855103622401;5809;5819.563532735019;5838.649681019152;3437.332893546628;3563.1448452371505;3851.1501488898016;3932.3315036443873;3958.723733853046;5749.367569567345;5952.511762179245;6079.1701228226375;6169.907451388232;6183.907241391383;3342.5320455136302;3514.876979305712;3720.255948810249;4028.5425890206952;4031.9395209071886;3331.7334613230882;3557.395242808677;3882.971282399676;3958.7030972677167;4047.595240475988;4265.637420819203;4300.440942677432;4687.1328804171335;4758.643101767381;4766.404199475066;5150.574867712929;5784.248047753849;5825.854353641108;5863.149843272787;5891.558133140032;1181.4211036592008;1242.3353505874313;1284.7602064008277;1295.643697983062;1346.3335648853683;788.9270591994882;809.9797505062421;857.8327226190958;860.3117505995178;860.7331727164599;3968.4324691746597;4020.341489244773;4204.495460544754;4414.4702635683925;4614.446266448048;4311.2239796836875;4590.921133533617;4967.726775027409;5002.849914502571;5032.213564184735;4586;4615.769211539477;4616.8614941551805;4642.86071417858;4651.906961860744;2373.8724106049835;2489.5269898719184;2547.898084076653;2642.920712378632;2657.9202623921315;4678.929816052762;5011.523905228997;5093.414257360377;5187.910538786821;5238.580913526908;4686.976565117153;4751.619870410359;4858.58702010326;5159.74201289934;5234.947650523446;4893.290472881412;6252.280987686383;6391.808245752635;6405.167328247298;6418.903716444163;5261.973690131525;5335.573154147582;5855.194123819551;6138.723757431016;6198.81403557894;4482.574155455227;5273.499017593323;5813.23871161212;5965.224520812267;6033.758649653964;5962.582619216787;6252.249730032243;6358.459530939737;6415.358464153547;6443.6455994920725;3692.504535663061;4153.231652144363;4155.667546596204;4216.515100763451;4226.323788193874;5225.24954140352;5240.873212259383;5580.86047848807;5961.463468287875;6022.337542870368;4895.768792596869;4923.08922849274;5290.788368465218;5777.335606405317;5849.151872978309;4388.429504164438;5887.558433117448;5892.823215303548;5914.491804589802;5921.289445266596;4620.12884781664;5546.916796247979;5755.625884317506;5790.913136302875;5808.983427900185;4570.360149578995;5914.231149950651;5914.645121292736;5963.940360596339;5986.281646202484;4825.179719447772;5802.883942321215;5806.883862322646;5834.591578589458;5856.560757943086 21:55:13 INFO - PROCESS | 1655 | |5;yui.html;697.8813601687713;735.6174789109659;764.9349805266552;784.4508843809333;799.3205775091174;15157;16208.189590520486;16213.027218366877;16225.594360141002;16230.10734409607;14696.265186740648;14862.851371486282;14864.702705945874;14881.404743810235;14906.478273260438;648.2804087462936;666.3170250493234;810.205998121838;812.6261919517015;826.4875777018257;843.6288033265374;847.5973912391596;852.5779739029189;854.4830377621543;856.9571521423904;785.3285440947993;903.7876099116702;905.9184673379394;906.8866391701038;906.9365144439892;746.2239271157989;799.0251892690908;895.552223888056;900.8018235988105;915.0757734687946;615.4061330815784;647.4561368450477;660.1451120798578;663.7809522857445;663.91037209977;15019;15023.023503472348;15088.54734357971;15213.163276019815;15223.086614803147;12546.749065018648;14734.410623575044;14831.258437078102;14954.775678364833;15107.374230184676;11677.591284305094;11776.823347649792;11840.940795296054;11918.761624767456;12024.33866137362;3744.120131769032;3798.1074447504816;3820.2550502651993;3830.7701537907815;3924.1759230561615;116666;117141.24288135685;117449.41275293569;118013;122365.38817305857;9598.136167744937;11132;11224;11251.43742812856;11316.830247546293;23538.529229415657;23564.64653030206;23576.642335766628;23588.05647774104;23690.170844020377;7195.208527062019;7336.706531738778;7794.337481314038;8026.398020148512;8062.153473885275;4310.719803212781;4371.147626212858;4372.803223854934;4375.9935214900115;4484.708493947883;3575.2670702505925;3594.4428613564937;3689.5572531296416;3693.3536631089987;3693.8707145250323;626.4737620398796;630.3349965786048;644.0628884972353;656.5765081522392;664.259350823828;613.8557439001831;631.5894668465534;636.710296814948;650.6876699184323;652.1456891472187;8974.326925480615;8997.055309192572;9049.864252036225;9267.72196834096;9275.489848058422;563.248063834777;608.3703367015119;653.6600967496875;665.4377051391566;665.5640555436197;4354.521002689701;4546.931796023062;4556.567126123079;4560.315952607069;4613.861584152481;104368;144780;151694.24152879385;154295.45704543035;156326;128452;129222.35388822996;129693;131351;132098;115783;115971;116265.8373416272;116995.41502292434;118032;8770.693025744069;8842.425242359226;8863.601137948937;8937.329700272636;9019.188273055457;62761.68619156875;64065.35934640594;65134.67432662996;65831.67084164548;67352;86020.56989715261;95704;96114;98768.50615747162;99052;10681.786364272826;11286.604968826052;11909.22590031645;12063.51745930188;12187.390630468619;13025.413856376676;13170.539031134247;13383;13455.327233638083;13782.724345512834;9266.629334826532;10726.410047447465;12151.75696486083;12175.269483830998;12225;9693.515324233902;11385.829212561652;12044.75910481768;12173.208741432132;12560.434780435085;11715.414229288332;12123;12341.876581234073;12375.814362784746;12501.312427816558;10434.37393756377;10694.62568810088;10713.464326783474;11007;11026.08678424773;8340.87488687658;8728.563571821256;9052.34085617849;10361.585536578452;10709.036186743231 21:55:13 INFO - PROCESS | 1655 | __end_tp_report 21:55:13 INFO - PROCESS | 1655 | __start_cc_report 21:55:13 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,374 21:55:13 INFO - PROCESS | 1655 | __end_cc_report 21:55:13 INFO - PROCESS | 1655 | __startTimestamp1475902513899__endTimestamp 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | ------- Summary: start ------- 21:55:13 INFO - PROCESS | 1655 | Number of tests: 6 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5676.15 Median:5948.05 stddev:752.57 (12.7%) stddev-sans-first:720.09 21:55:13 INFO - PROCESS | 1655 | Values: 2793.3 3391.5 3411.0 3431.2 3434.9 4547.9 5607.2 5712.5 5724.5 5776.2 4540.8 5633.6 5657.5 5722.8 5758.0 4339.5 4415.4 4590.3 5197.2 5201.9 4261.0 4480.6 5123.5 5386.5 5427.6 4110.5 5199.1 5292.8 5308.3 5414.3 4258.7 5171.2 5200.8 5289.8 5319.4 5181.4 5206.9 5219.6 5231.8 5243.7 5658.0 5693.3 5767.7 5816.2 5817.6 6117.7 6146.1 6172.7 6177.1 6260.4 6231.7 6243.5 6245.0 6252.4 6277.4 5867.2 5883.8 5891.8 5900.1 5948.0 5390.8 6106.0 6167.5 6181.1 6265.2 6185.9 6197.1 6197.8 6218.7 6240.3 6253.1 6285.3 6297.3 6302.1 6318.1 6107.8 6111.4 6123.4 6163.3 6213.5 6198.7 6235.9 6245.4 6251.9 6261.5 4155.8 4930.2 4931.6 4937.1 4963.7 3172.0 4317.8 4362.3 4392.7 4426.7 5875.4 5921.5 5928.6 5939.5 5970.1 5247.6 6245.0 6245.4 6266.9 6269.9 5720.7 5814.6 5836.3 5885.6 5910.6 5406.6 5458.9 5470.6 5502.8 5505.9 6396.7 6403.5 6430.6 6440.4 6667.8 6128.9 6218.3 6268.2 6268.2 6285.2 6330.0 6342.3 6362.2 6453.2 6465.5 4796.9 5010.4 5128.3 5932.8 6251.9 6174.2 6252.6 6253.3 6254.8 6266.7 6098.2 6102.1 6115.3 6131.7 6138.2 5585.6 5991.8 6165.4 6219.7 6225.5 4844.6 5902.9 5969.4 5994.0 6004.3 6097.3 6136.1 6146.4 6202.3 6203.3 6047.8 6072.2 6074.5 6098.6 6100.3 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:72571.80 Median:40308.30 stddev:161279.94 (400.1%) stddev-sans-first:161641.60 21:55:13 INFO - PROCESS | 1655 | Values: 499.3 513.6 520.7 555.3 576.9 37598.0 40187.4 40232.4 40307.0 40309.6 40490.0 41271.8 41350.6 41388.8 41426.2 9544.9 9861.9 9865.4 9868.9 9892.2 9731.0 9741.2 9795.4 9800.7 9820.3 9714.2 9744.6 9745.8 9807.7 9826.7 9729.5 9748.0 9786.3 9787.2 9817.3 9728.5 9802.6 9850.7 9854.7 9870.3 39935.4 40117.4 40258.6 40264.2 40391.2 3179.8 3309.2 3313.8 3337.3 3420.9 30293.0 31353.4 31436.2 31558.8 32401.0 3219.1 3229.0 3249.5 3336.7 3342.2 498727.0 503438.0 504104.5 504491.0 506899.0 59883.7 60185.4 60459.7 60661.7 60741.0 62056.7 62883.0 62937.4 63069.7 63263.1 16236.3 16302.3 16409.8 16442.6 16454.8 12583.9 12727.6 12787.7 12790.5 12815.6 13210.7 14991.1 16383.4 17304.4 17346.4 3151.1 6329.3 6377.1 6385.8 6402.9 837.6 925.5 962.9 1009.9 1026.8 29740.0 29752.9 30270.8 30772.1 30982.7 998.5 1094.6 1117.3 1138.1 1156.9 14511.1 15007.7 15436.5 15911.7 16101.2 669128.0 671371.0 677602.0 678100.0 679506.0 50829.2 55520.9 58082.0 58340.7 58744.0 1312.6 1349.8 1366.0 1372.5 1377.7 24420.8 29933.7 29991.6 30154.8 30589.7 40652.0 50982.5 51422.0 51430.2 51442.0 613586.0 616225.0 616882.0 616893.0 617335.0 26577.7 26609.2 26913.6 26921.2 26962.2 46167.8 47086.0 47742.8 48060.3 48227.8 39146.8 39663.4 40337.8 40592.0 41019.4 29861.6 39149.2 39405.0 40245.0 40362.4 38256.8 38822.6 38852.2 38916.8 39199.4 33285.0 34894.7 35443.8 35559.0 35614.5 24584.3 25495.2 25880.0 25934.9 26293.0 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34595.87 Median:351.36 stddev:99546.12 (28331.6%) stddev-sans-first:99792.12 21:55:13 INFO - PROCESS | 1655 | Values: 327.4 375.3 380.6 388.4 402.9 17997.4 20337.9 20498.3 20654.0 20780.9 20135.9 20167.0 20335.5 20397.6 20647.5 5518.6 5610.8 5728.5 5832.5 6117.8 5709.3 6048.4 6130.0 6132.0 6135.2 5716.6 6013.2 6041.0 6057.9 6081.9 5769.7 5986.9 6032.3 6053.7 6080.6 4474.4 4762.6 5025.9 5197.6 5225.8 19192.4 24357.4 25186.6 25356.0 25378.2 2123.7 2138.8 2273.1 2393.0 2428.8 12590.7 15272.8 15545.8 15630.3 15815.4 1634.2 1914.5 1931.8 1954.0 1955.2 113197.4 114154.0 115283.4 115415.0 115763.0 9160.5 10097.8 10789.7 11117.3 11318.7 13387.8 13456.7 13466.1 13480.5 13493.2 8272.1 8333.4 8564.7 8572.2 8752.5 8516.2 8594.2 8602.6 8824.8 8827.7 6483.3 6586.5 6616.9 6636.4 6732.6 1870.9 1894.2 1897.4 1899.8 1900.2 734.4 843.8 935.4 944.5 965.3 20779.3 21248.9 21365.5 21498.0 21656.5 860.4 932.6 935.7 942.2 953.9 9153.8 9367.7 11393.8 11542.2 11578.7 581328.1 597835.0 601544.0 601643.0 605542.0 103274.0 107594.5 124812.0 128090.0 134312.0 435.6 451.5 453.4 454.4 456.9 10923.9 11137.7 11213.3 11465.7 11502.4 42519.8 45019.5 52951.7 55591.7 56120.2 79864.8 81008.0 82226.4 82446.0 83700.6 7851.9 8034.2 8048.0 8161.8 8407.9 11172.5 12955.1 13020.2 13399.0 13429.0 9009.9 11149.2 11152.9 11215.9 11374.2 10046.3 10742.7 11259.6 11339.7 11349.7 11354.1 11514.0 11597.9 11705.6 11941.3 8371.8 8432.4 8443.6 8506.2 8514.3 9037.9 11358.0 11375.7 11452.7 11638.9 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5733.71 Median:4893.46 stddev:3256.50 (66.5%) stddev-sans-first:3250.35 21:55:13 INFO - PROCESS | 1655 | Values: 1534.6 1558.9 1749.9 1769.8 1816.2 8121.0 8353.5 8586.6 9201.4 9250.3 6895.7 7715.1 8635.5 8829.4 8901.0 2329.8 2343.3 2377.0 2378.2 2381.6 2346.7 2357.6 2359.5 2384.4 2384.4 2347.2 2367.3 2369.7 2372.8 2412.4 2273.8 2296.0 2308.8 2312.8 2369.1 1962.7 2328.0 2331.1 2333.3 2344.2 8235.0 8635.5 8993.2 9061.2 9100.7 5229.7 5245.6 5310.4 5319.8 5411.4 3128.7 3521.6 3543.9 3666.1 3679.1 1014.2 1048.6 1053.3 1065.9 1088.0 11934.0 11981.5 12054.3 12074.1 12108.0 4559.4 4643.7 4825.8 4830.8 4837.0 10157.9 10216.1 10246.2 10254.7 10322.7 5399.5 5418.8 5421.6 5449.3 5476.0 4445.2 4577.6 4766.5 4892.8 4956.6 3889.8 3913.2 3985.5 4039.3 4039.6 1095.9 1271.5 1277.5 1285.0 1288.8 789.5 875.6 887.8 922.7 934.8 5778.1 5942.6 5959.2 6102.4 6271.1 867.8 892.6 909.4 913.4 955.8 3710.6 3783.3 3797.5 3800.8 3893.1 10669.6 11126.8 11148.1 11148.6 11173.7 10983.8 11080.7 11092.1 11115.2 11119.6 7832.3 8175.0 8274.9 8458.5 8497.6 5688.3 5809.2 5845.0 5900.8 5926.5 9588.5 9838.0 9976.1 9992.4 10012.9 9979.0 10035.9 10042.0 10056.7 10211.3 7026.2 7097.4 7571.7 7611.8 7730.0 6759.6 7112.3 8462.2 8547.3 8550.1 7426.8 7532.7 7715.3 7770.7 7796.8 7326.1 7531.3 7562.2 7672.4 7722.2 6016.4 7001.7 7092.8 7099.1 7139.5 4862.7 4936.3 4980.6 5017.0 5019.2 4867.4 4894.2 5015.2 5116.6 5117.5 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4507.53 Median:4762.94 stddev:1444.94 (30.3%) stddev-sans-first:1413.83 21:55:13 INFO - PROCESS | 1655 | Values: 286.1 287.7 317.1 320.9 321.1 4339.5 4600.4 4628.1 5350.3 5548.9 5169.7 5294.9 5513.2 5538.2 5554.2 4252.6 4289.4 4306.4 4321.8 4329.9 3416.5 3573.2 3734.4 4153.8 4315.6 3616.9 4096.0 4161.7 4176.0 4194.4 3444.8 4173.9 4186.0 4216.6 4250.6 2989.6 3603.0 3627.7 3628.1 3637.8 4410.4 4517.8 4553.6 5287.9 5409.2 3905.9 4759.5 4778.5 4796.8 4801.8 4767.4 5795.9 5809.0 5819.6 5838.6 3437.3 3563.1 3851.2 3932.3 3958.7 5749.4 5952.5 6079.2 6169.9 6183.9 3342.5 3514.9 3720.3 4028.5 4031.9 3331.7 3557.4 3883.0 3958.7 4047.6 4265.6 4300.4 4687.1 4758.6 4766.4 5150.6 5784.2 5825.9 5863.1 5891.6 1181.4 1242.3 1284.8 1295.6 1346.3 788.9 810.0 857.8 860.3 860.7 3968.4 4020.3 4204.5 4414.5 4614.4 4311.2 4590.9 4967.7 5002.8 5032.2 4586.0 4615.8 4616.9 4642.9 4651.9 2373.9 2489.5 2547.9 2642.9 2657.9 4678.9 5011.5 5093.4 5187.9 5238.6 4687.0 4751.6 4858.6 5159.7 5234.9 4893.3 6252.3 6391.8 6405.2 6418.9 5262.0 5335.6 5855.2 6138.7 6198.8 4482.6 5273.5 5813.2 5965.2 6033.8 5962.6 6252.2 6358.5 6415.4 6443.6 3692.5 4153.2 4155.7 4216.5 4226.3 5225.2 5240.9 5580.9 5961.5 6022.3 4895.8 4923.1 5290.8 5777.3 5849.2 4388.4 5887.6 5892.8 5914.5 5921.3 4620.1 5546.9 5755.6 5790.9 5809.0 4570.4 5914.2 5914.6 5963.9 5986.3 4825.2 5802.9 5806.9 5834.6 5856.6 21:55:13 INFO - PROCESS | 1655 | 21:55:13 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25091.95 Median:3809.18 stddev:40515.70 (1063.6%) stddev-sans-first:40587.96 21:55:13 INFO - PROCESS | 1655 | Values: 697.9 735.6 764.9 784.5 799.3 15157.0 16208.2 16213.0 16225.6 16230.1 14696.3 14862.9 14864.7 14881.4 14906.5 648.3 666.3 810.2 812.6 826.5 843.6 847.6 852.6 854.5 857.0 785.3 903.8 905.9 906.9 906.9 746.2 799.0 895.6 900.8 915.1 615.4 647.5 660.1 663.8 663.9 15019.0 15023.0 15088.5 15213.2 15223.1 12546.7 14734.4 14831.3 14954.8 15107.4 11677.6 11776.8 11840.9 11918.8 12024.3 3744.1 3798.1 3820.3 3830.8 3924.2 116666.0 117141.2 117449.4 118013.0 122365.4 9598.1 11132.0 11224.0 11251.4 11316.8 23538.5 23564.6 23576.6 23588.1 23690.2 7195.2 7336.7 7794.3 8026.4 8062.2 4310.7 4371.1 4372.8 4376.0 4484.7 3575.3 3594.4 3689.6 3693.4 3693.9 626.5 630.3 644.1 656.6 664.3 613.9 631.6 636.7 650.7 652.1 8974.3 8997.1 9049.9 9267.7 9275.5 563.2 608.4 653.7 665.4 665.6 4354.5 4546.9 4556.6 4560.3 4613.9 104368.0 144780.0 151694.2 154295.5 156326.0 128452.0 129222.4 129693.0 131351.0 132098.0 115783.0 115971.0 116265.8 116995.4 118032.0 8770.7 8842.4 8863.6 8937.3 9019.2 62761.7 64065.4 65134.7 65831.7 67352.0 86020.6 95704.0 96114.0 98768.5 99052.0 10681.8 11286.6 11909.2 12063.5 12187.4 13025.4 13170.5 13383.0 13455.3 13782.7 9266.6 10726.4 12151.8 12175.3 12225.0 9693.5 11385.8 12044.8 12173.2 12560.4 11715.4 12123.0 12341.9 12375.8 12501.3 10434.4 10694.6 10713.5 11007.0 11026.1 8340.9 8728.6 9052.3 10361.6 10709.0 21:55:13 INFO - PROCESS | 1655 | -------- Summary: end -------- 21:55:13 INFO - PROCESS | 1655 | 21:55:14 INFO - TEST-INFO | 1655: exit 0 21:55:14 INFO - TEST-OK | dromaeo_css | took 1114994ms 21:55:14 INFO - TEST-START | kraken 21:55:14 INFO - operating with platform_type : mac_ 21:55:14 INFO - Initialising browser for kraken test... 21:55:14 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp7us5i5/profile http://localhost:49267/getInfo.html) 21:55:17 INFO - PROCESS | 1664 | 2016-10-07 21:55:17.028 plugin-container[1665:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a0f, name = 'com.apple.tsm.portname' 21:55:17 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:55:17 INFO - PROCESS | 1664 | 2016-10-07 21:55:17.031 plugin-container[1665:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9503, name = 'com.apple.CFPasteboardClient' 21:55:17 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:55:17 INFO - PROCESS | 1664 | 2016-10-07 21:55:17.031 plugin-container[1665:10129] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:55:17 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 21:55:17 INFO - PROCESS | 1664 | colorDepth:24 21:55:17 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 21:55:17 INFO - PROCESS | 1664 | __metrics 21:55:17 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 21:55:17 INFO - TEST-INFO | 1664: exit 0 21:55:17 INFO - Browser initialized. 21:55:17 INFO - Running cycle 1/1 for kraken test... 21:55:17 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp7us5i5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:20 INFO - PROCESS | 1666 | 2016-10-07 21:55:20.365 plugin-container[1667:10241] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.tsm.portname' 21:55:20 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:55:20 INFO - PROCESS | 1666 | 2016-10-07 21:55:20.367 plugin-container[1667:10241] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 21:55:20 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:55:20 INFO - PROCESS | 1666 | 2016-10-07 21:55:20.367 plugin-container[1667:10241] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:55:30 INFO - PROCESS | 1666 | RSS: Main: 239226880 21:55:30 INFO - PROCESS | 1666 | 21:55:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 21:55:34 INFO - PROCESS | 1666 | RSS: Main: 252841984 21:55:34 INFO - PROCESS | 1666 | 21:55:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 21:55:37 INFO - PROCESS | 1666 | RSS: Main: 260399104 21:55:37 INFO - PROCESS | 1666 | 21:55:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 21:55:41 INFO - PROCESS | 1666 | RSS: Main: 261275648 21:55:41 INFO - PROCESS | 1666 | 21:55:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 21:55:44 INFO - PROCESS | 1666 | RSS: Main: 263471104 21:55:44 INFO - PROCESS | 1666 | 21:55:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:55:46 INFO - PROCESS | 1666 | RSS: Main: 264015872 21:55:46 INFO - PROCESS | 1666 | 21:55:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:50 INFO - PROCESS | 1666 | RSS: Main: 264851456 21:55:50 INFO - PROCESS | 1666 | 21:55:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:53 INFO - PROCESS | 1666 | RSS: Main: 265146368 21:55:53 INFO - PROCESS | 1666 | 21:55:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 21:55:57 INFO - PROCESS | 1666 | RSS: Main: 265072640 21:55:57 INFO - PROCESS | 1666 | 21:55:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:59 INFO - PROCESS | 1666 | RSS: Main: 265052160 21:55:59 INFO - PROCESS | 1666 | 21:56:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:56:02 INFO - PROCESS | 1666 | RSS: Main: 265129984 21:56:02 INFO - PROCESS | 1666 | 21:56:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:56:05 INFO - PROCESS | 1666 | RSS: Main: 265216000 21:56:05 INFO - PROCESS | 1666 | 21:56:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:56:09 INFO - PROCESS | 1666 | RSS: Main: 265498624 21:56:09 INFO - PROCESS | 1666 | 21:56:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:56:12 INFO - PROCESS | 1666 | RSS: Main: 265220096 21:56:12 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 21:56:14 INFO - PROCESS | 1666 | RSS: Main: 266952704 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | __start_tp_report 21:56:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:56:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:56:14 INFO - PROCESS | 1666 | |i|pagename|runs| 21:56:14 INFO - PROCESS | 1666 | |0;ai-astar;108;118;117;116;119;119;122;110;171;180 21:56:14 INFO - PROCESS | 1666 | |1;audio-beat-detection;130;119;146;182;140;141;145;114;145;117 21:56:14 INFO - PROCESS | 1666 | |2;audio-dft;201;248;281;268;195;201;198;196;197;231 21:56:14 INFO - PROCESS | 1666 | |3;audio-fft;78;58;59;83;60;60;59;59;75;57 21:56:14 INFO - PROCESS | 1666 | |4;audio-oscillator;89;71;87;71;68;69;89;69;71;86 21:56:14 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;135;76;136;133;88;85;91;99;87;76 21:56:14 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;103;117;152;150;95;97;96;95;95 21:56:14 INFO - PROCESS | 1666 | |7;imaging-desaturate;100;98;79;104;116;122;148;140;89;96 21:56:14 INFO - PROCESS | 1666 | |8;json-parse-financial;57;56;57;59;57;56;60;68;68;52 21:56:14 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;71;80;115;116;109;95;61;61;63 21:56:14 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;107;76;112;111;107;109;89;87;88;92 21:56:14 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;144;169;177;161;163;161;164;154;184;151 21:56:14 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;173;176;175;172;195;232;235;172;173;171 21:56:14 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;70;71;71;69;69;72;71;82;75;95 21:56:14 INFO - PROCESS | 1666 | __end_tp_report 21:56:14 INFO - PROCESS | 1666 | __start_cc_report 21:56:14 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,943 21:56:14 INFO - PROCESS | 1666 | __end_cc_report 21:56:14 INFO - PROCESS | 1666 | __startTimestamp1475902574927__endTimestamp 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:56:14 INFO - PROCESS | 1666 | Number of tests: 14 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:128.00 Median:119.00 stddev:25.47 (21.4%) stddev-sans-first:25.97 21:56:14 INFO - PROCESS | 1666 | Values: 108.0 118.0 117.0 116.0 119.0 119.0 122.0 110.0 171.0 180.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:143.00 stddev:19.87 (13.9%) stddev-sans-first:20.87 21:56:14 INFO - PROCESS | 1666 | Values: 130.0 119.0 146.0 182.0 140.0 141.0 145.0 114.0 145.0 117.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:221.60 Median:216.00 stddev:33.07 (15.3%) stddev-sans-first:34.22 21:56:14 INFO - PROCESS | 1666 | Values: 201.0 248.0 281.0 268.0 195.0 201.0 198.0 196.0 197.0 231.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.00 stddev:9.80 (16.3%) stddev-sans-first:9.15 21:56:14 INFO - PROCESS | 1666 | Values: 78.0 58.0 59.0 83.0 60.0 60.0 59.0 59.0 75.0 57.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:9.35 (11.9%) stddev-sans-first:8.85 21:56:14 INFO - PROCESS | 1666 | Values: 89.0 71.0 87.0 71.0 68.0 69.0 89.0 69.0 71.0 86.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:86.00 stddev:24.45 (28.4%) stddev-sans-first:22.54 21:56:14 INFO - PROCESS | 1666 | Values: 135.0 76.0 136.0 133.0 88.0 85.0 91.0 99.0 87.0 76.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:95.00 stddev:22.91 (24.1%) stddev-sans-first:23.69 21:56:14 INFO - PROCESS | 1666 | Values: 95.0 103.0 117.0 152.0 150.0 95.0 97.0 96.0 95.0 95.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:109.20 Median:113.50 stddev:22.10 (19.5%) stddev-sans-first:23.19 21:56:14 INFO - PROCESS | 1666 | Values: 100.0 98.0 79.0 104.0 116.0 122.0 148.0 140.0 89.0 96.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:5.19 (8.9%) stddev-sans-first:5.45 21:56:14 INFO - PROCESS | 1666 | Values: 57.0 56.0 57.0 59.0 57.0 56.0 60.0 68.0 68.0 52.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:83.80 Median:65.00 stddev:22.86 (35.2%) stddev-sans-first:23.43 21:56:14 INFO - PROCESS | 1666 | Values: 67.0 71.0 80.0 115.0 116.0 109.0 95.0 61.0 61.0 63.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:81.50 stddev:12.78 (15.7%) stddev-sans-first:13.11 21:56:14 INFO - PROCESS | 1666 | Values: 107.0 76.0 112.0 111.0 107.0 109.0 89.0 87.0 88.0 92.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:162.80 Median:163.50 stddev:11.87 (7.3%) stddev-sans-first:10.46 21:56:14 INFO - PROCESS | 1666 | Values: 144.0 169.0 177.0 161.0 163.0 161.0 164.0 154.0 184.0 151.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:175.50 stddev:25.29 (14.4%) stddev-sans-first:26.28 21:56:14 INFO - PROCESS | 1666 | Values: 173.0 176.0 175.0 172.0 195.0 232.0 235.0 172.0 173.0 171.0 21:56:14 INFO - PROCESS | 1666 | 21:56:14 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:71.50 stddev:8.17 (11.4%) stddev-sans-first:8.50 21:56:14 INFO - PROCESS | 1666 | Values: 70.0 71.0 71.0 69.0 69.0 72.0 71.0 82.0 75.0 95.0 21:56:14 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:56:14 INFO - PROCESS | 1666 | 21:56:15 INFO - TEST-INFO | 1666: exit 0 21:56:15 INFO - TEST-OK | kraken | took 61259ms 21:56:15 INFO - SUITE-END | took 1176s 21:56:16 INFO - Completed test suite (00:19:36) 21:56:16 INFO - javascript benchmark 21:56:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7276.7637154290605, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2793.3156376687703, 3391.5082313064604, 3411.044907425922, 3431.227973705918, 3434.8626054957804, 4547.931781023287, 5607.243022192003, 5712.4573165549255, 5724.542036637069, 5776.220210271623, 4540.7502587357685, 5633.6338138021, 5657.547396208303, 5722.828315150542, 5758.0, 4339.457567804025, 4415.403920470743, 4590.334401511779, 5197.194434862593, 5201.895962080756, 4261.0, 4480.619147372461, 5123.51326623972, 5386.461353864602, 5427.592930530206, 4110.506739191286, 5199.064168449678, 5292.841214763564, 5308.309919710451, 5414.269073675043, 4258.723182993095, 5171.198464238011, 5200.843974680765, 5289.761960711778, 5319.388270348921, 5181.35233095863, 5206.895862082775, 5219.582433405319, 5231.764570594332, 5243.685378877241, 5657.971710141423, 5693.259876216065, 5767.711614419262, 5816.214811000503, 5817.621854579481, 6117.66352850593, 6146.139540464339, 6172.660503672296, 6177.073438984144, 6260.436560709558, 6231.719572619198, 6243.469305109071, 6244.9687751561405, 6252.406021427957, 6277.403646653561, 5867.207926929853, 5883.764649413975, 5891.764329426818, 5900.1149827526215, 5948.048312270016, 5390.811321603804, 6105.975331700744, 6167.537434692416, 6181.134641150243, 6265.248170219512, 6185.948388773919, 6197.101420294122, 6197.845053873599, 6218.720157592919, 6240.251169859555, 6253.1245625612455, 6285.308616052231, 6297.338779428185, 6302.1492098566105, 6318.147050148263, 6107.84730381744, 6111.40942266768, 6123.418275263843, 6163.260408750979, 6213.5339849511465, 6198.659073750897, 6235.906461403082, 6245.406686364788, 6251.937480625226, 6261.499080073583, 4155.792210389468, 4930.235813448921, 4931.580815630711, 4937.136001199848, 4963.70217786934, 3172.0483854843455, 4317.784110794448, 4362.345648152803, 4392.714473559208, 4426.690131690751, 5875.41245875409, 5921.526277897758, 5928.584999050025, 5939.46544810969, 5970.104484327386, 5247.632665713363, 6244.968775156095, 6245.437910588069, 6266.937330626635, 6269.905951410732, 5720.685362305113, 5814.592978491465, 5836.328822185418, 5885.61743486672, 5910.615809972338, 5406.648567843156, 5458.945410545924, 5470.617056806065, 5502.752376143083, 5505.944940550623, 6396.680165991775, 6403.519736019724, 6430.614163150132, 6440.420362167428, 6667.833304167435, 6128.900367973304, 6218.347073557211, 6268.153799237045, 6268.153799237227, 6285.214348206474, 6329.968350158219, 6342.334054924167, 6362.23653161605, 6453.193350831146, 6465.482761379172, 4796.9280460792415, 5010.423801262901, 5128.333316668809, 5932.792352267823, 6251.906221406592, 6174.166487524127, 6252.5935814171935, 6253.343398943045, 6254.8123556293385, 6266.717997690023, 6098.159935307505, 6102.115193297036, 6115.331611966083, 6131.662758548323, 6138.1738283688655, 5585.5531557476115, 5991.820245392645, 6165.445109940127, 6219.720112595034, 6225.501959843111, 4844.636652251166, 5902.852428689317, 5969.432903874125, 5994.0, 6004.339522652417, 6097.329293777592, 6136.110264011604, 6146.371211629012, 6202.255729312511, 6203.31763506005, 6047.758089676364, 6072.240969878765, 6074.514038876968, 6098.573099882966, 6100.298465676504], "value": 5625.545147506488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.29599265036296, 513.6147889083188, 520.6901893373441, 555.272592903297, 576.85290250986, 37598.0, 40187.39718904219, 40232.39651405228, 40307.0, 40309.59690403099, 40490.0, 41271.76184714456, 41350.58649413505, 41388.75833724993, 41426.17147657045, 9544.90455095447, 9861.852072218922, 9865.358751681119, 9868.90131098687, 9892.208623310118, 9731.0, 9741.220702343831, 9795.412275263472, 9800.656977005807, 9820.263480239011, 9714.174295184883, 9744.56149473272, 9745.805083898318, 9807.70576882691, 9826.656067037655, 9729.464879431629, 9748.0, 9786.266030047775, 9787.217022638171, 9817.312788104835, 9728.513574321327, 9802.607895684165, 9850.655227067089, 9854.655087071918, 9870.25973052024, 39935.40096898549, 40117.398239026144, 40258.59741402607, 40264.194716105514, 40391.192176156605, 3179.7933134346194, 3309.238875058726, 3313.7680362374645, 3337.332533493287, 3420.880269190566, 30293.0, 31353.37293254145, 31436.21409464759, 31558.842205789053, 32401.0, 3219.098652377338, 3228.983855080733, 3249.5125731140283, 3336.7497437692027, 3342.19787251058, 498727.0, 503438.0, 504104.4794776039, 504491.0, 506899.0, 59883.700581496814, 60185.39814601885, 60459.697701512094, 60661.69669151626, 60741.0, 62056.689716551125, 62883.0, 62937.37062629315, 63069.68465157645, 63263.05105423422, 16236.269367878474, 16302.266398012118, 16409.753853692204, 16442.588935276715, 16454.75317870233, 12583.93708031454, 12727.554535591209, 12787.744245115231, 12790.488380464863, 12815.551455699006, 13210.73578528424, 14991.076740035589, 16383.36166383352, 17304.394346197823, 17346.392876249523, 3151.101935948244, 6329.303776584572, 6377.054998225586, 6385.776497822554, 6402.9359706403275, 837.6188834080479, 925.509479975614, 962.8844538655406, 1009.9242556808268, 1026.7741096958657, 29740.0, 29752.85123574368, 30270.84864575663, 30772.076837694905, 30982.69017309798, 998.5456617239139, 1094.6497120921229, 1117.3184357542054, 1138.117958582089, 1156.929839898091, 14511.1293322401, 15007.724343430713, 15436.459723909833, 15911.681766364607, 16101.19494025294, 669128.0, 671371.0, 677602.0, 678100.0, 679506.0, 50829.220977266355, 55520.88958220813, 58082.0, 58340.708296458244, 58744.0, 1312.586535241396, 1349.811026456297, 1365.9590212293647, 1372.5196181336253, 1377.6900197455493, 24420.755792441847, 29933.70066299309, 29991.550126748552, 30154.84922575373, 30589.694103058686, 40652.0, 50982.49017509926, 51421.9999999985, 51430.22854657258, 51441.97116057733, 613586.0, 616225.0, 616882.0, 616893.0, 617335.0, 26577.7342226583, 26609.201723948314, 26913.596296055966, 26921.192364229104, 26962.191134266002, 46167.76916115398, 47086.0, 47742.761286193345, 48060.27909581289, 48227.75886120547, 39146.804265978484, 39663.40504892371, 40337.79831100826, 40592.0, 41019.384709229984, 29861.55207671843, 39149.2170156601, 39405.01487462837, 40245.0, 40362.39456408215, 38256.80871595624, 38822.61177388303, 38852.222955540165, 38916.83249502519, 39199.41200881932, 33285.00144995654, 34894.65105348914, 35443.82278088593, 35559.0, 35614.465783012754, 24584.262472125865, 25495.23514294574, 25880.0, 25934.87032564825, 26293.0], "value": 19907.33496119393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.4449807576158, 375.27571786452137, 380.6117759884917, 388.36890053662796, 402.8529586700855, 17997.37009204678, 20337.898310508444, 20498.282560110398, 20654.0, 20780.8960955195, 20135.899320503377, 20166.991650417494, 20335.49161270969, 20397.59204815903, 20647.483812904684, 5518.613697041189, 5610.849775795952, 5728.455796699328, 5832.533397328214, 6117.785877494289, 5709.314882214119, 6048.3649216832255, 6129.988551888955, 6132.0, 6135.202423684915, 5716.599838011341, 6013.1581578579035, 6040.96979515104, 6057.878842423149, 6081.939180608181, 5769.653820770767, 5986.940130598704, 6032.27612686476, 6053.697315134225, 6080.574359794794, 4474.373587697725, 4762.5712286313965, 5025.924611130799, 5197.584193264567, 5225.790968361261, 19192.424227273204, 24357.391065223335, 25186.622200667003, 25356.0, 25378.238652840446, 2123.723915890924, 2138.807507324348, 2273.1362082408746, 2392.964105538418, 2428.7571242875747, 12590.68523286916, 15272.770908436383, 15545.766813497807, 15630.296636651377, 15815.446459373867, 1634.2237437217345, 1914.4830895658095, 1931.8164774346415, 1953.9609207815906, 1955.2276850643916, 113197.43401282941, 114154.0, 115283.42358288154, 115415.0, 115763.0, 9160.534314509647, 10097.848532272023, 10789.730256743644, 11117.27737697047, 11318.660440186808, 13387.756725448671, 13456.663583410493, 13466.057375983783, 13480.5281815136, 13493.190408575321, 8272.131426200283, 8333.374996875258, 8564.700235491728, 8572.185642363966, 8752.474851508803, 8516.190961858614, 8594.226519613265, 8602.569871506399, 8824.823503530022, 8827.69103081389, 6483.3192514786215, 6586.538942274091, 6616.86766264672, 6636.435902948207, 6732.629705366252, 1870.8971006594495, 1894.1571000904742, 1897.383350411122, 1899.7720273566983, 1900.2019151956213, 734.4344854462034, 843.7763992541982, 935.373299889076, 944.5230158769778, 965.280865755017, 20779.272725454837, 21248.893755531124, 21365.46586335323, 21498.0, 21656.458588535414, 860.3590325207635, 932.5849996751516, 935.7099299217128, 942.1520631431766, 953.8855337359561, 9153.77115572116, 9367.718968430958, 11393.772124557463, 11542.249753765978, 11578.710532236593, 581328.0933595389, 597835.0, 601544.0, 601643.0, 605541.9722901445, 103273.96726032793, 107594.46202768935, 124812.0, 128090.0, 134312.0, 435.58401726351894, 451.45374097342585, 453.4037740371467, 454.44784586727286, 456.940597722294, 10923.890761092287, 11137.665870023913, 11213.327200368005, 11465.713357166138, 11502.367369794742, 42519.7874010628, 45019.549804501534, 52951.73524132355, 55591.722041389534, 56120.15819762788, 79864.80202796847, 81008.0, 82226.43263861396, 82446.0, 83700.58149709212, 7851.882221766564, 8034.236747508978, 8047.961392074383, 8161.755147345589, 8407.873881891654, 11172.497237624164, 12955.093143479866, 13020.218786872818, 13399.0, 13428.992825538318, 9009.864852027094, 11149.163812713916, 11152.944235278772, 11215.887841121485, 11374.20380573352, 10046.296759226783, 10742.657167854019, 11259.605913792979, 11339.659810205707, 11349.716257093638, 11354.148438867283, 11514.021308188563, 11597.942010290231, 11705.590304339306, 11941.283522988648, 8371.790705232417, 8432.409731318749, 8443.577821108796, 8506.234438900528, 8514.318854491501, 9037.864432033657, 11358.0, 11375.658730238107, 11452.656420307405, 11638.941805290919], "value": 9318.21802723512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.562649644851, 1558.8674962628177, 1749.8512626426752, 1769.7876254849411, 1816.1827177770008, 8121.0, 8353.457025293366, 8586.570671466425, 9201.355905086655, 9250.306227032974, 6895.65521723913, 7715.112762032368, 8635.481871087739, 8829.381943263958, 8900.955495222532, 2329.8369114162015, 2343.297010896733, 2377.0491803278655, 2378.1914149189274, 2381.630847218684, 2346.718393792747, 2357.5520651076326, 2359.480914198882, 2384.391980045095, 2384.4158181245534, 2347.225415612844, 2367.266147494274, 2369.668246445499, 2372.7627237276306, 2412.421018955447, 2273.8408311418207, 2295.9655605165935, 2308.7575804540534, 2312.8496647717843, 2369.052379048377, 1962.7252184694155, 2327.988360058189, 2331.1258278145697, 2333.265021518216, 2344.179537161997, 8235.0, 8635.525046122524, 8993.235574976135, 9061.229795467394, 9100.726978190665, 5229.738513074369, 5245.580353571705, 5310.36275646921, 5319.813806516792, 5411.431799661058, 3128.7015888406286, 3521.6126226115107, 3543.94684079739, 3666.1018050577513, 3679.1354031802507, 1014.1849499240141, 1048.580567772897, 1053.3100818963592, 1065.9200559957956, 1087.9673609791719, 11934.0, 11981.46083426248, 12054.337011464366, 12074.094442916728, 12108.0, 4559.430071241095, 4643.674942753974, 4825.782839772219, 4830.806767729322, 4836.95163048365, 10157.9492102539, 10216.131628811485, 10246.180305575535, 10254.743631409274, 10322.690319290434, 5399.487048730364, 5418.756155972991, 5421.566274698014, 5449.3188351456065, 5475.959567682127, 4445.222086134913, 4577.56513131252, 4766.523347665206, 4892.755362231874, 4956.603471722254, 3889.844406223776, 3913.158670885773, 3985.501812273466, 4039.333509970822, 4039.555648878621, 1095.9287646302964, 1271.5295340723806, 1277.5337001994392, 1284.9720223820907, 1288.845338559379, 789.4947233770391, 875.5928493250669, 887.8446271902392, 922.7416323429451, 934.761635782871, 5778.075507918713, 5942.64344139353, 5959.225300710967, 6102.359252278536, 6271.090691849657, 867.7917299847991, 892.6340200517757, 909.3952521573212, 913.3743385780762, 955.7658373698488, 3710.591834898159, 3783.3000894834545, 3797.525309336333, 3800.809959502069, 3893.124047089382, 10669.573217071385, 11126.833097503544, 11148.108151347873, 11148.554057837759, 11173.664790056311, 10983.780324393627, 11080.667579972614, 11092.1126309895, 11115.166362522843, 11119.55521779136, 7832.316052048837, 8175.018997720193, 8274.917250827535, 8458.534780587004, 8497.617607207567, 5688.345840228427, 5809.186713860147, 5845.0, 5900.822975310747, 5926.496247818984, 9588.520573971413, 9837.95081024619, 9976.05227503386, 9992.350497217658, 10012.949935250277, 9979.0, 10035.949820250851, 10042.0, 10056.69829905104, 10211.285210035227, 7026.2271150174465, 7097.432205423451, 7571.734989275349, 7611.809704757426, 7729.961350193213, 6759.628220447923, 7112.288771122846, 8462.238398544161, 8547.316214702932, 8550.1449855014, 7426.777196684108, 7532.736354227576, 7715.267049630276, 7770.689172433039, 7796.844063118592, 7326.084239470067, 7531.284527969834, 7562.168161502121, 7672.350444654426, 7722.189170137055, 6016.42843929826, 7001.684924178322, 7092.822679433056, 7099.07711997437, 7139.535930164523, 4862.6839255448285, 4936.333594964633, 4980.601551875914, 5017.0, 5019.222020586815, 4867.41591009067, 4894.167991441393, 5015.172496538176, 5116.590672746246, 5117.5394214520875], "value": 4588.374982666884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.14157527417746, 287.6864218002378, 317.07414350097713, 320.9149575362531, 321.0656988164442, 4339.5009573899015, 4600.389863547756, 4628.05124949385, 5350.314650884969, 5548.86127846804, 5169.707573106723, 5294.920576191351, 5513.228148059275, 5538.240230160638, 5554.222408862763, 4252.638525725317, 4289.383476079589, 4306.397104405386, 4321.82712691492, 4329.935050974223, 3416.470447080694, 3573.2317551726373, 3734.365157923146, 4153.833846646131, 4315.633171180453, 3616.8734094306706, 4095.9590404096025, 4161.667066634662, 4176.0, 4194.412782210493, 3444.810535420551, 4173.895652608679, 4186.0, 4216.57834216579, 4250.553691862372, 2989.61135052444, 3602.9911624745114, 3627.7279204059537, 3628.129248980252, 3637.781733096023, 4410.360497727844, 4517.847948773075, 4553.567411095941, 5287.942411517712, 5409.164213111606, 3905.8828235152705, 4759.4764575896625, 4778.450478195017, 4796.824777929395, 4801.8079276828885, 4767.425590181298, 5795.855103622401, 5809.0, 5819.563532735019, 5838.649681019152, 3437.332893546628, 3563.1448452371505, 3851.1501488898016, 3932.3315036443873, 3958.723733853046, 5749.367569567345, 5952.511762179245, 6079.1701228226375, 6169.907451388232, 6183.907241391383, 3342.5320455136302, 3514.876979305712, 3720.255948810249, 4028.5425890206952, 4031.9395209071886, 3331.7334613230882, 3557.395242808677, 3882.971282399676, 3958.7030972677167, 4047.595240475988, 4265.637420819203, 4300.440942677432, 4687.1328804171335, 4758.643101767381, 4766.404199475066, 5150.574867712929, 5784.248047753849, 5825.854353641108, 5863.149843272787, 5891.558133140032, 1181.4211036592008, 1242.3353505874313, 1284.7602064008277, 1295.643697983062, 1346.3335648853683, 788.9270591994882, 809.9797505062421, 857.8327226190958, 860.3117505995178, 860.7331727164599, 3968.4324691746597, 4020.341489244773, 4204.495460544754, 4414.4702635683925, 4614.446266448048, 4311.2239796836875, 4590.921133533617, 4967.726775027409, 5002.849914502571, 5032.213564184735, 4586.0, 4615.769211539477, 4616.8614941551805, 4642.86071417858, 4651.906961860744, 2373.8724106049835, 2489.5269898719184, 2547.898084076653, 2642.920712378632, 2657.9202623921315, 4678.929816052762, 5011.523905228997, 5093.414257360377, 5187.910538786821, 5238.580913526908, 4686.976565117153, 4751.619870410359, 4858.58702010326, 5159.74201289934, 5234.947650523446, 4893.290472881412, 6252.280987686383, 6391.808245752635, 6405.167328247298, 6418.903716444163, 5261.973690131525, 5335.573154147582, 5855.194123819551, 6138.723757431016, 6198.81403557894, 4482.574155455227, 5273.499017593323, 5813.23871161212, 5965.224520812267, 6033.758649653964, 5962.582619216787, 6252.249730032243, 6358.459530939737, 6415.358464153547, 6443.6455994920725, 3692.504535663061, 4153.231652144363, 4155.667546596204, 4216.515100763451, 4226.323788193874, 5225.24954140352, 5240.873212259383, 5580.86047848807, 5961.463468287875, 6022.337542870368, 4895.768792596869, 4923.08922849274, 5290.788368465218, 5777.335606405317, 5849.151872978309, 4388.429504164438, 5887.558433117448, 5892.823215303548, 5914.491804589802, 5921.289445266596, 4620.12884781664, 5546.916796247979, 5755.625884317506, 5790.913136302875, 5808.983427900185, 4570.360149578995, 5914.231149950651, 5914.645121292736, 5963.940360596339, 5986.281646202484, 4825.179719447772, 5802.883942321215, 5806.883862322646, 5834.591578589458, 5856.560757943086], "value": 4048.68258509473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8813601687713, 735.6174789109659, 764.9349805266552, 784.4508843809333, 799.3205775091174, 15157.0, 16208.189590520486, 16213.027218366877, 16225.594360141002, 16230.10734409607, 14696.265186740648, 14862.851371486282, 14864.702705945874, 14881.404743810235, 14906.478273260438, 648.2804087462936, 666.3170250493234, 810.205998121838, 812.6261919517015, 826.4875777018257, 843.6288033265374, 847.5973912391596, 852.5779739029189, 854.4830377621543, 856.9571521423904, 785.3285440947993, 903.7876099116702, 905.9184673379394, 906.8866391701038, 906.9365144439892, 746.2239271157989, 799.0251892690908, 895.552223888056, 900.8018235988105, 915.0757734687946, 615.4061330815784, 647.4561368450477, 660.1451120798578, 663.7809522857445, 663.91037209977, 15019.0, 15023.023503472348, 15088.54734357971, 15213.163276019815, 15223.086614803147, 12546.749065018648, 14734.410623575044, 14831.258437078102, 14954.775678364833, 15107.374230184676, 11677.591284305094, 11776.823347649792, 11840.940795296054, 11918.761624767456, 12024.33866137362, 3744.120131769032, 3798.1074447504816, 3820.2550502651993, 3830.7701537907815, 3924.1759230561615, 116666.0, 117141.24288135685, 117449.41275293569, 118013.0, 122365.38817305857, 9598.136167744937, 11132.0, 11224.0, 11251.43742812856, 11316.830247546293, 23538.529229415657, 23564.64653030206, 23576.642335766628, 23588.05647774104, 23690.170844020377, 7195.208527062019, 7336.706531738778, 7794.337481314038, 8026.398020148512, 8062.153473885275, 4310.719803212781, 4371.147626212858, 4372.803223854934, 4375.9935214900115, 4484.708493947883, 3575.2670702505925, 3594.4428613564937, 3689.5572531296416, 3693.3536631089987, 3693.8707145250323, 626.4737620398796, 630.3349965786048, 644.0628884972353, 656.5765081522392, 664.259350823828, 613.8557439001831, 631.5894668465534, 636.710296814948, 650.6876699184323, 652.1456891472187, 8974.326925480615, 8997.055309192572, 9049.864252036225, 9267.72196834096, 9275.489848058422, 563.248063834777, 608.3703367015119, 653.6600967496875, 665.4377051391566, 665.5640555436197, 4354.521002689701, 4546.931796023062, 4556.567126123079, 4560.315952607069, 4613.861584152481, 104368.0, 144780.0, 151694.24152879385, 154295.45704543035, 156326.0, 128452.0, 129222.35388822996, 129693.0, 131351.0, 132098.0, 115783.0, 115971.0, 116265.8373416272, 116995.41502292434, 118032.0, 8770.693025744069, 8842.425242359226, 8863.601137948937, 8937.329700272636, 9019.188273055457, 62761.68619156875, 64065.35934640594, 65134.67432662996, 65831.67084164548, 67352.0, 86020.56989715261, 95704.0, 96114.0, 98768.50615747162, 99052.0, 10681.786364272826, 11286.604968826052, 11909.22590031645, 12063.51745930188, 12187.390630468619, 13025.413856376676, 13170.539031134247, 13383.0, 13455.327233638083, 13782.724345512834, 9266.629334826532, 10726.410047447465, 12151.75696486083, 12175.269483830998, 12225.0, 9693.515324233902, 11385.829212561652, 12044.75910481768, 12173.208741432132, 12560.434780435085, 11715.414229288332, 12123.0, 12341.876581234073, 12375.814362784746, 12501.312427816558, 10434.37393756377, 10694.62568810088, 10713.464326783474, 11007.0, 11026.08678424773, 8340.87488687658, 8728.563571821256, 9052.34085617849, 10361.585536578452, 10709.036186743231], "value": 7657.73354779547, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 117.0, 116.0, 119.0, 119.0, 122.0, 110.0, 171.0, 180.0], "value": 128.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 119.0, 146.0, 182.0, 140.0, 141.0, 145.0, 114.0, 145.0, 117.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 248.0, 281.0, 268.0, 195.0, 201.0, 198.0, 196.0, 197.0, 231.0], "value": 221.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 83.0, 60.0, 60.0, 59.0, 59.0, 75.0, 57.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 87.0, 71.0, 68.0, 69.0, 89.0, 69.0, 71.0, 86.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 76.0, 136.0, 133.0, 88.0, 85.0, 91.0, 99.0, 87.0, 76.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 103.0, 117.0, 152.0, 150.0, 95.0, 97.0, 96.0, 95.0, 95.0], "value": 109.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 79.0, 104.0, 116.0, 122.0, 148.0, 140.0, 89.0, 96.0], "value": 109.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 59.0, 57.0, 56.0, 60.0, 68.0, 68.0, 52.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 80.0, 115.0, 116.0, 109.0, 95.0, 61.0, 61.0, 63.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 76.0, 112.0, 111.0, 107.0, 109.0, 89.0, 87.0, 88.0, 92.0], "value": 97.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 169.0, 177.0, 161.0, 163.0, 161.0, 164.0, 154.0, 184.0, 151.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 175.0, 172.0, 195.0, 232.0, 235.0, 172.0, 173.0, 171.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 69.0, 72.0, 71.0, 82.0, 75.0, 95.0], "value": 74.5, "unit": "score"}]}]} 21:56:16 INFO - Return code: 0 21:56:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:56:16 ERROR - # TBPL SUCCESS # 21:56:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:56:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:56:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:56:16 INFO - 2016-10-07 21:56:16.230 screenresolution[1671:10633] starting screenresolution argv=screenresolution get 21:56:16 INFO - 2016-10-07 21:56:16.232 screenresolution[1671:10633] Display 0: 1600x1200x32@60 21:56:16 INFO - 2016-10-07 21:56:16.238 screenresolution[1672:10636] starting screenresolution argv=screenresolution list 21:56:16 INFO - Available Modes on Display 0 21:56:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:56:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:56:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:56:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:56:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:56:16 INFO - Intel Iris: 21:56:16 INFO - Chipset Model: Intel Iris 21:56:16 INFO - Type: GPU 21:56:16 INFO - Bus: Built-In 21:56:16 INFO - VRAM (Dynamic, Max): 1536 MB 21:56:16 INFO - Vendor: Intel (0x8086) 21:56:16 INFO - Device ID: 0x0a2e 21:56:16 INFO - Revision ID: 0x0009 21:56:16 INFO - Displays: 21:56:16 INFO - Display: 21:56:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:56:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:56:16 INFO - Display Serial Number: 1600x1200 60 21:56:16 INFO - Main Display: Yes 21:56:16 INFO - Mirror: Off 21:56:16 INFO - Online: Yes 21:56:16 INFO - Rotation: Supported 21:56:16 INFO - Return code: 0 21:56:16 INFO - Running post-action listener: _resource_record_post_action 21:56:16 INFO - [mozharness: 2016-10-08 04:56:16.473132Z] Finished run-tests step (success) 21:56:16 INFO - Running post-run listener: _resource_record_post_run 21:56:16 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37709312; Write bytes: 710594560; Read time: 239; Write time: 2045 21:56:16 INFO - TinderboxPrint: CPU usage
54.3% 21:56:16 INFO - TinderboxPrint: I/O read bytes / time
37,709,312 / 239 21:56:16 INFO - TinderboxPrint: I/O write bytes / time
710,594,560 / 2,045 21:56:16 INFO - TinderboxPrint: CPU idle
2,215.2 (45.7%) 21:56:16 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 21:56:16 INFO - TinderboxPrint: CPU user
1,656.7 (34.2%) 21:56:16 INFO - TinderboxPrint: Swap in / out
446,312,448 / 0 21:56:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 411751936; Write bytes: 402193920; Read time: 31075; Write time: 840 21:56:16 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29819392; Write bytes: 297390592; Read time: 175; Write time: 1173 21:56:16 INFO - Running post-run listener: _upload_blobber_files 21:56:16 INFO - Blob upload gear active. 21:56:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:56:16 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 21:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:56:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:18 INFO - (blobuploader) - INFO - Done attempting. 21:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:18 INFO - (blobuploader) - INFO - Done attempting. 21:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:21 INFO - (blobuploader) - INFO - Done attempting. 21:56:21 INFO - (blobuploader) - INFO - Iteration through files over. 21:56:21 INFO - Return code: 0 21:56:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:56:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:56:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/096f7651a1fae946d2f90ca589310f032c91586325d922f250f7a1102a080b7d8cd24f281095f1ed32cb58fad6a522119ba36ab5c7f257be6a6cb552727f79c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b8596930339778b396b3a99f41b5d09729e0091184016c807e7b7fb20e13608b105423e0b1449d55a78e53be3750d86dfb1295e40d2ca4966ceda87938bac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85643a8634b9c342eced8ae7198ea3569aa8015b6f40c13079ff423a6aa0441469f3f7bcaeaa588cac8ab174f61ded699287a4ea9772b29976756631c2857a5c"} 21:56:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:56:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:56:21 INFO - Contents: 21:56:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/096f7651a1fae946d2f90ca589310f032c91586325d922f250f7a1102a080b7d8cd24f281095f1ed32cb58fad6a522119ba36ab5c7f257be6a6cb552727f79c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b8596930339778b396b3a99f41b5d09729e0091184016c807e7b7fb20e13608b105423e0b1449d55a78e53be3750d86dfb1295e40d2ca4966ceda87938bac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85643a8634b9c342eced8ae7198ea3569aa8015b6f40c13079ff423a6aa0441469f3f7bcaeaa588cac8ab174f61ded699287a4ea9772b29976756631c2857a5c"} 21:56:21 INFO - Running post-run listener: copy_logs_to_upload_dir 21:56:21 INFO - Copying logs to upload dir... 21:56:21 INFO - mkdir: /builds/slave/test/build/upload/logs 21:56:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.135962 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-10-07 21:56:21.289081) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:21.292234) ========= 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.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/Firefox/sha512/096f7651a1fae946d2f90ca589310f032c91586325d922f250f7a1102a080b7d8cd24f281095f1ed32cb58fad6a522119ba36ab5c7f257be6a6cb552727f79c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b8596930339778b396b3a99f41b5d09729e0091184016c807e7b7fb20e13608b105423e0b1449d55a78e53be3750d86dfb1295e40d2ca4966ceda87938bac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85643a8634b9c342eced8ae7198ea3569aa8015b6f40c13079ff423a6aa0441469f3f7bcaeaa588cac8ab174f61ded699287a4ea9772b29976756631c2857a5c"} build_url:https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/096f7651a1fae946d2f90ca589310f032c91586325d922f250f7a1102a080b7d8cd24f281095f1ed32cb58fad6a522119ba36ab5c7f257be6a6cb552727f79c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b8596930339778b396b3a99f41b5d09729e0091184016c807e7b7fb20e13608b105423e0b1449d55a78e53be3750d86dfb1295e40d2ca4966ceda87938bac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85643a8634b9c342eced8ae7198ea3569aa8015b6f40c13079ff423a6aa0441469f3f7bcaeaa588cac8ab174f61ded699287a4ea9772b29976756631c2857a5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:21.325070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:21.325406) ========= 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.TZh8bkXmq8/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.jTuAREaJVR/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005088 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:21.374807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:21.375190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:21.375606) ========= ========= Total master_lag: 0.17 =========