builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0286 starttime: 1480506857.35 results: success (0) buildid: 20161130023745 builduid: f3b767ef7b154a0f82a51371d8ef9ba8 revision: e5a46a7cd14f7cc0a99298302239a66bd1658a3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.349383) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.357187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.357499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.403081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.403371) ========= 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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-30 03:54:17-- 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% 7.97M=0.001s 2016-11-30 03:54:17 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.221350 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.648242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.648569) ========= 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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.019769 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:17.699857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 03:54:17.700170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e5a46a7cd14f7cc0a99298302239a66bd1658a3c --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 e5a46a7cd14f7cc0a99298302239a66bd1658a3c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-30 03:54:17,783 truncating revision to first 12 chars 2016-11-30 03:54:17,783 Setting DEBUG logging. 2016-11-30 03:54:17,783 attempt 1/10 2016-11-30 03:54:17,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e5a46a7cd14f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 03:54:18,788 unpacking tar archive at: mozilla-aurora-e5a46a7cd14f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677607 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 03:54:19.424537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:19.424908) ========= script_repo_revision: e5a46a7cd14f7cc0a99298302239a66bd1658a3c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:19.425320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:19.425614) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 03:54:19.461314) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-30 03:54:19.461666) ========= /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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54:19 INFO - MultiFileLogger online at 20161130 03:54:19 in /builds/slave/test 03:54:19 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:54:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:19 INFO - {'append_to_log': False, 03:54:19 INFO - 'base_work_dir': '/builds/slave/test', 03:54:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:19 INFO - 'branch': 'Mozilla-Aurora', 03:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:19 INFO - 'config_files': ('talos/mac_config.py',), 03:54:19 INFO - 'default_actions': ('clobber', 03:54:19 INFO - 'read-buildbot-config', 03:54:19 INFO - 'download-and-extract', 03:54:19 INFO - 'populate-webroot', 03:54:19 INFO - 'create-virtualenv', 03:54:19 INFO - 'install', 03:54:19 INFO - 'run-tests'), 03:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:19 INFO - 'download_minidump_stackwalk': True, 03:54:19 INFO - 'download_symbols': 'ondemand', 03:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:19 INFO - 'installer_path': 'installer.exe', 03:54:19 INFO - 'log_level': 'info', 03:54:19 INFO - 'log_name': 'talos', 03:54:19 INFO - 'log_to_console': True, 03:54:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:54:19 INFO - 'opt_config_files': (), 03:54:19 INFO - 'pip_index': False, 03:54:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:19 INFO - 'cmd': ('bash', 03:54:19 INFO - '-c', 03:54:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:19 INFO - 'enabled': True, 03:54:19 INFO - 'halt_on_failure': False, 03:54:19 INFO - 'name': 'check_screen_resolution'},), 03:54:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:19 INFO - 'cmd': ('bash', 03:54:19 INFO - '-c', 03:54:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:19 INFO - 'enabled': True, 03:54:19 INFO - 'halt_on_failure': False, 03:54:19 INFO - 'name': 'check_screen_resolution'},), 03:54:19 INFO - 'run_cmd_checks_enabled': True, 03:54:19 INFO - 'sps_profile': False, 03:54:19 INFO - 'sps_profile_interval': 0, 03:54:19 INFO - 'suite': 'dromaeojs-e10s', 03:54:19 INFO - 'system_bits': '32', 03:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:19 INFO - 'title': 't-yosemite-r7-0286', 03:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:19 INFO - 'use_talos_json': True, 03:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:19 INFO - 'work_dir': 'build'} 03:54:19 INFO - [mozharness: 2016-11-30 11:54:19.661137Z] Running clobber step. 03:54:19 INFO - Running pre-action listener: _resource_record_pre_action 03:54:19 INFO - Running main action method: clobber 03:54:19 INFO - rmtree: /builds/slave/test/build 03:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:21 INFO - Running post-action listener: _resource_record_post_action 03:54:21 INFO - [mozharness: 2016-11-30 11:54:21.355378Z] Finished clobber step (success) 03:54:21 INFO - [mozharness: 2016-11-30 11:54:21.355628Z] Running read-buildbot-config step. 03:54:21 INFO - Running pre-action listener: _resource_record_pre_action 03:54:21 INFO - Running main action method: read_buildbot_config 03:54:21 INFO - Using buildbot properties: 03:54:21 INFO - { 03:54:21 INFO - "project": "", 03:54:21 INFO - "product": "firefox", 03:54:21 INFO - "script_repo_revision": "production", 03:54:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:54:21 INFO - "repository": "", 03:54:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:54:21 INFO - "buildid": "20161130023745", 03:54:21 INFO - "pgo_build": "False", 03:54:21 INFO - "basedir": "/builds/slave/test", 03:54:21 INFO - "buildnumber": 44, 03:54:21 INFO - "slavename": "t-yosemite-r7-0286", 03:54:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:54:21 INFO - "platform": "yosemite_r7", 03:54:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:54:21 INFO - "branch": "mozilla-aurora", 03:54:21 INFO - "repo_path": "releases/mozilla-aurora", 03:54:21 INFO - "revision": "e5a46a7cd14f7cc0a99298302239a66bd1658a3c", 03:54:21 INFO - "stage_platform": "macosx64", 03:54:21 INFO - "builduid": "f3b767ef7b154a0f82a51371d8ef9ba8", 03:54:21 INFO - "slavebuilddir": "test" 03:54:21 INFO - } 03:54:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:54:21 INFO - Running post-action listener: _resource_record_post_action 03:54:21 INFO - [mozharness: 2016-11-30 11:54:21.361302Z] Finished read-buildbot-config step (success) 03:54:21 INFO - [mozharness: 2016-11-30 11:54:21.361508Z] Running download-and-extract step. 03:54:21 INFO - Running pre-action listener: _resource_record_pre_action 03:54:21 INFO - Running main action method: download_and_extract 03:54:21 INFO - mkdir: /builds/slave/test/build/tests 03:54:21 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:54:21 INFO - trying https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:54:21 INFO - Downloading https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/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:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/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:54:22 INFO - Downloaded 1199 bytes. 03:54:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:54:22 INFO - Using the following test package requirements: 03:54:22 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:54:22 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:54:22 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:54:22 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'jsshell-mac.zip'], 03:54:22 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:54:22 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:54:22 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:54:22 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:54:22 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:54:22 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:54:22 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:54:22 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:54:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:54:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:54:22 INFO - Fetch https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:54:22 INFO - Http code: 200 03:54:22 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:54:22 INFO - x-amz-cf-id: eIdnUsAnlNgdL_FBwyMJ0y6vQZGa6Zf2e2zuyvKaoIjgHZWqw8UlqQ== 03:54:22 INFO - x-amz-version-id: UG9QkYDUQJCW7eBaF4GwCfl_h3okM1Q7 03:54:23 INFO - Expected file size: 16285047 03:54:23 INFO - Obtained file size: 16285047 03:54:29 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:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:54:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:54:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:54:30 INFO - Http code: 200 03:54:30 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 03:54:30 INFO - x-amz-cf-id: fYe5VjyB19CVvtV5bIzEbNbZw8SM3amuu4PlBAT4g-DfS8DEGtR98A== 03:54:30 INFO - x-amz-version-id: UG9QkYDUQJCW7eBaF4GwCfl_h3okM1Q7 03:54:30 INFO - Expected file size: 16285047 03:54:30 INFO - Obtained file size: 16285047 03:54:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:54:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:54:37 INFO - Fetch https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:54:37 INFO - Http code: 200 03:54:37 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 03:54:37 INFO - x-amz-cf-id: g0uA_1ylPCprRtky7iCgxu9CRouhpKtD6AcjGJxfe69unIV3qk3BXQ== 03:54:37 INFO - x-amz-version-id: Tjt.ihwHYTiNyaZ1UiJKfBVvCQ_lSRuC 03:54:38 INFO - Expected file size: 14409038 03:54:38 INFO - Obtained file size: 14409038 03:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:38 INFO - trying https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:54:38 INFO - Downloading https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/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:54:41 INFO - Downloaded 109709266 bytes. 03:54:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:54:41 INFO - mkdir: /builds/slave/test/properties 03:54:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:54:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:54:41 INFO - Contents: 03:54:41 INFO - build_url:https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:54:42 INFO - Running post-action listener: _resource_record_post_action 03:54:42 INFO - Running post-action listener: set_extra_try_arguments 03:54:42 INFO - [mozharness: 2016-11-30 11:54:42.492097Z] Finished download-and-extract step (success) 03:54:42 INFO - [mozharness: 2016-11-30 11:54:42.492237Z] Running populate-webroot step. 03:54:42 INFO - Running pre-action listener: _resource_record_pre_action 03:54:42 INFO - Running main action method: populate_webroot 03:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:54:42 INFO - '--tppagecycles', 03:54:42 INFO - '7'], 03:54:42 INFO - 'tests': ['tsvgm']}}, 03:54:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:54:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:54:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:54:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:54:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['damp', 'tps']}, 03:54:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'tests': ['damp', 'tps']}, 03:54:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['dromaeo_dom']}, 03:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:54:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['basic_compositor_video']}, 03:54:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:54:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['a11yr', 03:54:42 INFO - 'ts_paint', 03:54:42 INFO - 'tpaint', 03:54:42 INFO - 'sessionrestore', 03:54:42 INFO - 'sessionrestore_no_auto_restore', 03:54:42 INFO - 'tabpaint']}, 03:54:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['tsvgx', 03:54:42 INFO - 'tsvgr_opacity', 03:54:42 INFO - 'tart', 03:54:42 INFO - 'tscrollx', 03:54:42 INFO - 'cart']}, 03:54:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:54:42 INFO - 'tsvgr_opacity', 03:54:42 INFO - 'tart', 03:54:42 INFO - 'tscrollx', 03:54:42 INFO - 'cart']}, 03:54:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'talos_options': ['--disable-e10s'], 03:54:42 INFO - 'tests': ['tp5o']}, 03:54:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'tests': ['tp5o']}, 03:54:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'talos_options': ['--disable-e10s', 03:54:42 INFO - '--xperf_path', 03:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:42 INFO - 'tests': ['tp5n']}, 03:54:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:42 INFO - 'talos_options': ['--xperf_path', 03:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:42 INFO - 'tests': ['tp5n']}}, 03:54:42 INFO - 'talos.zip': {'path': '', 03:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:54:42 INFO - Running post-action listener: _resource_record_post_action 03:54:42 INFO - [mozharness: 2016-11-30 11:54:42.510992Z] Finished populate-webroot step (success) 03:54:42 INFO - [mozharness: 2016-11-30 11:54:42.511074Z] Running create-virtualenv step. 03:54:42 INFO - Running pre-action listener: _resource_record_pre_action 03:54:42 INFO - Running main action method: create_virtualenv 03:54:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:54:42 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:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:54:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:54:42 INFO - Using real prefix '/tools/python27' 03:54:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:54:46 INFO - Installing pip.................done. 03:54:46 INFO - Return code: 0 03:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:54:46 INFO - Reading from file tmpfile_stdout 03:54:46 INFO - Output received: 03:54:46 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:54:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:46 INFO - 'HOME': '/Users/cltbld', 03:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:46 INFO - 'LOGNAME': 'cltbld', 03:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:46 INFO - 'MOZ_NO_REMOTE': '1', 03:54:46 INFO - 'NO_EM_RESTART': '1', 03:54:46 INFO - 'PAGER': '/bin/cat', 03:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:46 INFO - 'PWD': '/builds/slave/test', 03:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:46 INFO - 'SHELL': '/bin/bash', 03:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:46 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:46 INFO - 'USER': 'cltbld', 03:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:46 INFO - 'XPC_FLAGS': '0x0', 03:54:46 INFO - 'XPC_SERVICE_NAME': '0', 03:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:46 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:54:46 INFO - Cleaning up... 03:54:46 INFO - Return code: 0 03:54:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:46 INFO - 'HOME': '/Users/cltbld', 03:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:46 INFO - 'LOGNAME': 'cltbld', 03:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:46 INFO - 'MOZ_NO_REMOTE': '1', 03:54:46 INFO - 'NO_EM_RESTART': '1', 03:54:46 INFO - 'PAGER': '/bin/cat', 03:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:46 INFO - 'PWD': '/builds/slave/test', 03:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:46 INFO - 'SHELL': '/bin/bash', 03:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:46 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:46 INFO - 'USER': 'cltbld', 03:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:46 INFO - 'XPC_FLAGS': '0x0', 03:54:46 INFO - 'XPC_SERVICE_NAME': '0', 03:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:46 INFO - Downloading/unpacking psutil>=3.1.1 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:50 INFO - Installing collected packages: psutil 03:54:50 INFO - Running setup.py install for psutil 03:54:50 INFO - building 'psutil._psutil_osx' extension 03:54:50 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:54:51 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:54:51 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:54:51 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:54:51 INFO - building 'psutil._psutil_posix' extension 03:54:51 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:54:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:54:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:54:51 INFO - ^ 03:54:51 INFO - 1 warning generated. 03:54:51 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:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:51 INFO - Successfully installed psutil 03:54:51 INFO - Cleaning up... 03:54:51 INFO - Return code: 0 03:54:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:54: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:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:51 INFO - 'HOME': '/Users/cltbld', 03:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:51 INFO - 'LOGNAME': 'cltbld', 03:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:51 INFO - 'MOZ_NO_REMOTE': '1', 03:54:51 INFO - 'NO_EM_RESTART': '1', 03:54:51 INFO - 'PAGER': '/bin/cat', 03:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:51 INFO - 'PWD': '/builds/slave/test', 03:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:51 INFO - 'SHELL': '/bin/bash', 03:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:51 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:51 INFO - 'USER': 'cltbld', 03:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:51 INFO - 'XPC_FLAGS': '0x0', 03:54:51 INFO - 'XPC_SERVICE_NAME': '0', 03:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:54:54 INFO - Installing collected packages: mozsystemmonitor 03:54:54 INFO - Running setup.py install for mozsystemmonitor 03:54:54 INFO - Successfully installed mozsystemmonitor 03:54:54 INFO - Cleaning up... 03:54:54 INFO - Return code: 0 03:54:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:54:54 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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:54 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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:54 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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54:54 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:54:54 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:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:54 INFO - 'HOME': '/Users/cltbld', 03:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:54 INFO - 'LOGNAME': 'cltbld', 03:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:54 INFO - 'MOZ_NO_REMOTE': '1', 03:54:54 INFO - 'NO_EM_RESTART': '1', 03:54:54 INFO - 'PAGER': '/bin/cat', 03:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:54 INFO - 'PWD': '/builds/slave/test', 03:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:54 INFO - 'SHELL': '/bin/bash', 03:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:54 INFO - 'USER': 'cltbld', 03:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:54 INFO - 'XPC_FLAGS': '0x0', 03:54:54 INFO - 'XPC_SERVICE_NAME': '0', 03:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:55 INFO - Downloading/unpacking jsonschema==2.5.1 03:54: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:54: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:54: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:54: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:54: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:54: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:54:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:54:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:54:57 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:54:57 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:54:57 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:54:57 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:54:57 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:54:57 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:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:54:58 INFO - warning: no files found matching '*.txt' 03:54:58 INFO - no previously-included directories found matching 'build' 03:54:58 INFO - no previously-included directories found matching 'dist' 03:54:58 INFO - no previously-included directories found matching '.git*' 03:54:58 INFO - Installing collected packages: jsonschema, functools32 03:54:58 INFO - Running setup.py install for functools32 03:54:58 INFO - warning: no files found matching '*.txt' 03:54:58 INFO - no previously-included directories found matching 'build' 03:54:58 INFO - no previously-included directories found matching 'dist' 03:54:58 INFO - no previously-included directories found matching '.git*' 03:54:58 INFO - Successfully installed jsonschema functools32 03:54:58 INFO - Cleaning up... 03:54:58 INFO - Return code: 0 03:54:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:54: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:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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', '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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:54: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 functools32==3.2.3-2 03:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:58 INFO - 'HOME': '/Users/cltbld', 03:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:58 INFO - 'LOGNAME': 'cltbld', 03:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:58 INFO - 'MOZ_NO_REMOTE': '1', 03:54:58 INFO - 'NO_EM_RESTART': '1', 03:54:58 INFO - 'PAGER': '/bin/cat', 03:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:58 INFO - 'PWD': '/builds/slave/test', 03:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:58 INFO - 'SHELL': '/bin/bash', 03:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:58 INFO - 'USER': 'cltbld', 03:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:58 INFO - 'XPC_FLAGS': '0x0', 03:54:58 INFO - 'XPC_SERVICE_NAME': '0', 03:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:54:58 INFO - Cleaning up... 03:54:58 INFO - Return code: 0 03:54:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:54: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:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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', '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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:54: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 blobuploader==1.2.4 03:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:58 INFO - 'HOME': '/Users/cltbld', 03:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:58 INFO - 'LOGNAME': 'cltbld', 03:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:58 INFO - 'MOZ_NO_REMOTE': '1', 03:54:58 INFO - 'NO_EM_RESTART': '1', 03:54:58 INFO - 'PAGER': '/bin/cat', 03:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:58 INFO - 'PWD': '/builds/slave/test', 03:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:58 INFO - 'SHELL': '/bin/bash', 03:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:54:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:58 INFO - 'USER': 'cltbld', 03:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:58 INFO - 'XPC_FLAGS': '0x0', 03:54:58 INFO - 'XPC_SERVICE_NAME': '0', 03:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55: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:55: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:55: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:55: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:55: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:55: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:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55: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:55: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:55: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:55: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:55: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:55: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:55:02 INFO - Downloading docopt-0.6.1.tar.gz 03:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:02 INFO - Running setup.py install for blobuploader 03:55:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:03 INFO - Running setup.py install for requests 03:55:03 INFO - Running setup.py install for docopt 03:55:03 INFO - Successfully installed blobuploader requests docopt 03:55:03 INFO - Cleaning up... 03:55:03 INFO - Return code: 0 03:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:03 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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:55:03 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:55:03 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:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:03 INFO - 'HOME': '/Users/cltbld', 03:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:03 INFO - 'LOGNAME': 'cltbld', 03:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:03 INFO - 'MOZ_NO_REMOTE': '1', 03:55:03 INFO - 'NO_EM_RESTART': '1', 03:55:03 INFO - 'PAGER': '/bin/cat', 03:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:03 INFO - 'PWD': '/builds/slave/test', 03:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:03 INFO - 'SHELL': '/bin/bash', 03:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:55:03 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:03 INFO - 'USER': 'cltbld', 03:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:03 INFO - 'XPC_FLAGS': '0x0', 03:55:03 INFO - 'XPC_SERVICE_NAME': '0', 03:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-BT5G3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-8m0MfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lImVH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-jEwlwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-RHDwKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-I1msKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-rxlg1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Qrr40q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CRF5Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ab8DaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IHbhxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Lrt7z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5R1oJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-bjyb2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-A57SUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-S8zCyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-zhWI0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:05 INFO - Running setup.py install for manifestparser 03:55:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:05 INFO - Running setup.py install for mozcrash 03:55:06 INFO - Running setup.py install for mozdebug 03:55:06 INFO - Running setup.py install for mozdevice 03:55:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Running setup.py install for mozfile 03:55:06 INFO - Running setup.py install for mozhttpd 03:55:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Running setup.py install for mozinfo 03:55:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Running setup.py install for mozInstall 03:55:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Running setup.py install for mozleak 03:55:07 INFO - Running setup.py install for mozlog 03:55:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Running setup.py install for moznetwork 03:55:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Running setup.py install for mozprocess 03:55:07 INFO - Running setup.py install for mozprofile 03:55:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Running setup.py install for mozrunner 03:55:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:07 INFO - Running setup.py install for mozscreenshot 03:55:08 INFO - Running setup.py install for moztest 03:55:08 INFO - Running setup.py install for mozversion 03:55:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:55:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:55:08 INFO - Cleaning up... 03:55:08 INFO - Return code: 0 03:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:08 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:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:08 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:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:08 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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:55:08 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:55:08 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:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:08 INFO - 'HOME': '/Users/cltbld', 03:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:08 INFO - 'LOGNAME': 'cltbld', 03:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:08 INFO - 'MOZ_NO_REMOTE': '1', 03:55:08 INFO - 'NO_EM_RESTART': '1', 03:55:08 INFO - 'PAGER': '/bin/cat', 03:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:08 INFO - 'PWD': '/builds/slave/test', 03:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:08 INFO - 'SHELL': '/bin/bash', 03:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:55:08 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:08 INFO - 'USER': 'cltbld', 03:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:08 INFO - 'XPC_FLAGS': '0x0', 03:55:08 INFO - 'XPC_SERVICE_NAME': '0', 03:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fxJAGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:08 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:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-XdOHZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:08 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:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-gWm9qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lpgqAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-iGWvg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-yrFkad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-yw1yqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-db_XNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-8mERyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-GcU_IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fXLZxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WQvZWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:09 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:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-p7QHNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:10 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-jI2Rof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:10 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-T9r57Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:10 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-oZ_WC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:10 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fx245g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:13 INFO - Downloading blessings-1.6.tar.gz 03:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:55:13 INFO - Installing collected packages: blessings 03:55:13 INFO - Running setup.py install for blessings 03:55:13 INFO - Successfully installed blessings 03:55:13 INFO - Cleaning up... 03:55:13 INFO - Return code: 0 03:55:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:13 INFO - Reading from file tmpfile_stdout 03:55:13 INFO - Current package versions: 03:55:13 INFO - blessings == 1.6 03:55:13 INFO - blobuploader == 1.2.4 03:55:13 INFO - docopt == 0.6.1 03:55:13 INFO - functools32 == 3.2.3-2 03:55:13 INFO - jsonschema == 2.5.1 03:55:13 INFO - manifestparser == 1.1 03:55:13 INFO - mozInstall == 1.12 03:55:13 INFO - mozcrash == 1.0 03:55:13 INFO - mozdebug == 0.1 03:55:13 INFO - mozdevice == 0.48 03:55:13 INFO - mozfile == 1.2 03:55:13 INFO - mozhttpd == 0.7 03:55:13 INFO - mozinfo == 0.9 03:55:13 INFO - mozleak == 0.1 03:55:13 INFO - mozlog == 3.4 03:55:13 INFO - moznetwork == 0.27 03:55:13 INFO - mozprocess == 0.23 03:55:13 INFO - mozprofile == 0.28 03:55:13 INFO - mozrunner == 6.13 03:55:13 INFO - mozscreenshot == 0.1 03:55:13 INFO - mozsystemmonitor == 0.3 03:55:13 INFO - moztest == 0.7 03:55:13 INFO - mozversion == 1.4 03:55:13 INFO - psutil == 3.1.1 03:55:13 INFO - requests == 1.2.3 03:55:13 INFO - wsgiref == 0.1.2 03:55:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:13 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:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:13 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:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:13 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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:55:13 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:55:13 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:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:13 INFO - 'HOME': '/Users/cltbld', 03:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:13 INFO - 'LOGNAME': 'cltbld', 03:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:13 INFO - 'MOZ_NO_REMOTE': '1', 03:55:13 INFO - 'NO_EM_RESTART': '1', 03:55:13 INFO - 'PAGER': '/bin/cat', 03:55:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:13 INFO - 'PWD': '/builds/slave/test', 03:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:13 INFO - 'SHELL': '/bin/bash', 03:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:55:13 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:13 INFO - 'USER': 'cltbld', 03:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:13 INFO - 'XPC_FLAGS': '0x0', 03:55:13 INFO - 'XPC_SERVICE_NAME': '0', 03:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:13 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 INFO - Cleaning up... 03:55:14 INFO - Return code: 0 03:55:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:14 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 0x10478c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104702570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f8bcb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, '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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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:55:14 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:55:14 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:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:14 INFO - 'HOME': '/Users/cltbld', 03:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:14 INFO - 'LOGNAME': 'cltbld', 03:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:14 INFO - 'MOZ_NO_REMOTE': '1', 03:55:14 INFO - 'NO_EM_RESTART': '1', 03:55:14 INFO - 'PAGER': '/bin/cat', 03:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:14 INFO - 'PWD': '/builds/slave/test', 03:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:14 INFO - 'SHELL': '/bin/bash', 03:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:55:14 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:14 INFO - 'USER': 'cltbld', 03:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:14 INFO - 'XPC_FLAGS': '0x0', 03:55:14 INFO - 'XPC_SERVICE_NAME': '0', 03:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:55:14 INFO - Cleaning up... 03:55:14 INFO - Return code: 0 03:55:14 INFO - Running post-action listener: _resource_record_post_action 03:55:14 INFO - Running post-action listener: _start_resource_monitoring 03:55:14 INFO - Starting resource monitoring. 03:55:14 INFO - [mozharness: 2016-11-30 11:55:14.309830Z] Finished create-virtualenv step (success) 03:55:14 INFO - [mozharness: 2016-11-30 11:55:14.310678Z] Running install step. 03:55:14 INFO - Running pre-action listener: _resource_record_pre_action 03:55:14 INFO - Running main action method: install 03:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:14 INFO - Reading from file tmpfile_stdout 03:55:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:14 INFO - Reading from file tmpfile_stdout 03:55:14 INFO - Output received: 03:55:14 INFO - Usage: mozinstall [options] installer 03:55:14 INFO - Options: 03:55:14 INFO - -h, --help show this help message and exit 03:55:14 INFO - -d DEST, --destination=DEST 03:55:14 INFO - Directory to install application into. [default: 03:55:14 INFO - "/builds/slave/test"] 03:55:14 INFO - --app=APP Application being installed. [default: firefox] 03:55:14 INFO - mkdir: /builds/slave/test/build/application 03:55:14 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:55:14 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:55:46 INFO - Reading from file tmpfile_stdout 03:55:46 INFO - Output received: 03:55:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:55:46 INFO - Running post-action listener: _resource_record_post_action 03:55:46 INFO - [mozharness: 2016-11-30 11:55:46.015786Z] Finished install step (success) 03:55:46 INFO - [mozharness: 2016-11-30 11:55:46.015936Z] Running run-tests step. 03:55:46 INFO - Running pre-action listener: _resource_record_pre_action 03:55:46 INFO - Running main action method: run_tests 03:55:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:55:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:55:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:55:46 INFO - 2016-11-30 03:55:46.030 screenresolution[2248:23694] starting screenresolution argv=screenresolution get 03:55:46 INFO - 2016-11-30 03:55:46.033 screenresolution[2248:23694] Display 0: 1600x1200x32@60 03:55:46 INFO - 2016-11-30 03:55:46.039 screenresolution[2249:23697] starting screenresolution argv=screenresolution list 03:55:46 INFO - Available Modes on Display 0 03:55:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:55:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:55:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:55:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:55:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:55:46 INFO - Intel Iris: 03:55:46 INFO - Chipset Model: Intel Iris 03:55:46 INFO - Type: GPU 03:55:46 INFO - Bus: Built-In 03:55:46 INFO - VRAM (Dynamic, Max): 1536 MB 03:55:46 INFO - Vendor: Intel (0x8086) 03:55:46 INFO - Device ID: 0x0a2e 03:55:46 INFO - Revision ID: 0x0009 03:55:46 INFO - Displays: 03:55:46 INFO - Display: 03:55:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:55:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:55:46 INFO - Display Serial Number: 1600x1200 60 03:55:46 INFO - Main Display: Yes 03:55:46 INFO - Mirror: Off 03:55:46 INFO - Online: Yes 03:55:46 INFO - Rotation: Supported 03:55:46 INFO - Return code: 0 03:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:55:46 INFO - Python 2.7.3 03:55:46 INFO - Return code: 0 03:55:46 INFO - grabbing minidump binary from tooltool 03:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:46 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 0x1045a0d30>, '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 0x104406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104598b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:55:46 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:55:46 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:55:46 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:55:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:55:46 INFO - Return code: 0 03:55:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:55:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:55:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:55:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:55:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:55:46 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/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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:55:46 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/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J5Kc5ecCHz/Render', 03:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:46 INFO - 'HOME': '/Users/cltbld', 03:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:46 INFO - 'LOGNAME': 'cltbld', 03:55:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:46 INFO - 'MOZ_NO_REMOTE': '1', 03:55:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:46 INFO - 'NO_EM_RESTART': '1', 03:55:46 INFO - 'PAGER': '/bin/cat', 03:55:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:46 INFO - 'PWD': '/builds/slave/test', 03:55:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:46 INFO - 'SHELL': '/bin/bash', 03:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAEEiziXc1/Listeners', 03:55:46 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 03:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:46 INFO - 'USER': 'cltbld', 03:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:46 INFO - 'XPC_FLAGS': '0x0', 03:55:46 INFO - 'XPC_SERVICE_NAME': '0', 03:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:46 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/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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:55:46 INFO - mozversion application_buildid: 20161130023745 03:55:46 INFO - mozversion application_changeset: e5a46a7cd14f7cc0a99298302239a66bd1658a3c 03:55:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:55:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:55:46 INFO - mozversion application_name: Firefox 03:55:46 INFO - mozversion application_remotingname: firefox-dev 03:55:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:55:46 INFO - mozversion application_vendor: Mozilla 03:55:46 INFO - mozversion application_version: 52.0a2 03:55:46 INFO - mozversion platform_buildid: 20161130023745 03:55:46 INFO - mozversion platform_changeset: e5a46a7cd14f7cc0a99298302239a66bd1658a3c 03:55:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:55:46 INFO - mozversion platform_version: 52.0a2 03:55:46 INFO - using testdate: 1480506946 03:55:46 INFO - actual date: 1480506946 03:55:46 INFO - starting webserver on 'localhost:54446' 03:55:46 INFO - SUITE-START | Running 2 tests 03:55:46 INFO - TEST-START | dromaeo_css 03:55:46 INFO - operating with platform_type : mac_ 03:55:46 INFO - Initialising browser for dromaeo_css test... 03:55:46 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp8lIsxD/profile http://localhost:54446/getInfo.html) 03:55:49 INFO - PROCESS | 2259 | 2016-11-30 03:55:49.680 plugin-container[2261:23870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 03:55:49 INFO - PROCESS | 2259 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:55:49 INFO - PROCESS | 2259 | 2016-11-30 03:55:49.682 plugin-container[2261:23870] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 03:55:49 INFO - PROCESS | 2259 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:55:49 INFO - PROCESS | 2259 | 2016-11-30 03:55:49.682 plugin-container[2261:23870] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:55:49 INFO - PROCESS | 2259 | __metrics Screen width/height:1600/1200 03:55:49 INFO - PROCESS | 2259 | colorDepth:24 03:55:49 INFO - PROCESS | 2259 | Browser inner width/height: 1024/689 03:55:49 INFO - PROCESS | 2259 | __metrics 03:55:49 ERROR - PROCESS | 2259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:55:50 INFO - TEST-INFO | 2259: exit 0 03:55:50 INFO - Browser initialized. 03:55:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:55:50 INFO - TEST-INFO | started process 2262 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp8lIsxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:53 INFO - PROCESS | 2262 | 2016-11-30 03:55:53.314 plugin-container[2263:24001] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 03:55:53 INFO - PROCESS | 2262 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:55:53 INFO - PROCESS | 2262 | 2016-11-30 03:55:53.315 plugin-container[2263:24001] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:55:53 INFO - PROCESS | 2262 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:55:53 INFO - PROCESS | 2262 | 2016-11-30 03:55:53.315 plugin-container[2263:24001] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:56:03 INFO - PROCESS | 2262 | RSS: Main: 228917248 03:56:03 INFO - PROCESS | 2262 | 03:56:52 INFO - PROCESS | 2262 | 1480507012644 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:59:06 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54446/tests/dromaeo/cssquery-ext.html) 03:59:08 INFO - PROCESS | 2262 | RSS: Main: 232022016 03:59:08 INFO - PROCESS | 2262 | 04:02:10 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-ext.html (next: http://localhost:54446/tests/dromaeo/cssquery-jquery.html) 04:02:11 INFO - PROCESS | 2262 | RSS: Main: 243032064 04:02:11 INFO - PROCESS | 2262 | 04:05:13 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54446/tests/dromaeo/cssquery-mootools.html) 04:05:14 INFO - PROCESS | 2262 | RSS: Main: 245915648 04:05:14 INFO - PROCESS | 2262 | 04:08:15 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54446/tests/dromaeo/cssquery-prototype.html) 04:08:16 INFO - PROCESS | 2262 | RSS: Main: 245260288 04:08:16 INFO - PROCESS | 2262 | 04:11:19 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54446/tests/dromaeo/cssquery-yui.html) 04:11:20 INFO - PROCESS | 2262 | RSS: Main: 249708544 04:11:20 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54446/tests/dromaeo/cssquery-yui.html (next: http://localhost:54446/tests/dromaeo/cssquery-dojo.html) 04:14:22 INFO - PROCESS | 2262 | RSS: Main: 251215872 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | __start_tp_report 04:14:22 INFO - PROCESS | 2262 | _x_x_mozilla_page_load 04:14:22 INFO - PROCESS | 2262 | _x_x_mozilla_page_load_details 04:14:22 INFO - PROCESS | 2262 | |i|pagename|runs| 04:14:22 INFO - PROCESS | 2262 | |0;dojo.html;3174.333389988102;3394.422948098823;3403.4894765785143;3423.1827425335937;3449.620541740408;5716.742746576404;5768.769249230026;5803.216565763621;5816.214811000514;5819.447152520504;5788.27646544182;5820.679862607555;5822.505087067604;5828.650280983144;5844.736986835592;4628.398308219927;5328.46715328468;5348.224507446418;5348.46515348464;5372.167314066326;5364.168553874136;5396.973015134919;5398.8920221595545;5411.891762164754;5428.75570599324;5258.211268309765;5272.182811664198;5389.541888939445;5390.91913621294;5398.24424580559;5321.866953326159;5344.893102137955;5393.487618676219;5413.566914646858;5447.836564903059;5194.662346947436;5328.813491527778;5330.200469929503;5374.0058089253225;5393.298871146726;5650.576206784466;5839.328477225131;5861.150133230701;5934.525237980951;5939.554533409968;6160.075988601746;6170;6191.0713392990965;6222.12890195373;6230.626162430269;6243.250809902841;6249.87500249997;6259.906101408483;6268.49852011838;6273.435390814803;5858.53131749459;5894.557908156906;5897.64614123154;5912.260967379078;5928.614640048426;5103.693778373236;6184.103305020837;6203.906941395882;6282.1519094921605;6326.810195694136;5634.408387119293;6028;6111.865232675556;6199.194104766351;6213.37866213375;6240.500759939194;6257.2491301044165;6263.937360626426;6269.0909818076125;6269.592476489013;6075.939240607538;6077.3314935357075;6127.724252408652;6130.754769809247;6155.569110162246;6123.4488895999575;6123.601965872204;6134.171886795315;6138.631682099089;6162.599431036968;4926.261060840831;4939.5554400104165;4983.476734942851;5004.424491183488;5021.046001259822;4440.089781594766;4444.400005999213;4460.286354183315;4467.7095988761275;4472.463304403427;4795.20879054952;5715.657060576379;5730.169125476783;5916.822495325147;5923.17075609415;6181.907271390933;6203.472704820141;6212.1303017577575;6251.906221406683;6310.0850376695125;5746.597738158289;5826.300843898759;5838.737256823453;5948.67282299469;5989.610675306091;5412.945870541323;5413.648112872651;5418.078926582491;5472.288602481652;5476.58925580583;6161.568690191643;6411.5832470889245;6439.00195469703;6441.774537891151;6444.097826304321;4724.385829842098;6182.227221597301;6183.165272688129;6222.408871157233;6238.500919926486;6366.554341196257;6375.489960803032;6377.808665740035;6379.362063793584;6415.582987105823;6240.594361366497;6250.968745156245;6252.3122456530655;6274.121622972696;6289.654069026247;6129.419919118684;6158.168647232566;6184.412480814495;6218.440340369389;6230.345813689497;6125.724342404514;6176.227971503562;6182.196314479089;6184.257889053342;6197.4732147767945;6100.359462256399;6143.84640383994;6151.415615516519;6187.381261873777;6210.875782484415;5211.114110601131;5709.172170035405;5809.448102430262;5872.647641141545;5881.2942446906645;6056.636601803906;6078;6089.421504957022;6133.957227271286;6139.416755408229;5984.95263328907;6036.879262414815;6038.969805150946;6052.213212282375;6096.664683442454 04:14:22 INFO - PROCESS | 2262 | |1;ext.html;463.8515674984004;486.6496122791591;489.532496465875;515.2245869965703;539.6761942834297;29529.40941181178;39628.40557391638;40742;40898.59101408985;41006;41766.791166044204;42291.36562951558;42307.57692423075;42615;42771.78614106925;8327.458715183493;9395.731576237189;9396.48319342436;9421.199198068172;9441.952790236039;9321.254299656046;9418.387804792666;9428.29287803414;9432.292578056638;9472.194863436616;7772.805679857992;8700.912990870105;9274.443533387985;9407.811843763155;9448.763780905463;9344.2524598032;9384.202342800836;9421.24630029596;9421.952890235574;9425.34022618417;9115.817683646355;9174.587143578556;9231.6307347706;9247.72256832296;9269.582868770922;38574.80712596419;39409.014774630865;39795.40306895399;39806.20387592261;39926.80036599799;3199.552062711199;3342.799432034086;3495.860165593373;3696.482492451059;3866.9226615467815;29010.709892901014;29453;29546;29724.70275297241;30226.54660180099;3102.1934297082694;3123.437781199383;3134.7648926330617;3139.199504126456;3248.772585918987;507251;516862.83137168526;517651.8234817641;518585.8141418613;518747;59706.70146649239;60041.39958600445;60096.699516502136;60128.69935650294;60225.69887150536;61779.07331390033;62905;63082.0537691935;63097;63109.68445157745;15820.841791582166;15845.445409410615;15894.682106357808;16076.196190190443;16076.919615401848;12348.753024939631;12379.75240495203;12478.18891772032;12487;12504.937475312747;15085.868559858054;16049.197540122947;16066.839331606769;16115.838841611434;16147.596310092342;3201.711845933877;5980.252468441445;6920.238773734885;7109.857802843914;7227.927720722831;852.3266619370628;910.239949642043;979.4466126638426;1065.4459680965854;1070.3127724987498;29630;29683;29705.85147074294;29726.851365743034;30033.549496757565;987.7431867714446;1035.435687550287;1047.8428235764695;1104.8784633690289;1192.713748700323;14930.552083437515;15018.69962600742;15224;15480.612984675474;15577.922110389376;656167;662014;662916;663213;664659;56751.43248567544;56823.43176568264;57027.863467509684;57227;57437;1176.758764453285;1199.310396521986;1221.8900298973135;1348.4875747215995;1465.9267036648125;23422.945967431166;23787.167449139197;28531.42937141287;29369;29668;48730.512694872596;49707.00585988188;50061;50190.749046255994;50337;534980;601767;602084;604866;605860;26059.869700651376;26385.944562217297;26450.338741531617;26458;26506.734932651198;39167.804160979016;44689.32966005448;45340.86647833831;45764.31353529633;46639;37743;37833.810830945666;38015;38038.80980595079;38616.2276754469;34909.65090349064;37617.4357384634;37963.620363796006;38616.034599134124;38787.2242555153;36110.09724756902;36419.817900910326;36962;37142.8142859284;37479.56382835107;31853;33362.33275334528;33923.83038084794;34003.829980849936;34014.319713605095;23716.391196968663;25282.494350113262;25451.74548254494;25490.617640735032;25516.617250741627 04:14:22 INFO - PROCESS | 2262 | |2;jquery.html;321.4118163760319;334.15958863458405;361.6961752128212;365.648976982097;399.9042623212397;14721;18028.18873150708;19619.5095122622;19633.312834050812;19760.913149776756;15202.467913623026;19576.804231957674;19728.81627102375;19742.605147897033;19750;5519.834404967847;5845.7369418376275;5852.917210316084;5861.472467477926;5873.500752436048;5473.8357849264585;5495.175723641466;5715.371309155989;5777.653340799566;5798.391168927265;5611.102223644218;5717.142428635717;5722.399148089453;5726.914096288559;5730.054541000751;5465.945340546603;5703.258576385085;5740.655560666352;5806.303243610793;5851.180834683148;5459.454054594548;5646.548276137899;5663.065594176997;5664.971675141639;5667.914981275284;12446.128770986035;12777.977761779128;12813.807792883114;12877.356132193447;12888.355582220851;2210.171185805323;2279.920202792894;2290.1297506947253;2378.881055947213;2381.011880069769;9199.954000229956;9567.952160239223;9740.805183896353;9841.655542056065;10263.2302577307;1851.268748844199;1865.3844231403605;1968.7145363922293;1969.3008981811538;1986.1856638778177;82996.58501707514;88159.11840881573;114779.27831082541;116890.83109168884;117763.4111829444;11624.244424112574;11747.765044699057;11825.113116516295;11861.525538978516;11993.820092698617;14324.212168330634;14419.990600657853;14456.638584035483;14478.927605361905;14524.63688407777;8172.346212303001;8290.212429819278;8294.838722578845;8315.085340612528;8350.164983501723;8184.6316915738935;8216.630251638691;8299.257155997188;8379.413441059067;8389.370797190235;4348.913021739548;4474.239379305526;4475;4493.146302202571;4563.06457176278;1662.2187571841216;1910.4937191644226;1931.9341748201484;1949.0996278628506;1953.1210955069992;790.3992965346263;830.7507747675794;953.6376177052675;989.9109080182818;999.7300728803183;19434.514137146685;19476.4157075288;19569.412917612495;19842.900785495982;20099;813.4265342933218;835.8370117827087;907.1336873285996;917.9908200917905;967.4437198610827;8693.608787604573;10494.947525262325;10498.95010498944;10523.579056837794;10551.894481055244;592380;594112;596627;609778;611363;128898;132831;134221;135565;137063;780.9687612495436;867.9001914779755;870.8476016697052;973.6056896956744;994.6667866264737;13116.5409210681;16589.75115373246;16769.422922855796;17895.37366192177;17919.910400448436;37681;57731.55671108088;58686;59005.40994589999;60412.395876040675;65125;84417.57791211005;84778;86478.56760716156;86973;6916.585004899722;7293.978842962096;7689.346405555367;7880.921190788019;8200.83598328042;12649.051321150766;12686.746265074462;12703.618891433272;12715.682107947376;13148.474061037452;10734.355938643706;10781.245312828027;10978.835317470084;11164.274322169033;11330.660080197607;9481.241500680067;10530.631427900293;10813.783724325627;10883.346999180074;11050.447477626247;10845.132389408986;11018.779624407307;11158.944205278922;11178.832317515082;11467.197296189186;7401.111866576045;7439.702411903463;7471.551706897603;7497.737579184703;7498.400127989857;9434.85847712271;10898.509567069343;11160.939710727467;11237.719057023312;11312.94343528277 04:14:22 INFO - PROCESS | 2262 | |3;mootools.html;1449.4202319072374;1486.3757221966773;1652.2399696139776;1723.7242041273398;1784.5092599535126;6331.683415829208;7146.7855964321025;7428.96285518573;7979.281864632189;8028;7504.962475187616;7789.987301650792;7862.646180921858;7872.842543149133;7905.683772649101;1976.476233798041;2302.0561569756405;2310.0066971202377;2312.4334538038206;2313.606686863229;2003.9679565024023;2256.255435706213;2315.131825565413;2322.4890524084676;2324.1052194904914;2188.5075857931915;2204.9669254961186;2233.932982010542;2234.6759719840693;2264.5810525052834;2074.4191626344646;2118.0045378672;2239.2274665240466;2259.954800903989;2273.6134857074253;1914.4161030885575;2242.955140897173;2259.898304576298;2263.343630347197;2264.252796577142;7821.765347039598;7859.68561257549;7928.405369597303;7935.801604959922;7945.324647404977;4870.512948705136;4969.478204788481;5032.547070763649;5074.162763144077;5080.364954380702;3097.9535306970415;3229.9838500807346;3391.9321613567836;3455.6198818129988;3463.0649724574478;896.2023798819056;947.5120313038791;959.2661613865398;985.6398170524702;1052.7578656908877;10046.648367307109;10122.595096196143;10177.745556361077;10205.897941020568;10214.387136771817;4061.5329237138108;4422.889427764331;4499.6400287976885;4522.4573051234065;4589.770511474413;6945.374916257561;7817.140114587391;8517.446365986316;8868.689595864244;8917.687880924137;4966.255061740696;4983.6760610560195;4986.501349865057;5006.4492905780335;5015.3229314042865;4097.549269580344;4573.771311434415;4611.861644150681;4615.699979501322;4674.462436819741;3737.084414318455;3757.4739536464917;3798.6771124454176;3818.8090595470117;3819.866304679323;1249.0632025980515;1252.2173641474078;1256.4157666685035;1257.0509265504486;1260.7770462651213;778.1362687416963;786.5880744064418;819.8647223208224;880.124276345028;916.2807196350833;5265.3944796348915;5395.730213489388;5447.754851031713;5507.201455788888;5604.887902241932;432.7533306015604;435.3491530162427;436.12774451097806;438.9780510974438;444.1538868455533;3695.7043436525014;3723.311187430334;3759.9060023499082;3782.791946442917;3827.8660246891227;8999.730008099768;9430.292728045286;9541.761455963657;9557.330986830855;9562.474063926551;9509.5720692569;9519.23846092311;9530.571124299424;9555.23558115363;9568.521573921276;6393.264774550986;6776.864462710718;7435.7025718970635;7462.291082347168;7870.881936770953;4651.279051746985;5154.072266991978;5382.354117505768;5385.892282154413;5501.284832971688;8582.742517724479;8889.244414224604;8962.820743585222;8965.910340896507;8990.32572557074;8450.66197352099;8826;8959.955200223958;9099.272058235458;9119;5388.407275199646;6318.494520438446;6532.118164047983;6694.196696396463;6861.142357205349;7467.1039475263315;7610.277023682741;7675.884861727191;7676.309132178131;7709.614519274126;6778.593284402951;6947.40947019509;6962.965185174245;6982.022516847544;7021.122359705037;6696.83257918556;6728.192616886005;6774.051632771515;6826;6844.486663500357;6407.167068281094;6437.613743175424;6442.516811239082;6470.158879345655;6502.739890404331;4565.7717114144825;4575.908481830278;4636.907261854812;4665.510121437336;4725.125851717443;4696.1546921554445;4712.717236965793;4720.929186062143;4749.4063242094735;4830.8792280193275 04:14:22 INFO - PROCESS | 2262 | |4;prototype.html;300.36472859901306;303.4901365705614;306.5830470560039;306.831242816451;312.8876842823761;4932.583034313187;5515.641483303582;5566.86082847929;5579.437757427917;5642.181883626877;5505.6696598204135;5508.779648814043;5514.283143191389;5578.944210557893;5593.776248950037;3387.8814241501555;3947.4868267125235;4097.19723321739;4125.525564560084;4172.123853990665;3417.8120203388803;3653.817309134546;4184.476940382452;4219.767912764797;4220;3702.2040261343805;4110.445089912869;4170.541240463546;4196.244675958326;4199.433076534659;3841.346971014906;4105.774182419966;4154.31453810121;4208.831646734127;4238.364245363189;3552.609212986569;3560;3567.500549923013;3571.2500374921296;3575.1955809942815;5324.547413469821;5375.892482150335;5382.84686125549;5383.804628533484;5391.649542779707;3641.3991691370893;3939.3500072488005;4658.091672123937;4713.670043096985;4751.360780530711;4215.114825886568;5731.455511726379;5759.395263497357;5831.3877042910735;5840.612444782017;3404.8467818948207;3577.4276115821604;3780.8298626561595;3890.2025084857537;3899.2786334528205;5058.570021548173;5261.421243663194;5277.891642755026;5320.866978325535;6023.789167379165;3226.435373809574;3699.741018128705;3954.1103251768122;3956.2680904032845;3966.186931678999;3568.589612194579;4036.7779772112817;4037.8788636340955;4052.230076285496;4056.817443215062;4199.67710171295;4688.359074323959;4689.835855745033;4712.387389639393;4765.880852978703;5258.316418865523;5363.597730170253;5548.528375088082;5778.3354914184565;5852.678102704393;1143.2111842828422;1254.9372531373394;1295.5271325966144;1304.9543265985835;1309.3649579953715;741.5021656254336;818.3698552114957;829.2619568583965;874.191372979991;881.6429346114834;4857.514248575114;5024.221245706921;5123.770295129217;5319.813806516753;5515.503604675599;4874.95125048745;5683.54531637468;5744.569157313218;5832.920909631732;6052.822268309085;5098.362704661918;5126.333576635014;5425.484578964992;5503.944960550423;5545.889082218333;2676.7992400570033;2804.214819850445;2855.1726894787353;2861.670907845583;3016.6078409806587;4956.8760780980765;5120.105560942401;5599.99200143978;5946.286445626552;6119.84700382494;5720.227769251098;5729.255196824386;6171.413715697002;6224.875502489925;6252.280987686383;5176.534111929945;6024.1566180734735;6256.562040657202;6286.937130628635;6337.3383179063985;5235.685858848481;5720.570957178145;6069.848253793514;6075.817725468243;6135.049067394561;5966.522678185822;5995.220621319375;5995.621007168288;5996.67018313997;6018.879622407615;5054.469280725618;5731.7420716067045;5975.970120149372;6333.086780081214;6339.415146213447;3300.62042865064;3370.752821456077;3979.462772525672;3988.9401658974557;4002.419649150915;5152.845414637567;5232.633715640021;5957.344692083954;6015.398460154124;6040.305364883095;5143;5569.972150139223;5856.472917437451;5882.117682347682;5902.852428689145;5748.48263656273;5759.39526349744;5807.390224026416;5829.53363730892;5845.720169134126;4171.957010747313;4699.906001880012;5266.154568429117;5390.541803946551;5711.400302968129;5533.501984821385;5569.805056822992;5740.512056475246;5774.2782152230975;5853.678047707417;5293.682379057269;5392.487713667196;5707;5763.7406316715005;5835.920354734388 04:14:22 INFO - PROCESS | 2262 | |5;yui.html;618.3198481670162;716.6667499612679;755.2032605601092;773.9690412383501;784.0238902566306;14013.789793153099;14227.146371217721;14348.497802576912;14443.205623690692;14946.327415266313;13115.016373771958;13399.263040532767;13566.796498052538;13572.389242484087;13592.184468931871;800.631709413669;826.8635675113599;827.4456114403334;830.6345208108443;831.3390854270839;645.6739346629945;665.3379887012405;819.5492479136481;826.3843436639681;841.0958219913587;880.1154839386408;881.6649673124203;883.960221790021;887.4054383563029;887.7336798960318;873.6811063961671;876.2245412809677;878.9979423457232;879.7009016934209;881.3874357321664;636.6657504809965;641.9165508483914;647.1586936981905;649.1074772188241;650.4666173737537;13679.316034198251;13812.86187138136;13854.653633659138;13939.16365018102;13979.65050873726;12299.938500307531;12819.166754161042;13106.541271055466;13206.933965330112;13344.332783360793;10297.485125743759;10763.19276054299;10809.081228095622;10900.563977440894;11152.442377881154;3577.3918433866306;3631.074076110575;3634.30948119859;3667.7615954962844;3675.1363429594026;79931.20068799295;80238.59880700617;80348;82660;84411;10059.849102263472;10132.088112069949;10171.7457063574;10355.430451325099;10425.895741042645;19884.801151988297;20031.799682002995;20157.697634535492;20203.79796202019;20215.29246476366;7610.315071643578;7619.466637335444;7625.618719064025;7653.234676532302;7827.530348179013;4151.46031015972;4230.682698797603;4336.891577710582;4345.478542574848;4367.908022994251;3193.8083714977174;3291.341731653631;3300.0924745694647;3301.5047742838287;3310.851011704479;592.1325258496323;611.8500967263049;618.832915112917;620.3548309757801;628.1990462160782;613.7667686279185;639.2105749399487;641.6919878458366;648.9967550162313;668.4451904918906;8823.735287941372;9065.274778017743;9101.852172922348;9115.453072815651;9214.76963075915;553.7037684838592;604.1994357476361;615.8214117905757;619.4734475695623;673.1484671890063;3275.033865009828;3439.9852043647184;4034.3948407738485;4370.759608221515;4420.425344705232;77632.22367776363;123111.38444307722;124350;126442;127538;106223.93776062141;106631;106675;107017.29827017392;108649;91823.54088229516;95619;95742.52128739312;97201.99999999859;97740;7358;7567.432442566939;8546.444481108709;8674.566271686517;8701.912980870111;43828.808559572535;50085;59231.988393873544;59523.70238148781;60779;57674;82881.17118828975;84249.57875210585;85460;88238.55880720812;10314.381137131797;10343.63797267092;10475.842862357224;10490.370577765358;10794.244402891722;11742.88257117418;11860.644180674593;11907.583234587095;11917.698582741332;12053.939730301292;11349.63376247525;11388.316700997966;11688.532458701557;11747.823782643438;12252.877471225174;11211.383373914514;11589.420528973686;11607.129465289969;11842.644720658394;11889.583864564698;11219.439028048728;11534.056257158596;11600.709982250173;11646.417679116179;11768.293902365886;9291.581878815334;9311.76720581991;9581.041895810364;10028.147607453448;10142.137918276734;9942.751431213988;10171.49142542855;10187.235957303084;10189.84715229287;10208.846867296848 04:14:22 INFO - PROCESS | 2262 | __end_tp_report 04:14:22 INFO - PROCESS | 2262 | __start_cc_report 04:14:22 INFO - PROCESS | 2262 | _x_x_mozilla_cycle_collect,368 04:14:22 INFO - PROCESS | 2262 | __end_cc_report 04:14:22 INFO - PROCESS | 2262 | __startTimestamp1480508062810__endTimestamp 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | ------- Summary: start ------- 04:14:22 INFO - PROCESS | 2262 | Number of tests: 6 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#0] dojo.html Cycles:165 Average:5765.83 Median:5984.95 stddev:634.76 (10.6%) stddev-sans-first:603.27 04:14:22 INFO - PROCESS | 2262 | Values: 3174.3 3394.4 3403.5 3423.2 3449.6 5716.7 5768.8 5803.2 5816.2 5819.4 5788.3 5820.7 5822.5 5828.7 5844.7 4628.4 5328.5 5348.2 5348.5 5372.2 5364.2 5397.0 5398.9 5411.9 5428.8 5258.2 5272.2 5389.5 5390.9 5398.2 5321.9 5344.9 5393.5 5413.6 5447.8 5194.7 5328.8 5330.2 5374.0 5393.3 5650.6 5839.3 5861.2 5934.5 5939.6 6160.1 6170.0 6191.1 6222.1 6230.6 6243.3 6249.9 6259.9 6268.5 6273.4 5858.5 5894.6 5897.6 5912.3 5928.6 5103.7 6184.1 6203.9 6282.2 6326.8 5634.4 6028.0 6111.9 6199.2 6213.4 6240.5 6257.2 6263.9 6269.1 6269.6 6075.9 6077.3 6127.7 6130.8 6155.6 6123.4 6123.6 6134.2 6138.6 6162.6 4926.3 4939.6 4983.5 5004.4 5021.0 4440.1 4444.4 4460.3 4467.7 4472.5 4795.2 5715.7 5730.2 5916.8 5923.2 6181.9 6203.5 6212.1 6251.9 6310.1 5746.6 5826.3 5838.7 5948.7 5989.6 5412.9 5413.6 5418.1 5472.3 5476.6 6161.6 6411.6 6439.0 6441.8 6444.1 4724.4 6182.2 6183.2 6222.4 6238.5 6366.6 6375.5 6377.8 6379.4 6415.6 6240.6 6251.0 6252.3 6274.1 6289.7 6129.4 6158.2 6184.4 6218.4 6230.3 6125.7 6176.2 6182.2 6184.3 6197.5 6100.4 6143.8 6151.4 6187.4 6210.9 5211.1 5709.2 5809.4 5872.6 5881.3 6056.6 6078.0 6089.4 6134.0 6139.4 5985.0 6036.9 6039.0 6052.2 6096.7 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#1] ext.html Cycles:180 Average:71323.67 Median:39518.71 stddev:158584.15 (401.3%) stddev-sans-first:158939.77 04:14:22 INFO - PROCESS | 2262 | Values: 463.9 486.6 489.5 515.2 539.7 29529.4 39628.4 40742.0 40898.6 41006.0 41766.8 42291.4 42307.6 42615.0 42771.8 8327.5 9395.7 9396.5 9421.2 9442.0 9321.3 9418.4 9428.3 9432.3 9472.2 7772.8 8700.9 9274.4 9407.8 9448.8 9344.3 9384.2 9421.2 9422.0 9425.3 9115.8 9174.6 9231.6 9247.7 9269.6 38574.8 39409.0 39795.4 39806.2 39926.8 3199.6 3342.8 3495.9 3696.5 3866.9 29010.7 29453.0 29546.0 29724.7 30226.5 3102.2 3123.4 3134.8 3139.2 3248.8 507251.0 516862.8 517651.8 518585.8 518747.0 59706.7 60041.4 60096.7 60128.7 60225.7 61779.1 62905.0 63082.1 63097.0 63109.7 15820.8 15845.4 15894.7 16076.2 16076.9 12348.8 12379.8 12478.2 12487.0 12504.9 15085.9 16049.2 16066.8 16115.8 16147.6 3201.7 5980.3 6920.2 7109.9 7227.9 852.3 910.2 979.4 1065.4 1070.3 29630.0 29683.0 29705.9 29726.9 30033.5 987.7 1035.4 1047.8 1104.9 1192.7 14930.6 15018.7 15224.0 15480.6 15577.9 656167.0 662014.0 662916.0 663213.0 664659.0 56751.4 56823.4 57027.9 57227.0 57437.0 1176.8 1199.3 1221.9 1348.5 1465.9 23422.9 23787.2 28531.4 29369.0 29668.0 48730.5 49707.0 50061.0 50190.7 50337.0 534980.0 601767.0 602084.0 604866.0 605860.0 26059.9 26385.9 26450.3 26458.0 26506.7 39167.8 44689.3 45340.9 45764.3 46639.0 37743.0 37833.8 38015.0 38038.8 38616.2 34909.7 37617.4 37963.6 38616.0 38787.2 36110.1 36419.8 36962.0 37142.8 37479.6 31853.0 33362.3 33923.8 34003.8 34014.3 23716.4 25282.5 25451.7 25490.6 25516.6 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#2] jquery.html Cycles:180 Average:34365.49 Median:19040.45 stddev:100344.72 (527.0%) stddev-sans-first:100593.66 04:14:22 INFO - PROCESS | 2262 | Values: 321.4 334.2 361.7 365.6 399.9 14721.0 18028.2 19619.5 19633.3 19760.9 15202.5 19576.8 19728.8 19742.6 19750.0 5519.8 5845.7 5852.9 5861.5 5873.5 5473.8 5495.2 5715.4 5777.7 5798.4 5611.1 5717.1 5722.4 5726.9 5730.1 5465.9 5703.3 5740.7 5806.3 5851.2 5459.5 5646.5 5663.1 5665.0 5667.9 12446.1 12778.0 12813.8 12877.4 12888.4 2210.2 2279.9 2290.1 2378.9 2381.0 9200.0 9568.0 9740.8 9841.7 10263.2 1851.3 1865.4 1968.7 1969.3 1986.2 82996.6 88159.1 114779.3 116890.8 117763.4 11624.2 11747.8 11825.1 11861.5 11993.8 14324.2 14420.0 14456.6 14478.9 14524.6 8172.3 8290.2 8294.8 8315.1 8350.2 8184.6 8216.6 8299.3 8379.4 8389.4 4348.9 4474.2 4475.0 4493.1 4563.1 1662.2 1910.5 1931.9 1949.1 1953.1 790.4 830.8 953.6 989.9 999.7 19434.5 19476.4 19569.4 19842.9 20099.0 813.4 835.8 907.1 918.0 967.4 8693.6 10494.9 10499.0 10523.6 10551.9 592380.0 594112.0 596627.0 609778.0 611363.0 128898.0 132831.0 134221.0 135565.0 137063.0 781.0 867.9 870.8 973.6 994.7 13116.5 16589.8 16769.4 17895.4 17919.9 37681.0 57731.6 58686.0 59005.4 60412.4 65125.0 84417.6 84778.0 86478.6 86973.0 6916.6 7294.0 7689.3 7880.9 8200.8 12649.1 12686.7 12703.6 12715.7 13148.5 10734.4 10781.2 10978.8 11164.3 11330.7 9481.2 10530.6 10813.8 10883.3 11050.4 10845.1 11018.8 11158.9 11178.8 11467.2 7401.1 7439.7 7471.6 7497.7 7498.4 9434.9 10898.5 11160.9 11237.7 11312.9 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#3] mootools.html Cycles:180 Average:5154.09 Median:5077.26 stddev:2786.86 (54.9%) stddev-sans-first:2780.77 04:14:22 INFO - PROCESS | 2262 | Values: 1449.4 1486.4 1652.2 1723.7 1784.5 6331.7 7146.8 7429.0 7979.3 8028.0 7505.0 7790.0 7862.6 7872.8 7905.7 1976.5 2302.1 2310.0 2312.4 2313.6 2004.0 2256.3 2315.1 2322.5 2324.1 2188.5 2205.0 2233.9 2234.7 2264.6 2074.4 2118.0 2239.2 2260.0 2273.6 1914.4 2243.0 2259.9 2263.3 2264.3 7821.8 7859.7 7928.4 7935.8 7945.3 4870.5 4969.5 5032.5 5074.2 5080.4 3098.0 3230.0 3391.9 3455.6 3463.1 896.2 947.5 959.3 985.6 1052.8 10046.6 10122.6 10177.7 10205.9 10214.4 4061.5 4422.9 4499.6 4522.5 4589.8 6945.4 7817.1 8517.4 8868.7 8917.7 4966.3 4983.7 4986.5 5006.4 5015.3 4097.5 4573.8 4611.9 4615.7 4674.5 3737.1 3757.5 3798.7 3818.8 3819.9 1249.1 1252.2 1256.4 1257.1 1260.8 778.1 786.6 819.9 880.1 916.3 5265.4 5395.7 5447.8 5507.2 5604.9 432.8 435.3 436.1 439.0 444.2 3695.7 3723.3 3759.9 3782.8 3827.9 8999.7 9430.3 9541.8 9557.3 9562.5 9509.6 9519.2 9530.6 9555.2 9568.5 6393.3 6776.9 7435.7 7462.3 7870.9 4651.3 5154.1 5382.4 5385.9 5501.3 8582.7 8889.2 8962.8 8965.9 8990.3 8450.7 8826.0 8960.0 9099.3 9119.0 5388.4 6318.5 6532.1 6694.2 6861.1 7467.1 7610.3 7675.9 7676.3 7709.6 6778.6 6947.4 6963.0 6982.0 7021.1 6696.8 6728.2 6774.1 6826.0 6844.5 6407.2 6437.6 6442.5 6470.2 6502.7 4565.8 4575.9 4636.9 4665.5 4725.1 4696.2 4712.7 4720.9 4749.4 4830.9 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#4] prototype.html Cycles:180 Average:4630.84 Median:5263.79 stddev:1474.09 (28.0%) stddev-sans-first:1441.94 04:14:22 INFO - PROCESS | 2262 | Values: 300.4 303.5 306.6 306.8 312.9 4932.6 5515.6 5566.9 5579.4 5642.2 5505.7 5508.8 5514.3 5578.9 5593.8 3387.9 3947.5 4097.2 4125.5 4172.1 3417.8 3653.8 4184.5 4219.8 4220.0 3702.2 4110.4 4170.5 4196.2 4199.4 3841.3 4105.8 4154.3 4208.8 4238.4 3552.6 3560.0 3567.5 3571.3 3575.2 5324.5 5375.9 5382.8 5383.8 5391.6 3641.4 3939.4 4658.1 4713.7 4751.4 4215.1 5731.5 5759.4 5831.4 5840.6 3404.8 3577.4 3780.8 3890.2 3899.3 5058.6 5261.4 5277.9 5320.9 6023.8 3226.4 3699.7 3954.1 3956.3 3966.2 3568.6 4036.8 4037.9 4052.2 4056.8 4199.7 4688.4 4689.8 4712.4 4765.9 5258.3 5363.6 5548.5 5778.3 5852.7 1143.2 1254.9 1295.5 1305.0 1309.4 741.5 818.4 829.3 874.2 881.6 4857.5 5024.2 5123.8 5319.8 5515.5 4875.0 5683.5 5744.6 5832.9 6052.8 5098.4 5126.3 5425.5 5503.9 5545.9 2676.8 2804.2 2855.2 2861.7 3016.6 4956.9 5120.1 5600.0 5946.3 6119.8 5720.2 5729.3 6171.4 6224.9 6252.3 5176.5 6024.2 6256.6 6286.9 6337.3 5235.7 5720.6 6069.8 6075.8 6135.0 5966.5 5995.2 5995.6 5996.7 6018.9 5054.5 5731.7 5976.0 6333.1 6339.4 3300.6 3370.8 3979.5 3988.9 4002.4 5152.8 5232.6 5957.3 6015.4 6040.3 5143.0 5570.0 5856.5 5882.1 5902.9 5748.5 5759.4 5807.4 5829.5 5845.7 4172.0 4699.9 5266.2 5390.5 5711.4 5533.5 5569.8 5740.5 5774.3 5853.7 5293.7 5392.5 5707.0 5763.7 5835.9 04:14:22 INFO - PROCESS | 2262 | 04:14:22 INFO - PROCESS | 2262 | [#5] yui.html Cycles:180 Average:20939.27 Median:4341.19 stddev:32260.91 (743.1%) stddev-sans-first:32315.33 04:14:22 INFO - PROCESS | 2262 | Values: 618.3 716.7 755.2 774.0 784.0 14013.8 14227.1 14348.5 14443.2 14946.3 13115.0 13399.3 13566.8 13572.4 13592.2 800.6 826.9 827.4 830.6 831.3 645.7 665.3 819.5 826.4 841.1 880.1 881.7 884.0 887.4 887.7 873.7 876.2 879.0 879.7 881.4 636.7 641.9 647.2 649.1 650.5 13679.3 13812.9 13854.7 13939.2 13979.7 12299.9 12819.2 13106.5 13206.9 13344.3 10297.5 10763.2 10809.1 10900.6 11152.4 3577.4 3631.1 3634.3 3667.8 3675.1 79931.2 80238.6 80348.0 82660.0 84411.0 10059.8 10132.1 10171.7 10355.4 10425.9 19884.8 20031.8 20157.7 20203.8 20215.3 7610.3 7619.5 7625.6 7653.2 7827.5 4151.5 4230.7 4336.9 4345.5 4367.9 3193.8 3291.3 3300.1 3301.5 3310.9 592.1 611.9 618.8 620.4 628.2 613.8 639.2 641.7 649.0 668.4 8823.7 9065.3 9101.9 9115.5 9214.8 553.7 604.2 615.8 619.5 673.1 3275.0 3440.0 4034.4 4370.8 4420.4 77632.2 123111.4 124350.0 126442.0 127538.0 106223.9 106631.0 106675.0 107017.3 108649.0 91823.5 95619.0 95742.5 97202.0 97740.0 7358.0 7567.4 8546.4 8674.6 8701.9 43828.8 50085.0 59232.0 59523.7 60779.0 57674.0 82881.2 84249.6 85460.0 88238.6 10314.4 10343.6 10475.8 10490.4 10794.2 11742.9 11860.6 11907.6 11917.7 12053.9 11349.6 11388.3 11688.5 11747.8 12252.9 11211.4 11589.4 11607.1 11842.6 11889.6 11219.4 11534.1 11600.7 11646.4 11768.3 9291.6 9311.8 9581.0 10028.1 10142.1 9942.8 10171.5 10187.2 10189.8 10208.8 04:14:22 INFO - PROCESS | 2262 | -------- Summary: end -------- 04:14:22 INFO - PROCESS | 2262 | 04:14:23 INFO - TEST-INFO | 2262: exit 0 04:14:23 INFO - TEST-OK | dromaeo_css | took 1116840ms 04:14:23 INFO - TEST-START | kraken 04:14:23 INFO - operating with platform_type : mac_ 04:14:23 INFO - Initialising browser for kraken test... 04:14:23 INFO - TEST-INFO | started process 2267 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp83qOHz/profile http://localhost:54446/getInfo.html) 04:14:26 INFO - PROCESS | 2267 | 2016-11-30 04:14:26.393 plugin-container[2268:26254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 04:14:26 INFO - PROCESS | 2267 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:26 INFO - PROCESS | 2267 | 2016-11-30 04:14:26.397 plugin-container[2268:26254] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 04:14:26 INFO - PROCESS | 2267 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:26 INFO - PROCESS | 2267 | 2016-11-30 04:14:26.397 plugin-container[2268:26254] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:14:26 INFO - PROCESS | 2267 | __metrics Screen width/height:1600/1200 04:14:26 INFO - PROCESS | 2267 | colorDepth:24 04:14:26 INFO - PROCESS | 2267 | Browser inner width/height: 1024/689 04:14:26 INFO - PROCESS | 2267 | __metrics 04:14:26 ERROR - PROCESS | 2267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:14:27 INFO - TEST-INFO | 2267: exit 0 04:14:27 INFO - Browser initialized. 04:14:27 INFO - Running cycle 1/1 for kraken test... 04:14:27 INFO - TEST-INFO | started process 2269 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp83qOHz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:30 INFO - PROCESS | 2269 | 2016-11-30 04:14:30.282 plugin-container[2270:26375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:14:30 INFO - PROCESS | 2269 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:30 INFO - PROCESS | 2269 | 2016-11-30 04:14:30.283 plugin-container[2270:26375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:14:30 INFO - PROCESS | 2269 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:30 INFO - PROCESS | 2269 | 2016-11-30 04:14:30.283 plugin-container[2270:26375] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:14:39 INFO - PROCESS | 2269 | RSS: Main: 229171200 04:14:39 INFO - PROCESS | 2269 | 04:14:43 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54446/tests/kraken/driver.html?testName=audio-beat-detection) 04:14:43 INFO - PROCESS | 2269 | RSS: Main: 241426432 04:14:43 INFO - PROCESS | 2269 | 04:14:46 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54446/tests/kraken/driver.html?testName=audio-dft) 04:14:47 INFO - PROCESS | 2269 | RSS: Main: 249012224 04:14:47 INFO - PROCESS | 2269 | 04:14:50 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54446/tests/kraken/driver.html?testName=audio-fft) 04:14:51 INFO - PROCESS | 2269 | RSS: Main: 252698624 04:14:51 INFO - PROCESS | 2269 | 04:14:53 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54446/tests/kraken/driver.html?testName=audio-oscillator) 04:14:53 INFO - PROCESS | 2269 | RSS: Main: 252960768 04:14:53 INFO - PROCESS | 2269 | 04:14:55 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:14:56 INFO - PROCESS | 2269 | RSS: Main: 254365696 04:14:56 INFO - PROCESS | 2269 | 04:14:59 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54446/tests/kraken/driver.html?testName=imaging-darkroom) 04:14:59 INFO - PROCESS | 2269 | RSS: Main: 258609152 04:14:59 INFO - PROCESS | 2269 | 04:15:03 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54446/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:03 INFO - PROCESS | 2269 | RSS: Main: 257953792 04:15:03 INFO - PROCESS | 2269 | 04:15:06 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54446/tests/kraken/driver.html?testName=json-parse-financial) 04:15:07 INFO - PROCESS | 2269 | RSS: Main: 257695744 04:15:07 INFO - PROCESS | 2269 | 04:15:09 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:09 INFO - PROCESS | 2269 | RSS: Main: 256761856 04:15:09 INFO - PROCESS | 2269 | 04:15:11 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:12 INFO - PROCESS | 2269 | RSS: Main: 257228800 04:15:12 INFO - PROCESS | 2269 | 04:15:14 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:15 INFO - PROCESS | 2269 | RSS: Main: 256819200 04:15:15 INFO - PROCESS | 2269 | 04:15:18 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:15:19 INFO - PROCESS | 2269 | RSS: Main: 257122304 04:15:19 INFO - PROCESS | 2269 | 04:15:22 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:15:22 INFO - PROCESS | 2269 | RSS: Main: 256974848 04:15:22 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | Cycle 1(1): loaded http://localhost:54446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54446/tests/kraken/driver.html?testName=ai-astar) 04:15:24 INFO - PROCESS | 2269 | RSS: Main: 258887680 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | __start_tp_report 04:15:24 INFO - PROCESS | 2269 | _x_x_mozilla_page_load 04:15:24 INFO - PROCESS | 2269 | _x_x_mozilla_page_load_details 04:15:24 INFO - PROCESS | 2269 | |i|pagename|runs| 04:15:24 INFO - PROCESS | 2269 | |0;ai-astar;110;159;120;120;118;120;120;130;162;119 04:15:24 INFO - PROCESS | 2269 | |1;audio-beat-detection;152;117;115;134;145;104;131;147;179;123 04:15:24 INFO - PROCESS | 2269 | |2;audio-dft;198;195;198;196;196;207;197;197;196;196 04:15:24 INFO - PROCESS | 2269 | |3;audio-fft;82;58;57;85;64;75;79;66;78;61 04:15:24 INFO - PROCESS | 2269 | |4;audio-oscillator;87;70;93;70;72;71;114;92;69;89 04:15:24 INFO - PROCESS | 2269 | |5;imaging-gaussian-blur;91;90;113;121;126;88;93;87;90;123 04:15:24 INFO - PROCESS | 2269 | |6;imaging-darkroom;146;97;119;108;149;132;115;93;94;149 04:15:24 INFO - PROCESS | 2269 | |7;imaging-desaturate;98;92;98;136;136;98;142;120;89;138 04:15:24 INFO - PROCESS | 2269 | |8;json-parse-financial;58;59;57;60;59;61;60;71;88;89 04:15:24 INFO - PROCESS | 2269 | |9;json-stringify-tinderbox;69;77;74;84;79;72;72;73;72;75 04:15:24 INFO - PROCESS | 2269 | |10;stanford-crypto-aes;86;99;87;86;85;83;95;106;102;84 04:15:24 INFO - PROCESS | 2269 | |11;stanford-crypto-ccm;169;163;152;151;157;154;153;161;200;171 04:15:24 INFO - PROCESS | 2269 | |12;stanford-crypto-pbkdf2;221;179;172;181;171;226;184;174;172;179 04:15:24 INFO - PROCESS | 2269 | |13;stanford-crypto-sha256-iterative;67;68;69;69;69;67;68;66;66;69 04:15:24 INFO - PROCESS | 2269 | __end_tp_report 04:15:24 INFO - PROCESS | 2269 | __start_cc_report 04:15:24 INFO - PROCESS | 2269 | _x_x_mozilla_cycle_collect,987 04:15:24 INFO - PROCESS | 2269 | __end_cc_report 04:15:24 INFO - PROCESS | 2269 | __startTimestamp1480508124857__endTimestamp 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | ------- Summary: start ------- 04:15:24 INFO - PROCESS | 2269 | Number of tests: 14 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#0] ai-astar Cycles:10 Average:127.80 Median:120.00 stddev:17.89 (14.9%) stddev-sans-first:17.78 04:15:24 INFO - PROCESS | 2269 | Values: 110.0 159.0 120.0 120.0 118.0 120.0 120.0 130.0 162.0 119.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:139.50 stddev:21.89 (15.7%) stddev-sans-first:22.31 04:15:24 INFO - PROCESS | 2269 | Values: 152.0 117.0 115.0 134.0 145.0 104.0 131.0 147.0 179.0 123.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#2] audio-dft Cycles:10 Average:197.60 Median:197.00 stddev:3.44 (1.7%) stddev-sans-first:3.64 04:15:24 INFO - PROCESS | 2269 | Values: 198.0 195.0 198.0 196.0 196.0 207.0 197.0 197.0 196.0 196.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#3] audio-fft Cycles:10 Average:70.50 Median:76.50 stddev:10.45 (13.7%) stddev-sans-first:10.22 04:15:24 INFO - PROCESS | 2269 | Values: 82.0 58.0 57.0 85.0 64.0 75.0 79.0 66.0 78.0 61.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:79.50 stddev:14.88 (18.7%) stddev-sans-first:15.70 04:15:24 INFO - PROCESS | 2269 | Values: 87.0 70.0 93.0 70.0 72.0 71.0 114.0 92.0 69.0 89.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#5] imaging-gaussian-blur Cycles:10 Average:102.20 Median:89.00 stddev:16.36 (18.4%) stddev-sans-first:16.85 04:15:24 INFO - PROCESS | 2269 | Values: 91.0 90.0 113.0 121.0 126.0 88.0 93.0 87.0 90.0 123.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#6] imaging-darkroom Cycles:10 Average:120.20 Median:149.00 stddev:22.62 (15.2%) stddev-sans-first:21.98 04:15:24 INFO - PROCESS | 2269 | Values: 146.0 97.0 119.0 108.0 149.0 132.0 115.0 93.0 94.0 149.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#7] imaging-desaturate Cycles:10 Average:114.70 Median:90.50 stddev:21.70 (24.0%) stddev-sans-first:22.15 04:15:24 INFO - PROCESS | 2269 | Values: 98.0 92.0 98.0 136.0 136.0 98.0 142.0 120.0 89.0 138.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:60.50 stddev:12.37 (20.4%) stddev-sans-first:12.76 04:15:24 INFO - PROCESS | 2269 | Values: 58.0 59.0 57.0 60.0 59.0 61.0 60.0 71.0 88.0 89.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:74.50 stddev:4.32 (5.8%) stddev-sans-first:4.06 04:15:24 INFO - PROCESS | 2269 | Values: 69.0 77.0 74.0 84.0 79.0 72.0 72.0 73.0 72.0 75.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:86.00 stddev:8.43 (9.8%) stddev-sans-first:8.72 04:15:24 INFO - PROCESS | 2269 | Values: 86.0 99.0 87.0 86.0 85.0 83.0 95.0 106.0 102.0 84.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#11] stanford-crypto-ccm Cycles:10 Average:163.10 Median:162.00 stddev:14.74 (9.1%) stddev-sans-first:15.48 04:15:24 INFO - PROCESS | 2269 | Values: 169.0 163.0 152.0 151.0 157.0 154.0 153.0 161.0 200.0 171.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.90 Median:180.00 stddev:20.31 (11.3%) stddev-sans-first:17.12 04:15:24 INFO - PROCESS | 2269 | Values: 221.0 179.0 172.0 181.0 171.0 226.0 184.0 174.0 172.0 179.0 04:15:24 INFO - PROCESS | 2269 | 04:15:24 INFO - PROCESS | 2269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 04:15:24 INFO - PROCESS | 2269 | Values: 67.0 68.0 69.0 69.0 69.0 67.0 68.0 66.0 66.0 69.0 04:15:24 INFO - PROCESS | 2269 | -------- Summary: end -------- 04:15:24 INFO - PROCESS | 2269 | 04:15:25 INFO - TEST-INFO | 2269: exit 0 04:15:25 INFO - TEST-OK | kraken | took 62454ms 04:15:25 INFO - SUITE-END | took 1179s 04:15:26 INFO - Completed test suite (00:19:39) 04:15:26 INFO - javascript benchmark 04:15:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7057.270172118129, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.333389988102, 3394.422948098823, 3403.4894765785143, 3423.1827425335937, 3449.620541740408, 5716.742746576404, 5768.769249230026, 5803.216565763621, 5816.214811000514, 5819.447152520504, 5788.27646544182, 5820.679862607555, 5822.505087067604, 5828.650280983144, 5844.736986835592, 4628.398308219927, 5328.46715328468, 5348.224507446418, 5348.46515348464, 5372.167314066326, 5364.168553874136, 5396.973015134919, 5398.8920221595545, 5411.891762164754, 5428.75570599324, 5258.211268309765, 5272.182811664198, 5389.541888939445, 5390.91913621294, 5398.24424580559, 5321.866953326159, 5344.893102137955, 5393.487618676219, 5413.566914646858, 5447.836564903059, 5194.662346947436, 5328.813491527778, 5330.200469929503, 5374.0058089253225, 5393.298871146726, 5650.576206784466, 5839.328477225131, 5861.150133230701, 5934.525237980951, 5939.554533409968, 6160.075988601746, 6170.0, 6191.0713392990965, 6222.12890195373, 6230.626162430269, 6243.250809902841, 6249.87500249997, 6259.906101408483, 6268.49852011838, 6273.435390814803, 5858.53131749459, 5894.557908156906, 5897.64614123154, 5912.260967379078, 5928.614640048426, 5103.693778373236, 6184.103305020837, 6203.906941395882, 6282.1519094921605, 6326.810195694136, 5634.408387119293, 6028.0, 6111.865232675556, 6199.194104766351, 6213.37866213375, 6240.500759939194, 6257.2491301044165, 6263.937360626426, 6269.0909818076125, 6269.592476489013, 6075.939240607538, 6077.3314935357075, 6127.724252408652, 6130.754769809247, 6155.569110162246, 6123.4488895999575, 6123.601965872204, 6134.171886795315, 6138.631682099089, 6162.599431036968, 4926.261060840831, 4939.5554400104165, 4983.476734942851, 5004.424491183488, 5021.046001259822, 4440.089781594766, 4444.400005999213, 4460.286354183315, 4467.7095988761275, 4472.463304403427, 4795.20879054952, 5715.657060576379, 5730.169125476783, 5916.822495325147, 5923.17075609415, 6181.907271390933, 6203.472704820141, 6212.1303017577575, 6251.906221406683, 6310.0850376695125, 5746.597738158289, 5826.300843898759, 5838.737256823453, 5948.67282299469, 5989.610675306091, 5412.945870541323, 5413.648112872651, 5418.078926582491, 5472.288602481652, 5476.58925580583, 6161.568690191643, 6411.5832470889245, 6439.00195469703, 6441.774537891151, 6444.097826304321, 4724.385829842098, 6182.227221597301, 6183.165272688129, 6222.408871157233, 6238.500919926486, 6366.554341196257, 6375.489960803032, 6377.808665740035, 6379.362063793584, 6415.582987105823, 6240.594361366497, 6250.968745156245, 6252.3122456530655, 6274.121622972696, 6289.654069026247, 6129.419919118684, 6158.168647232566, 6184.412480814495, 6218.440340369389, 6230.345813689497, 6125.724342404514, 6176.227971503562, 6182.196314479089, 6184.257889053342, 6197.4732147767945, 6100.359462256399, 6143.84640383994, 6151.415615516519, 6187.381261873777, 6210.875782484415, 5211.114110601131, 5709.172170035405, 5809.448102430262, 5872.647641141545, 5881.2942446906645, 6056.636601803906, 6078.0, 6089.421504957022, 6133.957227271286, 6139.416755408229, 5984.95263328907, 6036.879262414815, 6038.969805150946, 6052.213212282375, 6096.664683442454], "value": 5726.965813215267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.8515674984004, 486.6496122791591, 489.532496465875, 515.2245869965703, 539.6761942834297, 29529.40941181178, 39628.40557391638, 40742.0, 40898.59101408985, 41006.0, 41766.791166044204, 42291.36562951558, 42307.57692423075, 42615.0, 42771.78614106925, 8327.458715183493, 9395.731576237189, 9396.48319342436, 9421.199198068172, 9441.952790236039, 9321.254299656046, 9418.387804792666, 9428.29287803414, 9432.292578056638, 9472.194863436616, 7772.805679857992, 8700.912990870105, 9274.443533387985, 9407.811843763155, 9448.763780905463, 9344.2524598032, 9384.202342800836, 9421.24630029596, 9421.952890235574, 9425.34022618417, 9115.817683646355, 9174.587143578556, 9231.6307347706, 9247.72256832296, 9269.582868770922, 38574.80712596419, 39409.014774630865, 39795.40306895399, 39806.20387592261, 39926.80036599799, 3199.552062711199, 3342.799432034086, 3495.860165593373, 3696.482492451059, 3866.9226615467815, 29010.709892901014, 29453.0, 29546.0, 29724.70275297241, 30226.54660180099, 3102.1934297082694, 3123.437781199383, 3134.7648926330617, 3139.199504126456, 3248.772585918987, 507251.0, 516862.83137168526, 517651.8234817641, 518585.8141418613, 518747.0, 59706.70146649239, 60041.39958600445, 60096.699516502136, 60128.69935650294, 60225.69887150536, 61779.07331390033, 62905.0, 63082.0537691935, 63097.0, 63109.68445157745, 15820.841791582166, 15845.445409410615, 15894.682106357808, 16076.196190190443, 16076.919615401848, 12348.753024939631, 12379.75240495203, 12478.18891772032, 12487.0, 12504.937475312747, 15085.868559858054, 16049.197540122947, 16066.839331606769, 16115.838841611434, 16147.596310092342, 3201.711845933877, 5980.252468441445, 6920.238773734885, 7109.857802843914, 7227.927720722831, 852.3266619370628, 910.239949642043, 979.4466126638426, 1065.4459680965854, 1070.3127724987498, 29630.0, 29683.0, 29705.85147074294, 29726.851365743034, 30033.549496757565, 987.7431867714446, 1035.435687550287, 1047.8428235764695, 1104.8784633690289, 1192.713748700323, 14930.552083437515, 15018.69962600742, 15224.0, 15480.612984675474, 15577.922110389376, 656167.0, 662014.0, 662916.0, 663213.0, 664659.0, 56751.43248567544, 56823.43176568264, 57027.863467509684, 57227.0, 57437.0, 1176.758764453285, 1199.310396521986, 1221.8900298973135, 1348.4875747215995, 1465.9267036648125, 23422.945967431166, 23787.167449139197, 28531.42937141287, 29369.0, 29668.0, 48730.512694872596, 49707.00585988188, 50061.0, 50190.749046255994, 50337.0, 534980.0, 601767.0, 602084.0, 604866.0, 605860.0, 26059.869700651376, 26385.944562217297, 26450.338741531617, 26458.0, 26506.734932651198, 39167.804160979016, 44689.32966005448, 45340.86647833831, 45764.31353529633, 46639.0, 37743.0, 37833.810830945666, 38015.0, 38038.80980595079, 38616.2276754469, 34909.65090349064, 37617.4357384634, 37963.620363796006, 38616.034599134124, 38787.2242555153, 36110.09724756902, 36419.817900910326, 36962.0, 37142.8142859284, 37479.56382835107, 31853.0, 33362.33275334528, 33923.83038084794, 34003.829980849936, 34014.319713605095, 23716.391196968663, 25282.494350113262, 25451.74548254494, 25490.617640735032, 25516.617250741627], "value": 19441.315374597514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.4118163760319, 334.15958863458405, 361.6961752128212, 365.648976982097, 399.9042623212397, 14721.0, 18028.18873150708, 19619.5095122622, 19633.312834050812, 19760.913149776756, 15202.467913623026, 19576.804231957674, 19728.81627102375, 19742.605147897033, 19750.0, 5519.834404967847, 5845.7369418376275, 5852.917210316084, 5861.472467477926, 5873.500752436048, 5473.8357849264585, 5495.175723641466, 5715.371309155989, 5777.653340799566, 5798.391168927265, 5611.102223644218, 5717.142428635717, 5722.399148089453, 5726.914096288559, 5730.054541000751, 5465.945340546603, 5703.258576385085, 5740.655560666352, 5806.303243610793, 5851.180834683148, 5459.454054594548, 5646.548276137899, 5663.065594176997, 5664.971675141639, 5667.914981275284, 12446.128770986035, 12777.977761779128, 12813.807792883114, 12877.356132193447, 12888.355582220851, 2210.171185805323, 2279.920202792894, 2290.1297506947253, 2378.881055947213, 2381.011880069769, 9199.954000229956, 9567.952160239223, 9740.805183896353, 9841.655542056065, 10263.2302577307, 1851.268748844199, 1865.3844231403605, 1968.7145363922293, 1969.3008981811538, 1986.1856638778177, 82996.58501707514, 88159.11840881573, 114779.27831082541, 116890.83109168884, 117763.4111829444, 11624.244424112574, 11747.765044699057, 11825.113116516295, 11861.525538978516, 11993.820092698617, 14324.212168330634, 14419.990600657853, 14456.638584035483, 14478.927605361905, 14524.63688407777, 8172.346212303001, 8290.212429819278, 8294.838722578845, 8315.085340612528, 8350.164983501723, 8184.6316915738935, 8216.630251638691, 8299.257155997188, 8379.413441059067, 8389.370797190235, 4348.913021739548, 4474.239379305526, 4475.0, 4493.146302202571, 4563.06457176278, 1662.2187571841216, 1910.4937191644226, 1931.9341748201484, 1949.0996278628506, 1953.1210955069992, 790.3992965346263, 830.7507747675794, 953.6376177052675, 989.9109080182818, 999.7300728803183, 19434.514137146685, 19476.4157075288, 19569.412917612495, 19842.900785495982, 20099.0, 813.4265342933218, 835.8370117827087, 907.1336873285996, 917.9908200917905, 967.4437198610827, 8693.608787604573, 10494.947525262325, 10498.95010498944, 10523.579056837794, 10551.894481055244, 592380.0, 594112.0, 596627.0, 609778.0, 611363.0, 128898.0, 132831.0, 134221.0, 135565.0, 137063.0, 780.9687612495436, 867.9001914779755, 870.8476016697052, 973.6056896956744, 994.6667866264737, 13116.5409210681, 16589.75115373246, 16769.422922855796, 17895.37366192177, 17919.910400448436, 37681.0, 57731.55671108088, 58686.0, 59005.40994589999, 60412.395876040675, 65125.0, 84417.57791211005, 84778.0, 86478.56760716156, 86973.0, 6916.585004899722, 7293.978842962096, 7689.346405555367, 7880.921190788019, 8200.83598328042, 12649.051321150766, 12686.746265074462, 12703.618891433272, 12715.682107947376, 13148.474061037452, 10734.355938643706, 10781.245312828027, 10978.835317470084, 11164.274322169033, 11330.660080197607, 9481.241500680067, 10530.631427900293, 10813.783724325627, 10883.346999180074, 11050.447477626247, 10845.132389408986, 11018.779624407307, 11158.944205278922, 11178.832317515082, 11467.197296189186, 7401.111866576045, 7439.702411903463, 7471.551706897603, 7497.737579184703, 7498.400127989857, 9434.85847712271, 10898.509567069343, 11160.939710727467, 11237.719057023312, 11312.94343528277], "value": 9121.484302103123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.4202319072374, 1486.3757221966773, 1652.2399696139776, 1723.7242041273398, 1784.5092599535126, 6331.683415829208, 7146.7855964321025, 7428.96285518573, 7979.281864632189, 8028.0, 7504.962475187616, 7789.987301650792, 7862.646180921858, 7872.842543149133, 7905.683772649101, 1976.476233798041, 2302.0561569756405, 2310.0066971202377, 2312.4334538038206, 2313.606686863229, 2003.9679565024023, 2256.255435706213, 2315.131825565413, 2322.4890524084676, 2324.1052194904914, 2188.5075857931915, 2204.9669254961186, 2233.932982010542, 2234.6759719840693, 2264.5810525052834, 2074.4191626344646, 2118.0045378672, 2239.2274665240466, 2259.954800903989, 2273.6134857074253, 1914.4161030885575, 2242.955140897173, 2259.898304576298, 2263.343630347197, 2264.252796577142, 7821.765347039598, 7859.68561257549, 7928.405369597303, 7935.801604959922, 7945.324647404977, 4870.512948705136, 4969.478204788481, 5032.547070763649, 5074.162763144077, 5080.364954380702, 3097.9535306970415, 3229.9838500807346, 3391.9321613567836, 3455.6198818129988, 3463.0649724574478, 896.2023798819056, 947.5120313038791, 959.2661613865398, 985.6398170524702, 1052.7578656908877, 10046.648367307109, 10122.595096196143, 10177.745556361077, 10205.897941020568, 10214.387136771817, 4061.5329237138108, 4422.889427764331, 4499.6400287976885, 4522.4573051234065, 4589.770511474413, 6945.374916257561, 7817.140114587391, 8517.446365986316, 8868.689595864244, 8917.687880924137, 4966.255061740696, 4983.6760610560195, 4986.501349865057, 5006.4492905780335, 5015.3229314042865, 4097.549269580344, 4573.771311434415, 4611.861644150681, 4615.699979501322, 4674.462436819741, 3737.084414318455, 3757.4739536464917, 3798.6771124454176, 3818.8090595470117, 3819.866304679323, 1249.0632025980515, 1252.2173641474078, 1256.4157666685035, 1257.0509265504486, 1260.7770462651213, 778.1362687416963, 786.5880744064418, 819.8647223208224, 880.124276345028, 916.2807196350833, 5265.3944796348915, 5395.730213489388, 5447.754851031713, 5507.201455788888, 5604.887902241932, 432.7533306015604, 435.3491530162427, 436.12774451097806, 438.9780510974438, 444.1538868455533, 3695.7043436525014, 3723.311187430334, 3759.9060023499082, 3782.791946442917, 3827.8660246891227, 8999.730008099768, 9430.292728045286, 9541.761455963657, 9557.330986830855, 9562.474063926551, 9509.5720692569, 9519.23846092311, 9530.571124299424, 9555.23558115363, 9568.521573921276, 6393.264774550986, 6776.864462710718, 7435.7025718970635, 7462.291082347168, 7870.881936770953, 4651.279051746985, 5154.072266991978, 5382.354117505768, 5385.892282154413, 5501.284832971688, 8582.742517724479, 8889.244414224604, 8962.820743585222, 8965.910340896507, 8990.32572557074, 8450.66197352099, 8826.0, 8959.955200223958, 9099.272058235458, 9119.0, 5388.407275199646, 6318.494520438446, 6532.118164047983, 6694.196696396463, 6861.142357205349, 7467.1039475263315, 7610.277023682741, 7675.884861727191, 7676.309132178131, 7709.614519274126, 6778.593284402951, 6947.40947019509, 6962.965185174245, 6982.022516847544, 7021.122359705037, 6696.83257918556, 6728.192616886005, 6774.051632771515, 6826.0, 6844.486663500357, 6407.167068281094, 6437.613743175424, 6442.516811239082, 6470.158879345655, 6502.739890404331, 4565.7717114144825, 4575.908481830278, 4636.907261854812, 4665.510121437336, 4725.125851717443, 4696.1546921554445, 4712.717236965793, 4720.929186062143, 4749.4063242094735, 4830.8792280193275], "value": 4139.649606351361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.36472859901306, 303.4901365705614, 306.5830470560039, 306.831242816451, 312.8876842823761, 4932.583034313187, 5515.641483303582, 5566.86082847929, 5579.437757427917, 5642.181883626877, 5505.6696598204135, 5508.779648814043, 5514.283143191389, 5578.944210557893, 5593.776248950037, 3387.8814241501555, 3947.4868267125235, 4097.19723321739, 4125.525564560084, 4172.123853990665, 3417.8120203388803, 3653.817309134546, 4184.476940382452, 4219.767912764797, 4220.0, 3702.2040261343805, 4110.445089912869, 4170.541240463546, 4196.244675958326, 4199.433076534659, 3841.346971014906, 4105.774182419966, 4154.31453810121, 4208.831646734127, 4238.364245363189, 3552.609212986569, 3560.0, 3567.500549923013, 3571.2500374921296, 3575.1955809942815, 5324.547413469821, 5375.892482150335, 5382.84686125549, 5383.804628533484, 5391.649542779707, 3641.3991691370893, 3939.3500072488005, 4658.091672123937, 4713.670043096985, 4751.360780530711, 4215.114825886568, 5731.455511726379, 5759.395263497357, 5831.3877042910735, 5840.612444782017, 3404.8467818948207, 3577.4276115821604, 3780.8298626561595, 3890.2025084857537, 3899.2786334528205, 5058.570021548173, 5261.421243663194, 5277.891642755026, 5320.866978325535, 6023.789167379165, 3226.435373809574, 3699.741018128705, 3954.1103251768122, 3956.2680904032845, 3966.186931678999, 3568.589612194579, 4036.7779772112817, 4037.8788636340955, 4052.230076285496, 4056.817443215062, 4199.67710171295, 4688.359074323959, 4689.835855745033, 4712.387389639393, 4765.880852978703, 5258.316418865523, 5363.597730170253, 5548.528375088082, 5778.3354914184565, 5852.678102704393, 1143.2111842828422, 1254.9372531373394, 1295.5271325966144, 1304.9543265985835, 1309.3649579953715, 741.5021656254336, 818.3698552114957, 829.2619568583965, 874.191372979991, 881.6429346114834, 4857.514248575114, 5024.221245706921, 5123.770295129217, 5319.813806516753, 5515.503604675599, 4874.95125048745, 5683.54531637468, 5744.569157313218, 5832.920909631732, 6052.822268309085, 5098.362704661918, 5126.333576635014, 5425.484578964992, 5503.944960550423, 5545.889082218333, 2676.7992400570033, 2804.214819850445, 2855.1726894787353, 2861.670907845583, 3016.6078409806587, 4956.8760780980765, 5120.105560942401, 5599.99200143978, 5946.286445626552, 6119.84700382494, 5720.227769251098, 5729.255196824386, 6171.413715697002, 6224.875502489925, 6252.280987686383, 5176.534111929945, 6024.1566180734735, 6256.562040657202, 6286.937130628635, 6337.3383179063985, 5235.685858848481, 5720.570957178145, 6069.848253793514, 6075.817725468243, 6135.049067394561, 5966.522678185822, 5995.220621319375, 5995.621007168288, 5996.67018313997, 6018.879622407615, 5054.469280725618, 5731.7420716067045, 5975.970120149372, 6333.086780081214, 6339.415146213447, 3300.62042865064, 3370.752821456077, 3979.462772525672, 3988.9401658974557, 4002.419649150915, 5152.845414637567, 5232.633715640021, 5957.344692083954, 6015.398460154124, 6040.305364883095, 5143.0, 5569.972150139223, 5856.472917437451, 5882.117682347682, 5902.852428689145, 5748.48263656273, 5759.39526349744, 5807.390224026416, 5829.53363730892, 5845.720169134126, 4171.957010747313, 4699.906001880012, 5266.154568429117, 5390.541803946551, 5711.400302968129, 5533.501984821385, 5569.805056822992, 5740.512056475246, 5774.2782152230975, 5853.678047707417, 5293.682379057269, 5392.487713667196, 5707.0, 5763.7406316715005, 5835.920354734388], "value": 4151.359058022161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3198481670162, 716.6667499612679, 755.2032605601092, 773.9690412383501, 784.0238902566306, 14013.789793153099, 14227.146371217721, 14348.497802576912, 14443.205623690692, 14946.327415266313, 13115.016373771958, 13399.263040532767, 13566.796498052538, 13572.389242484087, 13592.184468931871, 800.631709413669, 826.8635675113599, 827.4456114403334, 830.6345208108443, 831.3390854270839, 645.6739346629945, 665.3379887012405, 819.5492479136481, 826.3843436639681, 841.0958219913587, 880.1154839386408, 881.6649673124203, 883.960221790021, 887.4054383563029, 887.7336798960318, 873.6811063961671, 876.2245412809677, 878.9979423457232, 879.7009016934209, 881.3874357321664, 636.6657504809965, 641.9165508483914, 647.1586936981905, 649.1074772188241, 650.4666173737537, 13679.316034198251, 13812.86187138136, 13854.653633659138, 13939.16365018102, 13979.65050873726, 12299.938500307531, 12819.166754161042, 13106.541271055466, 13206.933965330112, 13344.332783360793, 10297.485125743759, 10763.19276054299, 10809.081228095622, 10900.563977440894, 11152.442377881154, 3577.3918433866306, 3631.074076110575, 3634.30948119859, 3667.7615954962844, 3675.1363429594026, 79931.20068799295, 80238.59880700617, 80348.0, 82660.0, 84411.0, 10059.849102263472, 10132.088112069949, 10171.7457063574, 10355.430451325099, 10425.895741042645, 19884.801151988297, 20031.799682002995, 20157.697634535492, 20203.79796202019, 20215.29246476366, 7610.315071643578, 7619.466637335444, 7625.618719064025, 7653.234676532302, 7827.530348179013, 4151.46031015972, 4230.682698797603, 4336.891577710582, 4345.478542574848, 4367.908022994251, 3193.8083714977174, 3291.341731653631, 3300.0924745694647, 3301.5047742838287, 3310.851011704479, 592.1325258496323, 611.8500967263049, 618.832915112917, 620.3548309757801, 628.1990462160782, 613.7667686279185, 639.2105749399487, 641.6919878458366, 648.9967550162313, 668.4451904918906, 8823.735287941372, 9065.274778017743, 9101.852172922348, 9115.453072815651, 9214.76963075915, 553.7037684838592, 604.1994357476361, 615.8214117905757, 619.4734475695623, 673.1484671890063, 3275.033865009828, 3439.9852043647184, 4034.3948407738485, 4370.759608221515, 4420.425344705232, 77632.22367776363, 123111.38444307722, 124350.0, 126442.0, 127538.0, 106223.93776062141, 106631.0, 106675.0, 107017.29827017392, 108649.0, 91823.54088229516, 95619.0, 95742.52128739312, 97201.99999999859, 97740.0, 7358.0, 7567.432442566939, 8546.444481108709, 8674.566271686517, 8701.912980870111, 43828.808559572535, 50085.0, 59231.988393873544, 59523.70238148781, 60779.0, 57674.0, 82881.17118828975, 84249.57875210585, 85460.0, 88238.55880720812, 10314.381137131797, 10343.63797267092, 10475.842862357224, 10490.370577765358, 10794.244402891722, 11742.88257117418, 11860.644180674593, 11907.583234587095, 11917.698582741332, 12053.939730301292, 11349.63376247525, 11388.316700997966, 11688.532458701557, 11747.823782643438, 12252.877471225174, 11211.383373914514, 11589.420528973686, 11607.129465289969, 11842.644720658394, 11889.583864564698, 11219.439028048728, 11534.056257158596, 11600.709982250173, 11646.417679116179, 11768.293902365886, 9291.581878815334, 9311.76720581991, 9581.041895810364, 10028.147607453448, 10142.137918276734, 9942.751431213988, 10171.49142542855, 10187.235957303084, 10189.84715229287, 10208.846867296848], "value": 7077.883440346635, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 159.0, 120.0, 120.0, 118.0, 120.0, 120.0, 130.0, 162.0, 119.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 115.0, 134.0, 145.0, 104.0, 131.0, 147.0, 179.0, 123.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 198.0, 196.0, 196.0, 207.0, 197.0, 197.0, 196.0, 196.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 57.0, 85.0, 64.0, 75.0, 79.0, 66.0, 78.0, 61.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 93.0, 70.0, 72.0, 71.0, 114.0, 92.0, 69.0, 89.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 113.0, 121.0, 126.0, 88.0, 93.0, 87.0, 90.0, 123.0], "value": 102.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 97.0, 119.0, 108.0, 149.0, 132.0, 115.0, 93.0, 94.0, 149.0], "value": 120.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 92.0, 98.0, 136.0, 136.0, 98.0, 142.0, 120.0, 89.0, 138.0], "value": 114.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 60.0, 59.0, 61.0, 60.0, 71.0, 88.0, 89.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 74.0, 84.0, 79.0, 72.0, 72.0, 73.0, 72.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 99.0, 87.0, 86.0, 85.0, 83.0, 95.0, 106.0, 102.0, 84.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 152.0, 151.0, 157.0, 154.0, 153.0, 161.0, 200.0, 171.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 179.0, 172.0, 181.0, 171.0, 226.0, 184.0, 174.0, 172.0, 179.0], "value": 185.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 69.0, 69.0, 67.0, 68.0, 66.0, 66.0, 69.0], "value": 67.8, "unit": "score"}]}]} 04:15:26 INFO - Return code: 0 04:15:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:15:26 ERROR - # TBPL SUCCESS # 04:15:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:26 INFO - 2016-11-30 04:15:26.195 screenresolution[2274:26755] starting screenresolution argv=screenresolution get 04:15:26 INFO - 2016-11-30 04:15:26.199 screenresolution[2274:26755] Display 0: 1600x1200x32@60 04:15:26 INFO - 2016-11-30 04:15:26.205 screenresolution[2275:26758] starting screenresolution argv=screenresolution list 04:15:26 INFO - Available Modes on Display 0 04:15:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:26 INFO - Intel Iris: 04:15:26 INFO - Chipset Model: Intel Iris 04:15:26 INFO - Type: GPU 04:15:26 INFO - Bus: Built-In 04:15:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:26 INFO - Vendor: Intel (0x8086) 04:15:26 INFO - Device ID: 0x0a2e 04:15:26 INFO - Revision ID: 0x0009 04:15:26 INFO - Displays: 04:15:26 INFO - Display: 04:15:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:26 INFO - Display Serial Number: 1600x1200 60 04:15:26 INFO - Main Display: Yes 04:15:26 INFO - Mirror: Off 04:15:26 INFO - Online: Yes 04:15:26 INFO - Rotation: Supported 04:15:26 INFO - Return code: 0 04:15:26 INFO - Running post-action listener: _resource_record_post_action 04:15:26 INFO - [mozharness: 2016-11-30 12:15:26.452176Z] Finished run-tests step (success) 04:15:26 INFO - Running post-run listener: _resource_record_post_run 04:15:26 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 495616; Write bytes: 663647744; Read time: 4; Write time: 1938 04:15:26 INFO - TinderboxPrint: CPU usage
54.4% 04:15:26 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 4 04:15:26 INFO - TinderboxPrint: I/O write bytes / time
663,647,744 / 1,938 04:15:26 INFO - TinderboxPrint: CPU idle
2,209.0 (45.6%) 04:15:26 INFO - TinderboxPrint: CPU system
983.1 (20.3%) 04:15:26 INFO - TinderboxPrint: CPU user
1,653.7 (34.1%) 04:15:26 INFO - TinderboxPrint: Swap in / out
348,569,600 / 0 04:15:26 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 340181504; Write bytes: 335947264; Read time: 26710; Write time: 697 04:15:26 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 495616; Write bytes: 311017472; Read time: 4; Write time: 1187 04:15:26 INFO - Running post-run listener: _upload_blobber_files 04:15:26 INFO - Blob upload gear active. 04:15:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:15:26 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 04:15:26 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'] 04:15:26 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 04:15:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:15:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:28 INFO - (blobuploader) - INFO - Done attempting. 04:15:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:15:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:29 INFO - (blobuploader) - INFO - Done attempting. 04:15:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:15:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:32 INFO - (blobuploader) - INFO - Done attempting. 04:15:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:15:32 INFO - Return code: 0 04:15:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:15:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:15:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e56dd6bed2d41e7177771ed34a2df4a10f9fe72548007a51b2b9de224bcc25cb99b620b3495fa121a0bddf47a056594ec5f622321473ddb9663b792a8f3060a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ee2e71438eac58c065203b8ff5456aaf63067da902cc6ed0c5cee8be57fc6720d64f2a5ff9fb019493eb011dc37d1863fb60710293b7e920c3c863b30f2ff6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced16e1c6b5d6e4dcecd8c75f3b001fb75388e3cca44827bd27f6f93cb253d9b853640212570c590a0a45d60b4356d6eb5581bd5458ede0dded2c1772498be40"} 04:15:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:15:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:15:32 INFO - Contents: 04:15:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e56dd6bed2d41e7177771ed34a2df4a10f9fe72548007a51b2b9de224bcc25cb99b620b3495fa121a0bddf47a056594ec5f622321473ddb9663b792a8f3060a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ee2e71438eac58c065203b8ff5456aaf63067da902cc6ed0c5cee8be57fc6720d64f2a5ff9fb019493eb011dc37d1863fb60710293b7e920c3c863b30f2ff6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced16e1c6b5d6e4dcecd8c75f3b001fb75388e3cca44827bd27f6f93cb253d9b853640212570c590a0a45d60b4356d6eb5581bd5458ede0dded2c1772498be40"} 04:15:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:15:32 INFO - Copying logs to upload dir... 04:15:32 INFO - mkdir: /builds/slave/test/build/upload/logs 04:15:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.073834 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-30 04:15:32.574453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 04:15:32.578127) ========= 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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/8e56dd6bed2d41e7177771ed34a2df4a10f9fe72548007a51b2b9de224bcc25cb99b620b3495fa121a0bddf47a056594ec5f622321473ddb9663b792a8f3060a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ee2e71438eac58c065203b8ff5456aaf63067da902cc6ed0c5cee8be57fc6720d64f2a5ff9fb019493eb011dc37d1863fb60710293b7e920c3c863b30f2ff6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced16e1c6b5d6e4dcecd8c75f3b001fb75388e3cca44827bd27f6f93cb253d9b853640212570c590a0a45d60b4356d6eb5581bd5458ede0dded2c1772498be40"} build_url:https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/dnyQUabsRwqvOSJlxNQpNQ/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/8e56dd6bed2d41e7177771ed34a2df4a10f9fe72548007a51b2b9de224bcc25cb99b620b3495fa121a0bddf47a056594ec5f622321473ddb9663b792a8f3060a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ee2e71438eac58c065203b8ff5456aaf63067da902cc6ed0c5cee8be57fc6720d64f2a5ff9fb019493eb011dc37d1863fb60710293b7e920c3c863b30f2ff6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced16e1c6b5d6e4dcecd8c75f3b001fb75388e3cca44827bd27f6f93cb253d9b853640212570c590a0a45d60b4356d6eb5581bd5458ede0dded2c1772498be40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 04:15:32.613677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 04:15:32.614037) ========= 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.J5Kc5ecCHz/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.KAEEiziXc1/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005201 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 04:15:32.664893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 04:15:32.665449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 04:15:32.665806) ========= ========= Total master_lag: 0.21 =========