builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0194 starttime: 1483985050.84 results: success (0) buildid: 20170109080108 builduid: a03e9b93979944dcb93411f21e7075af revision: ae40c9ff8660cbe0239161cff7ec3db1faa4c468 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:10.845190) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:10.845676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:10.845975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:10.876410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:10.876849) ========= 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.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-09 10:04:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 149M=0s 2017-01-09 10:04:10 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:11.020015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:11.020330) ========= 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.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.020161 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:11.069502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 10:04:11.070068) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae40c9ff8660cbe0239161cff7ec3db1faa4c468 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae40c9ff8660cbe0239161cff7ec3db1faa4c468 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-09 10:04:11,143 truncating revision to first 12 chars 2017-01-09 10:04:11,143 Setting DEBUG logging. 2017-01-09 10:04:11,144 attempt 1/10 2017-01-09 10:04:11,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae40c9ff8660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 10:04:12,119 unpacking tar archive at: mozilla-aurora-ae40c9ff8660/testing/mozharness/ program finished with exit code 0 elapsedTime=1.210788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 10:04:12.305781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:12.306128) ========= script_repo_revision: ae40c9ff8660cbe0239161cff7ec3db1faa4c468 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:12.306569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:12.306882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 10:04:12.327107) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-09 10:04:12.327498) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:12 INFO - MultiFileLogger online at 20170109 10:04:12 in /builds/slave/test 10:04:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:04:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:12 INFO - {'append_to_log': False, 10:04:12 INFO - 'base_work_dir': '/builds/slave/test', 10:04:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:04:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:12 INFO - 'branch': 'Mozilla-Aurora', 10:04:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:12 INFO - 'config_files': ('talos/mac_config.py',), 10:04:12 INFO - 'default_actions': ('clobber', 10:04:12 INFO - 'read-buildbot-config', 10:04:12 INFO - 'download-and-extract', 10:04:12 INFO - 'populate-webroot', 10:04:12 INFO - 'create-virtualenv', 10:04:12 INFO - 'install', 10:04:12 INFO - 'run-tests'), 10:04:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:12 INFO - 'download_minidump_stackwalk': True, 10:04:12 INFO - 'download_symbols': 'ondemand', 10:04:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:12 INFO - 'installer_path': 'installer.exe', 10:04:12 INFO - 'log_level': 'info', 10:04:12 INFO - 'log_name': 'talos', 10:04:12 INFO - 'log_to_console': True, 10:04:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:04:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:04:12 INFO - 'opt_config_files': (), 10:04:12 INFO - 'pip_index': False, 10:04:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:12 INFO - 'cmd': ('bash', 10:04:12 INFO - '-c', 10:04:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:12 INFO - 'enabled': True, 10:04:12 INFO - 'halt_on_failure': False, 10:04:12 INFO - 'name': 'check_screen_resolution'},), 10:04:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:12 INFO - 'cmd': ('bash', 10:04:12 INFO - '-c', 10:04:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:12 INFO - 'enabled': True, 10:04:12 INFO - 'halt_on_failure': False, 10:04:12 INFO - 'name': 'check_screen_resolution'},), 10:04:12 INFO - 'run_cmd_checks_enabled': True, 10:04:12 INFO - 'sps_profile': False, 10:04:12 INFO - 'sps_profile_interval': 0, 10:04:12 INFO - 'suite': 'dromaeojs-e10s', 10:04:12 INFO - 'system_bits': '32', 10:04:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:12 INFO - 'title': 't-yosemite-r7-0194', 10:04:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:12 INFO - 'use_talos_json': True, 10:04:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:12 INFO - 'work_dir': 'build'} 10:04:12 INFO - [mozharness: 2017-01-09 18:04:12.527110Z] Running clobber step. 10:04:12 INFO - Running pre-action listener: _resource_record_pre_action 10:04:12 INFO - Running main action method: clobber 10:04:12 INFO - rmtree: /builds/slave/test/build 10:04:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:14 INFO - Running post-action listener: _resource_record_post_action 10:04:14 INFO - [mozharness: 2017-01-09 18:04:14.039778Z] Finished clobber step (success) 10:04:14 INFO - [mozharness: 2017-01-09 18:04:14.039945Z] Running read-buildbot-config step. 10:04:14 INFO - Running pre-action listener: _resource_record_pre_action 10:04:14 INFO - Running main action method: read_buildbot_config 10:04:14 INFO - Using buildbot properties: 10:04:14 INFO - { 10:04:14 INFO - "project": "", 10:04:14 INFO - "product": "firefox", 10:04:14 INFO - "script_repo_revision": "production", 10:04:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:04:14 INFO - "repository": "", 10:04:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:04:14 INFO - "buildid": "20170109080108", 10:04:14 INFO - "pgo_build": "False", 10:04:14 INFO - "basedir": "/builds/slave/test", 10:04:14 INFO - "buildnumber": 29, 10:04:14 INFO - "slavename": "t-yosemite-r7-0194", 10:04:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:04:14 INFO - "platform": "yosemite_r7", 10:04:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:04:14 INFO - "branch": "mozilla-aurora", 10:04:14 INFO - "repo_path": "releases/mozilla-aurora", 10:04:14 INFO - "revision": "ae40c9ff8660cbe0239161cff7ec3db1faa4c468", 10:04:14 INFO - "stage_platform": "macosx64", 10:04:14 INFO - "builduid": "a03e9b93979944dcb93411f21e7075af", 10:04:14 INFO - "slavebuilddir": "test" 10:04:14 INFO - } 10:04:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:04:14 INFO - Running post-action listener: _resource_record_post_action 10:04:14 INFO - [mozharness: 2017-01-09 18:04:14.043315Z] Finished read-buildbot-config step (success) 10:04:14 INFO - [mozharness: 2017-01-09 18:04:14.043399Z] Running download-and-extract step. 10:04:14 INFO - Running pre-action listener: _resource_record_pre_action 10:04:14 INFO - Running main action method: download_and_extract 10:04:14 INFO - mkdir: /builds/slave/test/build/tests 10:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:14 INFO - trying https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:04:14 INFO - Downloading https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:04:15 INFO - Downloaded 1199 bytes. 10:04:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:04:15 INFO - Using the following test package requirements: 10:04:15 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:04:15 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:04:15 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:04:15 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'jsshell-mac.zip'], 10:04:15 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:04:15 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:04:15 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:04:15 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:04:15 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:04:15 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:04:15 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:04:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:04:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:04:15 INFO - Fetch https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:04:15 INFO - Http code: 200 10:04:15 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 10:04:15 INFO - x-amz-cf-id: 76rpgHbiD61tngoPEjgBHndS65OnQ791MXSu9-xwyecEC9bDLRABNg== 10:04:15 INFO - x-amz-version-id: gLxi.ga8DoEwp0lrayUZHtmpXTaImLg4 10:04:15 INFO - Expected file size: 16270878 10:04:15 INFO - Obtained file size: 16270878 10:04:22 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:04:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:04:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:04:22 INFO - Fetch https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:04:23 INFO - Http code: 200 10:04:23 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:04:23 INFO - x-amz-cf-id: T5lHcFTui4Kmtm1122xMcIgFV_u6z6yJhLbkIXEi1YxE1SfCAXifqA== 10:04:23 INFO - x-amz-version-id: gLxi.ga8DoEwp0lrayUZHtmpXTaImLg4 10:04:23 INFO - Expected file size: 16270878 10:04:23 INFO - Obtained file size: 16270878 10:04:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:04:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:04:29 INFO - Fetch https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:04:30 INFO - Http code: 200 10:04:30 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 10:04:30 INFO - x-amz-cf-id: 6_kdnbkU8bYD_GlZZhN8IPLinecXoyjBrGFY8u9e7mN7-fMO82ym6g== 10:04:30 INFO - x-amz-version-id: UgJD_taXKgZCSU5gclXP_uJNWRKqieog 10:04:30 INFO - Expected file size: 14409038 10:04:30 INFO - Obtained file size: 14409038 10:04:31 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')]} 10:04:31 INFO - trying https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:04:31 INFO - Downloading https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:04:33 INFO - Downloaded 109878819 bytes. 10:04:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:04:33 INFO - mkdir: /builds/slave/test/properties 10:04:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:33 INFO - Contents: 10:04:33 INFO - build_url:https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - Running post-action listener: set_extra_try_arguments 10:04:34 INFO - [mozharness: 2017-01-09 18:04:34.536449Z] Finished download-and-extract step (success) 10:04:34 INFO - [mozharness: 2017-01-09 18:04:34.536578Z] Running populate-webroot step. 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: populate_webroot 10:04:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:34 INFO - '--tppagecycles', 10:04:34 INFO - '7'], 10:04:34 INFO - 'tests': ['tsvgm']}}, 10:04:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['damp', 'tps']}, 10:04:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['damp', 'tps']}, 10:04:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['dromaeo_dom']}, 10:04:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['basic_compositor_video']}, 10:04:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:04:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['a11yr', 10:04:34 INFO - 'ts_paint', 10:04:34 INFO - 'tpaint', 10:04:34 INFO - 'sessionrestore', 10:04:34 INFO - 'sessionrestore_no_auto_restore', 10:04:34 INFO - 'tabpaint']}, 10:04:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tsvgx', 10:04:34 INFO - 'tsvgr_opacity', 10:04:34 INFO - 'tart', 10:04:34 INFO - 'tscrollx', 10:04:34 INFO - 'cart']}, 10:04:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:34 INFO - 'tsvgr_opacity', 10:04:34 INFO - 'tart', 10:04:34 INFO - 'tscrollx', 10:04:34 INFO - 'cart']}, 10:04:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s'], 10:04:34 INFO - 'tests': ['tp5o']}, 10:04:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'tests': ['tp5o']}, 10:04:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--disable-e10s', 10:04:34 INFO - '--xperf_path', 10:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:34 INFO - 'tests': ['tp5n']}, 10:04:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:34 INFO - 'talos_options': ['--xperf_path', 10:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:34 INFO - 'tests': ['tp5n']}}, 10:04:34 INFO - 'talos.zip': {'path': '', 10:04:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:34 INFO - Running post-action listener: _resource_record_post_action 10:04:34 INFO - [mozharness: 2017-01-09 18:04:34.556159Z] Finished populate-webroot step (success) 10:04:34 INFO - [mozharness: 2017-01-09 18:04:34.556268Z] Running create-virtualenv step. 10:04:34 INFO - Running pre-action listener: _resource_record_pre_action 10:04:34 INFO - Running main action method: create_virtualenv 10:04:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:34 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 10:04:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:34 INFO - Using real prefix '/tools/python27' 10:04:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:38 INFO - Installing pip.................done. 10:04:38 INFO - Return code: 0 10:04:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:04:38 INFO - Reading from file tmpfile_stdout 10:04:38 INFO - Output received: 10:04:38 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) 10:04:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04: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', 'pip>=1.5'] in /builds/slave/test/build 10:04: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 pip>=1.5 10:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:38 INFO - 'HOME': '/Users/cltbld', 10:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:38 INFO - 'LOGNAME': 'cltbld', 10:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:38 INFO - 'MOZ_NO_REMOTE': '1', 10:04:38 INFO - 'NO_EM_RESTART': '1', 10:04:38 INFO - 'PAGER': '/bin/cat', 10:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:38 INFO - 'PWD': '/builds/slave/test', 10:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:38 INFO - 'SHELL': '/bin/bash', 10:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:38 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:38 INFO - 'USER': 'cltbld', 10:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:38 INFO - 'XPC_FLAGS': '0x0', 10:04:38 INFO - 'XPC_SERVICE_NAME': '0', 10:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:38 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 10:04:38 INFO - Cleaning up... 10:04:38 INFO - Return code: 0 10:04:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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', '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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:04: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 psutil>=3.1.1 10:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:38 INFO - 'HOME': '/Users/cltbld', 10:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:38 INFO - 'LOGNAME': 'cltbld', 10:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:38 INFO - 'MOZ_NO_REMOTE': '1', 10:04:38 INFO - 'NO_EM_RESTART': '1', 10:04:38 INFO - 'PAGER': '/bin/cat', 10:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:38 INFO - 'PWD': '/builds/slave/test', 10:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:38 INFO - 'SHELL': '/bin/bash', 10:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:38 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:38 INFO - 'USER': 'cltbld', 10:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:38 INFO - 'XPC_FLAGS': '0x0', 10:04:38 INFO - 'XPC_SERVICE_NAME': '0', 10:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:39 INFO - Downloading/unpacking psutil>=3.1.1 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:42 INFO - Installing collected packages: psutil 10:04:42 INFO - Running setup.py install for psutil 10:04:42 INFO - building 'psutil._psutil_osx' extension 10:04:42 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 10:04:42 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 10:04:43 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 10:04:43 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 10:04:43 INFO - building 'psutil._psutil_posix' extension 10:04:43 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 10:04:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:04:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:04:43 INFO - ^ 10:04:43 INFO - 1 warning generated. 10:04:43 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 10:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:43 INFO - Successfully installed psutil 10:04:43 INFO - Cleaning up... 10:04:43 INFO - Return code: 0 10:04:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:04:43 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')]} 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:43 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')]} 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:43 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:43 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 10:04:43 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 10:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:43 INFO - 'HOME': '/Users/cltbld', 10:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:43 INFO - 'LOGNAME': 'cltbld', 10:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:43 INFO - 'MOZ_NO_REMOTE': '1', 10:04:43 INFO - 'NO_EM_RESTART': '1', 10:04:43 INFO - 'PAGER': '/bin/cat', 10:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:43 INFO - 'PWD': '/builds/slave/test', 10:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:43 INFO - 'SHELL': '/bin/bash', 10:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:43 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:43 INFO - 'USER': 'cltbld', 10:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:43 INFO - 'XPC_FLAGS': '0x0', 10:04:43 INFO - 'XPC_SERVICE_NAME': '0', 10:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:04:46 INFO - Installing collected packages: mozsystemmonitor 10:04:46 INFO - Running setup.py install for mozsystemmonitor 10:04:46 INFO - Successfully installed mozsystemmonitor 10:04:46 INFO - Cleaning up... 10:04:46 INFO - Return code: 0 10:04:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:04:46 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')]} 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:46 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')]} 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:46 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:46 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 10:04:46 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 10:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:46 INFO - 'HOME': '/Users/cltbld', 10:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:46 INFO - 'LOGNAME': 'cltbld', 10:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:46 INFO - 'MOZ_NO_REMOTE': '1', 10:04:46 INFO - 'NO_EM_RESTART': '1', 10:04:46 INFO - 'PAGER': '/bin/cat', 10:04:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:46 INFO - 'PWD': '/builds/slave/test', 10:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:46 INFO - 'SHELL': '/bin/bash', 10:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:46 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:46 INFO - 'USER': 'cltbld', 10:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:46 INFO - 'XPC_FLAGS': '0x0', 10:04:46 INFO - 'XPC_SERVICE_NAME': '0', 10:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:50 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:50 INFO - warning: no files found matching '*.txt' 10:04:50 INFO - no previously-included directories found matching 'build' 10:04:50 INFO - no previously-included directories found matching 'dist' 10:04:50 INFO - no previously-included directories found matching '.git*' 10:04:50 INFO - Installing collected packages: jsonschema, functools32 10:04:50 INFO - Running setup.py install for functools32 10:04:50 INFO - warning: no files found matching '*.txt' 10:04:50 INFO - no previously-included directories found matching 'build' 10:04:50 INFO - no previously-included directories found matching 'dist' 10:04:50 INFO - no previously-included directories found matching '.git*' 10:04:50 INFO - Successfully installed jsonschema functools32 10:04:50 INFO - Cleaning up... 10:04:50 INFO - Return code: 0 10:04:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:50 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 10:04:50 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 10:04:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:50 INFO - 'HOME': '/Users/cltbld', 10:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:50 INFO - 'LOGNAME': 'cltbld', 10:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:50 INFO - 'MOZ_NO_REMOTE': '1', 10:04:50 INFO - 'NO_EM_RESTART': '1', 10:04:50 INFO - 'PAGER': '/bin/cat', 10:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:50 INFO - 'PWD': '/builds/slave/test', 10:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:50 INFO - 'SHELL': '/bin/bash', 10:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:50 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:50 INFO - 'USER': 'cltbld', 10:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:50 INFO - 'XPC_FLAGS': '0x0', 10:04:50 INFO - 'XPC_SERVICE_NAME': '0', 10:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:04:50 INFO - Cleaning up... 10:04:50 INFO - Return code: 0 10:04:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:50 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 10:04:50 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 10:04:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:50 INFO - 'HOME': '/Users/cltbld', 10:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:50 INFO - 'LOGNAME': 'cltbld', 10:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:50 INFO - 'MOZ_NO_REMOTE': '1', 10:04:50 INFO - 'NO_EM_RESTART': '1', 10:04:50 INFO - 'PAGER': '/bin/cat', 10:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:50 INFO - 'PWD': '/builds/slave/test', 10:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:50 INFO - 'SHELL': '/bin/bash', 10:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:50 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:50 INFO - 'USER': 'cltbld', 10:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:50 INFO - 'XPC_FLAGS': '0x0', 10:04:50 INFO - 'XPC_SERVICE_NAME': '0', 10:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:53 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 10:04:53 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 10:04:53 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 10:04:53 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 10:04:53 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 10:04:53 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 10:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - Downloading docopt-0.6.1.tar.gz 10:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:54 INFO - Running setup.py install for blobuploader 10:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:55 INFO - Running setup.py install for requests 10:04:55 INFO - Running setup.py install for docopt 10:04:55 INFO - Successfully installed blobuploader requests docopt 10:04:55 INFO - Cleaning up... 10:04:55 INFO - Return code: 0 10:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:55 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:04:55 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 10:04:55 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 10:04:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:04:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:55 INFO - 'HOME': '/Users/cltbld', 10:04:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:55 INFO - 'LOGNAME': 'cltbld', 10:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:55 INFO - 'MOZ_NO_REMOTE': '1', 10:04:55 INFO - 'NO_EM_RESTART': '1', 10:04:55 INFO - 'PAGER': '/bin/cat', 10:04:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:55 INFO - 'PWD': '/builds/slave/test', 10:04:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:55 INFO - 'SHELL': '/bin/bash', 10:04:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:04:55 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:04:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:55 INFO - 'USER': 'cltbld', 10:04:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:55 INFO - 'XPC_FLAGS': '0x0', 10:04:55 INFO - 'XPC_SERVICE_NAME': '0', 10:04:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-eJ6J11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-utAj9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-fqoNKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-EBam68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-NLieoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-8Dnv81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-ajJ93l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Ez5qle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-6ghnk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:56 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-7Flrh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Flenmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-sa5_bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-3Bcsy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-acCGyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-e1vshh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-akj9ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:57 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-FkuxSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:57 INFO - Running setup.py install for manifestparser 10:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:57 INFO - Running setup.py install for mozcrash 10:04:58 INFO - Running setup.py install for mozdebug 10:04:58 INFO - Running setup.py install for mozdevice 10:04:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozfile 10:04:58 INFO - Running setup.py install for mozhttpd 10:04:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozinfo 10:04:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozInstall 10:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozleak 10:04:59 INFO - Running setup.py install for mozlog 10:04:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for moznetwork 10:04:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozprocess 10:04:59 INFO - Running setup.py install for mozprofile 10:04:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozrunner 10:04:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozscreenshot 10:05:00 INFO - Running setup.py install for moztest 10:05:00 INFO - Running setup.py install for mozversion 10:05:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:00 INFO - Cleaning up... 10:05:00 INFO - Return code: 0 10:05:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:00 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:05:00 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 10:05:00 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 10:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:00 INFO - 'HOME': '/Users/cltbld', 10:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:00 INFO - 'LOGNAME': 'cltbld', 10:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:00 INFO - 'MOZ_NO_REMOTE': '1', 10:05:00 INFO - 'NO_EM_RESTART': '1', 10:05:00 INFO - 'PAGER': '/bin/cat', 10:05:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:00 INFO - 'PWD': '/builds/slave/test', 10:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:00 INFO - 'SHELL': '/bin/bash', 10:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:05:00 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:00 INFO - 'USER': 'cltbld', 10:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:00 INFO - 'XPC_FLAGS': '0x0', 10:05:00 INFO - 'XPC_SERVICE_NAME': '0', 10:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-FiKXZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:00 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)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Ui1Cnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-W0zkKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Z_QnLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-qHs9DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-wsKRFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Ojs21n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Cq4Krs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-3jZYF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-FhaK9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Q4uX8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 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)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-OkqLBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:02 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)) 10:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:02 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-A66onT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:02 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)) 10:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:02 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Yw2B_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:02 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-LZLo8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:02 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)) 10:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:02 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Xmocro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:02 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-WzCjJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:02 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)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:02 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)) 10:05:02 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)) 10:05:02 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)) 10:05:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:02 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 10:05:02 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 10:05:02 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 10:05:02 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 10:05:02 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 10:05:02 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 10:05:05 INFO - Downloading blessings-1.6.tar.gz 10:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:05 INFO - Installing collected packages: blessings 10:05:05 INFO - Running setup.py install for blessings 10:05:05 INFO - Successfully installed blessings 10:05:05 INFO - Cleaning up... 10:05:05 INFO - Return code: 0 10:05:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:05 INFO - Reading from file tmpfile_stdout 10:05:05 INFO - Current package versions: 10:05:05 INFO - blessings == 1.6 10:05:05 INFO - blobuploader == 1.2.4 10:05:05 INFO - docopt == 0.6.1 10:05:05 INFO - functools32 == 3.2.3-2 10:05:05 INFO - jsonschema == 2.5.1 10:05:05 INFO - manifestparser == 1.1 10:05:05 INFO - mozInstall == 1.12 10:05:05 INFO - mozcrash == 1.0 10:05:05 INFO - mozdebug == 0.1 10:05:05 INFO - mozdevice == 0.48 10:05:05 INFO - mozfile == 1.2 10:05:05 INFO - mozhttpd == 0.7 10:05:05 INFO - mozinfo == 0.9 10:05:05 INFO - mozleak == 0.1 10:05:05 INFO - mozlog == 3.4 10:05:05 INFO - moznetwork == 0.27 10:05:05 INFO - mozprocess == 0.23 10:05:05 INFO - mozprofile == 0.28 10:05:05 INFO - mozrunner == 6.13 10:05:05 INFO - mozscreenshot == 0.1 10:05:05 INFO - mozsystemmonitor == 0.3 10:05:05 INFO - moztest == 0.8 10:05:05 INFO - mozversion == 1.4 10:05:05 INFO - psutil == 3.1.1 10:05:05 INFO - requests == 1.2.3 10:05:05 INFO - wsgiref == 0.1.2 10:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 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 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:05:05 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 10:05:05 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 10:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:05 INFO - 'HOME': '/Users/cltbld', 10:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:05 INFO - 'LOGNAME': 'cltbld', 10:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:05 INFO - 'MOZ_NO_REMOTE': '1', 10:05:05 INFO - 'NO_EM_RESTART': '1', 10:05:05 INFO - 'PAGER': '/bin/cat', 10:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:05 INFO - 'PWD': '/builds/slave/test', 10:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:05 INFO - 'SHELL': '/bin/bash', 10:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:05:05 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:05 INFO - 'USER': 'cltbld', 10:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:05 INFO - 'XPC_FLAGS': '0x0', 10:05:05 INFO - 'XPC_SERVICE_NAME': '0', 10:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 INFO - Cleaning up... 10:05:05 INFO - Return code: 0 10:05:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107960490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078d6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde49489010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.QTWy69cM5o/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.WGVpzowRrv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 10:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:05:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:06 INFO - 'HOME': '/Users/cltbld', 10:05:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:06 INFO - 'LOGNAME': 'cltbld', 10:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:06 INFO - 'MOZ_NO_REMOTE': '1', 10:05:06 INFO - 'NO_EM_RESTART': '1', 10:05:06 INFO - 'PAGER': '/bin/cat', 10:05:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:06 INFO - 'PWD': '/builds/slave/test', 10:05:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:06 INFO - 'SHELL': '/bin/bash', 10:05:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:05:06 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:05:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:06 INFO - 'USER': 'cltbld', 10:05:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:06 INFO - 'XPC_FLAGS': '0x0', 10:05:06 INFO - 'XPC_SERVICE_NAME': '0', 10:05:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:05:06 INFO - Cleaning up... 10:05:06 INFO - Return code: 0 10:05:06 INFO - Running post-action listener: _resource_record_post_action 10:05:06 INFO - Running post-action listener: _start_resource_monitoring 10:05:06 INFO - Starting resource monitoring. 10:05:06 INFO - [mozharness: 2017-01-09 18:05:06.287411Z] Finished create-virtualenv step (success) 10:05:06 INFO - [mozharness: 2017-01-09 18:05:06.288435Z] Running install step. 10:05:06 INFO - Running pre-action listener: _resource_record_pre_action 10:05:06 INFO - Running main action method: install 10:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:06 INFO - Reading from file tmpfile_stdout 10:05:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:06 INFO - Reading from file tmpfile_stdout 10:05:06 INFO - Output received: 10:05:06 INFO - Usage: mozinstall [options] installer 10:05:06 INFO - Options: 10:05:06 INFO - -h, --help show this help message and exit 10:05:06 INFO - -d DEST, --destination=DEST 10:05:06 INFO - Directory to install application into. [default: 10:05:06 INFO - "/builds/slave/test"] 10:05:06 INFO - --app=APP Application being installed. [default: firefox] 10:05:06 INFO - mkdir: /builds/slave/test/build/application 10:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:05:37 INFO - Reading from file tmpfile_stdout 10:05:37 INFO - Output received: 10:05:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - [mozharness: 2017-01-09 18:05:37.851610Z] Finished install step (success) 10:05:37 INFO - [mozharness: 2017-01-09 18:05:37.851750Z] Running run-tests step. 10:05:37 INFO - Running pre-action listener: _resource_record_pre_action 10:05:37 INFO - Running main action method: run_tests 10:05:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:37 INFO - 2017-01-09 10:05:37.866 screenresolution[2218:18392] starting screenresolution argv=screenresolution get 10:05:37 INFO - 2017-01-09 10:05:37.868 screenresolution[2218:18392] Display 0: 1600x1200x32@60 10:05:37 INFO - 2017-01-09 10:05:37.874 screenresolution[2219:18394] starting screenresolution argv=screenresolution list 10:05:37 INFO - Available Modes on Display 0 10:05:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:38 INFO - Intel Iris: 10:05:38 INFO - Chipset Model: Intel Iris 10:05:38 INFO - Type: GPU 10:05:38 INFO - Bus: Built-In 10:05:38 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:38 INFO - Vendor: Intel (0x8086) 10:05:38 INFO - Device ID: 0x0a2e 10:05:38 INFO - Revision ID: 0x0009 10:05:38 INFO - Displays: 10:05:38 INFO - Display: 10:05:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:38 INFO - Display Serial Number: 1600x1200 60 10:05:38 INFO - Main Display: Yes 10:05:38 INFO - Mirror: Off 10:05:38 INFO - Online: Yes 10:05:38 INFO - Rotation: Supported 10:05:38 INFO - Return code: 0 10:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:38 INFO - Python 2.7.3 10:05:38 INFO - Return code: 0 10:05:38 INFO - grabbing minidump binary from tooltool 10:05: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')]} 10:05:38 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 0x107774d30>, '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 0x1075dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:38 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 10:05:38 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 10:05:38 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 10:05:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:38 INFO - Return code: 0 10:05:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:05:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:05:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 10:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0194 --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 10:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QTWy69cM5o/Render', 10:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:38 INFO - 'HOME': '/Users/cltbld', 10:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:38 INFO - 'LOGNAME': 'cltbld', 10:05:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:38 INFO - 'MOZ_NO_REMOTE': '1', 10:05:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:38 INFO - 'NO_EM_RESTART': '1', 10:05:38 INFO - 'PAGER': '/bin/cat', 10:05:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:38 INFO - 'PWD': '/builds/slave/test', 10:05:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:38 INFO - 'SHELL': '/bin/bash', 10:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WGVpzowRrv/Listeners', 10:05:38 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 10:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:38 INFO - 'USER': 'cltbld', 10:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:38 INFO - 'XPC_FLAGS': '0x0', 10:05:38 INFO - 'XPC_SERVICE_NAME': '0', 10:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 10:05:38 INFO - mozversion application_buildid: 20170109080108 10:05:38 INFO - mozversion application_changeset: ae40c9ff8660cbe0239161cff7ec3db1faa4c468 10:05:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:05:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:38 INFO - mozversion application_name: Firefox 10:05:38 INFO - mozversion application_remotingname: firefox-dev 10:05:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:05:38 INFO - mozversion application_vendor: Mozilla 10:05:38 INFO - mozversion application_version: 52.0a2 10:05:38 INFO - mozversion platform_buildid: 20170109080108 10:05:38 INFO - mozversion platform_changeset: ae40c9ff8660cbe0239161cff7ec3db1faa4c468 10:05:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:05:38 INFO - mozversion platform_version: 52.0a2 10:05:38 INFO - using testdate: 1483985138 10:05:38 INFO - actual date: 1483985138 10:05:38 INFO - starting webserver on 'localhost:52745' 10:05:38 INFO - SUITE-START | Running 2 tests 10:05:38 INFO - TEST-START | dromaeo_css 10:05:38 INFO - operating with platform_type : mac_ 10:05:38 INFO - Initialising browser for dromaeo_css test... 10:05:38 INFO - TEST-INFO | started process 2229 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmp7FGYJe/profile http://localhost:52745/getInfo.html) 10:05:41 INFO - PROCESS | 2229 | 2017-01-09 10:05:41.491 plugin-container[2231:18561] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 10:05:41 INFO - PROCESS | 2229 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:05:41 INFO - PROCESS | 2229 | 2017-01-09 10:05:41.494 plugin-container[2231:18561] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1f, name = 'com.apple.CFPasteboardClient' 10:05:41 INFO - PROCESS | 2229 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:05:41 INFO - PROCESS | 2229 | 2017-01-09 10:05:41.494 plugin-container[2231:18561] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:05:41 INFO - PROCESS | 2229 | __metrics Screen width/height:1600/1200 10:05:41 INFO - PROCESS | 2229 | colorDepth:24 10:05:41 INFO - PROCESS | 2229 | Browser inner width/height: 1024/689 10:05:41 INFO - PROCESS | 2229 | __metrics 10:05:41 ERROR - PROCESS | 2229 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:05:42 INFO - TEST-INFO | 2229: exit 0 10:05:42 INFO - Browser initialized. 10:05:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:42 INFO - TEST-INFO | started process 2232 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmp7FGYJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:45 INFO - PROCESS | 2232 | 2017-01-09 10:05:45.166 plugin-container[2233:18688] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:05:45 INFO - PROCESS | 2232 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:05:45 INFO - PROCESS | 2232 | 2017-01-09 10:05:45.168 plugin-container[2233:18688] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:05:45 INFO - PROCESS | 2232 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:05:45 INFO - PROCESS | 2232 | 2017-01-09 10:05:45.168 plugin-container[2233:18688] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:05:54 INFO - PROCESS | 2232 | RSS: Main: 229937152 10:05:54 INFO - PROCESS | 2232 | 10:08:57 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52745/tests/dromaeo/cssquery-ext.html) 10:08:59 INFO - PROCESS | 2232 | RSS: Main: 232693760 10:08:59 INFO - PROCESS | 2232 | 10:12:01 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-ext.html (next: http://localhost:52745/tests/dromaeo/cssquery-jquery.html) 10:12:02 INFO - PROCESS | 2232 | RSS: Main: 243658752 10:12:02 INFO - PROCESS | 2232 | 10:15:04 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52745/tests/dromaeo/cssquery-mootools.html) 10:15:05 INFO - PROCESS | 2232 | RSS: Main: 247664640 10:15:05 INFO - PROCESS | 2232 | 10:18:07 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52745/tests/dromaeo/cssquery-prototype.html) 10:18:07 INFO - PROCESS | 2232 | RSS: Main: 246984704 10:18:07 INFO - PROCESS | 2232 | 10:21:10 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52745/tests/dromaeo/cssquery-yui.html) 10:21:11 INFO - PROCESS | 2232 | RSS: Main: 250298368 10:21:11 INFO - PROCESS | 2232 | 10:24:13 INFO - PROCESS | 2232 | Cycle 1(1): loaded http://localhost:52745/tests/dromaeo/cssquery-yui.html (next: http://localhost:52745/tests/dromaeo/cssquery-dojo.html) 10:24:14 INFO - PROCESS | 2232 | RSS: Main: 256036864 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | __start_tp_report 10:24:14 INFO - PROCESS | 2232 | _x_x_mozilla_page_load 10:24:14 INFO - PROCESS | 2232 | _x_x_mozilla_page_load_details 10:24:14 INFO - PROCESS | 2232 | |i|pagename|runs| 10:24:14 INFO - PROCESS | 2232 | |0;dojo.html;2795.818271812332;3421.469672200808;3422.264213194163;3424.743144264181;3476.183096972211;5755.050416681248;5796.391378905218;5841.503472204862;5862.2965244170655;5863.970680146604;5814.1860139580385;5856.648601083938;5881.8823623527505;5896.380880007591;5908.172855800191;4290.97854510727;5310.017646735367;5323.547498462635;5336.119540275849;5384.757685904124;5365.463453654643;5394.163904594794;5398.379186393556;5419.078756611366;5421.349438067437;5268.973655131719;5287.682739035651;5388.380336261341;5391.946080539204;5395.568354531628;4917.164082106033;5279.287296215;5313.973430132824;5374.7850085996515;5422.15956526739;5235.110031294689;5312.787488500456;5317.787288508455;5326.387465441485;5356.866078348034;5651.039323315005;5843.620164689324;5914.4676979071655;5932.932072226998;5969.313528944183;6197.752089916398;6200.224971878515;6204.317525072239;6221.3156552779155;6236.501079913596;6261.029540421242;6306.274778400497;6313.715882785285;6315.0843127746675;6321.336259692712;5952.761889524414;5963.344032156459;5977.133315669291;5980.760769569169;6000.819975400745;6157.014877619559;6192.225971753531;6246.562740608205;6250.937490625127;6258.624482531062;6223.159873417121;6228.968855155696;6236.968815155895;6239.656818874914;6264.561480696399;6268.655223962634;6291;6297.527685423612;6304.6847657617855;6345.07996340528;6137.478314343331;6138.143176733788;6159.876802464015;6174.629522228681;6200.162977998003;6214.161088253028;6238.064290356483;6259.061140828912;6259.3427690091885;6259.812205633747;4919.926201106986;4925.359703238556;4976.154053810861;4980.377452818398;5003.849884503471;4418.624416924597;4430.13612345596;4440.33394990754;4448.55514448559;4487.6185524230805;5747.1379293106365;5904.793332233351;5988;5993.520518358608;6042.425969532887;6261.436470717657;6287.654179020198;6295.874082518324;6303;6316.873662526724;4200.642945349679;4875.927295994876;5126.897462050738;5763.337216220105;5784.1902133701315;4513.751743654065;5391.865203369947;5450.182472629058;5502.9174562381595;5538.778448862;6346.174997250328;6369.26753423353;6442.838929026718;6452.064450654722;6457.935420645734;5403.621746477709;6044.821259854462;6162.075688646739;6279.529035322278;6284.937150628435;6237.157983672328;6300.7794727186165;6326.145970293951;6343.175387199634;6426.260979987174;6268.529860260407;6274.152989346379;6275.184226050585;6276.246850377984;6329.367063293634;6092.2689277285235;6223.066540018853;6244.875102498016;6258.655773932295;6267.059941008885;6077.939220607737;6106;6112.17485639433;6134.846628834315;6149.907751383822;5359.383670877899;6019.668918209365;6133.304060594526;6222.657753823583;6240.469560087444;5973.880522389615;6022.36765139654;6090.208272924491;6095;6125;5877.118432235199;6065.909011364744;6111.052786818051;6139.754409823736;6224.875502490016;5969.850753731192;6003.039513677791;6030.30651475086;6033.396660334107;6038.094285856981 10:24:14 INFO - PROCESS | 2232 | |1;ext.html;462.30423213064336;490.5241915342119;513.3147248423354;520.6823837459149;522.9816956406524;37681;39224.21551568967;39497.80251098744;39501.8024909875;41074.7946260269;40465.79767101168;40969.59030409695;41094.17811643765;41112.794436027856;41220.96947576312;9150.450972941611;9326.53367331634;9329.11373419524;9356.625734970594;9364.11040951112;9308;9341.159295663389;9357.157855792977;9414.717558473223;9426;9430.528473576294;9485.952570237174;9488.66789662362;9492;9493.667721629745;7994.24054714807;9440.57517411718;9446.905530944705;9462.621495140185;9479.763005924839;7245.4928155029165;9255.935567409766;9333.346665733401;9337.346385753;9431.952840235823;38707.8064609678;38966.02584935371;38974;38979.220415591815;39005.41491877624;3214.228585139573;3265.9183520411943;3294.1764558860286;3327.4010678077934;3349.296647703985;27941.301467463272;29200;29721.108366748816;29750.404991900257;30211.546826797614;3019.9396012079856;3032.1964679359985;3054.5418187271866;3075.8000729952705;3078.830664313462;487327;489540;493217;494345;495317.5234123842;55304.44695552993;55607.721961389936;55699.72150139223;55702.607434814454;55759.163612545846;54487.455125448236;57373.85252294931;57571.71214143903;57785;57830;15177.16525591081;15461.690766184838;15666.764998525032;15705.764413533807;15710.528684139494;12251.93874030642;12323.568675096329;12326.81509777354;12333.691657708629;12351.69120771988;11984.28094314344;14208.360623771956;14487.637809054648;14597.270136493133;14605.12369257848;3228.0961330827404;6789.608130333269;6920.377166055079;6934.202566704793;6945.576156887826;768.2586304216458;824.8309096635176;896.8968568614563;1009.7879445316565;1012.3116280928891;28437.57343639847;29173.85413072921;29387.706122938496;30081.849590752343;30146.547801782992;1016.5628779624832;1038.7195457226658;1072.420892717939;1081.3403823667556;1088.5210507376728;15306.540803775904;15544.533663990098;15993.600159996093;16243.756343654855;16432.342706291853;672754;678520;680158;681108;683795;47147.764261178476;54285.1857222142;55623;55893.161602575994;55951.440485595434;1334.2261488336742;1340.0552610409638;1371.2732251906505;1374.9587512374644;1386.0297791545959;28880.2779930495;29392.412151756416;29516;29569.556456653598;30185.396292073598;47220.05559888852;47748.761256193495;47911.28133077937;47981.52018479771;48012.7599362001;633818;637987;638491;638544;638594;24995;25211.621825672995;25524.361890952874;25579.87210063938;25631.23106306814;42729.145417092106;43141.92145196395;43272;43440.56559434492;43560.34659480047;35034.82482587571;36165.27669446649;36581.26837463289;37344.43983340306;37781.43327850029;35906.8204658975;35947.82026089853;35954.64045359513;37114.62885371112;37317;36090.278194435436;36146.819265903505;36396;37036;37342;31885;33403.1649208762;33542.664573353955;33899.83050084734;33985.15037124092;25348.873255633604;25388.74611253864;25398.619020714334;25625;25826.225213243633 10:24:14 INFO - PROCESS | 2232 | |2;jquery.html;372.48410950833096;372.61248301766165;378.82384691118625;386.4956232117086;399.32115403813526;18262.908685456572;19706.802931970677;20287.39137825864;20392.490187745312;20469.771813691154;19496.707549386734;19695.606087878234;20280.797192028076;20357.898210508964;20767.480812979684;4950.108980383529;5782.797602083939;5885;5953.077273022688;5979;4861.222204447289;5882.205902203212;5951.256092988377;5960.52315814736;5982.910256346158;5621.859453513674;5868.149118377833;5876.5004974577;5886.6468011919205;5897.262842144732;5591.133374326986;5784.855378615526;5829.183914252008;5867.706614669292;5880.9411905880825;5048.368953880765;5059.241113832918;5124.615653825941;5134.1528647773075;5140.794368225266;24990.875045624838;25072.373190670198;25099.37251568707;25239.36901577457;25322.87338563314;2388.3312672451566;2424.7575242475787;2489.95020099597;2890;2988.8804447822063;9675.467849268287;10216.948915255376;14290.356933937997;14643.267836608127;15842.603934901605;1737.504811128835;1811.4384540792396;1812.9847285520018;1956.4815323939167;1958.4712127725577;107083.46458267736;108013.37979930307;109304;126520;129692.35153824171;11152.275102118336;11406.42967851604;11554.306741595363;11579.710507237387;11838.230515016496;14501.637459063397;14582.854171458363;14609.977301588786;14611.342489587782;14629.268536573129;8238.752837414888;8454.915450845536;8504.022037465771;8567.314614830799;8619.6983105591;6854.725810967506;8377.790555236168;8390.664373425117;8412.663493460315;8523.65905363791;3832;4299.763513006752;4421.403110580095;4522.615577675934;4640.164770341371;1559.5555266748922;1936.1964784614509;1955.4817973237105;1972.684370500713;2013.9093740781407;836.3392919593452;866.181458521691;869.4783130121876;887.2635712358726;943.5942544705705;14358;18980.810191897905;19971.900140499496;19994.100265488087;20986.160553577687;772.6523064620943;795.9960200198962;871.1549796697194;878.6880657366671;946.1437399153776;8071.878921816177;10824.296420732628;10831.458427078614;10835.144520222933;10860.030368655596;603730;608852;609472;612888;616888;102611;110171;132169.33915330554;136691;138828;997.2570435025807;1006.184990157989;1035.233926894093;1038.444432228769;1040.9375437473775;17069.48791536256;18039.909800451438;18436.723449148005;18492.81507184911;18805.247790088244;54684.453155467934;55659.72170139123;56243.71878140747;58026.7098664504;59585.702071489366;81924.59037704773;82432.17567824245;82521;82856.58571707344;83663.58168209363;6972.337627925339;7290.015847860683;7313.305236002571;7369.963150184215;7475.215102414386;9976.60093596277;12436.626901192978;12548.49806007786;12613.87386126127;12824.29466379358;10582.46554249614;10826.783464330827;10837.45812709377;11106.389148596905;11283.66149015531;5993.520518358434;10490.632827850988;10838.837417438586;10874.07570356497;10941.781164376827;10603.840942386025;11091.057260132657;11242.325460472397;11284.749801429902;11430.085593152695;6571.7185148895505;7181.569105853666;7311.159216690149;7455;7683.577403242875;10337.9145189757;10988.835167472655;11121.83317250258;11296.209265351346;11313.773724525628 10:24:14 INFO - PROCESS | 2232 | |3;mootools.html;1435.6626192844683;1477.977830332545;1645.5886028492878;1782.3316256403848;1811.3479147506903;7577.962110189442;7874;8102.1492743262;8587.656493740244;8599.097094805049;7635.656395462203;7910.4462687611895;7931;8027.076886158094;8036.357091432686;2289.622212334967;2335.369450248432;2340.496793189464;2341.6370462578243;2343.8124950003958;2327.3832434404894;2357.316378250305;2373.9406514837096;2379.9885048854253;2384.4873352229265;1803.323753592403;2030.4416285521452;2252.2680128958073;2313.097891822191;2337.2053501809382;1790.4628611416522;1808.5569035586234;2294.6902168207243;2320.4546931471177;2327.511222643247;2321.442853715113;2346.507233480971;2347.8708671023087;2349.1543044503965;2350.8589484630975;8411.663533458654;8480.109588493182;8525.701600444017;8536.829263414758;8572.528510931896;4333.1766964276685;5035.672681275705;5154.664946778447;5184.974075129638;5202.193659982671;3021.9876341425647;3230.91922701932;3284.5237440571223;3449.034270404291;3538.7345949053924;900.2977677411563;1029.130384824822;1062.0706881478707;1069.3637285814928;1084.983725244122;10565;10748.516316765686;10878.129749620011;10921.290116142425;11040.227184097117;4261.31818908973;4324.8486302979245;4417.961778981937;4471.016376397188;4473.977630111894;8650.437721548205;8737.737867863974;8748.825023499494;8752.912470875337;8769.868451973098;5081.390233171969;5086.0845047891735;5087.898242035212;5094.821681241138;5100.515451032146;4264.211120942636;4351.6518678505645;4576.176288268077;4698.201305778026;4765.285207218945;3075.6616772155044;3651.653092956165;3692.1508053147927;3778.0366006668673;3833.5399752029375;1144.2492985731844;1156.6298784388914;1157.288267715349;1158.7798318319492;1164.342146687136;785.9115125551039;864.9091845356273;904.2901322461836;905.248643625789;908.1554154636119;5586.52514536269;5633.324001119892;5654.491095801398;5714.342850572238;5812.505936995318;877.8024944387589;896.6906417286026;913.356083960806;917.3028498341308;949.5110018340561;3644.817759112034;3707.740458167956;3740.270647223765;3748.4002559590335;3862.7102967277565;9548.474833884064;10025.398476091457;10046.04562566555;10208.846867296996;10214.744631384126;10080.747981300527;10142.087212150942;10160.745981350525;10163.542640581043;10181;7678.731244406419;7842.764717058498;7843.9215607844335;7872;7880.605969701492;5301.151815709468;5473.507384335429;5590.664560126405;5678.119891416837;5723.713814309352;9348;9364.578593963151;9468.195203407788;9481.66814161501;9521.238300935769;9098.135677110664;9362.438253704799;9484.288678349014;9506.667266645634;9509.572069257038;6694.230163531061;6894.103766510321;7056.364927156581;7182.96408517954;7369.63151842395;7865.764027079197;8004.199580042182;8034.47775894565;8048.154943731058;8054.23484768946;7006.789796306119;7089.964550177217;7248.238934911758;7271.636418179176;7345.338919497271;6973.442124629916;7092.822679433056;7117.7152913882865;7126.643667816485;7258.0927384076995;6649.501287403561;6791.286914873867;6797.150356205474;6799.150106236721;6816.591004539743;4840.491748366371;4842.007388485282;4853.733044682435;4880.585150262267;4903.509649035068;4843.733594652328;4864.440589332272;4907.852764417074;4937.506249375034;4970.6023518117745 10:24:14 INFO - PROCESS | 2232 | |4;prototype.html;286.86087247684884;299.9535072063831;302.53862859139815;311.80200572636375;314.878771672906;4434.135343607998;4640.767961601915;4902.828401005965;5218.373795144588;5357.73211339433;5017.598592112631;5151.81968631098;5366.409694933554;5378.731063446822;5458.426865179159;3051.3217730248384;3260.673932606744;3640.7427395014997;4188.371744238359;4202.994858676046;3576.9805605402466;3583.5351089588326;3789.2149270286454;3913.6477717005464;4213.662906967435;4038.2731108400476;4046.5548789633117;4089.5501494835544;4094.9385759213637;4117.958820411787;3163.604549431321;3453.9827300863335;3457.6542345765224;3753.174301653632;3958.584348643394;2951.8819247230085;2961.851907404621;3176.5235214717745;3559.875404360835;3581.3374525712825;4467.709598876063;4704.342046743579;5236.423993360727;5246.193286591693;5438.809641662562;3662.5238718966366;4459.955400445986;4662.6269898408045;4698.107359601665;4710.62315014798;5455.4179288006435;5734.455226753452;5771.624844385144;5787.421257874221;5805.042168042268;3795.5635101963353;3800.847966081353;3809.3727226306596;3857.6528112470014;3902.6487616114687;5803.390643982363;5895.145203945404;5933.605602683366;5963.254593175897;5963.880722385571;3874.6706529945272;3877.8448862045766;3885.339492286318;3925.352316867742;3936.8976686527817;3138.717515423623;3805.771653700787;3941.5270167580074;3976.5029371328583;3985.6612187964347;4505.414296141481;4533.753217865114;4576.512633394093;4586.174488592019;4615.769211539409;5646.20953066571;5649.406812284733;5656.745446454837;5677.1768093627015;5770.509506691894;1200.1598880783486;1240.5720026590811;1260.1242136715077;1291.5350473829415;1292.4571679894466;796.366888323784;833.8159813065462;842.5913431985482;853.7694822397917;879.3229213505565;4579.2221417330165;5051.907954556821;5081.8311788288165;5099.97450012755;5115.360579927509;4781.784819683123;4990.451050384455;5248.6325957182635;5560.944390556043;5715.799947001835;4229.746215227096;4696.825793551612;5119.1553393690365;5144.948550514522;5159.329287192641;2633.9473210536066;2870.937623263101;2902.521084021113;2924.251203868357;2994.446027484879;5113.8721531962;5165.974170129125;5414.675119492765;5613.186088017214;5789.478946894799;4700.482946875841;4846.830360937351;5378.596605254622;5632.324121105494;5838.4453476919625;5084.415292241366;5167.63057789686;5377.650452720561;5752.526413642174;5839.2482255324085;4939.950600493949;5270.915040843377;5478.205660179331;5497.87293604818;5570.832875013756;4806.447258565309;4984.675996060245;5334.813281535127;5548.389677135431;5608.4111168326735;4737.857864264078;5202.479752024768;5648.85877853057;5823.650580965155;5854.590178687621;3347.0460918638073;3511.4030614795033;3757.455169000534;3760.3231418344963;3773.905652358713;4915.410150781929;4976.5023497649945;5138.820141295037;5177.404598471224;5533.285076005227;4743.83396581118;4937.8271760488215;5642.520385767091;5807.796727114531;5838.970805145947;5745.224394706661;5804.593678442468;5823.941760582509;5828.280657206219;5875.911861321998;4367.366731823931;4786.242799402452;4790.760461976957;4932.087563800708;5278.81226723984;4540.8637740867825;4969.676970996874;5551.500364967173;5701.771929122789;5832.445917637818;4499.977500112478;5595.356533998643;5599.944000559943;5631.887362252814;5645.802396916089 10:24:14 INFO - PROCESS | 2232 | |5;yui.html;675.9966200168999;676.610948704495;724.7354715528834;725.8512005038966;751.1474476469206;11220;14792.926035369836;14840.925795371035;14867.62830929226;14900.03149795264;13192.340382980861;13195.208287502757;13239.669008274797;13306.800397994039;13315.667108322297;644.7582156691241;667.0794303860665;792.9484583502083;809.878518222267;811.3468657730524;822.5599304372162;822.983540329193;825.1253671108614;826.5660528222671;828.3704384667635;870.682200996638;874.0909454167657;874.152072489684;875.089906497242;876.2551830943711;844.2401838345477;870.7910101575576;872.6116877989298;872.9345299102561;873.4453621950075;634.6481993354172;639.0829160155192;647.5111290975331;647.517599388454;651.6546230497844;11276.605318813885;12323.815142772866;13737.175769453865;13901.0964287321;13993;12903.483860645563;13263.010548417718;13285.734285314336;13361.599152025456;13402.994775391884;9572.712818615382;11066.39134847583;11475.77048459026;11544.884551154464;11888.227265227819;3458.792472451661;3470.875476126561;3560.8041557714314;3566.8038257895805;3679.319325924686;80481.79277310845;81481.96295092611;89545;90152.54923725339;91657.54171229168;10194;10438.843417348746;10444.425556594308;10716.303440276357;10831.458427078614;19880.801191988183;19894.50263743418;19896.801031989784;19930;20008.59982800336;6576.145101136917;6931.584104953719;7329.633518324063;7623.69505219785;7920.207979202034;3163.3198862244267;4217.40956266123;4285.185814695198;4296.656267498655;4418.182636212311;3329.3174899145615;3430.1939044324563;3453.827308634558;3456.1705190754037;3463.913402164966;633.3508154142041;639.6290151712088;643.0900276109346;643.2024289880608;657.8684263147389;563.4253061876863;635;650.4536189600758;658.4666420199653;659.9241087274929;9015.459072455673;9058.32062595308;9174.449533028039;9198.264138868875;9389.371932534388;561.7247548701189;561.7528287553463;611.2664802237333;648.7469886744174;661.9441990025902;4387.3857659927;4412.3160910059;4444.422408535822;4496.145732310851;4595.9080818383445;69519.30480695229;92948;109726;112345.43827280811;115642;62487;89030.55484722534;93253;95077;95880;85506;86354.56822715847;87190.12809871948;89410;90241;8501.744947651581;8672.392932494917;8748.56257187151;8755.168259015383;9041.231495322709;54425;56229.71885140548;57119.42880571141;57186.7140664294;58264.70867645634;71071;74913.87629185675;78346.60826696058;78530;80110.79833802614;10158.382853874975;10160.390376577428;10684.038436540748;11164.944175279072;11592.88407115918;12221.572244971383;12259.570915018288;12274;12310.75378492443;12652.546496271274;11588.6523404298;11608.709782255512;11687.88312116868;12020.098492612915;12054.638360849189;11674.299542027506;11695.415229238333;11766.764664706829;11851.644450666494;11955.880441195477;10449.582016719247;11222.158338124837;11844.289342639124;12173.939130304292;12330.50677972871;10612.843891144774;10690.679279621623;11035.779284414428;11091.72270693239;11394;10744.73138171552;11095.11239100886;11423.371714555447;11486.655400338002;11502.194846360675 10:24:14 INFO - PROCESS | 2232 | __end_tp_report 10:24:14 INFO - PROCESS | 2232 | __start_cc_report 10:24:14 INFO - PROCESS | 2232 | _x_x_mozilla_cycle_collect,377 10:24:14 INFO - PROCESS | 2232 | __end_cc_report 10:24:14 INFO - PROCESS | 2232 | __startTimestamp1483986254089__endTimestamp 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | ------- Summary: start ------- 10:24:14 INFO - PROCESS | 2232 | Number of tests: 6 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#0] dojo.html Cycles:165 Average:5775.29 Median:6030.31 stddev:675.14 (11.2%) stddev-sans-first:635.47 10:24:14 INFO - PROCESS | 2232 | Values: 2795.8 3421.5 3422.3 3424.7 3476.2 5755.1 5796.4 5841.5 5862.3 5864.0 5814.2 5856.6 5881.9 5896.4 5908.2 4291.0 5310.0 5323.5 5336.1 5384.8 5365.5 5394.2 5398.4 5419.1 5421.3 5269.0 5287.7 5388.4 5391.9 5395.6 4917.2 5279.3 5314.0 5374.8 5422.2 5235.1 5312.8 5317.8 5326.4 5356.9 5651.0 5843.6 5914.5 5932.9 5969.3 6197.8 6200.2 6204.3 6221.3 6236.5 6261.0 6306.3 6313.7 6315.1 6321.3 5952.8 5963.3 5977.1 5980.8 6000.8 6157.0 6192.2 6246.6 6250.9 6258.6 6223.2 6229.0 6237.0 6239.7 6264.6 6268.7 6291.0 6297.5 6304.7 6345.1 6137.5 6138.1 6159.9 6174.6 6200.2 6214.2 6238.1 6259.1 6259.3 6259.8 4919.9 4925.4 4976.2 4980.4 5003.8 4418.6 4430.1 4440.3 4448.6 4487.6 5747.1 5904.8 5988.0 5993.5 6042.4 6261.4 6287.7 6295.9 6303.0 6316.9 4200.6 4875.9 5126.9 5763.3 5784.2 4513.8 5391.9 5450.2 5502.9 5538.8 6346.2 6369.3 6442.8 6452.1 6457.9 5403.6 6044.8 6162.1 6279.5 6284.9 6237.2 6300.8 6326.1 6343.2 6426.3 6268.5 6274.2 6275.2 6276.2 6329.4 6092.3 6223.1 6244.9 6258.7 6267.1 6077.9 6106.0 6112.2 6134.8 6149.9 5359.4 6019.7 6133.3 6222.7 6240.5 5973.9 6022.4 6090.2 6095.0 6125.0 5877.1 6065.9 6111.1 6139.8 6224.9 5969.9 6003.0 6030.3 6033.4 6038.1 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#1] ext.html Cycles:180 Average:71886.63 Median:38970.01 stddev:163096.52 (418.5%) stddev-sans-first:163465.89 10:24:14 INFO - PROCESS | 2232 | Values: 462.3 490.5 513.3 520.7 523.0 37681.0 39224.2 39497.8 39501.8 41074.8 40465.8 40969.6 41094.2 41112.8 41221.0 9150.5 9326.5 9329.1 9356.6 9364.1 9308.0 9341.2 9357.2 9414.7 9426.0 9430.5 9486.0 9488.7 9492.0 9493.7 7994.2 9440.6 9446.9 9462.6 9479.8 7245.5 9255.9 9333.3 9337.3 9432.0 38707.8 38966.0 38974.0 38979.2 39005.4 3214.2 3265.9 3294.2 3327.4 3349.3 27941.3 29200.0 29721.1 29750.4 30211.5 3019.9 3032.2 3054.5 3075.8 3078.8 487327.0 489540.0 493217.0 494345.0 495317.5 55304.4 55607.7 55699.7 55702.6 55759.2 54487.5 57373.9 57571.7 57785.0 57830.0 15177.2 15461.7 15666.8 15705.8 15710.5 12251.9 12323.6 12326.8 12333.7 12351.7 11984.3 14208.4 14487.6 14597.3 14605.1 3228.1 6789.6 6920.4 6934.2 6945.6 768.3 824.8 896.9 1009.8 1012.3 28437.6 29173.9 29387.7 30081.8 30146.5 1016.6 1038.7 1072.4 1081.3 1088.5 15306.5 15544.5 15993.6 16243.8 16432.3 672754.0 678520.0 680158.0 681108.0 683795.0 47147.8 54285.2 55623.0 55893.2 55951.4 1334.2 1340.1 1371.3 1375.0 1386.0 28880.3 29392.4 29516.0 29569.6 30185.4 47220.1 47748.8 47911.3 47981.5 48012.8 633818.0 637987.0 638491.0 638544.0 638594.0 24995.0 25211.6 25524.4 25579.9 25631.2 42729.1 43141.9 43272.0 43440.6 43560.3 35034.8 36165.3 36581.3 37344.4 37781.4 35906.8 35947.8 35954.6 37114.6 37317.0 36090.3 36146.8 36396.0 37036.0 37342.0 31885.0 33403.2 33542.7 33899.8 33985.2 25348.9 25388.7 25398.6 25625.0 25826.2 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#2] jquery.html Cycles:180 Average:35267.83 Median:25169.37 stddev:101779.96 (404.4%) stddev-sans-first:102031.76 10:24:14 INFO - PROCESS | 2232 | Values: 372.5 372.6 378.8 386.5 399.3 18262.9 19706.8 20287.4 20392.5 20469.8 19496.7 19695.6 20280.8 20357.9 20767.5 4950.1 5782.8 5885.0 5953.1 5979.0 4861.2 5882.2 5951.3 5960.5 5982.9 5621.9 5868.1 5876.5 5886.6 5897.3 5591.1 5784.9 5829.2 5867.7 5880.9 5048.4 5059.2 5124.6 5134.2 5140.8 24990.9 25072.4 25099.4 25239.4 25322.9 2388.3 2424.8 2490.0 2890.0 2988.9 9675.5 10216.9 14290.4 14643.3 15842.6 1737.5 1811.4 1813.0 1956.5 1958.5 107083.5 108013.4 109304.0 126520.0 129692.4 11152.3 11406.4 11554.3 11579.7 11838.2 14501.6 14582.9 14610.0 14611.3 14629.3 8238.8 8454.9 8504.0 8567.3 8619.7 6854.7 8377.8 8390.7 8412.7 8523.7 3832.0 4299.8 4421.4 4522.6 4640.2 1559.6 1936.2 1955.5 1972.7 2013.9 836.3 866.2 869.5 887.3 943.6 14358.0 18980.8 19971.9 19994.1 20986.2 772.7 796.0 871.2 878.7 946.1 8071.9 10824.3 10831.5 10835.1 10860.0 603730.0 608852.0 609472.0 612888.0 616888.0 102611.0 110171.0 132169.3 136691.0 138828.0 997.3 1006.2 1035.2 1038.4 1040.9 17069.5 18039.9 18436.7 18492.8 18805.2 54684.5 55659.7 56243.7 58026.7 59585.7 81924.6 82432.2 82521.0 82856.6 83663.6 6972.3 7290.0 7313.3 7370.0 7475.2 9976.6 12436.6 12548.5 12613.9 12824.3 10582.5 10826.8 10837.5 11106.4 11283.7 5993.5 10490.6 10838.8 10874.1 10941.8 10603.8 11091.1 11242.3 11284.7 11430.1 6571.7 7181.6 7311.2 7455.0 7683.6 10337.9 10988.8 11121.8 11296.2 11313.8 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#3] mootools.html Cycles:180 Average:5405.30 Median:5083.74 stddev:2983.46 (58.7%) stddev-sans-first:2976.91 10:24:14 INFO - PROCESS | 2232 | Values: 1435.7 1478.0 1645.6 1782.3 1811.3 7578.0 7874.0 8102.1 8587.7 8599.1 7635.7 7910.4 7931.0 8027.1 8036.4 2289.6 2335.4 2340.5 2341.6 2343.8 2327.4 2357.3 2373.9 2380.0 2384.5 1803.3 2030.4 2252.3 2313.1 2337.2 1790.5 1808.6 2294.7 2320.5 2327.5 2321.4 2346.5 2347.9 2349.2 2350.9 8411.7 8480.1 8525.7 8536.8 8572.5 4333.2 5035.7 5154.7 5185.0 5202.2 3022.0 3230.9 3284.5 3449.0 3538.7 900.3 1029.1 1062.1 1069.4 1085.0 10565.0 10748.5 10878.1 10921.3 11040.2 4261.3 4324.8 4418.0 4471.0 4474.0 8650.4 8737.7 8748.8 8752.9 8769.9 5081.4 5086.1 5087.9 5094.8 5100.5 4264.2 4351.7 4576.2 4698.2 4765.3 3075.7 3651.7 3692.2 3778.0 3833.5 1144.2 1156.6 1157.3 1158.8 1164.3 785.9 864.9 904.3 905.2 908.2 5586.5 5633.3 5654.5 5714.3 5812.5 877.8 896.7 913.4 917.3 949.5 3644.8 3707.7 3740.3 3748.4 3862.7 9548.5 10025.4 10046.0 10208.8 10214.7 10080.7 10142.1 10160.7 10163.5 10181.0 7678.7 7842.8 7843.9 7872.0 7880.6 5301.2 5473.5 5590.7 5678.1 5723.7 9348.0 9364.6 9468.2 9481.7 9521.2 9098.1 9362.4 9484.3 9506.7 9509.6 6694.2 6894.1 7056.4 7183.0 7369.6 7865.8 8004.2 8034.5 8048.2 8054.2 7006.8 7090.0 7248.2 7271.6 7345.3 6973.4 7092.8 7117.7 7126.6 7258.1 6649.5 6791.3 6797.2 6799.2 6816.6 4840.5 4842.0 4853.7 4880.6 4903.5 4843.7 4864.4 4907.9 4937.5 4970.6 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#4] prototype.html Cycles:180 Average:4430.46 Median:4934.96 stddev:1384.77 (28.1%) stddev-sans-first:1353.28 10:24:14 INFO - PROCESS | 2232 | Values: 286.9 300.0 302.5 311.8 314.9 4434.1 4640.8 4902.8 5218.4 5357.7 5017.6 5151.8 5366.4 5378.7 5458.4 3051.3 3260.7 3640.7 4188.4 4203.0 3577.0 3583.5 3789.2 3913.6 4213.7 4038.3 4046.6 4089.6 4094.9 4118.0 3163.6 3454.0 3457.7 3753.2 3958.6 2951.9 2961.9 3176.5 3559.9 3581.3 4467.7 4704.3 5236.4 5246.2 5438.8 3662.5 4460.0 4662.6 4698.1 4710.6 5455.4 5734.5 5771.6 5787.4 5805.0 3795.6 3800.8 3809.4 3857.7 3902.6 5803.4 5895.1 5933.6 5963.3 5963.9 3874.7 3877.8 3885.3 3925.4 3936.9 3138.7 3805.8 3941.5 3976.5 3985.7 4505.4 4533.8 4576.5 4586.2 4615.8 5646.2 5649.4 5656.7 5677.2 5770.5 1200.2 1240.6 1260.1 1291.5 1292.5 796.4 833.8 842.6 853.8 879.3 4579.2 5051.9 5081.8 5100.0 5115.4 4781.8 4990.5 5248.6 5560.9 5715.8 4229.7 4696.8 5119.2 5144.9 5159.3 2633.9 2870.9 2902.5 2924.3 2994.4 5113.9 5166.0 5414.7 5613.2 5789.5 4700.5 4846.8 5378.6 5632.3 5838.4 5084.4 5167.6 5377.7 5752.5 5839.2 4940.0 5270.9 5478.2 5497.9 5570.8 4806.4 4984.7 5334.8 5548.4 5608.4 4737.9 5202.5 5648.9 5823.7 5854.6 3347.0 3511.4 3757.5 3760.3 3773.9 4915.4 4976.5 5138.8 5177.4 5533.3 4743.8 4937.8 5642.5 5807.8 5839.0 5745.2 5804.6 5823.9 5828.3 5875.9 4367.4 4786.2 4790.8 4932.1 5278.8 4540.9 4969.7 5551.5 5701.8 5832.4 4500.0 5595.4 5599.9 5631.9 5645.8 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - PROCESS | 2232 | [#5] yui.html Cycles:180 Average:19938.86 Median:4546.03 stddev:29248.98 (643.4%) stddev-sans-first:29295.27 10:24:14 INFO - PROCESS | 2232 | Values: 676.0 676.6 724.7 725.9 751.1 11220.0 14792.9 14840.9 14867.6 14900.0 13192.3 13195.2 13239.7 13306.8 13315.7 644.8 667.1 792.9 809.9 811.3 822.6 823.0 825.1 826.6 828.4 870.7 874.1 874.2 875.1 876.3 844.2 870.8 872.6 872.9 873.4 634.6 639.1 647.5 647.5 651.7 11276.6 12323.8 13737.2 13901.1 13993.0 12903.5 13263.0 13285.7 13361.6 13403.0 9572.7 11066.4 11475.8 11544.9 11888.2 3458.8 3470.9 3560.8 3566.8 3679.3 80481.8 81482.0 89545.0 90152.5 91657.5 10194.0 10438.8 10444.4 10716.3 10831.5 19880.8 19894.5 19896.8 19930.0 20008.6 6576.1 6931.6 7329.6 7623.7 7920.2 3163.3 4217.4 4285.2 4296.7 4418.2 3329.3 3430.2 3453.8 3456.2 3463.9 633.4 639.6 643.1 643.2 657.9 563.4 635.0 650.5 658.5 659.9 9015.5 9058.3 9174.4 9198.3 9389.4 561.7 561.8 611.3 648.7 661.9 4387.4 4412.3 4444.4 4496.1 4595.9 69519.3 92948.0 109726.0 112345.4 115642.0 62487.0 89030.6 93253.0 95077.0 95880.0 85506.0 86354.6 87190.1 89410.0 90241.0 8501.7 8672.4 8748.6 8755.2 9041.2 54425.0 56229.7 57119.4 57186.7 58264.7 71071.0 74913.9 78346.6 78530.0 80110.8 10158.4 10160.4 10684.0 11164.9 11592.9 12221.6 12259.6 12274.0 12310.8 12652.5 11588.7 11608.7 11687.9 12020.1 12054.6 11674.3 11695.4 11766.8 11851.6 11955.9 10449.6 11222.2 11844.3 12173.9 12330.5 10612.8 10690.7 11035.8 11091.7 11394.0 10744.7 11095.1 11423.4 11486.7 11502.2 10:24:14 INFO - PROCESS | 2232 | -------- Summary: end -------- 10:24:14 INFO - PROCESS | 2232 | 10:24:14 INFO - TEST-INFO | 2232: exit 0 10:24:14 INFO - TEST-OK | dromaeo_css | took 1116288ms 10:24:14 INFO - TEST-START | kraken 10:24:14 INFO - operating with platform_type : mac_ 10:24:14 INFO - Initialising browser for kraken test... 10:24:14 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpuhpu92/profile http://localhost:52745/getInfo.html) 10:24:17 INFO - PROCESS | 2236 | 2017-01-09 10:24:17.764 plugin-container[2237:20813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 10:24:17 INFO - PROCESS | 2236 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:17 INFO - PROCESS | 2236 | 2017-01-09 10:24:17.767 plugin-container[2237:20813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 10:24:17 INFO - PROCESS | 2236 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:17 INFO - PROCESS | 2236 | 2017-01-09 10:24:17.767 plugin-container[2237:20813] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:24:17 INFO - PROCESS | 2236 | __metrics Screen width/height:1600/1200 10:24:17 INFO - PROCESS | 2236 | colorDepth:24 10:24:17 INFO - PROCESS | 2236 | Browser inner width/height: 1024/689 10:24:17 INFO - PROCESS | 2236 | __metrics 10:24:17 ERROR - PROCESS | 2236 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:24:18 INFO - TEST-INFO | 2236: exit 0 10:24:18 INFO - Browser initialized. 10:24:18 INFO - Running cycle 1/1 for kraken test... 10:24:18 INFO - TEST-INFO | started process 2238 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpuhpu92/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:21 INFO - PROCESS | 2238 | 2017-01-09 10:24:21.381 plugin-container[2239:20933] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 10:24:21 INFO - PROCESS | 2238 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:21 INFO - PROCESS | 2238 | 2017-01-09 10:24:21.382 plugin-container[2239:20933] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.CFPasteboardClient' 10:24:21 INFO - PROCESS | 2238 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:21 INFO - PROCESS | 2238 | 2017-01-09 10:24:21.382 plugin-container[2239:20933] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:24:31 INFO - PROCESS | 2238 | RSS: Main: 229539840 10:24:31 INFO - PROCESS | 2238 | 10:24:34 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52745/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:35 INFO - PROCESS | 2238 | RSS: Main: 241680384 10:24:35 INFO - PROCESS | 2238 | 10:24:37 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52745/tests/kraken/driver.html?testName=audio-dft) 10:24:38 INFO - PROCESS | 2238 | RSS: Main: 249307136 10:24:38 INFO - PROCESS | 2238 | 10:24:41 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52745/tests/kraken/driver.html?testName=audio-fft) 10:24:42 INFO - PROCESS | 2238 | RSS: Main: 253136896 10:24:42 INFO - PROCESS | 2238 | 10:24:44 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52745/tests/kraken/driver.html?testName=audio-oscillator) 10:24:44 INFO - PROCESS | 2238 | RSS: Main: 254382080 10:24:44 INFO - PROCESS | 2238 | 10:24:46 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:47 INFO - PROCESS | 2238 | RSS: Main: 254644224 10:24:47 INFO - PROCESS | 2238 | 10:24:50 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52745/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:51 INFO - PROCESS | 2238 | RSS: Main: 258977792 10:24:51 INFO - PROCESS | 2238 | 10:24:54 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52745/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:54 INFO - PROCESS | 2238 | RSS: Main: 258125824 10:24:54 INFO - PROCESS | 2238 | 10:24:57 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52745/tests/kraken/driver.html?testName=json-parse-financial) 10:24:58 INFO - PROCESS | 2238 | RSS: Main: 257933312 10:24:58 INFO - PROCESS | 2238 | 10:25:00 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:00 INFO - PROCESS | 2238 | RSS: Main: 257146880 10:25:00 INFO - PROCESS | 2238 | 10:25:03 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:03 INFO - PROCESS | 2238 | RSS: Main: 257142784 10:25:03 INFO - PROCESS | 2238 | 10:25:05 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:06 INFO - PROCESS | 2238 | RSS: Main: 257257472 10:25:06 INFO - PROCESS | 2238 | 10:25:09 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:10 INFO - PROCESS | 2238 | RSS: Main: 257429504 10:25:10 INFO - PROCESS | 2238 | 10:25:13 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:13 INFO - PROCESS | 2238 | RSS: Main: 257376256 10:25:13 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | Cycle 1(1): loaded http://localhost:52745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52745/tests/kraken/driver.html?testName=ai-astar) 10:25:15 INFO - PROCESS | 2238 | RSS: Main: 259174400 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | __start_tp_report 10:25:15 INFO - PROCESS | 2238 | _x_x_mozilla_page_load 10:25:15 INFO - PROCESS | 2238 | _x_x_mozilla_page_load_details 10:25:15 INFO - PROCESS | 2238 | |i|pagename|runs| 10:25:15 INFO - PROCESS | 2238 | |0;ai-astar;117;117;118;118;118;132;171;159;124;118 10:25:15 INFO - PROCESS | 2238 | |1;audio-beat-detection;150;113;117;148;111;116;117;112;139;113 10:25:15 INFO - PROCESS | 2238 | |2;audio-dft;197;200;194;207;196;193;202;198;198;196 10:25:15 INFO - PROCESS | 2238 | |3;audio-fft;81;63;83;110;66;62;61;59;80;84 10:25:15 INFO - PROCESS | 2238 | |4;audio-oscillator;86;71;90;74;68;69;85;70;73;89 10:25:15 INFO - PROCESS | 2238 | |5;imaging-gaussian-blur;139;87;91;92;91;93;108;134;87;132 10:25:15 INFO - PROCESS | 2238 | |6;imaging-darkroom;128;176;107;115;100;99;115;114;180;176 10:25:15 INFO - PROCESS | 2238 | |7;imaging-desaturate;74;75;115;96;136;74;150;101;76;103 10:25:15 INFO - PROCESS | 2238 | |8;json-parse-financial;53;58;58;61;60;62;60;60;60;62 10:25:15 INFO - PROCESS | 2238 | |9;json-stringify-tinderbox;71;94;113;127;78;72;80;111;110;82 10:25:15 INFO - PROCESS | 2238 | |10;stanford-crypto-aes;81;83;83;82;85;85;84;89;115;75 10:25:15 INFO - PROCESS | 2238 | |11;stanford-crypto-ccm;159;165;167;151;147;166;163;142;221;201 10:25:15 INFO - PROCESS | 2238 | |12;stanford-crypto-pbkdf2;168;171;166;169;173;166;177;172;171;171 10:25:15 INFO - PROCESS | 2238 | |13;stanford-crypto-sha256-iterative;69;68;67;67;71;68;66;67;80;84 10:25:15 INFO - PROCESS | 2238 | __end_tp_report 10:25:15 INFO - PROCESS | 2238 | __start_cc_report 10:25:15 INFO - PROCESS | 2238 | _x_x_mozilla_cycle_collect,976 10:25:15 INFO - PROCESS | 2238 | __end_cc_report 10:25:15 INFO - PROCESS | 2238 | __startTimestamp1483986315911__endTimestamp 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | ------- Summary: start ------- 10:25:15 INFO - PROCESS | 2238 | Number of tests: 14 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#0] ai-astar Cycles:10 Average:129.20 Median:121.00 stddev:19.63 (16.2%) stddev-sans-first:20.32 10:25:15 INFO - PROCESS | 2238 | Values: 117.0 117.0 118.0 118.0 118.0 132.0 171.0 159.0 124.0 118.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:117.00 stddev:15.61 (13.3%) stddev-sans-first:13.31 10:25:15 INFO - PROCESS | 2238 | Values: 150.0 113.0 117.0 148.0 111.0 116.0 117.0 112.0 139.0 113.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#2] audio-dft Cycles:10 Average:198.10 Median:198.00 stddev:4.09 (2.1%) stddev-sans-first:4.32 10:25:15 INFO - PROCESS | 2238 | Values: 197.0 200.0 194.0 207.0 196.0 193.0 202.0 198.0 198.0 196.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#3] audio-fft Cycles:10 Average:74.90 Median:73.00 stddev:15.91 (21.8%) stddev-sans-first:16.72 10:25:15 INFO - PROCESS | 2238 | Values: 81.0 63.0 83.0 110.0 66.0 62.0 61.0 59.0 80.0 84.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.50 stddev:8.89 (11.2%) stddev-sans-first:8.88 10:25:15 INFO - PROCESS | 2238 | Values: 86.0 71.0 90.0 74.0 68.0 69.0 85.0 70.0 73.0 89.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:89.00 stddev:21.31 (23.9%) stddev-sans-first:18.81 10:25:15 INFO - PROCESS | 2238 | Values: 139.0 87.0 91.0 92.0 91.0 93.0 108.0 134.0 87.0 132.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#6] imaging-darkroom Cycles:10 Average:131.00 Median:152.00 stddev:33.04 (21.7%) stddev-sans-first:35.02 10:25:15 INFO - PROCESS | 2238 | Values: 128.0 176.0 107.0 115.0 100.0 99.0 115.0 114.0 180.0 176.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:74.00 stddev:27.08 (36.6%) stddev-sans-first:27.04 10:25:15 INFO - PROCESS | 2238 | Values: 74.0 75.0 115.0 96.0 136.0 74.0 150.0 101.0 76.0 103.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:2.63 (4.4%) stddev-sans-first:1.45 10:25:15 INFO - PROCESS | 2238 | Values: 53.0 58.0 58.0 61.0 60.0 62.0 60.0 60.0 60.0 62.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#9] json-stringify-tinderbox Cycles:10 Average:93.80 Median:75.00 stddev:20.01 (26.7%) stddev-sans-first:19.45 10:25:15 INFO - PROCESS | 2238 | Values: 71.0 94.0 113.0 127.0 78.0 72.0 80.0 111.0 110.0 82.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.50 stddev:10.73 (12.8%) stddev-sans-first:11.21 10:25:15 INFO - PROCESS | 2238 | Values: 81.0 83.0 83.0 82.0 85.0 85.0 84.0 89.0 115.0 75.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#11] stanford-crypto-ccm Cycles:10 Average:168.20 Median:165.50 stddev:24.55 (14.8%) stddev-sans-first:25.81 10:25:15 INFO - PROCESS | 2238 | Values: 159.0 165.0 167.0 151.0 147.0 166.0 163.0 142.0 221.0 201.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:3.34 (2.0%) stddev-sans-first:3.43 10:25:15 INFO - PROCESS | 2238 | Values: 168.0 171.0 166.0 169.0 173.0 166.0 177.0 172.0 171.0 171.0 10:25:15 INFO - PROCESS | 2238 | 10:25:15 INFO - PROCESS | 2238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:68.50 stddev:6.18 (9.0%) stddev-sans-first:6.53 10:25:15 INFO - PROCESS | 2238 | Values: 69.0 68.0 67.0 67.0 71.0 68.0 66.0 67.0 80.0 84.0 10:25:15 INFO - PROCESS | 2238 | -------- Summary: end -------- 10:25:15 INFO - PROCESS | 2238 | 10:25:16 INFO - TEST-INFO | 2238: exit 0 10:25:16 INFO - TEST-OK | kraken | took 62208ms 10:25:16 INFO - SUITE-END | took 1178s 10:25:17 INFO - Completed test suite (00:19:38) 10:25:17 INFO - javascript benchmark 10:25:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7096.303556017961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2795.818271812332, 3421.469672200808, 3422.264213194163, 3424.743144264181, 3476.183096972211, 5755.050416681248, 5796.391378905218, 5841.503472204862, 5862.2965244170655, 5863.970680146604, 5814.1860139580385, 5856.648601083938, 5881.8823623527505, 5896.380880007591, 5908.172855800191, 4290.97854510727, 5310.017646735367, 5323.547498462635, 5336.119540275849, 5384.757685904124, 5365.463453654643, 5394.163904594794, 5398.379186393556, 5419.078756611366, 5421.349438067437, 5268.973655131719, 5287.682739035651, 5388.380336261341, 5391.946080539204, 5395.568354531628, 4917.164082106033, 5279.287296215, 5313.973430132824, 5374.7850085996515, 5422.15956526739, 5235.110031294689, 5312.787488500456, 5317.787288508455, 5326.387465441485, 5356.866078348034, 5651.039323315005, 5843.620164689324, 5914.4676979071655, 5932.932072226998, 5969.313528944183, 6197.752089916398, 6200.224971878515, 6204.317525072239, 6221.3156552779155, 6236.501079913596, 6261.029540421242, 6306.274778400497, 6313.715882785285, 6315.0843127746675, 6321.336259692712, 5952.761889524414, 5963.344032156459, 5977.133315669291, 5980.760769569169, 6000.819975400745, 6157.014877619559, 6192.225971753531, 6246.562740608205, 6250.937490625127, 6258.624482531062, 6223.159873417121, 6228.968855155696, 6236.968815155895, 6239.656818874914, 6264.561480696399, 6268.655223962634, 6291.0, 6297.527685423612, 6304.6847657617855, 6345.07996340528, 6137.478314343331, 6138.143176733788, 6159.876802464015, 6174.629522228681, 6200.162977998003, 6214.161088253028, 6238.064290356483, 6259.061140828912, 6259.3427690091885, 6259.812205633747, 4919.926201106986, 4925.359703238556, 4976.154053810861, 4980.377452818398, 5003.849884503471, 4418.624416924597, 4430.13612345596, 4440.33394990754, 4448.55514448559, 4487.6185524230805, 5747.1379293106365, 5904.793332233351, 5988.0, 5993.520518358608, 6042.425969532887, 6261.436470717657, 6287.654179020198, 6295.874082518324, 6303.0, 6316.873662526724, 4200.642945349679, 4875.927295994876, 5126.897462050738, 5763.337216220105, 5784.1902133701315, 4513.751743654065, 5391.865203369947, 5450.182472629058, 5502.9174562381595, 5538.778448862, 6346.174997250328, 6369.26753423353, 6442.838929026718, 6452.064450654722, 6457.935420645734, 5403.621746477709, 6044.821259854462, 6162.075688646739, 6279.529035322278, 6284.937150628435, 6237.157983672328, 6300.7794727186165, 6326.145970293951, 6343.175387199634, 6426.260979987174, 6268.529860260407, 6274.152989346379, 6275.184226050585, 6276.246850377984, 6329.367063293634, 6092.2689277285235, 6223.066540018853, 6244.875102498016, 6258.655773932295, 6267.059941008885, 6077.939220607737, 6106.0, 6112.17485639433, 6134.846628834315, 6149.907751383822, 5359.383670877899, 6019.668918209365, 6133.304060594526, 6222.657753823583, 6240.469560087444, 5973.880522389615, 6022.36765139654, 6090.208272924491, 6095.0, 6125.0, 5877.118432235199, 6065.909011364744, 6111.052786818051, 6139.754409823736, 6224.875502490016, 5969.850753731192, 6003.039513677791, 6030.30651475086, 6033.396660334107, 6038.094285856981], "value": 5731.321783506439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.30423213064336, 490.5241915342119, 513.3147248423354, 520.6823837459149, 522.9816956406524, 37681.0, 39224.21551568967, 39497.80251098744, 39501.8024909875, 41074.7946260269, 40465.79767101168, 40969.59030409695, 41094.17811643765, 41112.794436027856, 41220.96947576312, 9150.450972941611, 9326.53367331634, 9329.11373419524, 9356.625734970594, 9364.11040951112, 9308.0, 9341.159295663389, 9357.157855792977, 9414.717558473223, 9426.0, 9430.528473576294, 9485.952570237174, 9488.66789662362, 9492.0, 9493.667721629745, 7994.24054714807, 9440.57517411718, 9446.905530944705, 9462.621495140185, 9479.763005924839, 7245.4928155029165, 9255.935567409766, 9333.346665733401, 9337.346385753, 9431.952840235823, 38707.8064609678, 38966.02584935371, 38974.0, 38979.220415591815, 39005.41491877624, 3214.228585139573, 3265.9183520411943, 3294.1764558860286, 3327.4010678077934, 3349.296647703985, 27941.301467463272, 29200.0, 29721.108366748816, 29750.404991900257, 30211.546826797614, 3019.9396012079856, 3032.1964679359985, 3054.5418187271866, 3075.8000729952705, 3078.830664313462, 487327.0, 489540.0, 493217.0, 494345.0, 495317.5234123842, 55304.44695552993, 55607.721961389936, 55699.72150139223, 55702.607434814454, 55759.163612545846, 54487.455125448236, 57373.85252294931, 57571.71214143903, 57785.0, 57830.0, 15177.16525591081, 15461.690766184838, 15666.764998525032, 15705.764413533807, 15710.528684139494, 12251.93874030642, 12323.568675096329, 12326.81509777354, 12333.691657708629, 12351.69120771988, 11984.28094314344, 14208.360623771956, 14487.637809054648, 14597.270136493133, 14605.12369257848, 3228.0961330827404, 6789.608130333269, 6920.377166055079, 6934.202566704793, 6945.576156887826, 768.2586304216458, 824.8309096635176, 896.8968568614563, 1009.7879445316565, 1012.3116280928891, 28437.57343639847, 29173.85413072921, 29387.706122938496, 30081.849590752343, 30146.547801782992, 1016.5628779624832, 1038.7195457226658, 1072.420892717939, 1081.3403823667556, 1088.5210507376728, 15306.540803775904, 15544.533663990098, 15993.600159996093, 16243.756343654855, 16432.342706291853, 672754.0, 678520.0, 680158.0, 681108.0, 683795.0, 47147.764261178476, 54285.1857222142, 55623.0, 55893.161602575994, 55951.440485595434, 1334.2261488336742, 1340.0552610409638, 1371.2732251906505, 1374.9587512374644, 1386.0297791545959, 28880.2779930495, 29392.412151756416, 29516.0, 29569.556456653598, 30185.396292073598, 47220.05559888852, 47748.761256193495, 47911.28133077937, 47981.52018479771, 48012.7599362001, 633818.0, 637987.0, 638491.0, 638544.0, 638594.0, 24995.0, 25211.621825672995, 25524.361890952874, 25579.87210063938, 25631.23106306814, 42729.145417092106, 43141.92145196395, 43272.0, 43440.56559434492, 43560.34659480047, 35034.82482587571, 36165.27669446649, 36581.26837463289, 37344.43983340306, 37781.43327850029, 35906.8204658975, 35947.82026089853, 35954.64045359513, 37114.62885371112, 37317.0, 36090.278194435436, 36146.819265903505, 36396.0, 37036.0, 37342.0, 31885.0, 33403.1649208762, 33542.664573353955, 33899.83050084734, 33985.15037124092, 25348.873255633604, 25388.74611253864, 25398.619020714334, 25625.0, 25826.225213243633], "value": 19165.548391307493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.48410950833096, 372.61248301766165, 378.82384691118625, 386.4956232117086, 399.32115403813526, 18262.908685456572, 19706.802931970677, 20287.39137825864, 20392.490187745312, 20469.771813691154, 19496.707549386734, 19695.606087878234, 20280.797192028076, 20357.898210508964, 20767.480812979684, 4950.108980383529, 5782.797602083939, 5885.0, 5953.077273022688, 5979.0, 4861.222204447289, 5882.205902203212, 5951.256092988377, 5960.52315814736, 5982.910256346158, 5621.859453513674, 5868.149118377833, 5876.5004974577, 5886.6468011919205, 5897.262842144732, 5591.133374326986, 5784.855378615526, 5829.183914252008, 5867.706614669292, 5880.9411905880825, 5048.368953880765, 5059.241113832918, 5124.615653825941, 5134.1528647773075, 5140.794368225266, 24990.875045624838, 25072.373190670198, 25099.37251568707, 25239.36901577457, 25322.87338563314, 2388.3312672451566, 2424.7575242475787, 2489.95020099597, 2890.0, 2988.8804447822063, 9675.467849268287, 10216.948915255376, 14290.356933937997, 14643.267836608127, 15842.603934901605, 1737.504811128835, 1811.4384540792396, 1812.9847285520018, 1956.4815323939167, 1958.4712127725577, 107083.46458267736, 108013.37979930307, 109304.0, 126520.0, 129692.35153824171, 11152.275102118336, 11406.42967851604, 11554.306741595363, 11579.710507237387, 11838.230515016496, 14501.637459063397, 14582.854171458363, 14609.977301588786, 14611.342489587782, 14629.268536573129, 8238.752837414888, 8454.915450845536, 8504.022037465771, 8567.314614830799, 8619.6983105591, 6854.725810967506, 8377.790555236168, 8390.664373425117, 8412.663493460315, 8523.65905363791, 3832.0, 4299.763513006752, 4421.403110580095, 4522.615577675934, 4640.164770341371, 1559.5555266748922, 1936.1964784614509, 1955.4817973237105, 1972.684370500713, 2013.9093740781407, 836.3392919593452, 866.181458521691, 869.4783130121876, 887.2635712358726, 943.5942544705705, 14358.0, 18980.810191897905, 19971.900140499496, 19994.100265488087, 20986.160553577687, 772.6523064620943, 795.9960200198962, 871.1549796697194, 878.6880657366671, 946.1437399153776, 8071.878921816177, 10824.296420732628, 10831.458427078614, 10835.144520222933, 10860.030368655596, 603730.0, 608852.0, 609472.0, 612888.0, 616888.0, 102611.0, 110171.0, 132169.33915330554, 136691.0, 138828.0, 997.2570435025807, 1006.184990157989, 1035.233926894093, 1038.444432228769, 1040.9375437473775, 17069.48791536256, 18039.909800451438, 18436.723449148005, 18492.81507184911, 18805.247790088244, 54684.453155467934, 55659.72170139123, 56243.71878140747, 58026.7098664504, 59585.702071489366, 81924.59037704773, 82432.17567824245, 82521.0, 82856.58571707344, 83663.58168209363, 6972.337627925339, 7290.015847860683, 7313.305236002571, 7369.963150184215, 7475.215102414386, 9976.60093596277, 12436.626901192978, 12548.49806007786, 12613.87386126127, 12824.29466379358, 10582.46554249614, 10826.783464330827, 10837.45812709377, 11106.389148596905, 11283.66149015531, 5993.520518358434, 10490.632827850988, 10838.837417438586, 10874.07570356497, 10941.781164376827, 10603.840942386025, 11091.057260132657, 11242.325460472397, 11284.749801429902, 11430.085593152695, 6571.7185148895505, 7181.569105853666, 7311.159216690149, 7455.0, 7683.577403242875, 10337.9145189757, 10988.835167472655, 11121.83317250258, 11296.209265351346, 11313.773724525628], "value": 9432.47232267838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.6626192844683, 1477.977830332545, 1645.5886028492878, 1782.3316256403848, 1811.3479147506903, 7577.962110189442, 7874.0, 8102.1492743262, 8587.656493740244, 8599.097094805049, 7635.656395462203, 7910.4462687611895, 7931.0, 8027.076886158094, 8036.357091432686, 2289.622212334967, 2335.369450248432, 2340.496793189464, 2341.6370462578243, 2343.8124950003958, 2327.3832434404894, 2357.316378250305, 2373.9406514837096, 2379.9885048854253, 2384.4873352229265, 1803.323753592403, 2030.4416285521452, 2252.2680128958073, 2313.097891822191, 2337.2053501809382, 1790.4628611416522, 1808.5569035586234, 2294.6902168207243, 2320.4546931471177, 2327.511222643247, 2321.442853715113, 2346.507233480971, 2347.8708671023087, 2349.1543044503965, 2350.8589484630975, 8411.663533458654, 8480.109588493182, 8525.701600444017, 8536.829263414758, 8572.528510931896, 4333.1766964276685, 5035.672681275705, 5154.664946778447, 5184.974075129638, 5202.193659982671, 3021.9876341425647, 3230.91922701932, 3284.5237440571223, 3449.034270404291, 3538.7345949053924, 900.2977677411563, 1029.130384824822, 1062.0706881478707, 1069.3637285814928, 1084.983725244122, 10565.0, 10748.516316765686, 10878.129749620011, 10921.290116142425, 11040.227184097117, 4261.31818908973, 4324.8486302979245, 4417.961778981937, 4471.016376397188, 4473.977630111894, 8650.437721548205, 8737.737867863974, 8748.825023499494, 8752.912470875337, 8769.868451973098, 5081.390233171969, 5086.0845047891735, 5087.898242035212, 5094.821681241138, 5100.515451032146, 4264.211120942636, 4351.6518678505645, 4576.176288268077, 4698.201305778026, 4765.285207218945, 3075.6616772155044, 3651.653092956165, 3692.1508053147927, 3778.0366006668673, 3833.5399752029375, 1144.2492985731844, 1156.6298784388914, 1157.288267715349, 1158.7798318319492, 1164.342146687136, 785.9115125551039, 864.9091845356273, 904.2901322461836, 905.248643625789, 908.1554154636119, 5586.52514536269, 5633.324001119892, 5654.491095801398, 5714.342850572238, 5812.505936995318, 877.8024944387589, 896.6906417286026, 913.356083960806, 917.3028498341308, 949.5110018340561, 3644.817759112034, 3707.740458167956, 3740.270647223765, 3748.4002559590335, 3862.7102967277565, 9548.474833884064, 10025.398476091457, 10046.04562566555, 10208.846867296996, 10214.744631384126, 10080.747981300527, 10142.087212150942, 10160.745981350525, 10163.542640581043, 10181.0, 7678.731244406419, 7842.764717058498, 7843.9215607844335, 7872.0, 7880.605969701492, 5301.151815709468, 5473.507384335429, 5590.664560126405, 5678.119891416837, 5723.713814309352, 9348.0, 9364.578593963151, 9468.195203407788, 9481.66814161501, 9521.238300935769, 9098.135677110664, 9362.438253704799, 9484.288678349014, 9506.667266645634, 9509.572069257038, 6694.230163531061, 6894.103766510321, 7056.364927156581, 7182.96408517954, 7369.63151842395, 7865.764027079197, 8004.199580042182, 8034.47775894565, 8048.154943731058, 8054.23484768946, 7006.789796306119, 7089.964550177217, 7248.238934911758, 7271.636418179176, 7345.338919497271, 6973.442124629916, 7092.822679433056, 7117.7152913882865, 7126.643667816485, 7258.0927384076995, 6649.501287403561, 6791.286914873867, 6797.150356205474, 6799.150106236721, 6816.591004539743, 4840.491748366371, 4842.007388485282, 4853.733044682435, 4880.585150262267, 4903.509649035068, 4843.733594652328, 4864.440589332272, 4907.852764417074, 4937.506249375034, 4970.6023518117745], "value": 4364.566662285942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.86087247684884, 299.9535072063831, 302.53862859139815, 311.80200572636375, 314.878771672906, 4434.135343607998, 4640.767961601915, 4902.828401005965, 5218.373795144588, 5357.73211339433, 5017.598592112631, 5151.81968631098, 5366.409694933554, 5378.731063446822, 5458.426865179159, 3051.3217730248384, 3260.673932606744, 3640.7427395014997, 4188.371744238359, 4202.994858676046, 3576.9805605402466, 3583.5351089588326, 3789.2149270286454, 3913.6477717005464, 4213.662906967435, 4038.2731108400476, 4046.5548789633117, 4089.5501494835544, 4094.9385759213637, 4117.958820411787, 3163.604549431321, 3453.9827300863335, 3457.6542345765224, 3753.174301653632, 3958.584348643394, 2951.8819247230085, 2961.851907404621, 3176.5235214717745, 3559.875404360835, 3581.3374525712825, 4467.709598876063, 4704.342046743579, 5236.423993360727, 5246.193286591693, 5438.809641662562, 3662.5238718966366, 4459.955400445986, 4662.6269898408045, 4698.107359601665, 4710.62315014798, 5455.4179288006435, 5734.455226753452, 5771.624844385144, 5787.421257874221, 5805.042168042268, 3795.5635101963353, 3800.847966081353, 3809.3727226306596, 3857.6528112470014, 3902.6487616114687, 5803.390643982363, 5895.145203945404, 5933.605602683366, 5963.254593175897, 5963.880722385571, 3874.6706529945272, 3877.8448862045766, 3885.339492286318, 3925.352316867742, 3936.8976686527817, 3138.717515423623, 3805.771653700787, 3941.5270167580074, 3976.5029371328583, 3985.6612187964347, 4505.414296141481, 4533.753217865114, 4576.512633394093, 4586.174488592019, 4615.769211539409, 5646.20953066571, 5649.406812284733, 5656.745446454837, 5677.1768093627015, 5770.509506691894, 1200.1598880783486, 1240.5720026590811, 1260.1242136715077, 1291.5350473829415, 1292.4571679894466, 796.366888323784, 833.8159813065462, 842.5913431985482, 853.7694822397917, 879.3229213505565, 4579.2221417330165, 5051.907954556821, 5081.8311788288165, 5099.97450012755, 5115.360579927509, 4781.784819683123, 4990.451050384455, 5248.6325957182635, 5560.944390556043, 5715.799947001835, 4229.746215227096, 4696.825793551612, 5119.1553393690365, 5144.948550514522, 5159.329287192641, 2633.9473210536066, 2870.937623263101, 2902.521084021113, 2924.251203868357, 2994.446027484879, 5113.8721531962, 5165.974170129125, 5414.675119492765, 5613.186088017214, 5789.478946894799, 4700.482946875841, 4846.830360937351, 5378.596605254622, 5632.324121105494, 5838.4453476919625, 5084.415292241366, 5167.63057789686, 5377.650452720561, 5752.526413642174, 5839.2482255324085, 4939.950600493949, 5270.915040843377, 5478.205660179331, 5497.87293604818, 5570.832875013756, 4806.447258565309, 4984.675996060245, 5334.813281535127, 5548.389677135431, 5608.4111168326735, 4737.857864264078, 5202.479752024768, 5648.85877853057, 5823.650580965155, 5854.590178687621, 3347.0460918638073, 3511.4030614795033, 3757.455169000534, 3760.3231418344963, 3773.905652358713, 4915.410150781929, 4976.5023497649945, 5138.820141295037, 5177.404598471224, 5533.285076005227, 4743.83396581118, 4937.8271760488215, 5642.520385767091, 5807.796727114531, 5838.970805145947, 5745.224394706661, 5804.593678442468, 5823.941760582509, 5828.280657206219, 5875.911861321998, 4367.366731823931, 4786.242799402452, 4790.760461976957, 4932.087563800708, 5278.81226723984, 4540.8637740867825, 4969.676970996874, 5551.500364967173, 5701.771929122789, 5832.445917637818, 4499.977500112478, 5595.356533998643, 5599.944000559943, 5631.887362252814, 5645.802396916089], "value": 3989.288934445986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.9966200168999, 676.610948704495, 724.7354715528834, 725.8512005038966, 751.1474476469206, 11220.0, 14792.926035369836, 14840.925795371035, 14867.62830929226, 14900.03149795264, 13192.340382980861, 13195.208287502757, 13239.669008274797, 13306.800397994039, 13315.667108322297, 644.7582156691241, 667.0794303860665, 792.9484583502083, 809.878518222267, 811.3468657730524, 822.5599304372162, 822.983540329193, 825.1253671108614, 826.5660528222671, 828.3704384667635, 870.682200996638, 874.0909454167657, 874.152072489684, 875.089906497242, 876.2551830943711, 844.2401838345477, 870.7910101575576, 872.6116877989298, 872.9345299102561, 873.4453621950075, 634.6481993354172, 639.0829160155192, 647.5111290975331, 647.517599388454, 651.6546230497844, 11276.605318813885, 12323.815142772866, 13737.175769453865, 13901.0964287321, 13993.0, 12903.483860645563, 13263.010548417718, 13285.734285314336, 13361.599152025456, 13402.994775391884, 9572.712818615382, 11066.39134847583, 11475.77048459026, 11544.884551154464, 11888.227265227819, 3458.792472451661, 3470.875476126561, 3560.8041557714314, 3566.8038257895805, 3679.319325924686, 80481.79277310845, 81481.96295092611, 89545.0, 90152.54923725339, 91657.54171229168, 10194.0, 10438.843417348746, 10444.425556594308, 10716.303440276357, 10831.458427078614, 19880.801191988183, 19894.50263743418, 19896.801031989784, 19930.0, 20008.59982800336, 6576.145101136917, 6931.584104953719, 7329.633518324063, 7623.69505219785, 7920.207979202034, 3163.3198862244267, 4217.40956266123, 4285.185814695198, 4296.656267498655, 4418.182636212311, 3329.3174899145615, 3430.1939044324563, 3453.827308634558, 3456.1705190754037, 3463.913402164966, 633.3508154142041, 639.6290151712088, 643.0900276109346, 643.2024289880608, 657.8684263147389, 563.4253061876863, 635.0, 650.4536189600758, 658.4666420199653, 659.9241087274929, 9015.459072455673, 9058.32062595308, 9174.449533028039, 9198.264138868875, 9389.371932534388, 561.7247548701189, 561.7528287553463, 611.2664802237333, 648.7469886744174, 661.9441990025902, 4387.3857659927, 4412.3160910059, 4444.422408535822, 4496.145732310851, 4595.9080818383445, 69519.30480695229, 92948.0, 109726.0, 112345.43827280811, 115642.0, 62487.0, 89030.55484722534, 93253.0, 95077.0, 95880.0, 85506.0, 86354.56822715847, 87190.12809871948, 89410.0, 90241.0, 8501.744947651581, 8672.392932494917, 8748.56257187151, 8755.168259015383, 9041.231495322709, 54425.0, 56229.71885140548, 57119.42880571141, 57186.7140664294, 58264.70867645634, 71071.0, 74913.87629185675, 78346.60826696058, 78530.0, 80110.79833802614, 10158.382853874975, 10160.390376577428, 10684.038436540748, 11164.944175279072, 11592.88407115918, 12221.572244971383, 12259.570915018288, 12274.0, 12310.75378492443, 12652.546496271274, 11588.6523404298, 11608.709782255512, 11687.88312116868, 12020.098492612915, 12054.638360849189, 11674.299542027506, 11695.415229238333, 11766.764664706829, 11851.644450666494, 11955.880441195477, 10449.582016719247, 11222.158338124837, 11844.289342639124, 12173.939130304292, 12330.50677972871, 10612.843891144774, 10690.679279621623, 11035.779284414428, 11091.72270693239, 11394.0, 10744.73138171552, 11095.11239100886, 11423.371714555447, 11486.655400338002, 11502.194846360675], "value": 7077.956845590699, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 132.0, 171.0, 159.0, 124.0, 118.0], "value": 129.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 117.0, 148.0, 111.0, 116.0, 117.0, 112.0, 139.0, 113.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 194.0, 207.0, 196.0, 193.0, 202.0, 198.0, 198.0, 196.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 63.0, 83.0, 110.0, 66.0, 62.0, 61.0, 59.0, 80.0, 84.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 90.0, 74.0, 68.0, 69.0, 85.0, 70.0, 73.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 87.0, 91.0, 92.0, 91.0, 93.0, 108.0, 134.0, 87.0, 132.0], "value": 105.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 176.0, 107.0, 115.0, 100.0, 99.0, 115.0, 114.0, 180.0, 176.0], "value": 131.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 115.0, 96.0, 136.0, 74.0, 150.0, 101.0, 76.0, 103.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 58.0, 61.0, 60.0, 62.0, 60.0, 60.0, 60.0, 62.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 94.0, 113.0, 127.0, 78.0, 72.0, 80.0, 111.0, 110.0, 82.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 82.0, 85.0, 85.0, 84.0, 89.0, 115.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 167.0, 151.0, 147.0, 166.0, 163.0, 142.0, 221.0, 201.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 166.0, 169.0, 173.0, 166.0, 177.0, 172.0, 171.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 71.0, 68.0, 66.0, 67.0, 80.0, 84.0], "value": 70.7, "unit": "score"}]}]} 10:25:17 INFO - Return code: 0 10:25:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:17 ERROR - # TBPL SUCCESS # 10:25:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:17 INFO - 2017-01-09 10:25:17.192 screenresolution[2243:21314] starting screenresolution argv=screenresolution get 10:25:17 INFO - 2017-01-09 10:25:17.195 screenresolution[2243:21314] Display 0: 1600x1200x32@60 10:25:17 INFO - 2017-01-09 10:25:17.201 screenresolution[2244:21317] starting screenresolution argv=screenresolution list 10:25:17 INFO - Available Modes on Display 0 10:25:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:17 INFO - Intel Iris: 10:25:17 INFO - Chipset Model: Intel Iris 10:25:17 INFO - Type: GPU 10:25:17 INFO - Bus: Built-In 10:25:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:17 INFO - Vendor: Intel (0x8086) 10:25:17 INFO - Device ID: 0x0a2e 10:25:17 INFO - Revision ID: 0x0009 10:25:17 INFO - Displays: 10:25:17 INFO - Display: 10:25:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:17 INFO - Display Serial Number: 1600x1200 60 10:25:17 INFO - Main Display: Yes 10:25:17 INFO - Mirror: Off 10:25:17 INFO - Online: Yes 10:25:17 INFO - Rotation: Supported 10:25:17 INFO - Return code: 0 10:25:17 INFO - Running post-action listener: _resource_record_post_action 10:25:17 INFO - [mozharness: 2017-01-09 18:25:17.449151Z] Finished run-tests step (success) 10:25:17 INFO - Running post-run listener: _resource_record_post_run 10:25:17 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1168896; Write bytes: 655340544; Read time: 11; Write time: 2072 10:25:17 INFO - TinderboxPrint: CPU usage
54.3% 10:25:17 INFO - TinderboxPrint: I/O read bytes / time
1,168,896 / 11 10:25:17 INFO - TinderboxPrint: I/O write bytes / time
655,340,544 / 2,072 10:25:17 INFO - TinderboxPrint: CPU idle
2,212.6 (45.7%) 10:25:17 INFO - TinderboxPrint: CPU system
982.8 (20.3%) 10:25:17 INFO - TinderboxPrint: CPU user
1,646.2 (34.0%) 10:25:17 INFO - TinderboxPrint: Swap in / out
349,917,184 / 0 10:25:17 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344537600; Write bytes: 345859584; Read time: 26760; Write time: 716 10:25:17 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1168896; Write bytes: 302603776; Read time: 11; Write time: 1328 10:25:18 INFO - Running post-run listener: _upload_blobber_files 10:25:18 INFO - Blob upload gear active. 10:25:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:19 INFO - (blobuploader) - INFO - Done attempting. 10:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:20 INFO - (blobuploader) - INFO - Done attempting. 10:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:23 INFO - (blobuploader) - INFO - Done attempting. 10:25:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:23 INFO - Return code: 0 10:25:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b080d74cc05c7997cc4cfb80c6db0ea07dc5de915e7b9782be5ea3252020458d813f1717bc2a09e9a3396f977c722d3465765b30c7573871fca3d9c358d2dd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5e059a744b90dab91e85a96ecc7eaf71e19dafea9cf447f794b63eb88e7fa7584845149525d46fa4a6108d90f5be42ba0a559676f5993440c49499393b05b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18f6ce9ffdbb82576a925bf483c895dc44a9ad25b151a79dc95168f2094d1ab418dccb2dbbec221b56c619e505cc9d7d3df9e70b07609f09597c8f8e5cb2196"} 10:25:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:23 INFO - Contents: 10:25:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b080d74cc05c7997cc4cfb80c6db0ea07dc5de915e7b9782be5ea3252020458d813f1717bc2a09e9a3396f977c722d3465765b30c7573871fca3d9c358d2dd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5e059a744b90dab91e85a96ecc7eaf71e19dafea9cf447f794b63eb88e7fa7584845149525d46fa4a6108d90f5be42ba0a559676f5993440c49499393b05b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18f6ce9ffdbb82576a925bf483c895dc44a9ad25b151a79dc95168f2094d1ab418dccb2dbbec221b56c619e505cc9d7d3df9e70b07609f09597c8f8e5cb2196"} 10:25:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:23 INFO - Copying logs to upload dir... 10:25:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.732302 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-09 10:25:23.097388) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 10:25:23.101136) ========= 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.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b080d74cc05c7997cc4cfb80c6db0ea07dc5de915e7b9782be5ea3252020458d813f1717bc2a09e9a3396f977c722d3465765b30c7573871fca3d9c358d2dd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5e059a744b90dab91e85a96ecc7eaf71e19dafea9cf447f794b63eb88e7fa7584845149525d46fa4a6108d90f5be42ba0a559676f5993440c49499393b05b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18f6ce9ffdbb82576a925bf483c895dc44a9ad25b151a79dc95168f2094d1ab418dccb2dbbec221b56c619e505cc9d7d3df9e70b07609f09597c8f8e5cb2196"} build_url:https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010937 build_url: 'https://queue.taskcluster.net/v1/task/OYZK6tX8ShG83PG1K25lKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b080d74cc05c7997cc4cfb80c6db0ea07dc5de915e7b9782be5ea3252020458d813f1717bc2a09e9a3396f977c722d3465765b30c7573871fca3d9c358d2dd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5e059a744b90dab91e85a96ecc7eaf71e19dafea9cf447f794b63eb88e7fa7584845149525d46fa4a6108d90f5be42ba0a559676f5993440c49499393b05b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18f6ce9ffdbb82576a925bf483c895dc44a9ad25b151a79dc95168f2094d1ab418dccb2dbbec221b56c619e505cc9d7d3df9e70b07609f09597c8f8e5cb2196"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 10:25:23.134463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:25:23.134770) ========= 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.QTWy69cM5o/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.WGVpzowRrv/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.005368 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 10:25:23.182396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 10:25:23.182690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 10:25:23.182995) ========= ========= Total master_lag: 0.18 =========