builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0356 starttime: 1483614201.12 results: success (0) buildid: 20170105012039 builduid: bd736b8adc4a474686699464dcb8503d revision: 4f7d41ab5f850f84b3a62b421c9474b30830f115 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.116301) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.116754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.117025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.144042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.144603) ========= 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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-05 03:03:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.7M=0s 2017-01-05 03:03:21 (29.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140775 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.311605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.312000) ========= 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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.024582 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:21.360729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 03:03:21.361096) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7d41ab5f850f84b3a62b421c9474b30830f115 --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 4f7d41ab5f850f84b3a62b421c9474b30830f115 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-05 03:03:21,456 truncating revision to first 12 chars 2017-01-05 03:03:21,456 Setting DEBUG logging. 2017-01-05 03:03:21,456 attempt 1/10 2017-01-05 03:03:21,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7d41ab5f85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 03:03:22,521 unpacking tar archive at: mozilla-aurora-4f7d41ab5f85/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338798 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 03:03:22.723421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:22.723757) ========= script_repo_revision: 4f7d41ab5f850f84b3a62b421c9474b30830f115 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:22.724162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:22.724424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:03:22.744494) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-05 03:03:22.744885) ========= /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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:03:22 INFO - MultiFileLogger online at 20170105 03:03:22 in /builds/slave/test 03:03:22 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 03:03:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:03:22 INFO - {'append_to_log': False, 03:03:22 INFO - 'base_work_dir': '/builds/slave/test', 03:03:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:03:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:03:22 INFO - 'branch': 'Mozilla-Aurora', 03:03:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:03:22 INFO - 'config_files': ('talos/mac_config.py',), 03:03:22 INFO - 'default_actions': ('clobber', 03:03:22 INFO - 'read-buildbot-config', 03:03:22 INFO - 'download-and-extract', 03:03:22 INFO - 'populate-webroot', 03:03:22 INFO - 'create-virtualenv', 03:03:22 INFO - 'install', 03:03:22 INFO - 'run-tests'), 03:03:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:03:22 INFO - 'download_minidump_stackwalk': True, 03:03:22 INFO - 'download_symbols': 'ondemand', 03:03:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:03:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:03:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:03:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:03:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:03:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:03:22 INFO - 'installer_path': 'installer.exe', 03:03:22 INFO - 'log_level': 'info', 03:03:22 INFO - 'log_name': 'talos', 03:03:22 INFO - 'log_to_console': True, 03:03:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:03:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:03:22 INFO - 'opt_config_files': (), 03:03:22 INFO - 'pip_index': False, 03:03:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:03:22 INFO - 'cmd': ('bash', 03:03:22 INFO - '-c', 03:03:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:03:22 INFO - 'enabled': True, 03:03:22 INFO - 'halt_on_failure': False, 03:03:22 INFO - 'name': 'check_screen_resolution'},), 03:03:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:03:22 INFO - 'cmd': ('bash', 03:03:22 INFO - '-c', 03:03:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:03:22 INFO - 'enabled': True, 03:03:22 INFO - 'halt_on_failure': False, 03:03:22 INFO - 'name': 'check_screen_resolution'},), 03:03:22 INFO - 'run_cmd_checks_enabled': True, 03:03:22 INFO - 'sps_profile': False, 03:03:22 INFO - 'sps_profile_interval': 0, 03:03:22 INFO - 'suite': 'dromaeojs-e10s', 03:03:22 INFO - 'system_bits': '32', 03:03:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:03:22 INFO - 'title': 't-yosemite-r7-0356', 03:03:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:03:22 INFO - 'use_talos_json': True, 03:03:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:03:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:03:22 INFO - 'work_dir': 'build'} 03:03:22 INFO - [mozharness: 2017-01-05 11:03:22.942420Z] Running clobber step. 03:03:22 INFO - Running pre-action listener: _resource_record_pre_action 03:03:22 INFO - Running main action method: clobber 03:03:22 INFO - rmtree: /builds/slave/test/build 03:03:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:03:25 INFO - Running post-action listener: _resource_record_post_action 03:03:25 INFO - [mozharness: 2017-01-05 11:03:25.248922Z] Finished clobber step (success) 03:03:25 INFO - [mozharness: 2017-01-05 11:03:25.249164Z] Running read-buildbot-config step. 03:03:25 INFO - Running pre-action listener: _resource_record_pre_action 03:03:25 INFO - Running main action method: read_buildbot_config 03:03:25 INFO - Using buildbot properties: 03:03:25 INFO - { 03:03:25 INFO - "project": "", 03:03:25 INFO - "product": "firefox", 03:03:25 INFO - "script_repo_revision": "production", 03:03:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:03:25 INFO - "repository": "", 03:03:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:03:25 INFO - "buildid": "20170105012039", 03:03:25 INFO - "pgo_build": "False", 03:03:25 INFO - "basedir": "/builds/slave/test", 03:03:25 INFO - "buildnumber": 62, 03:03:25 INFO - "slavename": "t-yosemite-r7-0356", 03:03:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:03:25 INFO - "platform": "yosemite_r7", 03:03:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:03:25 INFO - "branch": "mozilla-aurora", 03:03:25 INFO - "repo_path": "releases/mozilla-aurora", 03:03:25 INFO - "revision": "4f7d41ab5f850f84b3a62b421c9474b30830f115", 03:03:25 INFO - "stage_platform": "macosx64", 03:03:25 INFO - "builduid": "bd736b8adc4a474686699464dcb8503d", 03:03:25 INFO - "slavebuilddir": "test" 03:03:25 INFO - } 03:03:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:03:25 INFO - Running post-action listener: _resource_record_post_action 03:03:25 INFO - [mozharness: 2017-01-05 11:03:25.254821Z] Finished read-buildbot-config step (success) 03:03:25 INFO - [mozharness: 2017-01-05 11:03:25.255026Z] Running download-and-extract step. 03:03:25 INFO - Running pre-action listener: _resource_record_pre_action 03:03:25 INFO - Running main action method: download_and_extract 03:03:25 INFO - mkdir: /builds/slave/test/build/tests 03:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:25 INFO - trying https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:03:25 INFO - Downloading https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/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 03:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/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 03:03:26 INFO - Downloaded 1199 bytes. 03:03:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:03:26 INFO - Using the following test package requirements: 03:03:26 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:03:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:03:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:03:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'jsshell-mac.zip'], 03:03:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:03:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:03:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:03:26 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:03:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:03:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:03:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:03:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:03:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:03:27 INFO - Http code: 200 03:03:27 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 03:03:27 INFO - x-amz-cf-id: wjdiUAckxaFCkxX-Ov3fP-uPk1e9sPz13Z0nbK3XDoUSy3HCzuCFjg== 03:03:27 INFO - x-amz-version-id: nE5kGcPcODaaFzSz1niTvcVFxZcvDh77 03:03:27 INFO - Expected file size: 16270079 03:03:27 INFO - Obtained file size: 16270079 03:03:34 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 03:03:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:03:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:34 INFO - Fetch https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:03:34 INFO - Http code: 200 03:03:34 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 03:03:34 INFO - x-amz-cf-id: v47Dw0_OwvUtCjV2mDUY5-caDPya7Xr7j5J9YLJPtqnIKet8uGmnnA== 03:03:34 INFO - x-amz-version-id: nE5kGcPcODaaFzSz1niTvcVFxZcvDh77 03:03:34 INFO - Expected file size: 16270079 03:03:34 INFO - Obtained file size: 16270079 03:03:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:03:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:03:41 INFO - Fetch https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:03:41 INFO - Http code: 200 03:03:41 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 03:03:41 INFO - x-amz-cf-id: Lm2npiQnc_C-SnJhGsgDoPD__iecqmMA4WO3tDuDg0s1TQl7gcZYEg== 03:03:41 INFO - x-amz-version-id: MRES8iy1fWeItUvHgLV1Yj8B.OHqowxC 03:03:42 INFO - Expected file size: 14409038 03:03:42 INFO - Obtained file size: 14409038 03:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:42 INFO - trying https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/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 03:03:45 INFO - Downloaded 109828103 bytes. 03:03:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:03:45 INFO - mkdir: /builds/slave/test/properties 03:03:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:45 INFO - Contents: 03:03:45 INFO - build_url:https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:03:45 INFO - Running post-action listener: _resource_record_post_action 03:03:45 INFO - Running post-action listener: set_extra_try_arguments 03:03:45 INFO - [mozharness: 2017-01-05 11:03:45.826954Z] Finished download-and-extract step (success) 03:03:45 INFO - [mozharness: 2017-01-05 11:03:45.827067Z] Running populate-webroot step. 03:03:45 INFO - Running pre-action listener: _resource_record_pre_action 03:03:45 INFO - Running main action method: populate_webroot 03:03:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:45 INFO - '--tppagecycles', 03:03:45 INFO - '7'], 03:03:45 INFO - 'tests': ['tsvgm']}}, 03:03:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['damp', 'tps']}, 03:03:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'tests': ['damp', 'tps']}, 03:03:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['dromaeo_dom']}, 03:03:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['basic_compositor_video']}, 03:03:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:03:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['a11yr', 03:03:45 INFO - 'ts_paint', 03:03:45 INFO - 'tpaint', 03:03:45 INFO - 'sessionrestore', 03:03:45 INFO - 'sessionrestore_no_auto_restore', 03:03:45 INFO - 'tabpaint']}, 03:03:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['tsvgx', 03:03:45 INFO - 'tsvgr_opacity', 03:03:45 INFO - 'tart', 03:03:45 INFO - 'tscrollx', 03:03:45 INFO - 'cart']}, 03:03:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:45 INFO - 'tsvgr_opacity', 03:03:45 INFO - 'tart', 03:03:45 INFO - 'tscrollx', 03:03:45 INFO - 'cart']}, 03:03:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'talos_options': ['--disable-e10s'], 03:03:45 INFO - 'tests': ['tp5o']}, 03:03:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'tests': ['tp5o']}, 03:03:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'talos_options': ['--disable-e10s', 03:03:45 INFO - '--xperf_path', 03:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:45 INFO - 'tests': ['tp5n']}, 03:03:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:45 INFO - 'talos_options': ['--xperf_path', 03:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:45 INFO - 'tests': ['tp5n']}}, 03:03:45 INFO - 'talos.zip': {'path': '', 03:03:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:45 INFO - Running post-action listener: _resource_record_post_action 03:03:45 INFO - [mozharness: 2017-01-05 11:03:45.846052Z] Finished populate-webroot step (success) 03:03:45 INFO - [mozharness: 2017-01-05 11:03:45.846165Z] Running create-virtualenv step. 03:03:45 INFO - Running pre-action listener: _resource_record_pre_action 03:03:45 INFO - Running main action method: create_virtualenv 03:03:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:45 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 03:03:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:45 INFO - Using real prefix '/tools/python27' 03:03:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:49 INFO - Installing pip.................done. 03:03:49 INFO - Return code: 0 03:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:49 INFO - Reading from file tmpfile_stdout 03:03:49 INFO - Output received: 03:03:49 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) 03:03:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:49 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')]} 03:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:49 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')]} 03:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:49 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:03:49 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 03:03:49 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 03:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:49 INFO - 'HOME': '/Users/cltbld', 03:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:49 INFO - 'LOGNAME': 'cltbld', 03:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:49 INFO - 'MOZ_NO_REMOTE': '1', 03:03:49 INFO - 'NO_EM_RESTART': '1', 03:03:49 INFO - 'PAGER': '/bin/cat', 03:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:49 INFO - 'PWD': '/builds/slave/test', 03:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:49 INFO - 'SHELL': '/bin/bash', 03:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:03:49 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:49 INFO - 'USER': 'cltbld', 03:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:49 INFO - 'XPC_FLAGS': '0x0', 03:03:49 INFO - 'XPC_SERVICE_NAME': '0', 03:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:50 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 03:03:50 INFO - Cleaning up... 03:03:50 INFO - Return code: 0 03:03:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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', '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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:03: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 psutil>=3.1.1 03:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:50 INFO - 'HOME': '/Users/cltbld', 03:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:50 INFO - 'LOGNAME': 'cltbld', 03:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:50 INFO - 'MOZ_NO_REMOTE': '1', 03:03:50 INFO - 'NO_EM_RESTART': '1', 03:03:50 INFO - 'PAGER': '/bin/cat', 03:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:50 INFO - 'PWD': '/builds/slave/test', 03:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:50 INFO - 'SHELL': '/bin/bash', 03:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:03:50 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:50 INFO - 'USER': 'cltbld', 03:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:50 INFO - 'XPC_FLAGS': '0x0', 03:03:50 INFO - 'XPC_SERVICE_NAME': '0', 03:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:50 INFO - Downloading/unpacking psutil>=3.1.1 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:53 INFO - Installing collected packages: psutil 03:03:53 INFO - Running setup.py install for psutil 03:03:53 INFO - building 'psutil._psutil_osx' extension 03:03:53 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 03:03:54 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 03:03:54 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 03:03:54 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 03:03:54 INFO - building 'psutil._psutil_posix' extension 03:03:54 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 03:03:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:03:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:03:54 INFO - ^ 03:03:54 INFO - 1 warning generated. 03:03:54 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 03:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:54 INFO - Successfully installed psutil 03:03:54 INFO - Cleaning up... 03:03:55 INFO - Return code: 0 03:03:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:55 INFO - 'HOME': '/Users/cltbld', 03:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PAGER': '/bin/cat', 03:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test', 03:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:03:55 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - 'XPC_FLAGS': '0x0', 03:03:55 INFO - 'XPC_SERVICE_NAME': '0', 03:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:58 INFO - Installing collected packages: mozsystemmonitor 03:03:58 INFO - Running setup.py install for mozsystemmonitor 03:03:58 INFO - Successfully installed mozsystemmonitor 03:03:58 INFO - Cleaning up... 03:03:58 INFO - Return code: 0 03:03:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:58 INFO - 'HOME': '/Users/cltbld', 03:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:58 INFO - 'LOGNAME': 'cltbld', 03:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:58 INFO - 'MOZ_NO_REMOTE': '1', 03:03:58 INFO - 'NO_EM_RESTART': '1', 03:03:58 INFO - 'PAGER': '/bin/cat', 03:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:58 INFO - 'PWD': '/builds/slave/test', 03:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:58 INFO - 'SHELL': '/bin/bash', 03:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:03:58 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:58 INFO - 'USER': 'cltbld', 03:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:58 INFO - 'XPC_FLAGS': '0x0', 03:03:58 INFO - 'XPC_SERVICE_NAME': '0', 03:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:01 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 03:04:01 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 03:04:01 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 03:04:01 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 03:04:01 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 03:04:01 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 03:04:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:01 INFO - warning: no files found matching '*.txt' 03:04:01 INFO - no previously-included directories found matching 'build' 03:04:01 INFO - no previously-included directories found matching 'dist' 03:04:01 INFO - no previously-included directories found matching '.git*' 03:04:01 INFO - Installing collected packages: jsonschema, functools32 03:04:01 INFO - Running setup.py install for functools32 03:04:01 INFO - warning: no files found matching '*.txt' 03:04:01 INFO - no previously-included directories found matching 'build' 03:04:01 INFO - no previously-included directories found matching 'dist' 03:04:01 INFO - no previously-included directories found matching '.git*' 03:04:01 INFO - Successfully installed jsonschema functools32 03:04:01 INFO - Cleaning up... 03:04:01 INFO - Return code: 0 03:04:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:04:01 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')]} 03:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:01 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')]} 03:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:01 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:01 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 03:04:01 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 03:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:01 INFO - 'HOME': '/Users/cltbld', 03:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:01 INFO - 'LOGNAME': 'cltbld', 03:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:01 INFO - 'MOZ_NO_REMOTE': '1', 03:04:01 INFO - 'NO_EM_RESTART': '1', 03:04:01 INFO - 'PAGER': '/bin/cat', 03:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:01 INFO - 'PWD': '/builds/slave/test', 03:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:01 INFO - 'SHELL': '/bin/bash', 03:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:01 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:01 INFO - 'USER': 'cltbld', 03:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:01 INFO - 'XPC_FLAGS': '0x0', 03:04:01 INFO - 'XPC_SERVICE_NAME': '0', 03:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:04:02 INFO - Cleaning up... 03:04:02 INFO - Return code: 0 03:04:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:02 INFO - 'HOME': '/Users/cltbld', 03:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:02 INFO - 'LOGNAME': 'cltbld', 03:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:02 INFO - 'MOZ_NO_REMOTE': '1', 03:04:02 INFO - 'NO_EM_RESTART': '1', 03:04:02 INFO - 'PAGER': '/bin/cat', 03:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:02 INFO - 'PWD': '/builds/slave/test', 03:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:02 INFO - 'SHELL': '/bin/bash', 03:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:02 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:02 INFO - 'USER': 'cltbld', 03:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:02 INFO - 'XPC_FLAGS': '0x0', 03:04:02 INFO - 'XPC_SERVICE_NAME': '0', 03:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:06 INFO - Downloading docopt-0.6.1.tar.gz 03:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:06 INFO - Running setup.py install for blobuploader 03:04:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:06 INFO - Running setup.py install for requests 03:04:07 INFO - Running setup.py install for docopt 03:04:07 INFO - Successfully installed blobuploader requests docopt 03:04:07 INFO - Cleaning up... 03:04:07 INFO - Return code: 0 03:04:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:07 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')]} 03:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 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')]} 03:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:07 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 03:04:07 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 03:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:07 INFO - 'HOME': '/Users/cltbld', 03:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:07 INFO - 'LOGNAME': 'cltbld', 03:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:07 INFO - 'MOZ_NO_REMOTE': '1', 03:04:07 INFO - 'NO_EM_RESTART': '1', 03:04:07 INFO - 'PAGER': '/bin/cat', 03:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:07 INFO - 'PWD': '/builds/slave/test', 03:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:07 INFO - 'SHELL': '/bin/bash', 03:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:07 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:07 INFO - 'USER': 'cltbld', 03:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:07 INFO - 'XPC_FLAGS': '0x0', 03:04:07 INFO - 'XPC_SERVICE_NAME': '0', 03:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-1rrjOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-vNUiGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-2wS_5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-IC11TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-2GSAaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Pp1pDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-MFX3Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-SqQ05f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ALeZU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-T60dRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-l_18f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-LFaexp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-zjnNQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-SY14QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:08 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-UV9rV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:09 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-I0Yzvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:09 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YWB9LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:09 INFO - Running setup.py install for manifestparser 03:04:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Running setup.py install for mozcrash 03:04:09 INFO - Running setup.py install for mozdebug 03:04:09 INFO - Running setup.py install for mozdevice 03:04:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Running setup.py install for mozfile 03:04:10 INFO - Running setup.py install for mozhttpd 03:04:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Running setup.py install for mozinfo 03:04:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Running setup.py install for mozInstall 03:04:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Running setup.py install for mozleak 03:04:10 INFO - Running setup.py install for mozlog 03:04:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Running setup.py install for moznetwork 03:04:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:10 INFO - Running setup.py install for mozprocess 03:04:11 INFO - Running setup.py install for mozprofile 03:04:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:11 INFO - Running setup.py install for mozrunner 03:04:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:11 INFO - Running setup.py install for mozscreenshot 03:04:11 INFO - Running setup.py install for moztest 03:04:11 INFO - Running setup.py install for mozversion 03:04:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:11 INFO - Cleaning up... 03:04:11 INFO - Return code: 0 03:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:11 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:11 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 03:04:11 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 03:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:11 INFO - 'HOME': '/Users/cltbld', 03:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:11 INFO - 'LOGNAME': 'cltbld', 03:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:11 INFO - 'MOZ_NO_REMOTE': '1', 03:04:11 INFO - 'NO_EM_RESTART': '1', 03:04:11 INFO - 'PAGER': '/bin/cat', 03:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:11 INFO - 'PWD': '/builds/slave/test', 03:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:11 INFO - 'SHELL': '/bin/bash', 03:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:11 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:11 INFO - 'USER': 'cltbld', 03:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:11 INFO - 'XPC_FLAGS': '0x0', 03:04:11 INFO - 'XPC_SERVICE_NAME': '0', 03:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-7JqgJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-KrjH3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-5nO_sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-o4wPku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-jLmHpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-cBAMxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ZwGSGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-AYt9x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:12 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)) 03:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-6UfAYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-7Mw4Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YYkgpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-71WQrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-P6Rqdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-CZScdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-NUqeuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-DGzvBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:13 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)) 03:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:13 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-0zzrjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:13 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)) 03:04:13 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)) 03:04:13 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)) 03:04:13 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)) 03:04:13 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)) 03:04:13 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)) 03:04:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:16 INFO - Downloading blessings-1.6.tar.gz 03:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:16 INFO - Installing collected packages: blessings 03:04:16 INFO - Running setup.py install for blessings 03:04:16 INFO - Successfully installed blessings 03:04:16 INFO - Cleaning up... 03:04:16 INFO - Return code: 0 03:04:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:17 INFO - Reading from file tmpfile_stdout 03:04:17 INFO - Current package versions: 03:04:17 INFO - blessings == 1.6 03:04:17 INFO - blobuploader == 1.2.4 03:04:17 INFO - docopt == 0.6.1 03:04:17 INFO - functools32 == 3.2.3-2 03:04:17 INFO - jsonschema == 2.5.1 03:04:17 INFO - manifestparser == 1.1 03:04:17 INFO - mozInstall == 1.12 03:04:17 INFO - mozcrash == 1.0 03:04:17 INFO - mozdebug == 0.1 03:04:17 INFO - mozdevice == 0.48 03:04:17 INFO - mozfile == 1.2 03:04:17 INFO - mozhttpd == 0.7 03:04:17 INFO - mozinfo == 0.9 03:04:17 INFO - mozleak == 0.1 03:04:17 INFO - mozlog == 3.4 03:04:17 INFO - moznetwork == 0.27 03:04:17 INFO - mozprocess == 0.23 03:04:17 INFO - mozprofile == 0.28 03:04:17 INFO - mozrunner == 6.13 03:04:17 INFO - mozscreenshot == 0.1 03:04:17 INFO - mozsystemmonitor == 0.3 03:04:17 INFO - moztest == 0.8 03:04:17 INFO - mozversion == 1.4 03:04:17 INFO - psutil == 3.1.1 03:04:17 INFO - requests == 1.2.3 03:04:17 INFO - wsgiref == 0.1.2 03:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:17 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')]} 03:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:17 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')]} 03:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:18 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:18 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 03:04:18 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 03:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:18 INFO - 'HOME': '/Users/cltbld', 03:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:18 INFO - 'LOGNAME': 'cltbld', 03:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:18 INFO - 'MOZ_NO_REMOTE': '1', 03:04:18 INFO - 'NO_EM_RESTART': '1', 03:04:18 INFO - 'PAGER': '/bin/cat', 03:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:18 INFO - 'PWD': '/builds/slave/test', 03:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:18 INFO - 'SHELL': '/bin/bash', 03:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:18 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:18 INFO - 'USER': 'cltbld', 03:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:18 INFO - 'XPC_FLAGS': '0x0', 03:04:18 INFO - 'XPC_SERVICE_NAME': '0', 03:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 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)) 03:04:18 INFO - Cleaning up... 03:04:18 INFO - Return code: 0 03:04:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:18 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')]} 03:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:18 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')]} 03:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:18 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 0x10dce4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67049ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, '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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 03:04:18 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 03:04:18 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 03:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:18 INFO - 'HOME': '/Users/cltbld', 03:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:18 INFO - 'LOGNAME': 'cltbld', 03:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:18 INFO - 'MOZ_NO_REMOTE': '1', 03:04:18 INFO - 'NO_EM_RESTART': '1', 03:04:18 INFO - 'PAGER': '/bin/cat', 03:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:18 INFO - 'PWD': '/builds/slave/test', 03:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:18 INFO - 'SHELL': '/bin/bash', 03:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:18 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:18 INFO - 'USER': 'cltbld', 03:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:18 INFO - 'XPC_FLAGS': '0x0', 03:04:18 INFO - 'XPC_SERVICE_NAME': '0', 03:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:04:19 INFO - Cleaning up... 03:04:19 INFO - Return code: 0 03:04:19 INFO - Running post-action listener: _resource_record_post_action 03:04:19 INFO - Running post-action listener: _start_resource_monitoring 03:04:19 INFO - Starting resource monitoring. 03:04:19 INFO - [mozharness: 2017-01-05 11:04:19.217813Z] Finished create-virtualenv step (success) 03:04:19 INFO - [mozharness: 2017-01-05 11:04:19.218721Z] Running install step. 03:04:19 INFO - Running pre-action listener: _resource_record_pre_action 03:04:19 INFO - Running main action method: install 03:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:19 INFO - Reading from file tmpfile_stdout 03:04:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:19 INFO - Reading from file tmpfile_stdout 03:04:19 INFO - Output received: 03:04:19 INFO - Usage: mozinstall [options] installer 03:04:19 INFO - Options: 03:04:19 INFO - -h, --help show this help message and exit 03:04:19 INFO - -d DEST, --destination=DEST 03:04:19 INFO - Directory to install application into. [default: 03:04:19 INFO - "/builds/slave/test"] 03:04:19 INFO - --app=APP Application being installed. [default: firefox] 03:04:19 INFO - mkdir: /builds/slave/test/build/application 03:04:19 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'] 03:04:19 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 03:04:50 INFO - Reading from file tmpfile_stdout 03:04:50 INFO - Output received: 03:04:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:04:50 INFO - Running post-action listener: _resource_record_post_action 03:04:50 INFO - [mozharness: 2017-01-05 11:04:50.857522Z] Finished install step (success) 03:04:50 INFO - [mozharness: 2017-01-05 11:04:50.857673Z] Running run-tests step. 03:04:50 INFO - Running pre-action listener: _resource_record_pre_action 03:04:50 INFO - Running main action method: run_tests 03:04:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:50 INFO - 2017-01-05 03:04:50.871 screenresolution[1622:7510] starting screenresolution argv=screenresolution get 03:04:50 INFO - 2017-01-05 03:04:50.874 screenresolution[1622:7510] Display 0: 1600x1200x32@60 03:04:50 INFO - 2017-01-05 03:04:50.880 screenresolution[1623:7513] starting screenresolution argv=screenresolution list 03:04:50 INFO - Available Modes on Display 0 03:04:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:51 INFO - Intel Iris: 03:04:51 INFO - Chipset Model: Intel Iris 03:04:51 INFO - Type: GPU 03:04:51 INFO - Bus: Built-In 03:04:51 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:51 INFO - Vendor: Intel (0x8086) 03:04:51 INFO - Device ID: 0x0a2e 03:04:51 INFO - Revision ID: 0x0009 03:04:51 INFO - Displays: 03:04:51 INFO - Display: 03:04:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:51 INFO - Display Serial Number: 1600x1200 60 03:04:51 INFO - Main Display: Yes 03:04:51 INFO - Mirror: Off 03:04:51 INFO - Online: Yes 03:04:51 INFO - Rotation: Supported 03:04:51 INFO - Return code: 0 03:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:51 INFO - Python 2.7.3 03:04:51 INFO - Return code: 0 03:04:51 INFO - grabbing minidump binary from tooltool 03:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:51 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 0x10daf8d30>, '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 0x10d95edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:51 INFO - Return code: 0 03:04:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:04:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:04:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:51 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/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 03:04:51 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/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --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 03:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmeQ08HbLP/Render', 03:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:51 INFO - 'HOME': '/Users/cltbld', 03:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:51 INFO - 'LOGNAME': 'cltbld', 03:04:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:51 INFO - 'MOZ_NO_REMOTE': '1', 03:04:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:51 INFO - 'NO_EM_RESTART': '1', 03:04:51 INFO - 'PAGER': '/bin/cat', 03:04:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:51 INFO - 'PWD': '/builds/slave/test', 03:04:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:51 INFO - 'SHELL': '/bin/bash', 03:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHZUnQLvHk/Listeners', 03:04:51 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 03:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:51 INFO - 'USER': 'cltbld', 03:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:51 INFO - 'XPC_FLAGS': '0x0', 03:04:51 INFO - 'XPC_SERVICE_NAME': '0', 03:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:51 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/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 03:04:51 INFO - mozversion application_buildid: 20170105012039 03:04:51 INFO - mozversion application_changeset: 4f7d41ab5f850f84b3a62b421c9474b30830f115 03:04:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:04:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:51 INFO - mozversion application_name: Firefox 03:04:51 INFO - mozversion application_remotingname: firefox-dev 03:04:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:51 INFO - mozversion application_vendor: Mozilla 03:04:51 INFO - mozversion application_version: 52.0a2 03:04:51 INFO - mozversion platform_buildid: 20170105012039 03:04:51 INFO - mozversion platform_changeset: 4f7d41ab5f850f84b3a62b421c9474b30830f115 03:04:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:51 INFO - mozversion platform_version: 52.0a2 03:04:51 INFO - using testdate: 1483614291 03:04:51 INFO - actual date: 1483614291 03:04:51 INFO - starting webserver on 'localhost:49238' 03:04:51 INFO - SUITE-START | Running 2 tests 03:04:51 INFO - TEST-START | dromaeo_css 03:04:51 INFO - operating with platform_type : mac_ 03:04:51 INFO - Initialising browser for dromaeo_css test... 03:04:51 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpZ_2Hym/profile http://localhost:49238/getInfo.html) 03:04:54 INFO - PROCESS | 1633 | 2017-01-05 03:04:54.515 plugin-container[1635:7658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 03:04:54 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:54 INFO - PROCESS | 1633 | 2017-01-05 03:04:54.518 plugin-container[1635:7658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 03:04:54 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:54 INFO - PROCESS | 1633 | 2017-01-05 03:04:54.518 plugin-container[1635:7658] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:04:54 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 03:04:54 INFO - PROCESS | 1633 | colorDepth:24 03:04:54 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 03:04:54 INFO - PROCESS | 1633 | __metrics 03:04:54 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:04:55 INFO - TEST-INFO | 1633: exit 0 03:04:55 INFO - Browser initialized. 03:04:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:55 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpZ_2Hym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:58 INFO - PROCESS | 1636 | 2017-01-05 03:04:58.148 plugin-container[1637:7795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 03:04:58 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:58 INFO - PROCESS | 1636 | 2017-01-05 03:04:58.148 plugin-container[1637:7795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 03:04:58 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:58 INFO - PROCESS | 1636 | 2017-01-05 03:04:58.148 plugin-container[1637:7795] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:07 INFO - PROCESS | 1636 | RSS: Main: 229642240 03:05:07 INFO - PROCESS | 1636 | 03:08:11 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 03:08:14 INFO - PROCESS | 1636 | RSS: Main: 233680896 03:08:14 INFO - PROCESS | 1636 | 03:11:16 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 03:11:16 INFO - PROCESS | 1636 | RSS: Main: 244297728 03:11:16 INFO - PROCESS | 1636 | 03:14:18 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 03:14:19 INFO - PROCESS | 1636 | RSS: Main: 247193600 03:14:19 INFO - PROCESS | 1636 | 03:17:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 03:17:21 INFO - PROCESS | 1636 | RSS: Main: 246403072 03:17:21 INFO - PROCESS | 1636 | 03:20:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 03:20:25 INFO - PROCESS | 1636 | RSS: Main: 249716736 03:20:25 INFO - PROCESS | 1636 | 03:23:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 03:23:28 INFO - PROCESS | 1636 | RSS: Main: 250863616 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | __start_tp_report 03:23:28 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 03:23:28 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 03:23:28 INFO - PROCESS | 1636 | |i|pagename|runs| 03:23:28 INFO - PROCESS | 1636 | |0;dojo.html;3391.1691635549296;3397.5922889253293;3429.9657003429975;3436.3470940521297;3437.0548099272683;4836.202026665596;5343.759530821118;5724.198612194296;5746;5795.304563452381;5708.942910570893;5835.533157347412;5849.415058494148;5850.946829570676;5862.824115276538;5245.8950820983555;5263.3683957925105;5264;5274.81538146165;5312.150055991042;5315.867103322409;5330.973345133269;5338.225957236198;5373.408925018245;5395.487428694288;5142.357205349332;5177.508136727024;5329.546988505982;5330.733463326837;5342.332208473941;4456.576625220631;4587.669575823007;5226.738663066832;5254.763535640867;5294.682319060868;5055.9241611375855;5184.481551844823;5200.6879587224885;5209.114450543417;5251.396089449724;4755.762211889391;5774.989376859033;5839.416058394169;5903.881922361528;5973.581849270553;4567.383403240553;5347.6256662033675;6272.090546870678;6293.087502312139;6378.043293505965;5120.6927584344685;5132.5893928486;5236.764345604457;6308.463780578611;6339.778107766252;4806.4712881583;5937.465628093492;5956.851078723066;5957.642541447527;5992.520598352208;5700.458456446631;6206.193194884636;6323.430891219812;6360.6501642409185;6370.74517019314;5112.36095488064;5595;6095.451409373178;6117.1130186123655;6128.509719222451;5842.941570584325;6209.627422354673;6224.502039836802;6248.4064013918605;6296.685165741695;6210.627362358273;6243.43809057187;6274.874502509924;6320.5259605528845;6366.872662546723;6197.03945888388;6259.123722678829;6319.715612797435;6324.335944725737;6328.936710632926;4868.805247790048;4910.091633047826;4913.361263035782;4934.037862616827;5020.899582008339;4434.046679963823;4436.157130145262;4457.9331310030375;4473.485549161823;4479.037007043501;5607.831765047055;5793.797217097382;5820.1560773688425;5849.61977471463;5867.119932010147;6174.845628859314;6212.596181248205;6219.813405597839;6246.3753624637175;6295.622262664163;5846.093855452412;5848.3274423441;5857.297124345106;5868.765249390062;5901.203337549376;5331.70675612845;5380.408155102936;5450.127979523258;5474.206240095244;5505.953868764922;6370.872582548323;6386;6402.775902843378;6415.711292991827;6420.967895160495;6165.0444181152;6219.782307619212;6239.688015599111;6250.781222657367;6288.717007734755;6333.524985626004;6340.4927605792345;6348.174737284308;6348.333424990495;6354.872902542016;6238.812835614939;6242.5942313749465;6250.9998400255745;6261.311255761953;6265.561410701207;5122.692638441706;6015.849603759941;6172.753089876354;6203;6265.27949285838;6022.307434645072;6022.879542409215;6027.126066720389;6132.0495871890025;6136.478399335928;4342.956570434255;4980.775865086008;5078.771455284595;5298.7350632469;6169.352218017044;5922.289325280994;5970.58205925581;6112.480439162721;6119.969400152971;6121.4490695837585;4753.263244197155;6018.428249316308;6098.481629061402;6201;6231.906521402092;5147.768350424315;5800.535957123504;5946.821595352147;5999.820005399845;6020.337762846171 03:23:28 INFO - PROCESS | 1636 | |1;ext.html;472.90305487375093;495.6332314087574;527.4751622135975;539.4955716405161;539.749016707231;38101.809490952575;39956.00109997251;40106.79946600267;40163.19673606526;40210.7989460053;32626.836865815636;40323.395149072785;41009;41119.38320925181;41277.793611031906;9157.862632060524;9402.43585384879;9430.717078487656;9438.622455101788;9443.197328227108;9171.724848254564;9188.12712792287;9280.164785169334;9299.95350023249;9304;9173.036831132735;9177.128172823572;9215.907840921573;9220.446773193597;9262.444253344787;9219.723408297728;9268.536573171314;9297.581608827619;9301.53492325381;9328.953355233214;9374.812503749887;9383.906160938439;9468.952655236748;9469.384490008128;9472.194863436616;39106.80446597777;39476.407853882214;39525.40711889324;39569;39623.60376396228;3153.7634677399055;3296.0935742670717;3552.0764601203614;3724.981375093107;3960.940585891214;28273.43453130926;28293.29266768327;28392.432151356858;29345.826166953295;29536.704632953824;3043.239190202449;3230.596175478065;3277.8361081946045;3300.5214243934734;3307.6361600223954;424430;496615;497936;499946;502546;59196.40803591909;59205.40794591999;59459;59731.70134149301;59733.402665973656;57990.710046449494;60918;61482;61531.69234153801;61837.69081154565;15870.761938570931;15924.76112858308;15973.520794376187;16158.515244542683;16171;12441.502339906483;12509.812352814715;12539.498420063277;12545.93359564429;12550.560730374393;13637.659058523417;14478.927605361905;16621;16743.16284185786;16839.579010524834;3120.672329405425;3235.3044095519576;6020.886136064842;6119.969400152971;6151.415615516519;857.4897935728231;960.544774666381;974.2400927276735;1018.0481250031245;1062.0414136819468;29974.25064373408;30089.946851860517;30517;30623.2344191397;31379.84310078435;999.2455695949657;1006.7281833904805;1019.4138370437029;1083.772407794372;1101.895319944604;14944.70110597782;15660.843391566166;15739.763903541456;15949.920250398905;16221.513354599381;649164.7541762355;652354;652585;652952;654586;57619;57897.71051144717;58049;58126;58859.70570147122;1069.44512704575;1247.3451437994943;1323.7887333090114;1347.9932600336936;1378.710470801123;29904.85047574748;30359.636175051077;31068.067957960393;31279.374412511166;31475;40201;45226.346706661665;51302.486975129774;51457.48542514677;51489.97020059503;447095;483490;491726;493380;599434;20387.694184586948;25237;26155.215343539723;26427.207183784518;26449.94200231969;42689.786551067045;44986;45420.772896135306;45672.8581785458;45712.54287457083;37462.8126859364;37566.812165938994;37930.0517487054;37980.62019379771;39240.21519569535;37713.43429848499;37976.620233798414;38476;38776.030599235244;39201.01997449972;36195;36708.632913670524;37193.69822056215;37537.812310939364;38020.61979380281;26063.951011186426;29967.550486743152;34008;34031.80888668984;34069.318613627096;25127.49745005053;25140.24579262625;25331.873340633178;25543.744562554137;25574.744252557237 03:23:28 INFO - PROCESS | 1636 | |2;jquery.html;369.7023895763909;372.15149459232947;379.2661200576884;383.0939827308416;393.16060211448564;18846.34037808677;20232.190712371506;20330;20641.896790516028;20838.270660526883;19559.902200488978;19721.90139049306;20259;20373.18507259708;20489.07799149038;5438.53772429344;5452.318460192476;5560.36055853577;5757.337906140785;5813.651180929158;5764.193012978166;5840.299164100314;5852.824415267528;5857.26784151981;5857.3849745776715;5562.610617256793;5610.915836262459;5702.344230413493;5746.138079288119;5803.82588522345;5675.631083979528;5676.829695109174;5682.687452190128;5696.401877802812;5731.570132240057;4803.903921921542;4973.676711013773;4977.178765503688;5018.569707633307;5034.471380505068;24703.382415439577;24974.87613057417;24988.625170622454;24994.875025624755;25116;2040.1227472187102;2248.8088512476297;2274.55646149001;2328.6041372966465;2356.988215058931;9973.152282056033;10098.040686134806;10098.343607665553;10360.222983276284;10421.166306695523;1789.6241789224277;1816.8637352198505;1840.9815901841077;1882.1436246507806;1907.1322548240655;112129.87870121357;114723;116496;124258.75741242562;129391;8955.880514935632;11070.501827417786;11373.886261137448;11603.709907252387;11645.53417863293;14273.214973176367;14531.636709082146;14608.123512589065;14620.488282910048;14647.267636618126;8194.385421093322;8230.670773169126;8307.626156822958;8333.208345207195;8424.283935865398;8191.221833925768;8227.753167404988;8290.502569845828;8310.875336869953;8368.874466883002;4422.756748378806;4486.080353527519;4553.385292985471;4555.40779698637;4567.337736028324;1464.5500954055408;1723.6983527882571;1825.3337531800796;1875.5311172206948;1964.9115789789494;376.9114258149333;684.4011489946297;714.8141483214298;913.1325241021057;971.965981190669;10385.740356491147;11035.72410689723;11478.94260528692;11626.721060683318;11869.643910682693;422.61753113432394;425.35133920770454;427.77755567105555;437.1039369292937;452.4344569288389;6121.938780612226;6123.4488895999575;6163.840991635065;6283.937160628427;6301.275353334425;564742;567487;579091;609285;618074;135594;136210;136546;138272;139548.30225848805;952.5046975572664;994.4629899854142;1012.3318609717551;1015.7359086637528;1017.97455063624;15849.841501585297;18728.157232924823;19352.32266870653;19407.417777466697;19516.804831952068;53722;55677;56787.432125679865;57724;57867.42132578621;76268;78148.60925695335;80116.59941700254;80579.58261252171;81562;8029.8394032120195;8057.274845263954;8218.424710270463;8254;8314.958425207835;11218.775624487627;12805.423755930819;12900.41948112356;12937.805932911202;13022;10958.232923695583;11230.382328971986;11302.943485282522;11401;11430.885691142983;10547.525361358605;10610.469476525988;10958.890411096107;11015.228933974546;11086.833697494705;11218.158638102012;11256.718582035188;11343.602973896204;11478.253913495597;11607.36159511235;7963;8060.193980601893;8289.502629842229;8310.855287578794;8380.622871970654;8077.555734434663;10617.734556636145;11055.170862185207;11134.331940083297;11242.718932026764 03:23:28 INFO - PROCESS | 1636 | |3;mootools.html;1441.3369849869057;1478.667299857532;1641.7537369394597;1763.955901102473;1780.652772709322;6564.409203171714;7517.736879209228;8112.91887081129;8523.53120578367;8574.099719529446;7164.2835716428335;7164.570125792443;7171.569705817642;8305;8404.86534317867;2295.999999999996;2310.191432998454;2338.4449341188088;2343.039353864916;2343.929682109531;2102.8317734581196;2182.7380714314304;2365.3613524348416;2372.5017746273215;2376.1802178248477;1923.7691477022777;1936.738540297056;2214.3689048621145;2266.6826644269813;2323.4075310795724;1929.9421017369502;2307.7230732312064;2320.4198950262435;2325.5232677301196;2325.5581439526436;2329.0683726509533;2363.314638754759;2364.5270945810908;2370.194133994433;2370.5140446208484;8409.789755256168;8411.83176336476;8460.111688272704;8492.278156356655;8502.979642442884;5021.17150670139;5158.432572417031;5162.612804039674;5183.196604526304;5188.948110518922;3252.317013427183;3352.2457447074457;3579.427291633326;3586.6234045425376;3599.1362073102528;1048.0829274384914;1052.8210204265292;1079.3955384984356;1087.34215799441;1098.5770478365807;10987.725306867313;11029.61396351124;11097.445127743662;11144.554217831277;11154.219204655596;4508.211063064016;4631.444226692818;4712.986707857827;4729.4797572267025;4759.428868535729;9333.020032896584;9475.620975161055;9480;9487.573059212353;9488.715338539716;5216.21756736485;5222.529972302511;5229.08491014071;5236.214567814858;5250.159974404077;4083.387491876183;4753.168195565762;4754.405699287589;4770.069836381872;4805.543473370024;3823.9044023899623;3862.6909847212155;3912.8434862605745;3927.7250592458254;3934.626210509997;1206.390772659801;1255.1088727003746;1271.3007845684836;1280.6286177008562;1280.9487620495263;741.6180666956521;856.5674334461057;904.5748498205833;916.225789208118;921.8064206516707;5586.692731899703;5667.489925906688;5702.600817942704;5764.365919748824;5878.265216847894;443.7359770936288;447.8735979012786;451.84863070870966;451.8666993237003;454.3253268895687;3445.7243420526297;3813.4089216171537;3821.3503704370323;3840.5007349044445;3910.8631197907935;9891;10287.125594324416;10290.228232882564;10301.587936482456;10318.742031449274;9636.71089867305;10081.19350451962;10105.090541851268;10109.241806864515;10284.742881427874;7799.064112306446;7995.560244186509;8009.0789559200275;8012.759617211376;8025;5755.453231942959;5777.653340799566;5798.188253644409;5837.620554663933;6085.995810691186;9356.4386136832;9384.859227111736;9395.671151509665;9494.28792840526;9528.380655257386;7732.420068494998;9258.490783006999;9627.614895404105;9705.563249653642;9716.9028309716;6619.470442364695;6798.252192258748;6976.895346569704;7107.040549525748;7270.491065625567;7833.686652534063;8041.638126284214;8044.477108987897;8049.87925181111;8052.557109358807;7012.228654848064;7137.286271372821;7148.320909513588;7170;7248.238934911758;6921.367971650626;7008.913618389158;7030.2969703029285;7110.288971102848;7127.893081603676;6571;6743.2582415935185;6753.898691519533;6767.560108592926;6807.863842723217;4852.927206091982;4881.707097574157;4893.755312234445;4897.094037603055;5014.297998280171;4129.690273229459;4220.894477638084;4877.829275975324;4879.975600121977;4982.302477653204 03:23:28 INFO - PROCESS | 1636 | |4;prototype.html;262.632314759337;283.6355283460752;291.1745202351334;291.62817407805045;310.6101842188054;5162.948370516294;5247.711375874325;5250.8424747257595;5396.136618141093;5403.2165336026255;5145.3568303962;5348.839534813952;5358.758855851486;5371.462853714626;5396.703181325035;3892.5718171001167;4082.3060079786505;4112.115895082557;4129.958700412987;4159.688023398242;3777.773333599993;3805;4006.399040143973;4160.916781664365;4173.520045194796;3997.240524300388;4016.2529299754556;4053.9797301013455;4061.451704019964;4073.6005114476443;3705.907352316187;3711.719456787404;3916.902077448058;4009.218202450523;4030.9395359069636;2984.567237750514;3513.051476101464;3517.1734642359024;3524.1189702574356;3533.434650455915;4544.750038747868;4989.401271847365;5247.947520524822;5283.969625922947;5346.957343318055;4479.2609219478745;4657.394538709946;4678.8596342109795;4679.227927391977;4681.859544213679;4956.942868709481;5743.712814359307;5749.700119952011;5751.338596061465;5765.913511297334;3252.8940160345596;3545.3909917107912;3768.9623103768886;3784.3566593678866;3906.3554513505237;5253.868653283698;6029.758809647609;6029.8191054268445;6033.336333003366;6039.584166333458;3954.525456945185;3969.4045893115685;3972.741771784825;3975.8012099394914;3975.980120099381;3721;3945.4870866787132;3948.486696729407;4009.51885773709;4016.2770701274053;4600.263957766741;4615.976920115378;4624.676272660949;4632.513586073481;4650.255959046604;5686.715664216773;5702.942970570324;5761.415610707089;5763.366029736726;5772.7690892363835;1169.6900321414832;1221.9511219551118;1227.9079069069855;1259.1878238536092;1293.5925183567147;741.6328917186028;753.8906858505486;780.7228433905996;781.8116462976244;880.6350157256227;4448.998975230547;4631.513691062457;4881;4933.506649335038;5116.002379535955;4882.926756098661;5533.3083364579425;5561.9710353583905;5571.470710282517;5594.244776955059;4396.802143903532;4539.024109816405;4543.409356783597;4749.548792864673;4925.064237794808;2843.9853755019744;2905.5617469352806;2913.4113770810636;2929.3050393637905;2931.7654587633365;5170.304455729839;5305.683947532792;5803.82588522345;5813.593048486566;5814.941850581525;5137.691738495628;5211.5049070338255;5682.801101961411;5726.914096288559;5819.970900145472;4569.680122391467;4727.196376615983;5710.3433105193435;5799.652020878761;5831.970840145772;5144.768485418091;5565.831175453201;5576.247206627054;5597.216389705526;5633.690147041952;5282.656627319212;5457;5497.807576734955;5517.703339715244;5541.5289700375915;5106.642535022661;5686.658800471985;5786.0453025252045;5793.594448388572;5865.853353666193;3211.8246279835653;3366.848491817825;3762.2099359134886;3769.4534292526882;3786.659200671953;5198.232600915707;5461.644993075437;5488.945110549003;5504.311961004874;5514.704044549608;4724.299252269249;4879.512048795092;4959.7272150032095;5112.693238405707;5726.713664316851;4653.905742415859;5094.9490505095955;5158.922616160836;5274.709890955881;5627.324721033502;4454.955450445454;5326.8934621308135;5622.5501959842295;5628.324601047901;5634;4521.638268938543;4829.903401932012;5718.228039214653;5817.70911454434;5831.7667293307795;4860.708357498562;5657.547396208376;5658.519025882846;5675.432456754292;5701.914471283017 03:23:28 INFO - PROCESS | 1636 | |5;yui.html;678.674236366544;741.8850078237873;749.0449676662255;763.496092578898;775.7633921653896;14504.854951450483;15117.168555729431;15140.697186056272;15163.620909477255;15197.54407367778;13345.866541334608;13402.195868247913;13472;13481.191128532295;13485.460581576725;785.3952456608408;792.8969233999572;804.3203493048394;805.9884844520149;806.5281810141046;784.2001158818002;788.2590365056857;794.6026986506747;795.761271618515;796.5220867479524;836.9246767790897;840.970566030189;844.7254642241296;845.6659619450313;845.953472559009;809.8258874342044;827.8634025385804;834.7620928035481;835.7116794705817;838.2078935406043;610.2524407600698;619.3342157181004;627.0281064350239;628.8302158417248;630.4672551693811;12592.622221333375;12679.239245645198;12682;12698.492060317576;12733.045021623415;9639.469829159394;11115.221934464591;11500;11811.586594469152;11916.080560262704;10167.644132455402;10230.232732545015;10341.638042668546;10395.84406233907;10879.673609791718;3488;3521.5245941798044;3534;3540.185757275841;3569.6787289144104;60219.89230376916;90684.6397304041;92124;92394.07605923922;92528.07471925329;8086.838263234702;8497.320214382835;8641.827163456821;8835.337349698799;8988.966268879032;18457.90771046136;18578.907105464656;18812.52968675794;18818.717719234224;18975.525611859815;5998.370171131968;7514.361279291322;7619.161892191854;7627.237276272439;7660.616969151632;4009.799510024487;4106.1992911382595;4145.419641250227;4188.308929026676;4244.193603215379;3183.395154920604;3347.7154441872226;3385.2213990781765;3394.932101357959;3405.7275417966503;643.1028714942722;670.3665036540423;678.7726111752618;688.879446096931;689.7689274093135;573.3984772203021;574.319431473705;595.5057302438966;627.05314974389;640.4876099120778;8529.57352132391;8698.260647844878;9066.274698024143;9079.68221112258;9101.135392137736;537.3068741323726;579.4524174654911;623.82844717703;633.762339122829;682.4267615203253;4221.514525829508;4285.849995250152;4571.748553829571;4594.609458196024;4737.45519265282;96075;108098;111231;111588.44205778919;115355;92719.53640231755;95471.52264238773;97937.51031244798;99158;101261.98738012525;65424.018639720445;79380.99999999885;84532.73200901992;87137.5643121793;90579;7332.71495965607;9777.266704997295;9811.460369679737;9827.705168844946;9840.753981150528;40250.59749402585;45373.54626453825;50743;50973;51472.22791658203;72159.63920180366;72863;73408.63295683487;73640;78212.04469888298;12462.626121216015;12666.683332916382;12670.746585068431;12692.492300307884;13077.542286019943;14040.719185616026;14169.574912752634;14196.645083872985;14427.49503767363;14440.061396009225;13167.209967401986;13240.80138797938;13354.399052042487;13404.865951340362;13432.529861454803;10668.146548276274;13058.34708264602;13067.085304028627;13250.536231231861;13434.261115638734;12546.623601291976;12757;12771.744565108831;12887.613371598867;12972.481100755864;10779.67660970172;11032.558697652004;11056;11464.82802757976;11591.88408115908;11356.94321528387;11587.740390623747;11787.11596630239;11813.468393922467;11818.881811181778 03:23:28 INFO - PROCESS | 1636 | __end_tp_report 03:23:28 INFO - PROCESS | 1636 | __start_cc_report 03:23:28 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,366 03:23:28 INFO - PROCESS | 1636 | __end_cc_report 03:23:28 INFO - PROCESS | 1636 | __startTimestamp1483615408138__endTimestamp 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | ------- Summary: start ------- 03:23:28 INFO - PROCESS | 1636 | Number of tests: 6 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5669.44 Median:5862.82 stddev:679.15 (11.6%) stddev-sans-first:657.29 03:23:28 INFO - PROCESS | 1636 | Values: 3391.2 3397.6 3430.0 3436.3 3437.1 4836.2 5343.8 5724.2 5746.0 5795.3 5708.9 5835.5 5849.4 5850.9 5862.8 5245.9 5263.4 5264.0 5274.8 5312.2 5315.9 5331.0 5338.2 5373.4 5395.5 5142.4 5177.5 5329.5 5330.7 5342.3 4456.6 4587.7 5226.7 5254.8 5294.7 5055.9 5184.5 5200.7 5209.1 5251.4 4755.8 5775.0 5839.4 5903.9 5973.6 4567.4 5347.6 6272.1 6293.1 6378.0 5120.7 5132.6 5236.8 6308.5 6339.8 4806.5 5937.5 5956.9 5957.6 5992.5 5700.5 6206.2 6323.4 6360.7 6370.7 5112.4 5595.0 6095.5 6117.1 6128.5 5842.9 6209.6 6224.5 6248.4 6296.7 6210.6 6243.4 6274.9 6320.5 6366.9 6197.0 6259.1 6319.7 6324.3 6328.9 4868.8 4910.1 4913.4 4934.0 5020.9 4434.0 4436.2 4457.9 4473.5 4479.0 5607.8 5793.8 5820.2 5849.6 5867.1 6174.8 6212.6 6219.8 6246.4 6295.6 5846.1 5848.3 5857.3 5868.8 5901.2 5331.7 5380.4 5450.1 5474.2 5506.0 6370.9 6386.0 6402.8 6415.7 6421.0 6165.0 6219.8 6239.7 6250.8 6288.7 6333.5 6340.5 6348.2 6348.3 6354.9 6238.8 6242.6 6251.0 6261.3 6265.6 5122.7 6015.8 6172.8 6203.0 6265.3 6022.3 6022.9 6027.1 6132.0 6136.5 4343.0 4980.8 5078.8 5298.7 6169.4 5922.3 5970.6 6112.5 6120.0 6121.4 4753.3 6018.4 6098.5 6201.0 6231.9 5147.8 5800.5 5946.8 5999.8 6020.3 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:67689.09 Median:39500.91 stddev:147794.45 (374.2%) stddev-sans-first:148122.89 03:23:28 INFO - PROCESS | 1636 | Values: 472.9 495.6 527.5 539.5 539.7 38101.8 39956.0 40106.8 40163.2 40210.8 32626.8 40323.4 41009.0 41119.4 41277.8 9157.9 9402.4 9430.7 9438.6 9443.2 9171.7 9188.1 9280.2 9300.0 9304.0 9173.0 9177.1 9215.9 9220.4 9262.4 9219.7 9268.5 9297.6 9301.5 9329.0 9374.8 9383.9 9469.0 9469.4 9472.2 39106.8 39476.4 39525.4 39569.0 39623.6 3153.8 3296.1 3552.1 3725.0 3960.9 28273.4 28293.3 28392.4 29345.8 29536.7 3043.2 3230.6 3277.8 3300.5 3307.6 424430.0 496615.0 497936.0 499946.0 502546.0 59196.4 59205.4 59459.0 59731.7 59733.4 57990.7 60918.0 61482.0 61531.7 61837.7 15870.8 15924.8 15973.5 16158.5 16171.0 12441.5 12509.8 12539.5 12545.9 12550.6 13637.7 14478.9 16621.0 16743.2 16839.6 3120.7 3235.3 6020.9 6120.0 6151.4 857.5 960.5 974.2 1018.0 1062.0 29974.3 30089.9 30517.0 30623.2 31379.8 999.2 1006.7 1019.4 1083.8 1101.9 14944.7 15660.8 15739.8 15949.9 16221.5 649164.8 652354.0 652585.0 652952.0 654586.0 57619.0 57897.7 58049.0 58126.0 58859.7 1069.4 1247.3 1323.8 1348.0 1378.7 29904.9 30359.6 31068.1 31279.4 31475.0 40201.0 45226.3 51302.5 51457.5 51490.0 447095.0 483490.0 491726.0 493380.0 599434.0 20387.7 25237.0 26155.2 26427.2 26449.9 42689.8 44986.0 45420.8 45672.9 45712.5 37462.8 37566.8 37930.1 37980.6 39240.2 37713.4 37976.6 38476.0 38776.0 39201.0 36195.0 36708.6 37193.7 37537.8 38020.6 26064.0 29967.6 34008.0 34031.8 34069.3 25127.5 25140.2 25331.9 25543.7 25574.7 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:34642.48 Median:370.93 stddev:98707.23 (26611.0%) stddev-sans-first:98950.58 03:23:28 INFO - PROCESS | 1636 | Values: 369.7 372.2 379.3 383.1 393.2 18846.3 20232.2 20330.0 20641.9 20838.3 19559.9 19721.9 20259.0 20373.2 20489.1 5438.5 5452.3 5560.4 5757.3 5813.7 5764.2 5840.3 5852.8 5857.3 5857.4 5562.6 5610.9 5702.3 5746.1 5803.8 5675.6 5676.8 5682.7 5696.4 5731.6 4803.9 4973.7 4977.2 5018.6 5034.5 24703.4 24974.9 24988.6 24994.9 25116.0 2040.1 2248.8 2274.6 2328.6 2357.0 9973.2 10098.0 10098.3 10360.2 10421.2 1789.6 1816.9 1841.0 1882.1 1907.1 112129.9 114723.0 116496.0 124258.8 129391.0 8955.9 11070.5 11373.9 11603.7 11645.5 14273.2 14531.6 14608.1 14620.5 14647.3 8194.4 8230.7 8307.6 8333.2 8424.3 8191.2 8227.8 8290.5 8310.9 8368.9 4422.8 4486.1 4553.4 4555.4 4567.3 1464.6 1723.7 1825.3 1875.5 1964.9 376.9 684.4 714.8 913.1 972.0 10385.7 11035.7 11478.9 11626.7 11869.6 422.6 425.4 427.8 437.1 452.4 6121.9 6123.4 6163.8 6283.9 6301.3 564742.0 567487.0 579091.0 609285.0 618074.0 135594.0 136210.0 136546.0 138272.0 139548.3 952.5 994.5 1012.3 1015.7 1018.0 15849.8 18728.2 19352.3 19407.4 19516.8 53722.0 55677.0 56787.4 57724.0 57867.4 76268.0 78148.6 80116.6 80579.6 81562.0 8029.8 8057.3 8218.4 8254.0 8315.0 11218.8 12805.4 12900.4 12937.8 13022.0 10958.2 11230.4 11302.9 11401.0 11430.9 10547.5 10610.5 10958.9 11015.2 11086.8 11218.2 11256.7 11343.6 11478.3 11607.4 7963.0 8060.2 8289.5 8310.9 8380.6 8077.6 10617.7 11055.2 11134.3 11242.7 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5437.47 Median:4939.70 stddev:3014.04 (61.0%) stddev-sans-first:3007.54 03:23:28 INFO - PROCESS | 1636 | Values: 1441.3 1478.7 1641.8 1764.0 1780.7 6564.4 7517.7 8112.9 8523.5 8574.1 7164.3 7164.6 7171.6 8305.0 8404.9 2296.0 2310.2 2338.4 2343.0 2343.9 2102.8 2182.7 2365.4 2372.5 2376.2 1923.8 1936.7 2214.4 2266.7 2323.4 1929.9 2307.7 2320.4 2325.5 2325.6 2329.1 2363.3 2364.5 2370.2 2370.5 8409.8 8411.8 8460.1 8492.3 8503.0 5021.2 5158.4 5162.6 5183.2 5188.9 3252.3 3352.2 3579.4 3586.6 3599.1 1048.1 1052.8 1079.4 1087.3 1098.6 10987.7 11029.6 11097.4 11144.6 11154.2 4508.2 4631.4 4713.0 4729.5 4759.4 9333.0 9475.6 9480.0 9487.6 9488.7 5216.2 5222.5 5229.1 5236.2 5250.2 4083.4 4753.2 4754.4 4770.1 4805.5 3823.9 3862.7 3912.8 3927.7 3934.6 1206.4 1255.1 1271.3 1280.6 1280.9 741.6 856.6 904.6 916.2 921.8 5586.7 5667.5 5702.6 5764.4 5878.3 443.7 447.9 451.8 451.9 454.3 3445.7 3813.4 3821.4 3840.5 3910.9 9891.0 10287.1 10290.2 10301.6 10318.7 9636.7 10081.2 10105.1 10109.2 10284.7 7799.1 7995.6 8009.1 8012.8 8025.0 5755.5 5777.7 5798.2 5837.6 6086.0 9356.4 9384.9 9395.7 9494.3 9528.4 7732.4 9258.5 9627.6 9705.6 9716.9 6619.5 6798.3 6976.9 7107.0 7270.5 7833.7 8041.6 8044.5 8049.9 8052.6 7012.2 7137.3 7148.3 7170.0 7248.2 6921.4 7008.9 7030.3 7110.3 7127.9 6571.0 6743.3 6753.9 6767.6 6807.9 4852.9 4881.7 4893.8 4897.1 5014.3 4129.7 4220.9 4877.8 4880.0 4982.3 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4490.63 Median:4958.34 stddev:1385.91 (28.0%) stddev-sans-first:1352.98 03:23:28 INFO - PROCESS | 1636 | Values: 262.6 283.6 291.2 291.6 310.6 5162.9 5247.7 5250.8 5396.1 5403.2 5145.4 5348.8 5358.8 5371.5 5396.7 3892.6 4082.3 4112.1 4130.0 4159.7 3777.8 3805.0 4006.4 4160.9 4173.5 3997.2 4016.3 4054.0 4061.5 4073.6 3705.9 3711.7 3916.9 4009.2 4030.9 2984.6 3513.1 3517.2 3524.1 3533.4 4544.8 4989.4 5247.9 5284.0 5347.0 4479.3 4657.4 4678.9 4679.2 4681.9 4956.9 5743.7 5749.7 5751.3 5765.9 3252.9 3545.4 3769.0 3784.4 3906.4 5253.9 6029.8 6029.8 6033.3 6039.6 3954.5 3969.4 3972.7 3975.8 3976.0 3721.0 3945.5 3948.5 4009.5 4016.3 4600.3 4616.0 4624.7 4632.5 4650.3 5686.7 5702.9 5761.4 5763.4 5772.8 1169.7 1222.0 1227.9 1259.2 1293.6 741.6 753.9 780.7 781.8 880.6 4449.0 4631.5 4881.0 4933.5 5116.0 4882.9 5533.3 5562.0 5571.5 5594.2 4396.8 4539.0 4543.4 4749.5 4925.1 2844.0 2905.6 2913.4 2929.3 2931.8 5170.3 5305.7 5803.8 5813.6 5814.9 5137.7 5211.5 5682.8 5726.9 5820.0 4569.7 4727.2 5710.3 5799.7 5832.0 5144.8 5565.8 5576.2 5597.2 5633.7 5282.7 5457.0 5497.8 5517.7 5541.5 5106.6 5686.7 5786.0 5793.6 5865.9 3211.8 3366.8 3762.2 3769.5 3786.7 5198.2 5461.6 5488.9 5504.3 5514.7 4724.3 4879.5 4959.7 5112.7 5726.7 4653.9 5094.9 5158.9 5274.7 5627.3 4455.0 5326.9 5622.6 5628.3 5634.0 4521.6 4829.9 5718.2 5817.7 5831.8 4860.7 5657.5 5658.5 5675.4 5701.9 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20022.61 Median:27740.23 stddev:29652.63 (106.9%) stddev-sans-first:29700.24 03:23:28 INFO - PROCESS | 1636 | Values: 678.7 741.9 749.0 763.5 775.8 14504.9 15117.2 15140.7 15163.6 15197.5 13345.9 13402.2 13472.0 13481.2 13485.5 785.4 792.9 804.3 806.0 806.5 784.2 788.3 794.6 795.8 796.5 836.9 841.0 844.7 845.7 846.0 809.8 827.9 834.8 835.7 838.2 610.3 619.3 627.0 628.8 630.5 12592.6 12679.2 12682.0 12698.5 12733.0 9639.5 11115.2 11500.0 11811.6 11916.1 10167.6 10230.2 10341.6 10395.8 10879.7 3488.0 3521.5 3534.0 3540.2 3569.7 60219.9 90684.6 92124.0 92394.1 92528.1 8086.8 8497.3 8641.8 8835.3 8989.0 18457.9 18578.9 18812.5 18818.7 18975.5 5998.4 7514.4 7619.2 7627.2 7660.6 4009.8 4106.2 4145.4 4188.3 4244.2 3183.4 3347.7 3385.2 3394.9 3405.7 643.1 670.4 678.8 688.9 689.8 573.4 574.3 595.5 627.1 640.5 8529.6 8698.3 9066.3 9079.7 9101.1 537.3 579.5 623.8 633.8 682.4 4221.5 4285.8 4571.7 4594.6 4737.5 96075.0 108098.0 111231.0 111588.4 115355.0 92719.5 95471.5 97937.5 99158.0 101262.0 65424.0 79381.0 84532.7 87137.6 90579.0 7332.7 9777.3 9811.5 9827.7 9840.8 40250.6 45373.5 50743.0 50973.0 51472.2 72159.6 72863.0 73408.6 73640.0 78212.0 12462.6 12666.7 12670.7 12692.5 13077.5 14040.7 14169.6 14196.6 14427.5 14440.1 13167.2 13240.8 13354.4 13404.9 13432.5 10668.1 13058.3 13067.1 13250.5 13434.3 12546.6 12757.0 12771.7 12887.6 12972.5 10779.7 11032.6 11056.0 11464.8 11591.9 11356.9 11587.7 11787.1 11813.5 11818.9 03:23:28 INFO - PROCESS | 1636 | -------- Summary: end -------- 03:23:28 INFO - PROCESS | 1636 | 03:23:28 INFO - TEST-INFO | 1636: exit 0 03:23:28 INFO - TEST-OK | dromaeo_css | took 1117300ms 03:23:28 INFO - TEST-START | kraken 03:23:28 INFO - operating with platform_type : mac_ 03:23:28 INFO - Initialising browser for kraken test... 03:23:28 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpcel2fy/profile http://localhost:49238/getInfo.html) 03:23:31 INFO - PROCESS | 1647 | 2017-01-05 03:23:31.845 plugin-container[1648:10338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 03:23:31 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:31 INFO - PROCESS | 1647 | 2017-01-05 03:23:31.849 plugin-container[1648:10338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4327, name = 'com.apple.CFPasteboardClient' 03:23:31 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:31 INFO - PROCESS | 1647 | 2017-01-05 03:23:31.849 plugin-container[1648:10338] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:23:31 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 03:23:31 INFO - PROCESS | 1647 | colorDepth:24 03:23:31 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 03:23:31 INFO - PROCESS | 1647 | __metrics 03:23:32 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:23:32 INFO - TEST-INFO | 1647: exit 0 03:23:32 INFO - Browser initialized. 03:23:32 INFO - Running cycle 1/1 for kraken test... 03:23:32 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpcel2fy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:35 INFO - PROCESS | 1649 | 2017-01-05 03:23:35.624 plugin-container[1650:10463] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 03:23:35 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:35 INFO - PROCESS | 1649 | 2017-01-05 03:23:35.625 plugin-container[1650:10463] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 03:23:35 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:35 INFO - PROCESS | 1649 | 2017-01-05 03:23:35.625 plugin-container[1650:10463] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:23:45 INFO - PROCESS | 1649 | RSS: Main: 229957632 03:23:45 INFO - PROCESS | 1649 | 03:23:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:49 INFO - PROCESS | 1649 | RSS: Main: 241954816 03:23:49 INFO - PROCESS | 1649 | 03:23:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 03:23:52 INFO - PROCESS | 1649 | RSS: Main: 249495552 03:23:52 INFO - PROCESS | 1649 | 03:23:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 03:23:56 INFO - PROCESS | 1649 | RSS: Main: 251396096 03:23:56 INFO - PROCESS | 1649 | 03:23:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 03:23:59 INFO - PROCESS | 1649 | RSS: Main: 254042112 03:23:59 INFO - PROCESS | 1649 | 03:24:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:01 INFO - PROCESS | 1649 | RSS: Main: 254365696 03:24:01 INFO - PROCESS | 1649 | 03:24:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:05 INFO - PROCESS | 1649 | RSS: Main: 258850816 03:24:05 INFO - PROCESS | 1649 | 03:24:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:09 INFO - PROCESS | 1649 | RSS: Main: 257994752 03:24:09 INFO - PROCESS | 1649 | 03:24:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 03:24:12 INFO - PROCESS | 1649 | RSS: Main: 257974272 03:24:12 INFO - PROCESS | 1649 | 03:24:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:14 INFO - PROCESS | 1649 | RSS: Main: 257490944 03:24:14 INFO - PROCESS | 1649 | 03:24:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:17 INFO - PROCESS | 1649 | RSS: Main: 257429504 03:24:17 INFO - PROCESS | 1649 | 03:24:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:20 INFO - PROCESS | 1649 | RSS: Main: 257245184 03:24:20 INFO - PROCESS | 1649 | 03:24:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:24 INFO - PROCESS | 1649 | RSS: Main: 257560576 03:24:24 INFO - PROCESS | 1649 | 03:24:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:28 INFO - PROCESS | 1649 | RSS: Main: 257695744 03:24:28 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 03:24:30 INFO - PROCESS | 1649 | RSS: Main: 259477504 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | __start_tp_report 03:24:30 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 03:24:30 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 03:24:30 INFO - PROCESS | 1649 | |i|pagename|runs| 03:24:30 INFO - PROCESS | 1649 | |0;ai-astar;123;96;178;168;176;120;122;114;177;175 03:24:30 INFO - PROCESS | 1649 | |1;audio-beat-detection;154;146;113;179;144;114;114;114;141;129 03:24:30 INFO - PROCESS | 1649 | |2;audio-dft;201;205;280;164;207;289;262;198;193;197 03:24:30 INFO - PROCESS | 1649 | |3;audio-fft;83;59;60;85;62;60;68;67;72;75 03:24:30 INFO - PROCESS | 1649 | |4;audio-oscillator;89;69;89;73;71;70;87;69;73;88 03:24:30 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;90;75;136;121;138;131;92;99;90;85 03:24:30 INFO - PROCESS | 1649 | |6;imaging-darkroom;96;96;95;95;106;95;103;152;152;97 03:24:30 INFO - PROCESS | 1649 | |7;imaging-desaturate;97;92;88;86;93;89;91;91;89;87 03:24:30 INFO - PROCESS | 1649 | |8;json-parse-financial;58;57;55;67;82;95;92;94;53;59 03:24:30 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;79;88;66;106;113;107;109;113;77;77 03:24:30 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;85;88;88;86;84;90;78;79;75;75 03:24:30 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;142;144;141;151;174;161;144;154;271;202 03:24:30 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;199;159;156;236;203;240;236;168;170;171 03:24:30 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;69;68;84;79;68;67;71;82;84;90 03:24:30 INFO - PROCESS | 1649 | __end_tp_report 03:24:30 INFO - PROCESS | 1649 | __start_cc_report 03:24:30 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1011 03:24:30 INFO - PROCESS | 1649 | __end_cc_report 03:24:30 INFO - PROCESS | 1649 | __startTimestamp1483615470265__endTimestamp 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | ------- Summary: start ------- 03:24:30 INFO - PROCESS | 1649 | Number of tests: 14 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:144.90 Median:175.50 stddev:32.49 (18.5%) stddev-sans-first:33.49 03:24:30 INFO - PROCESS | 1649 | Values: 123.0 96.0 178.0 168.0 176.0 120.0 122.0 114.0 177.0 175.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:142.50 stddev:22.05 (15.5%) stddev-sans-first:22.27 03:24:30 INFO - PROCESS | 1649 | Values: 154.0 146.0 113.0 179.0 144.0 114.0 114.0 114.0 141.0 129.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:219.60 Median:206.00 stddev:41.84 (20.3%) stddev-sans-first:43.83 03:24:30 INFO - PROCESS | 1649 | Values: 201.0 205.0 280.0 164.0 207.0 289.0 262.0 198.0 193.0 197.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:69.10 Median:70.00 stddev:9.50 (13.6%) stddev-sans-first:8.65 03:24:30 INFO - PROCESS | 1649 | Values: 83.0 59.0 60.0 85.0 62.0 60.0 68.0 67.0 72.0 75.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:9.11 (11.4%) stddev-sans-first:8.72 03:24:30 INFO - PROCESS | 1649 | Values: 89.0 69.0 89.0 73.0 71.0 70.0 87.0 69.0 73.0 88.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:105.70 Median:87.50 stddev:23.41 (26.8%) stddev-sans-first:24.13 03:24:30 INFO - PROCESS | 1649 | Values: 90.0 75.0 136.0 121.0 138.0 131.0 92.0 99.0 90.0 85.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:108.70 Median:95.00 stddev:23.12 (24.3%) stddev-sans-first:24.06 03:24:30 INFO - PROCESS | 1649 | Values: 96.0 96.0 95.0 95.0 106.0 95.0 103.0 152.0 152.0 97.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:91.00 stddev:3.23 (3.6%) stddev-sans-first:2.35 03:24:30 INFO - PROCESS | 1649 | Values: 97.0 92.0 88.0 86.0 93.0 89.0 91.0 91.0 89.0 87.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:74.50 stddev:17.55 (23.6%) stddev-sans-first:17.95 03:24:30 INFO - PROCESS | 1649 | Values: 58.0 57.0 55.0 67.0 82.0 95.0 92.0 94.0 53.0 59.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:93.50 Median:71.50 stddev:17.89 (25.0%) stddev-sans-first:18.19 03:24:30 INFO - PROCESS | 1649 | Values: 79.0 88.0 66.0 106.0 113.0 107.0 109.0 113.0 77.0 77.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:85.50 stddev:5.59 (6.5%) stddev-sans-first:5.88 03:24:30 INFO - PROCESS | 1649 | Values: 85.0 88.0 88.0 86.0 84.0 90.0 78.0 79.0 75.0 75.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:168.40 Median:157.50 stddev:40.68 (25.8%) stddev-sans-first:42.01 03:24:30 INFO - PROCESS | 1649 | Values: 142.0 144.0 141.0 151.0 174.0 161.0 144.0 154.0 271.0 202.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.80 Median:201.00 stddev:33.66 (16.7%) stddev-sans-first:35.65 03:24:30 INFO - PROCESS | 1649 | Values: 199.0 159.0 156.0 236.0 203.0 240.0 236.0 168.0 170.0 171.0 03:24:30 INFO - PROCESS | 1649 | 03:24:30 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:80.50 stddev:8.51 (10.6%) stddev-sans-first:8.62 03:24:30 INFO - PROCESS | 1649 | Values: 69.0 68.0 84.0 79.0 68.0 67.0 71.0 82.0 84.0 90.0 03:24:30 INFO - PROCESS | 1649 | -------- Summary: end -------- 03:24:30 INFO - PROCESS | 1649 | 03:24:31 INFO - TEST-INFO | 1649: exit 0 03:24:31 INFO - TEST-OK | kraken | took 62735ms 03:24:31 INFO - SUITE-END | took 1180s 03:24:31 INFO - Completed test suite (00:19:40) 03:24:31 INFO - javascript benchmark 03:24:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7020.16153976744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.1691635549296, 3397.5922889253293, 3429.9657003429975, 3436.3470940521297, 3437.0548099272683, 4836.202026665596, 5343.759530821118, 5724.198612194296, 5746.0, 5795.304563452381, 5708.942910570893, 5835.533157347412, 5849.415058494148, 5850.946829570676, 5862.824115276538, 5245.8950820983555, 5263.3683957925105, 5264.0, 5274.81538146165, 5312.150055991042, 5315.867103322409, 5330.973345133269, 5338.225957236198, 5373.408925018245, 5395.487428694288, 5142.357205349332, 5177.508136727024, 5329.546988505982, 5330.733463326837, 5342.332208473941, 4456.576625220631, 4587.669575823007, 5226.738663066832, 5254.763535640867, 5294.682319060868, 5055.9241611375855, 5184.481551844823, 5200.6879587224885, 5209.114450543417, 5251.396089449724, 4755.762211889391, 5774.989376859033, 5839.416058394169, 5903.881922361528, 5973.581849270553, 4567.383403240553, 5347.6256662033675, 6272.090546870678, 6293.087502312139, 6378.043293505965, 5120.6927584344685, 5132.5893928486, 5236.764345604457, 6308.463780578611, 6339.778107766252, 4806.4712881583, 5937.465628093492, 5956.851078723066, 5957.642541447527, 5992.520598352208, 5700.458456446631, 6206.193194884636, 6323.430891219812, 6360.6501642409185, 6370.74517019314, 5112.36095488064, 5595.0, 6095.451409373178, 6117.1130186123655, 6128.509719222451, 5842.941570584325, 6209.627422354673, 6224.502039836802, 6248.4064013918605, 6296.685165741695, 6210.627362358273, 6243.43809057187, 6274.874502509924, 6320.5259605528845, 6366.872662546723, 6197.03945888388, 6259.123722678829, 6319.715612797435, 6324.335944725737, 6328.936710632926, 4868.805247790048, 4910.091633047826, 4913.361263035782, 4934.037862616827, 5020.899582008339, 4434.046679963823, 4436.157130145262, 4457.9331310030375, 4473.485549161823, 4479.037007043501, 5607.831765047055, 5793.797217097382, 5820.1560773688425, 5849.61977471463, 5867.119932010147, 6174.845628859314, 6212.596181248205, 6219.813405597839, 6246.3753624637175, 6295.622262664163, 5846.093855452412, 5848.3274423441, 5857.297124345106, 5868.765249390062, 5901.203337549376, 5331.70675612845, 5380.408155102936, 5450.127979523258, 5474.206240095244, 5505.953868764922, 6370.872582548323, 6386.0, 6402.775902843378, 6415.711292991827, 6420.967895160495, 6165.0444181152, 6219.782307619212, 6239.688015599111, 6250.781222657367, 6288.717007734755, 6333.524985626004, 6340.4927605792345, 6348.174737284308, 6348.333424990495, 6354.872902542016, 6238.812835614939, 6242.5942313749465, 6250.9998400255745, 6261.311255761953, 6265.561410701207, 5122.692638441706, 6015.849603759941, 6172.753089876354, 6203.0, 6265.27949285838, 6022.307434645072, 6022.879542409215, 6027.126066720389, 6132.0495871890025, 6136.478399335928, 4342.956570434255, 4980.775865086008, 5078.771455284595, 5298.7350632469, 6169.352218017044, 5922.289325280994, 5970.58205925581, 6112.480439162721, 6119.969400152971, 6121.4490695837585, 4753.263244197155, 6018.428249316308, 6098.481629061402, 6201.0, 6231.906521402092, 5147.768350424315, 5800.535957123504, 5946.821595352147, 5999.820005399845, 6020.337762846171], "value": 5630.927384342564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.90305487375093, 495.6332314087574, 527.4751622135975, 539.4955716405161, 539.749016707231, 38101.809490952575, 39956.00109997251, 40106.79946600267, 40163.19673606526, 40210.7989460053, 32626.836865815636, 40323.395149072785, 41009.0, 41119.38320925181, 41277.793611031906, 9157.862632060524, 9402.43585384879, 9430.717078487656, 9438.622455101788, 9443.197328227108, 9171.724848254564, 9188.12712792287, 9280.164785169334, 9299.95350023249, 9304.0, 9173.036831132735, 9177.128172823572, 9215.907840921573, 9220.446773193597, 9262.444253344787, 9219.723408297728, 9268.536573171314, 9297.581608827619, 9301.53492325381, 9328.953355233214, 9374.812503749887, 9383.906160938439, 9468.952655236748, 9469.384490008128, 9472.194863436616, 39106.80446597777, 39476.407853882214, 39525.40711889324, 39569.0, 39623.60376396228, 3153.7634677399055, 3296.0935742670717, 3552.0764601203614, 3724.981375093107, 3960.940585891214, 28273.43453130926, 28293.29266768327, 28392.432151356858, 29345.826166953295, 29536.704632953824, 3043.239190202449, 3230.596175478065, 3277.8361081946045, 3300.5214243934734, 3307.6361600223954, 424430.0, 496615.0, 497936.0, 499946.0, 502546.0, 59196.40803591909, 59205.40794591999, 59459.0, 59731.70134149301, 59733.402665973656, 57990.710046449494, 60918.0, 61482.0, 61531.69234153801, 61837.69081154565, 15870.761938570931, 15924.76112858308, 15973.520794376187, 16158.515244542683, 16171.0, 12441.502339906483, 12509.812352814715, 12539.498420063277, 12545.93359564429, 12550.560730374393, 13637.659058523417, 14478.927605361905, 16621.0, 16743.16284185786, 16839.579010524834, 3120.672329405425, 3235.3044095519576, 6020.886136064842, 6119.969400152971, 6151.415615516519, 857.4897935728231, 960.544774666381, 974.2400927276735, 1018.0481250031245, 1062.0414136819468, 29974.25064373408, 30089.946851860517, 30517.0, 30623.2344191397, 31379.84310078435, 999.2455695949657, 1006.7281833904805, 1019.4138370437029, 1083.772407794372, 1101.895319944604, 14944.70110597782, 15660.843391566166, 15739.763903541456, 15949.920250398905, 16221.513354599381, 649164.7541762355, 652354.0, 652585.0, 652952.0, 654586.0, 57619.0, 57897.71051144717, 58049.0, 58126.0, 58859.70570147122, 1069.44512704575, 1247.3451437994943, 1323.7887333090114, 1347.9932600336936, 1378.710470801123, 29904.85047574748, 30359.636175051077, 31068.067957960393, 31279.374412511166, 31475.0, 40201.0, 45226.346706661665, 51302.486975129774, 51457.48542514677, 51489.97020059503, 447095.0, 483490.0, 491726.0, 493380.0, 599434.0, 20387.694184586948, 25237.0, 26155.215343539723, 26427.207183784518, 26449.94200231969, 42689.786551067045, 44986.0, 45420.772896135306, 45672.8581785458, 45712.54287457083, 37462.8126859364, 37566.812165938994, 37930.0517487054, 37980.62019379771, 39240.21519569535, 37713.43429848499, 37976.620233798414, 38476.0, 38776.030599235244, 39201.01997449972, 36195.0, 36708.632913670524, 37193.69822056215, 37537.812310939364, 38020.61979380281, 26063.951011186426, 29967.550486743152, 34008.0, 34031.80888668984, 34069.318613627096, 25127.49745005053, 25140.24579262625, 25331.873340633178, 25543.744562554137, 25574.744252557237], "value": 19234.817490826987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.7023895763909, 372.15149459232947, 379.2661200576884, 383.0939827308416, 393.16060211448564, 18846.34037808677, 20232.190712371506, 20330.0, 20641.896790516028, 20838.270660526883, 19559.902200488978, 19721.90139049306, 20259.0, 20373.18507259708, 20489.07799149038, 5438.53772429344, 5452.318460192476, 5560.36055853577, 5757.337906140785, 5813.651180929158, 5764.193012978166, 5840.299164100314, 5852.824415267528, 5857.26784151981, 5857.3849745776715, 5562.610617256793, 5610.915836262459, 5702.344230413493, 5746.138079288119, 5803.82588522345, 5675.631083979528, 5676.829695109174, 5682.687452190128, 5696.401877802812, 5731.570132240057, 4803.903921921542, 4973.676711013773, 4977.178765503688, 5018.569707633307, 5034.471380505068, 24703.382415439577, 24974.87613057417, 24988.625170622454, 24994.875025624755, 25116.0, 2040.1227472187102, 2248.8088512476297, 2274.55646149001, 2328.6041372966465, 2356.988215058931, 9973.152282056033, 10098.040686134806, 10098.343607665553, 10360.222983276284, 10421.166306695523, 1789.6241789224277, 1816.8637352198505, 1840.9815901841077, 1882.1436246507806, 1907.1322548240655, 112129.87870121357, 114723.0, 116496.0, 124258.75741242562, 129391.0, 8955.880514935632, 11070.501827417786, 11373.886261137448, 11603.709907252387, 11645.53417863293, 14273.214973176367, 14531.636709082146, 14608.123512589065, 14620.488282910048, 14647.267636618126, 8194.385421093322, 8230.670773169126, 8307.626156822958, 8333.208345207195, 8424.283935865398, 8191.221833925768, 8227.753167404988, 8290.502569845828, 8310.875336869953, 8368.874466883002, 4422.756748378806, 4486.080353527519, 4553.385292985471, 4555.40779698637, 4567.337736028324, 1464.5500954055408, 1723.6983527882571, 1825.3337531800796, 1875.5311172206948, 1964.9115789789494, 376.9114258149333, 684.4011489946297, 714.8141483214298, 913.1325241021057, 971.965981190669, 10385.740356491147, 11035.72410689723, 11478.94260528692, 11626.721060683318, 11869.643910682693, 422.61753113432394, 425.35133920770454, 427.77755567105555, 437.1039369292937, 452.4344569288389, 6121.938780612226, 6123.4488895999575, 6163.840991635065, 6283.937160628427, 6301.275353334425, 564742.0, 567487.0, 579091.0, 609285.0, 618074.0, 135594.0, 136210.0, 136546.0, 138272.0, 139548.30225848805, 952.5046975572664, 994.4629899854142, 1012.3318609717551, 1015.7359086637528, 1017.97455063624, 15849.841501585297, 18728.157232924823, 19352.32266870653, 19407.417777466697, 19516.804831952068, 53722.0, 55677.0, 56787.432125679865, 57724.0, 57867.42132578621, 76268.0, 78148.60925695335, 80116.59941700254, 80579.58261252171, 81562.0, 8029.8394032120195, 8057.274845263954, 8218.424710270463, 8254.0, 8314.958425207835, 11218.775624487627, 12805.423755930819, 12900.41948112356, 12937.805932911202, 13022.0, 10958.232923695583, 11230.382328971986, 11302.943485282522, 11401.0, 11430.885691142983, 10547.525361358605, 10610.469476525988, 10958.890411096107, 11015.228933974546, 11086.833697494705, 11218.158638102012, 11256.718582035188, 11343.602973896204, 11478.253913495597, 11607.36159511235, 7963.0, 8060.193980601893, 8289.502629842229, 8310.855287578794, 8380.622871970654, 8077.555734434663, 10617.734556636145, 11055.170862185207, 11134.331940083297, 11242.718932026764], "value": 8918.511928425945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.3369849869057, 1478.667299857532, 1641.7537369394597, 1763.955901102473, 1780.652772709322, 6564.409203171714, 7517.736879209228, 8112.91887081129, 8523.53120578367, 8574.099719529446, 7164.2835716428335, 7164.570125792443, 7171.569705817642, 8305.0, 8404.86534317867, 2295.999999999996, 2310.191432998454, 2338.4449341188088, 2343.039353864916, 2343.929682109531, 2102.8317734581196, 2182.7380714314304, 2365.3613524348416, 2372.5017746273215, 2376.1802178248477, 1923.7691477022777, 1936.738540297056, 2214.3689048621145, 2266.6826644269813, 2323.4075310795724, 1929.9421017369502, 2307.7230732312064, 2320.4198950262435, 2325.5232677301196, 2325.5581439526436, 2329.0683726509533, 2363.314638754759, 2364.5270945810908, 2370.194133994433, 2370.5140446208484, 8409.789755256168, 8411.83176336476, 8460.111688272704, 8492.278156356655, 8502.979642442884, 5021.17150670139, 5158.432572417031, 5162.612804039674, 5183.196604526304, 5188.948110518922, 3252.317013427183, 3352.2457447074457, 3579.427291633326, 3586.6234045425376, 3599.1362073102528, 1048.0829274384914, 1052.8210204265292, 1079.3955384984356, 1087.34215799441, 1098.5770478365807, 10987.725306867313, 11029.61396351124, 11097.445127743662, 11144.554217831277, 11154.219204655596, 4508.211063064016, 4631.444226692818, 4712.986707857827, 4729.4797572267025, 4759.428868535729, 9333.020032896584, 9475.620975161055, 9480.0, 9487.573059212353, 9488.715338539716, 5216.21756736485, 5222.529972302511, 5229.08491014071, 5236.214567814858, 5250.159974404077, 4083.387491876183, 4753.168195565762, 4754.405699287589, 4770.069836381872, 4805.543473370024, 3823.9044023899623, 3862.6909847212155, 3912.8434862605745, 3927.7250592458254, 3934.626210509997, 1206.390772659801, 1255.1088727003746, 1271.3007845684836, 1280.6286177008562, 1280.9487620495263, 741.6180666956521, 856.5674334461057, 904.5748498205833, 916.225789208118, 921.8064206516707, 5586.692731899703, 5667.489925906688, 5702.600817942704, 5764.365919748824, 5878.265216847894, 443.7359770936288, 447.8735979012786, 451.84863070870966, 451.8666993237003, 454.3253268895687, 3445.7243420526297, 3813.4089216171537, 3821.3503704370323, 3840.5007349044445, 3910.8631197907935, 9891.0, 10287.125594324416, 10290.228232882564, 10301.587936482456, 10318.742031449274, 9636.71089867305, 10081.19350451962, 10105.090541851268, 10109.241806864515, 10284.742881427874, 7799.064112306446, 7995.560244186509, 8009.0789559200275, 8012.759617211376, 8025.0, 5755.453231942959, 5777.653340799566, 5798.188253644409, 5837.620554663933, 6085.995810691186, 9356.4386136832, 9384.859227111736, 9395.671151509665, 9494.28792840526, 9528.380655257386, 7732.420068494998, 9258.490783006999, 9627.614895404105, 9705.563249653642, 9716.9028309716, 6619.470442364695, 6798.252192258748, 6976.895346569704, 7107.040549525748, 7270.491065625567, 7833.686652534063, 8041.638126284214, 8044.477108987897, 8049.87925181111, 8052.557109358807, 7012.228654848064, 7137.286271372821, 7148.320909513588, 7170.0, 7248.238934911758, 6921.367971650626, 7008.913618389158, 7030.2969703029285, 7110.288971102848, 7127.893081603676, 6571.0, 6743.2582415935185, 6753.898691519533, 6767.560108592926, 6807.863842723217, 4852.927206091982, 4881.707097574157, 4893.755312234445, 4897.094037603055, 5014.297998280171, 4129.690273229459, 4220.894477638084, 4877.829275975324, 4879.975600121977, 4982.302477653204], "value": 4330.388537364525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.632314759337, 283.6355283460752, 291.1745202351334, 291.62817407805045, 310.6101842188054, 5162.948370516294, 5247.711375874325, 5250.8424747257595, 5396.136618141093, 5403.2165336026255, 5145.3568303962, 5348.839534813952, 5358.758855851486, 5371.462853714626, 5396.703181325035, 3892.5718171001167, 4082.3060079786505, 4112.115895082557, 4129.958700412987, 4159.688023398242, 3777.773333599993, 3805.0, 4006.399040143973, 4160.916781664365, 4173.520045194796, 3997.240524300388, 4016.2529299754556, 4053.9797301013455, 4061.451704019964, 4073.6005114476443, 3705.907352316187, 3711.719456787404, 3916.902077448058, 4009.218202450523, 4030.9395359069636, 2984.567237750514, 3513.051476101464, 3517.1734642359024, 3524.1189702574356, 3533.434650455915, 4544.750038747868, 4989.401271847365, 5247.947520524822, 5283.969625922947, 5346.957343318055, 4479.2609219478745, 4657.394538709946, 4678.8596342109795, 4679.227927391977, 4681.859544213679, 4956.942868709481, 5743.712814359307, 5749.700119952011, 5751.338596061465, 5765.913511297334, 3252.8940160345596, 3545.3909917107912, 3768.9623103768886, 3784.3566593678866, 3906.3554513505237, 5253.868653283698, 6029.758809647609, 6029.8191054268445, 6033.336333003366, 6039.584166333458, 3954.525456945185, 3969.4045893115685, 3972.741771784825, 3975.8012099394914, 3975.980120099381, 3721.0, 3945.4870866787132, 3948.486696729407, 4009.51885773709, 4016.2770701274053, 4600.263957766741, 4615.976920115378, 4624.676272660949, 4632.513586073481, 4650.255959046604, 5686.715664216773, 5702.942970570324, 5761.415610707089, 5763.366029736726, 5772.7690892363835, 1169.6900321414832, 1221.9511219551118, 1227.9079069069855, 1259.1878238536092, 1293.5925183567147, 741.6328917186028, 753.8906858505486, 780.7228433905996, 781.8116462976244, 880.6350157256227, 4448.998975230547, 4631.513691062457, 4881.0, 4933.506649335038, 5116.002379535955, 4882.926756098661, 5533.3083364579425, 5561.9710353583905, 5571.470710282517, 5594.244776955059, 4396.802143903532, 4539.024109816405, 4543.409356783597, 4749.548792864673, 4925.064237794808, 2843.9853755019744, 2905.5617469352806, 2913.4113770810636, 2929.3050393637905, 2931.7654587633365, 5170.304455729839, 5305.683947532792, 5803.82588522345, 5813.593048486566, 5814.941850581525, 5137.691738495628, 5211.5049070338255, 5682.801101961411, 5726.914096288559, 5819.970900145472, 4569.680122391467, 4727.196376615983, 5710.3433105193435, 5799.652020878761, 5831.970840145772, 5144.768485418091, 5565.831175453201, 5576.247206627054, 5597.216389705526, 5633.690147041952, 5282.656627319212, 5457.0, 5497.807576734955, 5517.703339715244, 5541.5289700375915, 5106.642535022661, 5686.658800471985, 5786.0453025252045, 5793.594448388572, 5865.853353666193, 3211.8246279835653, 3366.848491817825, 3762.2099359134886, 3769.4534292526882, 3786.659200671953, 5198.232600915707, 5461.644993075437, 5488.945110549003, 5504.311961004874, 5514.704044549608, 4724.299252269249, 4879.512048795092, 4959.7272150032095, 5112.693238405707, 5726.713664316851, 4653.905742415859, 5094.9490505095955, 5158.922616160836, 5274.709890955881, 5627.324721033502, 4454.955450445454, 5326.8934621308135, 5622.5501959842295, 5628.324601047901, 5634.0, 4521.638268938543, 4829.903401932012, 5718.228039214653, 5817.70911454434, 5831.7667293307795, 4860.708357498562, 5657.547396208376, 5658.519025882846, 5675.432456754292, 5701.914471283017], "value": 4031.9824367903866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.674236366544, 741.8850078237873, 749.0449676662255, 763.496092578898, 775.7633921653896, 14504.854951450483, 15117.168555729431, 15140.697186056272, 15163.620909477255, 15197.54407367778, 13345.866541334608, 13402.195868247913, 13472.0, 13481.191128532295, 13485.460581576725, 785.3952456608408, 792.8969233999572, 804.3203493048394, 805.9884844520149, 806.5281810141046, 784.2001158818002, 788.2590365056857, 794.6026986506747, 795.761271618515, 796.5220867479524, 836.9246767790897, 840.970566030189, 844.7254642241296, 845.6659619450313, 845.953472559009, 809.8258874342044, 827.8634025385804, 834.7620928035481, 835.7116794705817, 838.2078935406043, 610.2524407600698, 619.3342157181004, 627.0281064350239, 628.8302158417248, 630.4672551693811, 12592.622221333375, 12679.239245645198, 12682.0, 12698.492060317576, 12733.045021623415, 9639.469829159394, 11115.221934464591, 11500.0, 11811.586594469152, 11916.080560262704, 10167.644132455402, 10230.232732545015, 10341.638042668546, 10395.84406233907, 10879.673609791718, 3488.0, 3521.5245941798044, 3534.0, 3540.185757275841, 3569.6787289144104, 60219.89230376916, 90684.6397304041, 92124.0, 92394.07605923922, 92528.07471925329, 8086.838263234702, 8497.320214382835, 8641.827163456821, 8835.337349698799, 8988.966268879032, 18457.90771046136, 18578.907105464656, 18812.52968675794, 18818.717719234224, 18975.525611859815, 5998.370171131968, 7514.361279291322, 7619.161892191854, 7627.237276272439, 7660.616969151632, 4009.799510024487, 4106.1992911382595, 4145.419641250227, 4188.308929026676, 4244.193603215379, 3183.395154920604, 3347.7154441872226, 3385.2213990781765, 3394.932101357959, 3405.7275417966503, 643.1028714942722, 670.3665036540423, 678.7726111752618, 688.879446096931, 689.7689274093135, 573.3984772203021, 574.319431473705, 595.5057302438966, 627.05314974389, 640.4876099120778, 8529.57352132391, 8698.260647844878, 9066.274698024143, 9079.68221112258, 9101.135392137736, 537.3068741323726, 579.4524174654911, 623.82844717703, 633.762339122829, 682.4267615203253, 4221.514525829508, 4285.849995250152, 4571.748553829571, 4594.609458196024, 4737.45519265282, 96075.0, 108098.0, 111231.0, 111588.44205778919, 115355.0, 92719.53640231755, 95471.52264238773, 97937.51031244798, 99158.0, 101261.98738012525, 65424.018639720445, 79380.99999999885, 84532.73200901992, 87137.5643121793, 90579.0, 7332.71495965607, 9777.266704997295, 9811.460369679737, 9827.705168844946, 9840.753981150528, 40250.59749402585, 45373.54626453825, 50743.0, 50973.0, 51472.22791658203, 72159.63920180366, 72863.0, 73408.63295683487, 73640.0, 78212.04469888298, 12462.626121216015, 12666.683332916382, 12670.746585068431, 12692.492300307884, 13077.542286019943, 14040.719185616026, 14169.574912752634, 14196.645083872985, 14427.49503767363, 14440.061396009225, 13167.209967401986, 13240.80138797938, 13354.399052042487, 13404.865951340362, 13432.529861454803, 10668.146548276274, 13058.34708264602, 13067.085304028627, 13250.536231231861, 13434.261115638734, 12546.623601291976, 12757.0, 12771.744565108831, 12887.613371598867, 12972.481100755864, 10779.67660970172, 11032.558697652004, 11056.0, 11464.82802757976, 11591.88408115908, 11356.94321528387, 11587.740390623747, 11787.11596630239, 11813.468393922467, 11818.881811181778], "value": 7096.273354801607, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1636.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 96.0, 178.0, 168.0, 176.0, 120.0, 122.0, 114.0, 177.0, 175.0], "value": 144.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 146.0, 113.0, 179.0, 144.0, 114.0, 114.0, 114.0, 141.0, 129.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 205.0, 280.0, 164.0, 207.0, 289.0, 262.0, 198.0, 193.0, 197.0], "value": 219.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 85.0, 62.0, 60.0, 68.0, 67.0, 72.0, 75.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 89.0, 73.0, 71.0, 70.0, 87.0, 69.0, 73.0, 88.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 75.0, 136.0, 121.0, 138.0, 131.0, 92.0, 99.0, 90.0, 85.0], "value": 105.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 106.0, 95.0, 103.0, 152.0, 152.0, 97.0], "value": 108.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 88.0, 86.0, 93.0, 89.0, 91.0, 91.0, 89.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 67.0, 82.0, 95.0, 92.0, 94.0, 53.0, 59.0], "value": 71.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 66.0, 106.0, 113.0, 107.0, 109.0, 113.0, 77.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 88.0, 86.0, 84.0, 90.0, 78.0, 79.0, 75.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 141.0, 151.0, 174.0, 161.0, 144.0, 154.0, 271.0, 202.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 159.0, 156.0, 236.0, 203.0, 240.0, 236.0, 168.0, 170.0, 171.0], "value": 193.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 84.0, 79.0, 68.0, 67.0, 71.0, 82.0, 84.0, 90.0], "value": 76.2, "unit": "score"}]}]} 03:24:31 INFO - Return code: 0 03:24:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:32 ERROR - # TBPL SUCCESS # 03:24:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:32 INFO - 2017-01-05 03:24:32.050 screenresolution[1654:10847] starting screenresolution argv=screenresolution get 03:24:32 INFO - 2017-01-05 03:24:32.052 screenresolution[1654:10847] Display 0: 1600x1200x32@60 03:24:32 INFO - 2017-01-05 03:24:32.058 screenresolution[1655:10851] starting screenresolution argv=screenresolution list 03:24:32 INFO - Available Modes on Display 0 03:24:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:32 INFO - Intel Iris: 03:24:32 INFO - Chipset Model: Intel Iris 03:24:32 INFO - Type: GPU 03:24:32 INFO - Bus: Built-In 03:24:32 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:32 INFO - Vendor: Intel (0x8086) 03:24:32 INFO - Device ID: 0x0a2e 03:24:32 INFO - Revision ID: 0x0009 03:24:32 INFO - Displays: 03:24:32 INFO - Display: 03:24:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:32 INFO - Display Serial Number: 1600x1200 60 03:24:32 INFO - Main Display: Yes 03:24:32 INFO - Mirror: Off 03:24:32 INFO - Online: Yes 03:24:32 INFO - Rotation: Supported 03:24:32 INFO - Return code: 0 03:24:32 INFO - Running post-action listener: _resource_record_post_action 03:24:32 INFO - [mozharness: 2017-01-05 11:24:32.298103Z] Finished run-tests step (success) 03:24:32 INFO - Running post-run listener: _resource_record_post_run 03:24:32 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38472192; Write bytes: 660772864; Read time: 248; Write time: 1917 03:24:32 INFO - TinderboxPrint: CPU usage
54.4% 03:24:32 INFO - TinderboxPrint: I/O read bytes / time
38,472,192 / 248 03:24:32 INFO - TinderboxPrint: I/O write bytes / time
660,772,864 / 1,917 03:24:32 INFO - TinderboxPrint: CPU idle
2,211.4 (45.6%) 03:24:32 INFO - TinderboxPrint: CPU system
982.0 (20.2%) 03:24:32 INFO - TinderboxPrint: CPU user
1,656.3 (34.2%) 03:24:32 INFO - TinderboxPrint: Swap in / out
387,977,216 / 0 03:24:32 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 343026176; Write bytes: 337536512; Read time: 26545; Write time: 677 03:24:32 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36596224; Write bytes: 307814912; Read time: 229; Write time: 1190 03:24:32 INFO - Running post-run listener: _upload_blobber_files 03:24:32 INFO - Blob upload gear active. 03:24:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:32 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 03:24:32 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'] 03:24:32 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 03:24:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:24:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:34 INFO - (blobuploader) - INFO - Done attempting. 03:24:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:24:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:24:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:35 INFO - (blobuploader) - INFO - Done attempting. 03:24:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:37 INFO - (blobuploader) - INFO - Done attempting. 03:24:37 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:37 INFO - Return code: 0 03:24:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb3e3e94f6036c6b222598021a83f8a11a4ede9e1e02a0ebd4ba8eedb35321000f7744c037927a22a47ddca9d8f32986ee87d580295ecf4c541a9d547bec9e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e08c995dcd6d0048b241e8daf1e15ce501d40f2a18645a905c249fea9752a5612df838fdb1c4ae0e325a546a2ccaa90bda2721d64fd91e33063f240b9e8188a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca63b39c481b3dfedfe32f980ca88690232ae38285b501f31bde308867dfd9d8817049ddd0aa7a4a31809183dfd6dbf26f0a11a2bad240c1c5757738b9324e86"} 03:24:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:37 INFO - Contents: 03:24:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb3e3e94f6036c6b222598021a83f8a11a4ede9e1e02a0ebd4ba8eedb35321000f7744c037927a22a47ddca9d8f32986ee87d580295ecf4c541a9d547bec9e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e08c995dcd6d0048b241e8daf1e15ce501d40f2a18645a905c249fea9752a5612df838fdb1c4ae0e325a546a2ccaa90bda2721d64fd91e33063f240b9e8188a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca63b39c481b3dfedfe32f980ca88690232ae38285b501f31bde308867dfd9d8817049ddd0aa7a4a31809183dfd6dbf26f0a11a2bad240c1c5757738b9324e86"} 03:24:37 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:37 INFO - Copying logs to upload dir... 03:24:37 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.179570 ========= master_lag: 1.68 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-05 03:24:39.607548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:24:39.612942) ========= 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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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/fb3e3e94f6036c6b222598021a83f8a11a4ede9e1e02a0ebd4ba8eedb35321000f7744c037927a22a47ddca9d8f32986ee87d580295ecf4c541a9d547bec9e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e08c995dcd6d0048b241e8daf1e15ce501d40f2a18645a905c249fea9752a5612df838fdb1c4ae0e325a546a2ccaa90bda2721d64fd91e33063f240b9e8188a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca63b39c481b3dfedfe32f980ca88690232ae38285b501f31bde308867dfd9d8817049ddd0aa7a4a31809183dfd6dbf26f0a11a2bad240c1c5757738b9324e86"} build_url:https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/QNoYU4odRhGB5NilAGW3tw/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/fb3e3e94f6036c6b222598021a83f8a11a4ede9e1e02a0ebd4ba8eedb35321000f7744c037927a22a47ddca9d8f32986ee87d580295ecf4c541a9d547bec9e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e08c995dcd6d0048b241e8daf1e15ce501d40f2a18645a905c249fea9752a5612df838fdb1c4ae0e325a546a2ccaa90bda2721d64fd91e33063f240b9e8188a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca63b39c481b3dfedfe32f980ca88690232ae38285b501f31bde308867dfd9d8817049ddd0aa7a4a31809183dfd6dbf26f0a11a2bad240c1c5757738b9324e86"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:24:39.654682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:24:39.655022) ========= 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.ZmeQ08HbLP/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.ZHZUnQLvHk/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.005000 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:24:40.023809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:24:40.024170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:24:40.025397) ========= ========= Total master_lag: 2.15 =========