builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0267 starttime: 1484047486.18 results: success (0) buildid: 20170110004021 builduid: bea679bac27f4f2fae09580a32180d8e revision: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.183760) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.184153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.184420) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.210246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.210547) ========= 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.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-10 03:24:46-- 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% 24.7M=0s 2017-01-10 03:24:46 (24.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.319236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.322580) ========= 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.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.027230 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:46.713534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 03:24:46.713876) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e5631748857e7df0b8e9c849fb7348f3318dfe4 --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 0e5631748857e7df0b8e9c849fb7348f3318dfe4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-10 03:24:46,809 truncating revision to first 12 chars 2017-01-10 03:24:46,809 Setting DEBUG logging. 2017-01-10 03:24:46,809 attempt 1/10 2017-01-10 03:24:46,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e5631748857?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 03:24:48,156 unpacking tar archive at: mozilla-aurora-0e5631748857/testing/mozharness/ program finished with exit code 0 elapsedTime=1.607236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 03:24:48.342128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:48.345435) ========= script_repo_revision: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:48.345823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:48.346080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 03:24:48.365341) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-10 03:24:48.365621) ========= /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.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:24:48 INFO - MultiFileLogger online at 20170110 03:24:48 in /builds/slave/test 03:24:48 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:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:48 INFO - {'append_to_log': False, 03:24:48 INFO - 'base_work_dir': '/builds/slave/test', 03:24:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:48 INFO - 'branch': 'Mozilla-Aurora', 03:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:48 INFO - 'config_files': ('talos/mac_config.py',), 03:24:48 INFO - 'default_actions': ('clobber', 03:24:48 INFO - 'read-buildbot-config', 03:24:48 INFO - 'download-and-extract', 03:24:48 INFO - 'populate-webroot', 03:24:48 INFO - 'create-virtualenv', 03:24:48 INFO - 'install', 03:24:48 INFO - 'run-tests'), 03:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:48 INFO - 'download_minidump_stackwalk': True, 03:24:48 INFO - 'download_symbols': 'ondemand', 03:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:48 INFO - 'installer_path': 'installer.exe', 03:24:48 INFO - 'log_level': 'info', 03:24:48 INFO - 'log_name': 'talos', 03:24:48 INFO - 'log_to_console': True, 03:24:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:24:48 INFO - 'opt_config_files': (), 03:24:48 INFO - 'pip_index': False, 03:24:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'run_cmd_checks_enabled': True, 03:24:48 INFO - 'sps_profile': False, 03:24:48 INFO - 'sps_profile_interval': 0, 03:24:48 INFO - 'suite': 'dromaeojs-e10s', 03:24:48 INFO - 'system_bits': '32', 03:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:48 INFO - 'title': 't-yosemite-r7-0267', 03:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:48 INFO - 'use_talos_json': True, 03:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:48 INFO - 'work_dir': 'build'} 03:24:48 INFO - [mozharness: 2017-01-10 11:24:48.564685Z] Running clobber step. 03:24:48 INFO - Running pre-action listener: _resource_record_pre_action 03:24:48 INFO - Running main action method: clobber 03:24:48 INFO - rmtree: /builds/slave/test/build 03:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:50 INFO - Running post-action listener: _resource_record_post_action 03:24:50 INFO - [mozharness: 2017-01-10 11:24:50.774086Z] Finished clobber step (success) 03:24:50 INFO - [mozharness: 2017-01-10 11:24:50.774241Z] Running read-buildbot-config step. 03:24:50 INFO - Running pre-action listener: _resource_record_pre_action 03:24:50 INFO - Running main action method: read_buildbot_config 03:24:50 INFO - Using buildbot properties: 03:24:50 INFO - { 03:24:50 INFO - "project": "", 03:24:50 INFO - "product": "firefox", 03:24:50 INFO - "script_repo_revision": "production", 03:24:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:24:50 INFO - "repository": "", 03:24:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:24:50 INFO - "buildid": "20170110004021", 03:24:50 INFO - "stage_platform": "macosx64", 03:24:50 INFO - "basedir": "/builds/slave/test", 03:24:50 INFO - "nightly_build": "True", 03:24:50 INFO - "buildnumber": 28, 03:24:50 INFO - "slavename": "t-yosemite-r7-0267", 03:24:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:24:50 INFO - "platform": "yosemite_r7", 03:24:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:24:50 INFO - "branch": "mozilla-aurora", 03:24:50 INFO - "repo_path": "releases/mozilla-aurora", 03:24:50 INFO - "revision": "0e5631748857e7df0b8e9c849fb7348f3318dfe4", 03:24:50 INFO - "pgo_build": "False", 03:24:50 INFO - "builduid": "bea679bac27f4f2fae09580a32180d8e", 03:24:50 INFO - "slavebuilddir": "test" 03:24:50 INFO - } 03:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:24:50 INFO - Running post-action listener: _resource_record_post_action 03:24:50 INFO - [mozharness: 2017-01-10 11:24:50.777853Z] Finished read-buildbot-config step (success) 03:24:50 INFO - [mozharness: 2017-01-10 11:24:50.777995Z] Running download-and-extract step. 03:24:50 INFO - Running pre-action listener: _resource_record_pre_action 03:24:50 INFO - Running main action method: download_and_extract 03:24:50 INFO - mkdir: /builds/slave/test/build/tests 03:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:50 INFO - trying https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/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:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/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:24:51 INFO - Downloaded 1199 bytes. 03:24:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:24:51 INFO - Using the following test package requirements: 03:24:51 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:24:51 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:24:51 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:24:51 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'jsshell-mac.zip'], 03:24:51 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:24:51 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:24:51 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:24:51 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:24:51 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:24:51 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:24:51 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:24:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:24:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:24:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:24:51 INFO - Fetch https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:24:52 INFO - Http code: 200 03:24:52 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 03:24:52 INFO - x-amz-cf-id: WeXpbEM0Lprl3OsENuClTnO_qvjSveWprWLIg8mF6TdJBut-yvWYnA== 03:24:52 INFO - x-amz-version-id: 6_rdf7bnGWTHk4hnE_qliny2ch3Z5.wF 03:24:52 INFO - Expected file size: 16271821 03:24:52 INFO - Obtained file size: 16271821 03:24:59 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:24:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:24:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:24:59 INFO - Fetch https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:24:59 INFO - Http code: 200 03:24:59 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 03:24:59 INFO - x-amz-cf-id: qUrYLECvMpnGEgn5wDn-tY18d6bY58gta-7daARhzIBWv9yysAiRqw== 03:24:59 INFO - x-amz-version-id: 6_rdf7bnGWTHk4hnE_qliny2ch3Z5.wF 03:25:00 INFO - Expected file size: 16271821 03:25:00 INFO - Obtained file size: 16271821 03:25:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:25:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:25:06 INFO - Fetch https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:25:07 INFO - Http code: 200 03:25:07 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 03:25:07 INFO - x-amz-cf-id: kG41VF1DTYdiJnvBGrx2Y-IvGSZa7iAedjPcnXvbKFwFZXOvSqT8lw== 03:25:07 INFO - x-amz-version-id: 8yFsjeNX9zrwmE96LFYB4ayuV2YzgSKa 03:25:07 INFO - Expected file size: 14409038 03:25:07 INFO - Obtained file size: 14409038 03:25: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:25:08 INFO - trying https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:25:08 INFO - Downloading https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/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:25:10 INFO - Downloaded 109992332 bytes. 03:25:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:25:10 INFO - mkdir: /builds/slave/test/properties 03:25:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:10 INFO - Contents: 03:25:10 INFO - build_url:https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:25:11 INFO - Running post-action listener: _resource_record_post_action 03:25:11 INFO - Running post-action listener: set_extra_try_arguments 03:25:11 INFO - [mozharness: 2017-01-10 11:25:11.521437Z] Finished download-and-extract step (success) 03:25:11 INFO - [mozharness: 2017-01-10 11:25:11.521563Z] Running populate-webroot step. 03:25:11 INFO - Running pre-action listener: _resource_record_pre_action 03:25:11 INFO - Running main action method: populate_webroot 03:25:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:11 INFO - '--tppagecycles', 03:25:11 INFO - '7'], 03:25:11 INFO - 'tests': ['tsvgm']}}, 03:25:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['damp', 'tps']}, 03:25:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['damp', 'tps']}, 03:25:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['dromaeo_dom']}, 03:25:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['basic_compositor_video']}, 03:25:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:25:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tsvgx', 03:25:11 INFO - 'tsvgr_opacity', 03:25:11 INFO - 'tart', 03:25:11 INFO - 'tscrollx', 03:25:11 INFO - 'cart']}, 03:25:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:11 INFO - 'tsvgr_opacity', 03:25:11 INFO - 'tart', 03:25:11 INFO - 'tscrollx', 03:25:11 INFO - 'cart']}, 03:25:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tp5o']}, 03:25:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['tp5o']}, 03:25:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s', 03:25:11 INFO - '--xperf_path', 03:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:11 INFO - 'tests': ['tp5n']}, 03:25:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--xperf_path', 03:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:11 INFO - 'tests': ['tp5n']}}, 03:25:11 INFO - 'talos.zip': {'path': '', 03:25:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:11 INFO - Running post-action listener: _resource_record_post_action 03:25:11 INFO - [mozharness: 2017-01-10 11:25:11.540428Z] Finished populate-webroot step (success) 03:25:11 INFO - [mozharness: 2017-01-10 11:25:11.540546Z] Running create-virtualenv step. 03:25:11 INFO - Running pre-action listener: _resource_record_pre_action 03:25:11 INFO - Running main action method: create_virtualenv 03:25:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:11 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:25:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:11 INFO - Using real prefix '/tools/python27' 03:25:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:15 INFO - Installing pip.................done. 03:25:15 INFO - Return code: 0 03:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:15 INFO - Reading from file tmpfile_stdout 03:25:15 INFO - Output received: 03:25:15 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:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:15 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:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:15 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:25:15 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:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:15 INFO - 'HOME': '/Users/cltbld', 03:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PAGER': '/bin/cat', 03:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:15 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - 'XPC_FLAGS': '0x0', 03:25:15 INFO - 'XPC_SERVICE_NAME': '0', 03:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 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:25:15 INFO - Cleaning up... 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:15 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:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:15 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:25:15 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:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:15 INFO - 'HOME': '/Users/cltbld', 03:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PAGER': '/bin/cat', 03:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:15 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - 'XPC_FLAGS': '0x0', 03:25:15 INFO - 'XPC_SERVICE_NAME': '0', 03:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:16 INFO - Downloading/unpacking psutil>=3.1.1 03:25:16 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:25:16 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:25:16 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:25:16 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:25:16 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:25:16 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:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:19 INFO - Installing collected packages: psutil 03:25:19 INFO - Running setup.py install for psutil 03:25:19 INFO - building 'psutil._psutil_osx' extension 03:25:19 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:25:20 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:25:20 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:25:20 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:25:20 INFO - building 'psutil._psutil_posix' extension 03:25:20 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:25:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:25:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:25:20 INFO - ^ 03:25:20 INFO - 1 warning generated. 03:25:20 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:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:20 INFO - Successfully installed psutil 03:25:20 INFO - Cleaning up... 03:25:20 INFO - Return code: 0 03:25:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:20 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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:20 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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:20 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:20 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:25:20 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:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:20 INFO - 'HOME': '/Users/cltbld', 03:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:20 INFO - 'LOGNAME': 'cltbld', 03:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:20 INFO - 'MOZ_NO_REMOTE': '1', 03:25:20 INFO - 'NO_EM_RESTART': '1', 03:25:20 INFO - 'PAGER': '/bin/cat', 03:25:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:20 INFO - 'PWD': '/builds/slave/test', 03:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:20 INFO - 'SHELL': '/bin/bash', 03:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:20 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:20 INFO - 'USER': 'cltbld', 03:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:20 INFO - 'XPC_FLAGS': '0x0', 03:25:20 INFO - 'XPC_SERVICE_NAME': '0', 03:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:23 INFO - Installing collected packages: mozsystemmonitor 03:25:23 INFO - Running setup.py install for mozsystemmonitor 03:25:23 INFO - Successfully installed mozsystemmonitor 03:25:23 INFO - Cleaning up... 03:25:23 INFO - Return code: 0 03:25:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:23 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:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:23 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:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:23 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:23 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:25:23 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:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:23 INFO - 'HOME': '/Users/cltbld', 03:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:23 INFO - 'LOGNAME': 'cltbld', 03:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:23 INFO - 'MOZ_NO_REMOTE': '1', 03:25:23 INFO - 'NO_EM_RESTART': '1', 03:25:23 INFO - 'PAGER': '/bin/cat', 03:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:23 INFO - 'PWD': '/builds/slave/test', 03:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:23 INFO - 'SHELL': '/bin/bash', 03:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:23 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:23 INFO - 'USER': 'cltbld', 03:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:23 INFO - 'XPC_FLAGS': '0x0', 03:25:23 INFO - 'XPC_SERVICE_NAME': '0', 03:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:24 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:25:24 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:25:24 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:25:24 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:25:24 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:25:24 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:25:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:26 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:25:26 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:25:26 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:25:26 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:25:26 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:25:26 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:25:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:27 INFO - warning: no files found matching '*.txt' 03:25:27 INFO - no previously-included directories found matching 'build' 03:25:27 INFO - no previously-included directories found matching 'dist' 03:25:27 INFO - no previously-included directories found matching '.git*' 03:25:27 INFO - Installing collected packages: jsonschema, functools32 03:25:27 INFO - Running setup.py install for functools32 03:25:27 INFO - warning: no files found matching '*.txt' 03:25:27 INFO - no previously-included directories found matching 'build' 03:25:27 INFO - no previously-included directories found matching 'dist' 03:25:27 INFO - no previously-included directories found matching '.git*' 03:25:27 INFO - Successfully installed jsonschema functools32 03:25:27 INFO - Cleaning up... 03:25:27 INFO - Return code: 0 03:25:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:27 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:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 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:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:27 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:25:27 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:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:27 INFO - 'HOME': '/Users/cltbld', 03:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:27 INFO - 'LOGNAME': 'cltbld', 03:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:27 INFO - 'MOZ_NO_REMOTE': '1', 03:25:27 INFO - 'NO_EM_RESTART': '1', 03:25:27 INFO - 'PAGER': '/bin/cat', 03:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:27 INFO - 'PWD': '/builds/slave/test', 03:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:27 INFO - 'SHELL': '/bin/bash', 03:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:27 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:27 INFO - 'USER': 'cltbld', 03:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:27 INFO - 'XPC_FLAGS': '0x0', 03:25:27 INFO - 'XPC_SERVICE_NAME': '0', 03:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:27 INFO - Cleaning up... 03:25:27 INFO - Return code: 0 03:25:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:27 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:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 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:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:27 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:25:27 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:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:27 INFO - 'HOME': '/Users/cltbld', 03:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:27 INFO - 'LOGNAME': 'cltbld', 03:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:27 INFO - 'MOZ_NO_REMOTE': '1', 03:25:27 INFO - 'NO_EM_RESTART': '1', 03:25:27 INFO - 'PAGER': '/bin/cat', 03:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:27 INFO - 'PWD': '/builds/slave/test', 03:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:27 INFO - 'SHELL': '/bin/bash', 03:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:27 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:27 INFO - 'USER': 'cltbld', 03:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:27 INFO - 'XPC_FLAGS': '0x0', 03:25:27 INFO - 'XPC_SERVICE_NAME': '0', 03:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:28 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:25:28 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:25:28 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:25:28 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:25:28 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:25:28 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:25:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:30 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:25:30 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:25:30 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:25:30 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:25:30 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:25:30 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:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:31 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:25:32 INFO - Downloading docopt-0.6.1.tar.gz 03:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:32 INFO - Running setup.py install for blobuploader 03:25:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:32 INFO - Running setup.py install for requests 03:25:32 INFO - Running setup.py install for docopt 03:25:33 INFO - Successfully installed blobuploader requests docopt 03:25:33 INFO - Cleaning up... 03:25:33 INFO - Return code: 0 03:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:33 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:33 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:25:33 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:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:33 INFO - 'HOME': '/Users/cltbld', 03:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:33 INFO - 'LOGNAME': 'cltbld', 03:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:33 INFO - 'MOZ_NO_REMOTE': '1', 03:25:33 INFO - 'NO_EM_RESTART': '1', 03:25:33 INFO - 'PAGER': '/bin/cat', 03:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:33 INFO - 'PWD': '/builds/slave/test', 03:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:33 INFO - 'SHELL': '/bin/bash', 03:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:33 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:33 INFO - 'USER': 'cltbld', 03:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:33 INFO - 'XPC_FLAGS': '0x0', 03:25:33 INFO - 'XPC_SERVICE_NAME': '0', 03:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-xkozC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-YM6MI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Z_Dn55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-UcEgHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-V88t30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-R8K2IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-nPDLZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-tifmgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_lE6_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-HswpZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-nCZXLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-4pI9hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-rw3em2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-oADpXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-GCaR8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-QGIijl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:35 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-vAnXeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:35 INFO - Running setup.py install for manifestparser 03:25:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for mozcrash 03:25:35 INFO - Running setup.py install for mozdebug 03:25:35 INFO - Running setup.py install for mozdevice 03:25:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for mozfile 03:25:35 INFO - Running setup.py install for mozhttpd 03:25:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Running setup.py install for mozinfo 03:25:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Running setup.py install for mozInstall 03:25:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Running setup.py install for mozleak 03:25:36 INFO - Running setup.py install for mozlog 03:25:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Running setup.py install for moznetwork 03:25:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Running setup.py install for mozprocess 03:25:36 INFO - Running setup.py install for mozprofile 03:25:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:37 INFO - Running setup.py install for mozrunner 03:25:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:37 INFO - Running setup.py install for mozscreenshot 03:25:37 INFO - Running setup.py install for moztest 03:25:37 INFO - Running setup.py install for mozversion 03:25:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:37 INFO - Cleaning up... 03:25:37 INFO - Return code: 0 03:25:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:37 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:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:38 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:38 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:25:38 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:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:38 INFO - 'HOME': '/Users/cltbld', 03:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:38 INFO - 'LOGNAME': 'cltbld', 03:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:38 INFO - 'MOZ_NO_REMOTE': '1', 03:25:38 INFO - 'NO_EM_RESTART': '1', 03:25:38 INFO - 'PAGER': '/bin/cat', 03:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:38 INFO - 'PWD': '/builds/slave/test', 03:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:38 INFO - 'SHELL': '/bin/bash', 03:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:38 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:38 INFO - 'USER': 'cltbld', 03:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:38 INFO - 'XPC_FLAGS': '0x0', 03:25:38 INFO - 'XPC_SERVICE_NAME': '0', 03:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-G9cvF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:38 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:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-eWeLN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_QmxJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-NogfVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-R0UHU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-K_P3XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-JaJlgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-bD_VyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-F_yiie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-laFHGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-wVP8zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:39 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-zSNKuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:40 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-xH3pVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:40 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Q1hGCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:40 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_idILR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:40 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-qRu7sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:40 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-QcYoYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:43 INFO - Downloading blessings-1.6.tar.gz 03:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:43 INFO - Installing collected packages: blessings 03:25:43 INFO - Running setup.py install for blessings 03:25:43 INFO - Successfully installed blessings 03:25:43 INFO - Cleaning up... 03:25:43 INFO - Return code: 0 03:25:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:43 INFO - Reading from file tmpfile_stdout 03:25:43 INFO - Current package versions: 03:25:43 INFO - blessings == 1.6 03:25:43 INFO - blobuploader == 1.2.4 03:25:43 INFO - docopt == 0.6.1 03:25:43 INFO - functools32 == 3.2.3-2 03:25:43 INFO - jsonschema == 2.5.1 03:25:43 INFO - manifestparser == 1.1 03:25:43 INFO - mozInstall == 1.12 03:25:43 INFO - mozcrash == 1.0 03:25:43 INFO - mozdebug == 0.1 03:25:43 INFO - mozdevice == 0.48 03:25:43 INFO - mozfile == 1.2 03:25:43 INFO - mozhttpd == 0.7 03:25:43 INFO - mozinfo == 0.9 03:25:43 INFO - mozleak == 0.1 03:25:43 INFO - mozlog == 3.4 03:25:43 INFO - moznetwork == 0.27 03:25:43 INFO - mozprocess == 0.23 03:25:43 INFO - mozprofile == 0.28 03:25:43 INFO - mozrunner == 6.13 03:25:43 INFO - mozscreenshot == 0.1 03:25:43 INFO - mozsystemmonitor == 0.3 03:25:43 INFO - moztest == 0.8 03:25:43 INFO - mozversion == 1.4 03:25:43 INFO - psutil == 3.1.1 03:25:43 INFO - requests == 1.2.3 03:25:43 INFO - wsgiref == 0.1.2 03:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:43 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:43 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:25:43 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:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:43 INFO - 'HOME': '/Users/cltbld', 03:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:43 INFO - 'LOGNAME': 'cltbld', 03:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:43 INFO - 'MOZ_NO_REMOTE': '1', 03:25:43 INFO - 'NO_EM_RESTART': '1', 03:25:43 INFO - 'PAGER': '/bin/cat', 03:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:43 INFO - 'PWD': '/builds/slave/test', 03:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:43 INFO - 'SHELL': '/bin/bash', 03:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:43 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:43 INFO - 'USER': 'cltbld', 03:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:43 INFO - 'XPC_FLAGS': '0x0', 03:25:43 INFO - 'XPC_SERVICE_NAME': '0', 03:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 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:25:44 INFO - Cleaning up... 03:25:44 INFO - Return code: 0 03:25:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25:44 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:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:44 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:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:44 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 0x109ab5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a2b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcd0ca7a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, '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.UL6eoK53Ti/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.CVbp0RQy30/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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:25:44 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:25:44 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:25:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:25:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:44 INFO - 'HOME': '/Users/cltbld', 03:25:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:44 INFO - 'LOGNAME': 'cltbld', 03:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:44 INFO - 'MOZ_NO_REMOTE': '1', 03:25:44 INFO - 'NO_EM_RESTART': '1', 03:25:44 INFO - 'PAGER': '/bin/cat', 03:25:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:44 INFO - 'PWD': '/builds/slave/test', 03:25:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:44 INFO - 'SHELL': '/bin/bash', 03:25:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:25:44 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:25:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:44 INFO - 'USER': 'cltbld', 03:25:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:44 INFO - 'XPC_FLAGS': '0x0', 03:25:44 INFO - 'XPC_SERVICE_NAME': '0', 03:25:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:44 INFO - Cleaning up... 03:25:44 INFO - Return code: 0 03:25:44 INFO - Running post-action listener: _resource_record_post_action 03:25:44 INFO - Running post-action listener: _start_resource_monitoring 03:25:44 INFO - Starting resource monitoring. 03:25:44 INFO - [mozharness: 2017-01-10 11:25:44.386851Z] Finished create-virtualenv step (success) 03:25:44 INFO - [mozharness: 2017-01-10 11:25:44.387842Z] Running install step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: install 03:25:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:44 INFO - Reading from file tmpfile_stdout 03:25:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:44 INFO - Reading from file tmpfile_stdout 03:25:44 INFO - Output received: 03:25:44 INFO - Usage: mozinstall [options] installer 03:25:44 INFO - Options: 03:25:44 INFO - -h, --help show this help message and exit 03:25:44 INFO - -d DEST, --destination=DEST 03:25:44 INFO - Directory to install application into. [default: 03:25:44 INFO - "/builds/slave/test"] 03:25:44 INFO - --app=APP Application being installed. [default: firefox] 03:25:44 INFO - mkdir: /builds/slave/test/build/application 03:25:44 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:25:44 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:26:15 INFO - Reading from file tmpfile_stdout 03:26:15 INFO - Output received: 03:26:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:26:15 INFO - Running post-action listener: _resource_record_post_action 03:26:15 INFO - [mozharness: 2017-01-10 11:26:15.632931Z] Finished install step (success) 03:26:15 INFO - [mozharness: 2017-01-10 11:26:15.633071Z] Running run-tests step. 03:26:15 INFO - Running pre-action listener: _resource_record_pre_action 03:26:15 INFO - Running main action method: run_tests 03:26:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:26:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:26:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:26:15 INFO - 2017-01-10 03:26:15.646 screenresolution[1626:7445] starting screenresolution argv=screenresolution get 03:26:15 INFO - 2017-01-10 03:26:15.649 screenresolution[1626:7445] Display 0: 1600x1200x32@60 03:26:15 INFO - 2017-01-10 03:26:15.654 screenresolution[1627:7447] starting screenresolution argv=screenresolution list 03:26:15 INFO - Available Modes on Display 0 03:26:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:26:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:26:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:26:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:26:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:26:15 INFO - Intel Iris: 03:26:15 INFO - Chipset Model: Intel Iris 03:26:15 INFO - Type: GPU 03:26:15 INFO - Bus: Built-In 03:26:15 INFO - VRAM (Dynamic, Max): 1536 MB 03:26:15 INFO - Vendor: Intel (0x8086) 03:26:15 INFO - Device ID: 0x0a2e 03:26:15 INFO - Revision ID: 0x0009 03:26:15 INFO - Displays: 03:26:15 INFO - Display: 03:26:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:26:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:26:15 INFO - Display Serial Number: 1600x1200 60 03:26:15 INFO - Main Display: Yes 03:26:15 INFO - Mirror: Off 03:26:15 INFO - Online: Yes 03:26:15 INFO - Rotation: Supported 03:26:15 INFO - Return code: 0 03:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:15 INFO - Python 2.7.3 03:26:15 INFO - Return code: 0 03:26:15 INFO - grabbing minidump binary from tooltool 03:26:15 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:26:15 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 0x1098c9d30>, '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 0x10972fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:15 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:26:15 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:26:15 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:26:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:16 INFO - Return code: 0 03:26:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:26:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:26:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:16 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/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--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:26:16 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/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0267 --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:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UL6eoK53Ti/Render', 03:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:16 INFO - 'HOME': '/Users/cltbld', 03:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:16 INFO - 'LOGNAME': 'cltbld', 03:26:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:16 INFO - 'MOZ_NO_REMOTE': '1', 03:26:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:16 INFO - 'NO_EM_RESTART': '1', 03:26:16 INFO - 'PAGER': '/bin/cat', 03:26:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:16 INFO - 'PWD': '/builds/slave/test', 03:26:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:16 INFO - 'SHELL': '/bin/bash', 03:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CVbp0RQy30/Listeners', 03:26:16 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 03:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:16 INFO - 'USER': 'cltbld', 03:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:16 INFO - 'XPC_FLAGS': '0x0', 03:26:16 INFO - 'XPC_SERVICE_NAME': '0', 03:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:16 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/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--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:26:16 INFO - mozversion application_buildid: 20170110004021 03:26:16 INFO - mozversion application_changeset: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 03:26:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:16 INFO - mozversion application_name: Firefox 03:26:16 INFO - mozversion application_remotingname: firefox-dev 03:26:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:16 INFO - mozversion application_vendor: Mozilla 03:26:16 INFO - mozversion application_version: 52.0a2 03:26:16 INFO - mozversion platform_buildid: 20170110004021 03:26:16 INFO - mozversion platform_changeset: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 03:26:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:16 INFO - mozversion platform_version: 52.0a2 03:26:16 INFO - using testdate: 1484047576 03:26:16 INFO - actual date: 1484047576 03:26:16 INFO - starting webserver on 'localhost:49240' 03:26:16 INFO - SUITE-START | Running 2 tests 03:26:16 INFO - TEST-START | dromaeo_css 03:26:16 INFO - operating with platform_type : mac_ 03:26:16 INFO - Initialising browser for dromaeo_css test... 03:26:16 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpXqxFDN/profile http://localhost:49240/getInfo.html) 03:26:19 INFO - PROCESS | 1637 | 2017-01-10 03:26:19.761 plugin-container[1640:7635] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 03:26:19 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:26:19 INFO - PROCESS | 1637 | 2017-01-10 03:26:19.762 plugin-container[1640:7635] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d17, name = 'com.apple.CFPasteboardClient' 03:26:19 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:26:19 INFO - PROCESS | 1637 | 2017-01-10 03:26:19.762 plugin-container[1640:7635] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:26:19 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 03:26:19 INFO - PROCESS | 1637 | colorDepth:24 03:26:19 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 03:26:19 INFO - PROCESS | 1637 | __metrics 03:26:19 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:26:20 INFO - TEST-INFO | 1637: exit 0 03:26:20 INFO - Browser initialized. 03:26:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:20 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpXqxFDN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:23 INFO - PROCESS | 1641 | 2017-01-10 03:26:23.589 plugin-container[1642:7764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:26:23 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:26:23 INFO - PROCESS | 1641 | 2017-01-10 03:26:23.590 plugin-container[1642:7764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 03:26:23 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:26:23 INFO - PROCESS | 1641 | 2017-01-10 03:26:23.590 plugin-container[1642:7764] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:26:33 INFO - PROCESS | 1641 | RSS: Main: 228847616 03:26:33 INFO - PROCESS | 1641 | 03:29:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:29:39 INFO - PROCESS | 1641 | RSS: Main: 232685568 03:29:39 INFO - PROCESS | 1641 | 03:32:41 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:32:42 INFO - PROCESS | 1641 | RSS: Main: 243519488 03:32:42 INFO - PROCESS | 1641 | 03:35:43 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:35:44 INFO - PROCESS | 1641 | RSS: Main: 246423552 03:35:44 INFO - PROCESS | 1641 | 03:38:46 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:38:47 INFO - PROCESS | 1641 | RSS: Main: 245665792 03:38:47 INFO - PROCESS | 1641 | 03:41:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:41:50 INFO - PROCESS | 1641 | RSS: Main: 249057280 03:41:50 INFO - PROCESS | 1641 | 03:44:52 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 03:44:53 INFO - PROCESS | 1641 | RSS: Main: 250785792 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | __start_tp_report 03:44:53 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 03:44:53 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 03:44:53 INFO - PROCESS | 1641 | |i|pagename|runs| 03:44:53 INFO - PROCESS | 1641 | |0;dojo.html;3412.5051867479233;3417.094469965458;3422.229998250394;3443.793372397655;3466.653334666533;5724.398938111501;5749.396313387097;5753.5109515691165;5787.855303617401;5802.158686990384;5771.624844385112;5889.381614930424;5893.528517718583;5905.881882362351;5931.258592675905;5241.86895327616;5277.498637629419;5312.389075256357;5349.866253343658;5355.169948657945;5338.486683590586;5349.9300139971965;5359.7320133993335;5379.1393377059485;5415.702136382517;5211.817586384477;5214.739263036852;5346.6524675896135;5348.251244825728;5354.250404943292;4584.724916504987;5247.895042099137;5257.684538927677;5325.094733895247;5427.240186373911;4280.507741609724;5281.947180528184;5294.205869119663;5313.44208858072;5329.493698098674;5487.451254874521;5694.572907031948;5702.5723070769445;5827.650340979512;5843.678597677126;6169.938300616981;6191.628502289877;6228.813135605939;6247.468965137969;6263.373662633746;6243.8126856194385;6277.2153480814895;6286.4342209201395;6286.591371560834;6300.243970723543;5913.674747888821;5936.881262374772;5941.851453713692;5968.1644569760265;6008.639481631116;6198;6296.0555916612875;6327.240731112296;6374.426301632875;6383.776567820104;6225.470834978987;6230.096635987757;6243.43809057187;6249.6875156242;6250.281217659936;6205.565610407228;6250.749970001149;6261.154744109578;6271;6282.308946015934;6039.275286965592;6099.878002439927;6115.510759139258;6120.721420533258;6175.783847565403;6205.627662340184;6235.688215589203;6241.7191226394925;6246.625202487774;6285.340039295899;4996.775145118479;5031.924521132186;5033.5469807716745;5043.142665746832;5060.468650791614;4355.760433176206;4426.114777044604;4487.192305385062;4515.1195516873895;4542.568455996675;5713.685747283939;5899.528037756969;5979.970100149471;6000.0999850022845;6067;6246.562740608205;6278.277998030194;6278.811635650938;6281.59169653971;6307.085472606446;5762.769489220468;5836.066229403275;5865.472107510344;5914.822555323261;5931.08068249422;5425.104857698515;5481.232627432163;5493.835184944458;5500.367457742331;5505.421930697299;6451.70967306463;6505.0567667688865;6506;6521.413072823469;6522.21733391996;6144.003198960445;6146.801373732079;6152.292486364126;6179.412955769195;6266.248050234001;6312.242530896322;6338.080978258219;6348.619082855043;6366.108744775643;6383.457406120532;6144.969275153596;6151.569390142647;6168.691565421801;6179.3820617937845;6195.132681424514;6147.231596050494;6180.381961803783;6222.81331560054;6223.626582405071;6245.000799871998;6041.546883983631;6116.969415152896;6239.594426362272;6244.500439964701;6247.156633854372;6154.907676384947;6225.875482490415;6230.252369715663;6231.855815882387;6252.656103914328;5111.565516931102;5879.382664820132;5972.313183983723;5985.042393217064;6034.2155519782145;6081.878362432815;6117.204763380732;6134.375358695159;6135.35515879939;6141.785037523665;6005.3694362091355;6005.549583781321;6055.031195008777;6067.332593414632;6069.150318955261 03:44:53 INFO - PROCESS | 1641 | |1;ext.html;450.8467121178799;453.95687409696086;499.732643035976;502.57783461892;514.9315171020135;31840.84079579602;36257.63742362579;38600.80699596505;40974.59025409745;43081.569184308224;42231.57768422315;42591.57408425915;42667.35998960018;42685.786571067176;42789.572104278945;8168.815521749372;9359;9504.619815207383;9524.904750952472;9535.189508891752;9313;9426.434413935185;9431.24550035999;9435.622575097022;9454.054594540525;8719.302455803552;9390.62437502499;9431.245500359955;9440.81118377632;9446.81106377872;8748.518831464267;8990;9421.528923553864;9425.76435589109;9431.575579098888;9420.717378478588;9426.528673566294;9449.055094490564;9484.573194206278;9522.381045232038;34902;39734;40122.59877401218;40125.799371002955;40220.597794021975;3281.835908204604;3480.704140148065;3887.688984881231;3926.960730392688;3946.7370441458743;29211.269718257;29278.70721292781;29283.707162928524;29373.853130734424;31128.221794455094;2413.698287714036;2953.4536110819354;3029.1366960416176;3046.817190968549;3053.618297712786;402013;402952;403630;404100;405477;58314.7084264576;58416.415835841944;58502.70748646229;58575;58664;57744.42255577474;58130.4186958125;63670;63828.68085659542;63933.04100438497;16286.429974950819;16472.929259598328;16474.09392483401;16505.504834854975;16523.421680241136;12570.057245706608;12618;12634.178778379375;12661.873381266254;12671.049671274692;18291.68756330472;18904.432867014013;18926.52683682919;19003;19066.142023608973;7202.351788339075;7316.817079573053;7381.741639042715;7417.814554636069;7498.325150736351;796.6614188969664;837.535167981776;972.0910948263396;1031.2832581355885;1122.5341483284346;30144;30603;30688.232794180323;30934.0719778407;31130.377392452476;1006.3509036671306;1032.4321623107262;1063.8723353197665;1081.5944020992129;1082.653550863716;12634.620961371174;13344.732250436193;15503.069815811088;15942.521724348288;16012.679746405007;646793;651464;653015;654113.7294313498;655298;58427.41572584305;58799.824003520545;58965;59030.70484647549;59205.40794592085;1344.7713888638955;1345.0920628575673;1364.733876894016;1371.7119404925077;1376.6695992961618;29712;30405.543916840823;31310.68689313169;32414.21721805229;32910.83544582262;55499.445005551046;56124;56160;56303;56331.71834140803;549870;551094;553895;554794;554810;42303.36544951767;42419.57580424156;42890;42935;43289.56710432981;46570.53429465798;47595.76202118967;47652.52347476481;47771.761141194074;48294.03411931671;30255.69744302529;39436.04636731497;39752.60247397489;39938.00154996148;40918;39100.80449597734;40190;40470.392944105275;40729.38905916354;40749.79625101974;37583;37801.62198377981;37804.43293350657;37900;38387.424188636636;32833.50749738708;33490.66037358576;34190.658093418744;34720.479192811625;35258.8237058813;23773.881130594236;26026.479470410864;26175.869120654275;26203.082892098686;26241 03:44:53 INFO - PROCESS | 1641 | |2;jquery.html;375.564345359383;380.7639263656533;385.05277018534406;390.51381030616886;407.7614595461655;18023.279068837248;19029.238830446764;19649.410517684457;19901.900490497545;20093.497662558424;17319.307227710877;17604.64790704185;17627.64744705105;18664.813351866476;19804.900975495104;5487.917681234785;5692.459216374458;5804.216430781854;5925.081612350093;5951.256092988377;5736.881308144913;5916.230889984296;5918.112283157518;5922.378150294222;5925.762969481216;5731.799387021455;5811.506021988115;5830.008898487246;5858.76564937402;6032.849178770544;5347.037533244014;6051.576389652726;6053.848653783647;6067.423594758513;6070.392960703938;5667.4615911488345;5804.941950580483;5844.181814545925;5862.443067908542;5871.882562348772;13192.86807131926;13417.194968301934;13423.261720605362;22361;24727;2159.8164156046755;2182.181681869299;2365.3377054424786;2494.6133349330885;2867.95319708305;9521.333506654537;10042.556576383076;10290.02244786744;10484.423356715377;10489.108425783817;1785.1074462768615;1829;1848.667239896818;1848.9907550462297;1860.265195247883;124167;124686;125906.37046814707;128907.35546322302;129039.41921161619;11274.54901803935;11477.253978491372;11931.761364772656;12100.81848772269;12135;14682.41270349174;14689.77965330521;14705.852941470448;14720;14730.558083257305;8177.877331840027;8412.915870841336;8448.183640517318;8547.10255423184;8559.272461840814;8130.105688374274;8175.182481751896;8190.426670133153;8211.95894020526;8316.251537361666;4458.5318541553315;4541.205289074399;4566.246569316092;4595.4025976622825;4601.44782626087;1605.2054233154663;1652.5538104711661;1887.226237242724;1950.9024548772504;1959.7849333413376;814.5316443045273;861.3927181337142;865.7056600755773;879.6437442835662;914.4787471141518;15265.465708700141;18992.905035474734;20411.489712757004;20457;20967.58064838725;909.3952521573212;914.835329640671;916.3768637326549;953.50894289441;963.6819849449665;9086.591103400362;9887.80224395508;10718.35689858611;10784.730381740519;10801.189910756724;548575;558320;561244;572150.2784972097;598217;129719;133219.00171497435;134745;137014.31492842472;138221;770.6300975531776;974.2206235011962;975.8828940527183;992.4938281476354;996.0637001218831;17291;18058.63882722312;18352.81647183511;18370.265189392274;18378.264869405073;41757.791211043754;55041.44958550363;55141;55609.72195138998;56571.434285658266;78327;79491.20508794839;80270;80798;81401;11556.537738490366;11735.119866009913;11750.11874109428;11817.881821181678;12001.939990300341;12809.743805123659;13352.933235333761;13359.064865459713;13754.174749515061;13872.861271387157;10809.621663241749;11162.665120046411;11409.771804563696;11531.827022594836;11791.941040295087;9943.950280248842;10358.119559837498;10446.268761186644;10487.213458990454;10523.421211833424;9360.812783744152;11413.60052398162;11621.88378116208;11736.295822250693;12011.339376334035;12158.209716368408;12165.75668486643;12180.330081845583;12217.69455763613;12397.442115105023;9961.252906032221;10803;11334.263272887236;11771.293722376684;11778.76442471163 03:44:53 INFO - PROCESS | 1641 | |3;mootools.html;1449.6810701645638;1487.345567950102;1553.69702907933;1642.622196894714;1726.214572369572;7514.0607424071995;7783.766487005385;8012.238837310453;8459.788505287363;8497.660093596256;8063.435559510836;8314.750557483285;8359;8470.407071504997;8505.74482765518;2271.806896413803;2301;2301.861888286708;2301.8835864605653;2308.284431826139;2327.5228578141523;2336.5443738471004;2386.689730335054;2393.0906255622926;2393.892274847636;2316.4093156245217;2317.385892738426;2321.791038806507;2331;2356.210669425736;2310.9306720798404;2318.2813327868416;2327.173853282086;2345.6950596422525;2346.9061237550477;2348.5655153796433;2374.9881250593808;2379.1553998330514;2381.2856143156982;2388.4267775733874;8362.414630975834;8472.025717042496;8507.957460212721;8523.14768523149;8698.47809131454;5033.370828646419;5086.491350864921;5212.348456442945;5268.92096618551;5283.418823929364;3268.4607039838397;3400.506926495644;3464.2725027744204;3464.445688689823;3471.1495683557437;984.2126298960874;1020.4387586827289;1032.0969151992008;1043.9060484556426;1043.9791204175874;10899.945500272528;10958;10964.890351096547;10984.945075274572;10996.945015274952;4545.795439205243;4681.625469962463;4768.165571025057;4787.712737235777;4805.879853003703;7785.18255583167;8471.830563388698;9474.763130921781;9477;9495.76260593477;5124.92312615311;5171.01750667372;5210.166373380241;5222.764975576109;5228.137357336073;4254.255505286563;4281.357796330575;4734.28985652148;4758.643101767381;4820.325154478376;3805.353089974711;3840.251151025579;3920.745151565139;3923.1757232886844;3924.803759811998;1282.3267784413258;1287.2726909296218;1287.6265882893856;1293.909426340147;1294.0682708449901;887.5562218890555;892.4110087342323;893.5130353957109;895.7088946092546;907.3331101640289;5063.240513922868;5596.608237423341;5657.688827114548;5782.190493330937;5881.676507792027;888.4225253585221;913.1462082952461;935.1069728409353;947.7156852944227;960.1550635440767;3748.5126933498473;3813.389857622767;3873.4189871518934;3881.6118388160958;3932.4494570760116;7692;10340.586376545005;10354.585816567404;10357.119644830123;10362.740931476774;10201.285909986229;10322.845157322647;10325.48372581368;10326.22553308505;10455.111315538112;7409;7871.645775940096;8033.0360356757565;8040.67837286502;8072.878906816402;5567.638103523258;5774.105013722879;5890.941090589039;5918;5940;9275.86086208721;9320.72037838866;9361.204297634777;9369.578368973276;9432.339736218399;9395.530223488935;9536.761580960532;9571.90428095738;9630.614775409185;9653.855192172263;6653.700583473658;6887.139107611549;7078.4691148163065;7193.424526037799;7312.232215617283;7809.648565814666;7982.521048737094;8025.15735847751;8025.518468891885;8030.196980301923;7054.047703560159;7213.567185968858;7227.421806255592;7237.529560578546;7302.452316076209;6962.443004559725;7018.192907815666;7057.541259818096;7162.820929476597;7189.460790440633;6630.701618427279;6669.433098186514;6684.766033188815;6745.3591908768585;6749.055132281386;4804.25534042224;4862.05189987949;4879.243717223836;4881.316615673737;4895.951040489549;4819.108464933998;4839.128956787812;4897.436794768647;4942.011597680406;5001.574866136273 03:44:53 INFO - PROCESS | 1641 | |4;prototype.html;260.29460162958384;304.5477465963044;310.9082820567932;315.0454124004267;318.90114064639965;4803.5916947059495;4951.479100802606;4973.626977976657;5488.545535433103;5532.529734972527;4572.9314060289125;4590.724556526602;4680.485146633868;5164.657189130825;5273.551748101407;3459.9654003459896;3491.493733408667;3946.427767973642;4176.770277634729;4185.707000509966;3943.5859234780364;3975.463312452811;4169.958300417003;4215.894602634928;4226.978865105671;3518.9648103518894;4103.343465045593;4108.589141085882;4114.753114813106;4125.2780763366445;3409.8465569049326;3715.5727091384565;3948.545917219528;3968.3253846846105;4120.608542188487;3566.5185199997927;3582.176099497104;3586.605473397924;3591.6947059499976;3604.1710406606367;4464.843730469418;5066.873328166788;5347.652402593819;5388.407275199725;5409.404965453797;4667.906641867177;4733.573978341966;4742.2886567014875;4744.715317080986;4779.641526885497;4813.029250868013;5080.161773307437;5618.747156377973;5811.953848307303;5879.206307148523;3470.958712386274;3795.3547896857326;3866.8646597368956;3877.263319969197;3943.2507823513442;5117.872053198663;5882.058920556206;5954.404559544054;6062.242219722535;6082.5742198046155;3501.964980350215;3960.4851369321805;3962.405639154092;3973.099637264813;3985.4221137934837;3049.969500305013;3542.875999340011;3714.257148570297;3896.8636097736444;3941.940870886882;3752.380857158593;4083.959160408358;4643.628509719214;4716.410448693913;4723.339411955693;5100.464451232567;5299.4435584263865;5820.534357251409;5824.79613213544;5892.998190307658;1064.8935106489444;1257.352463481308;1315.7829008167407;1317.2689157517477;1364.911280766747;780.6760194519211;927.526961249754;945.3571571331423;953.7377221264207;957.9760505987267;4411.904345435956;5150.845474635767;5165.586753059746;5210.853612205309;5211.687298762086;4838.709677419366;5093.821716239914;5648.491635752802;5652.943470565324;5683.943160568341;4422.960604258061;4919.2867034279825;4939.703617782944;5097.7629205454805;5146.739048932961;2464.322311364389;2882.884684612592;2899.246195989058;2938.823670579772;2953.9070543898897;4737.336772851803;5013.799448022111;5217.869553261199;5458.781648734006;5768.06769732136;4756.4541524004835;4981.2030075187795;5510.448955104457;5590.692511911802;5789.681567513743;5002.498750624688;5509.834704958777;5844.26946631671;5893.499052580579;5919.67441790697;4610.861674149781;4908.779104940358;5091.956148989522;5165.9483405165465;5497.1049636265925;4244.434674872998;4405.889852753707;5032.597392208541;5325.84303357141;5330.013947419739;4938;5147.845564633067;5713.742881570256;5886.705664716833;5921.3782552831335;3787.8295476703065;4004.5594984551094;4011.217812526529;4035.031592417857;4074.449949256931;4971.353724015855;5921.348651648402;6030.457258846549;6030.969845150747;6048.667323297261;4903.803847846046;5344.85085706575;5552.5280351168985;5801.94198058014;5894.351621321737;5395.3525576931015;5653.671387223917;5665.376808550974;5795.420457954171;5822.13691618678;4898.697612122297;5451.318585176853;5537.861553461195;5602.2717046783655;5704.3725190228215;4655.813767449399;5813.76744930198;5856.164212440688;5858.5898987070495;5882.647041177372;4992.301077849032;4998.925016124834;5327.493888080781;5705.62913410627;5725.8568535786935 03:44:53 INFO - PROCESS | 1641 | |5;yui.html;671.0906721392516;689.593140047372;692.0795342194879;736.2269616902255;779.2752739951846;13958.441662333507;14713.926430367834;14833;14884.25578721065;15710.607234819136;14566.927165364184;14904.776428353556;14995.47515836946;14995.550133495984;15018.849811501881;649.8180509457336;739.5394096659109;771.9343855772266;802.2739420824149;827.2967977219375;548.5200449606594;620.8323752586799;622.1973653986353;711.5552779512805;765.2118318132333;753.0097921233561;766.3639179481017;852.3649880838784;872.2629378175432;878.2534845381407;862.6204470033165;864.788126908905;864.952427616484;866.8266346730679;868.3227082875368;638.3488841381811;646.8382904273932;647.5855452510397;648.1994736500418;653.0172091003058;14191.78712319316;14512.782308265385;14533;14554.417823287056;14699.632509187355;13072.934635326763;13226.008049396238;13332.266725330102;13363.131396459296;13497.392617332243;10887.237893347468;10953;11221.438928053565;11238.831417528743;11539.192256542045;3544.929101417983;3605.369060414417;3615.2407994321225;3643.9979005773357;3726.0498572864017;93476;94686;94791;94893;95575.56636650456;10187.898121018696;10210.489475526194;10221.897781022244;10231.079202871777;10266.384016958857;19353.51616209606;19889;19987.300444484372;20226.292079777137;20336.9831508424;6180.227471566054;7172.533785303938;7327.157376901618;7369.594672292968;7527.698892044257;4131.855385061508;4134.751914885116;4235.53409124996;4246.830126794894;4326.697131200785;3252.7885687430717;3339.4322965095994;3375.9831200843837;3378.4256676365076;3379.746519011084;573.1889376532243;623.7991865658589;634.0236036503825;652.9510286728514;659.9076129341896;535.5929493584904;589.2840199158044;639.8976163813768;645.3224114679567;670.5976414151568;8038.995125609299;8718;9302.395344302598;9474.715758527254;9614.567344469515;561.1386521689269;586.652181427614;640.7405000974612;656.7471523463405;663.7776344924408;4159.688023398257;4319.611234988866;4353.238183317907;4380.299152135707;4406.0809069827465;68053.29866753271;96464;98675;98925;99169.50415248022;62206.0669089964;65977.67011164913;69464.30535694679;86455;86752.56623716967;26009.869950650125;43496.565034349886;61534;75491.62254188694;75897;8194.877076843972;8487.151284871463;8508.043150075393;8572.52851093196;8601.053884072622;42828.357574637026;45070.549294507946;52549.7372513135;52643;54576;56049.71975140098;68825.31174688389;69860.65069674619;71589.28410715827;73104.63447682727;10670.146388288764;10923.726906827393;11054.502547385548;11116.333020018825;11424.428778560872;12115.75768484643;12176.939115304367;12426.62720118398;12435.378231088229;12540.99672026254;11464.067772988376;11489.885101148882;11652.708682283012;11729.765404692029;11802.52789888395;10127.442990635585;10382.740431489274;11484.94257528707;11686.94156529212;12159.635210943687;11117.833232501358;11358.772824543297;11627.244229125079;11641.243319184226;12041.157119001586;9142.498418123369;9540.761480963032;9703.5148242589;9871.555779989774;10446.477676116316;9885.505724713592;10031.398116113056;10047.748806279902;10051.597936082768;10075.021473717823 03:44:53 INFO - PROCESS | 1641 | __end_tp_report 03:44:53 INFO - PROCESS | 1641 | __start_cc_report 03:44:53 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,369 03:44:53 INFO - PROCESS | 1641 | __end_cc_report 03:44:53 INFO - PROCESS | 1641 | __startTimestamp1484048693175__endTimestamp 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | ------- Summary: start ------- 03:44:53 INFO - PROCESS | 1641 | Number of tests: 6 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5801.51 Median:6041.55 stddev:640.88 (10.6%) stddev-sans-first:614.83 03:44:53 INFO - PROCESS | 1641 | Values: 3412.5 3417.1 3422.2 3443.8 3466.7 5724.4 5749.4 5753.5 5787.9 5802.2 5771.6 5889.4 5893.5 5905.9 5931.3 5241.9 5277.5 5312.4 5349.9 5355.2 5338.5 5349.9 5359.7 5379.1 5415.7 5211.8 5214.7 5346.7 5348.3 5354.3 4584.7 5247.9 5257.7 5325.1 5427.2 4280.5 5281.9 5294.2 5313.4 5329.5 5487.5 5694.6 5702.6 5827.7 5843.7 6169.9 6191.6 6228.8 6247.5 6263.4 6243.8 6277.2 6286.4 6286.6 6300.2 5913.7 5936.9 5941.9 5968.2 6008.6 6198.0 6296.1 6327.2 6374.4 6383.8 6225.5 6230.1 6243.4 6249.7 6250.3 6205.6 6250.7 6261.2 6271.0 6282.3 6039.3 6099.9 6115.5 6120.7 6175.8 6205.6 6235.7 6241.7 6246.6 6285.3 4996.8 5031.9 5033.5 5043.1 5060.5 4355.8 4426.1 4487.2 4515.1 4542.6 5713.7 5899.5 5980.0 6000.1 6067.0 6246.6 6278.3 6278.8 6281.6 6307.1 5762.8 5836.1 5865.5 5914.8 5931.1 5425.1 5481.2 5493.8 5500.4 5505.4 6451.7 6505.1 6506.0 6521.4 6522.2 6144.0 6146.8 6152.3 6179.4 6266.2 6312.2 6338.1 6348.6 6366.1 6383.5 6145.0 6151.6 6168.7 6179.4 6195.1 6147.2 6180.4 6222.8 6223.6 6245.0 6041.5 6117.0 6239.6 6244.5 6247.2 6154.9 6225.9 6230.3 6231.9 6252.7 5111.6 5879.4 5972.3 5985.0 6034.2 6081.9 6117.2 6134.4 6135.4 6141.8 6005.4 6005.5 6055.0 6067.3 6069.2 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:68011.07 Median:222973.70 stddev:145777.06 (65.4%) stddev-sans-first:146097.75 03:44:53 INFO - PROCESS | 1641 | Values: 450.8 454.0 499.7 502.6 514.9 31840.8 36257.6 38600.8 40974.6 43081.6 42231.6 42591.6 42667.4 42685.8 42789.6 8168.8 9359.0 9504.6 9524.9 9535.2 9313.0 9426.4 9431.2 9435.6 9454.1 8719.3 9390.6 9431.2 9440.8 9446.8 8748.5 8990.0 9421.5 9425.8 9431.6 9420.7 9426.5 9449.1 9484.6 9522.4 34902.0 39734.0 40122.6 40125.8 40220.6 3281.8 3480.7 3887.7 3927.0 3946.7 29211.3 29278.7 29283.7 29373.9 31128.2 2413.7 2953.5 3029.1 3046.8 3053.6 402013.0 402952.0 403630.0 404100.0 405477.0 58314.7 58416.4 58502.7 58575.0 58664.0 57744.4 58130.4 63670.0 63828.7 63933.0 16286.4 16472.9 16474.1 16505.5 16523.4 12570.1 12618.0 12634.2 12661.9 12671.0 18291.7 18904.4 18926.5 19003.0 19066.1 7202.4 7316.8 7381.7 7417.8 7498.3 796.7 837.5 972.1 1031.3 1122.5 30144.0 30603.0 30688.2 30934.1 31130.4 1006.4 1032.4 1063.9 1081.6 1082.7 12634.6 13344.7 15503.1 15942.5 16012.7 646793.0 651464.0 653015.0 654113.7 655298.0 58427.4 58799.8 58965.0 59030.7 59205.4 1344.8 1345.1 1364.7 1371.7 1376.7 29712.0 30405.5 31310.7 32414.2 32910.8 55499.4 56124.0 56160.0 56303.0 56331.7 549870.0 551094.0 553895.0 554794.0 554810.0 42303.4 42419.6 42890.0 42935.0 43289.6 46570.5 47595.8 47652.5 47771.8 48294.0 30255.7 39436.0 39752.6 39938.0 40918.0 39100.8 40190.0 40470.4 40729.4 40749.8 37583.0 37801.6 37804.4 37900.0 38387.4 32833.5 33490.7 34190.7 34720.5 35258.8 23773.9 26026.5 26175.9 26203.1 26241.0 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34499.58 Median:20712.29 stddev:95528.38 (461.2%) stddev-sans-first:95762.01 03:44:53 INFO - PROCESS | 1641 | Values: 375.6 380.8 385.1 390.5 407.8 18023.3 19029.2 19649.4 19901.9 20093.5 17319.3 17604.6 17627.6 18664.8 19804.9 5487.9 5692.5 5804.2 5925.1 5951.3 5736.9 5916.2 5918.1 5922.4 5925.8 5731.8 5811.5 5830.0 5858.8 6032.8 5347.0 6051.6 6053.8 6067.4 6070.4 5667.5 5804.9 5844.2 5862.4 5871.9 13192.9 13417.2 13423.3 22361.0 24727.0 2159.8 2182.2 2365.3 2494.6 2868.0 9521.3 10042.6 10290.0 10484.4 10489.1 1785.1 1829.0 1848.7 1849.0 1860.3 124167.0 124686.0 125906.4 128907.4 129039.4 11274.5 11477.3 11931.8 12100.8 12135.0 14682.4 14689.8 14705.9 14720.0 14730.6 8177.9 8412.9 8448.2 8547.1 8559.3 8130.1 8175.2 8190.4 8212.0 8316.3 4458.5 4541.2 4566.2 4595.4 4601.4 1605.2 1652.6 1887.2 1950.9 1959.8 814.5 861.4 865.7 879.6 914.5 15265.5 18992.9 20411.5 20457.0 20967.6 909.4 914.8 916.4 953.5 963.7 9086.6 9887.8 10718.4 10784.7 10801.2 548575.0 558320.0 561244.0 572150.3 598217.0 129719.0 133219.0 134745.0 137014.3 138221.0 770.6 974.2 975.9 992.5 996.1 17291.0 18058.6 18352.8 18370.3 18378.3 41757.8 55041.4 55141.0 55609.7 56571.4 78327.0 79491.2 80270.0 80798.0 81401.0 11556.5 11735.1 11750.1 11817.9 12001.9 12809.7 13352.9 13359.1 13754.2 13872.9 10809.6 11162.7 11409.8 11531.8 11791.9 9944.0 10358.1 10446.3 10487.2 10523.4 9360.8 11413.6 11621.9 11736.3 12011.3 12158.2 12165.8 12180.3 12217.7 12397.4 9961.3 10803.0 11334.3 11771.3 11778.8 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5475.63 Median:5105.71 stddev:2986.06 (58.5%) stddev-sans-first:2979.10 03:44:53 INFO - PROCESS | 1641 | Values: 1449.7 1487.3 1553.7 1642.6 1726.2 7514.1 7783.8 8012.2 8459.8 8497.7 8063.4 8314.8 8359.0 8470.4 8505.7 2271.8 2301.0 2301.9 2301.9 2308.3 2327.5 2336.5 2386.7 2393.1 2393.9 2316.4 2317.4 2321.8 2331.0 2356.2 2310.9 2318.3 2327.2 2345.7 2346.9 2348.6 2375.0 2379.2 2381.3 2388.4 8362.4 8472.0 8508.0 8523.1 8698.5 5033.4 5086.5 5212.3 5268.9 5283.4 3268.5 3400.5 3464.3 3464.4 3471.1 984.2 1020.4 1032.1 1043.9 1044.0 10899.9 10958.0 10964.9 10984.9 10996.9 4545.8 4681.6 4768.2 4787.7 4805.9 7785.2 8471.8 9474.8 9477.0 9495.8 5124.9 5171.0 5210.2 5222.8 5228.1 4254.3 4281.4 4734.3 4758.6 4820.3 3805.4 3840.3 3920.7 3923.2 3924.8 1282.3 1287.3 1287.6 1293.9 1294.1 887.6 892.4 893.5 895.7 907.3 5063.2 5596.6 5657.7 5782.2 5881.7 888.4 913.1 935.1 947.7 960.2 3748.5 3813.4 3873.4 3881.6 3932.4 7692.0 10340.6 10354.6 10357.1 10362.7 10201.3 10322.8 10325.5 10326.2 10455.1 7409.0 7871.6 8033.0 8040.7 8072.9 5567.6 5774.1 5890.9 5918.0 5940.0 9275.9 9320.7 9361.2 9369.6 9432.3 9395.5 9536.8 9571.9 9630.6 9653.9 6653.7 6887.1 7078.5 7193.4 7312.2 7809.6 7982.5 8025.2 8025.5 8030.2 7054.0 7213.6 7227.4 7237.5 7302.5 6962.4 7018.2 7057.5 7162.8 7189.5 6630.7 6669.4 6684.8 6745.4 6749.1 4804.3 4862.1 4879.2 4881.3 4896.0 4819.1 4839.1 4897.4 4942.0 5001.6 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4483.22 Median:4945.59 stddev:1377.65 (27.9%) stddev-sans-first:1344.56 03:44:53 INFO - PROCESS | 1641 | Values: 260.3 304.5 310.9 315.0 318.9 4803.6 4951.5 4973.6 5488.5 5532.5 4572.9 4590.7 4680.5 5164.7 5273.6 3460.0 3491.5 3946.4 4176.8 4185.7 3943.6 3975.5 4170.0 4215.9 4227.0 3519.0 4103.3 4108.6 4114.8 4125.3 3409.8 3715.6 3948.5 3968.3 4120.6 3566.5 3582.2 3586.6 3591.7 3604.2 4464.8 5066.9 5347.7 5388.4 5409.4 4667.9 4733.6 4742.3 4744.7 4779.6 4813.0 5080.2 5618.7 5812.0 5879.2 3471.0 3795.4 3866.9 3877.3 3943.3 5117.9 5882.1 5954.4 6062.2 6082.6 3502.0 3960.5 3962.4 3973.1 3985.4 3050.0 3542.9 3714.3 3896.9 3941.9 3752.4 4084.0 4643.6 4716.4 4723.3 5100.5 5299.4 5820.5 5824.8 5893.0 1064.9 1257.4 1315.8 1317.3 1364.9 780.7 927.5 945.4 953.7 958.0 4411.9 5150.8 5165.6 5210.9 5211.7 4838.7 5093.8 5648.5 5652.9 5683.9 4423.0 4919.3 4939.7 5097.8 5146.7 2464.3 2882.9 2899.2 2938.8 2953.9 4737.3 5013.8 5217.9 5458.8 5768.1 4756.5 4981.2 5510.4 5590.7 5789.7 5002.5 5509.8 5844.3 5893.5 5919.7 4610.9 4908.8 5092.0 5165.9 5497.1 4244.4 4405.9 5032.6 5325.8 5330.0 4938.0 5147.8 5713.7 5886.7 5921.4 3787.8 4004.6 4011.2 4035.0 4074.4 4971.4 5921.3 6030.5 6031.0 6048.7 4903.8 5344.9 5552.5 5801.9 5894.4 5395.4 5653.7 5665.4 5795.4 5822.1 4898.7 5451.3 5537.9 5602.3 5704.4 4655.8 5813.8 5856.2 5858.6 5882.6 4992.3 4998.9 5327.5 5705.6 5725.9 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:18273.03 Median:26589.30 stddev:26153.78 (98.4%) stddev-sans-first:26193.76 03:44:53 INFO - PROCESS | 1641 | Values: 671.1 689.6 692.1 736.2 779.3 13958.4 14713.9 14833.0 14884.3 15710.6 14566.9 14904.8 14995.5 14995.6 15018.8 649.8 739.5 771.9 802.3 827.3 548.5 620.8 622.2 711.6 765.2 753.0 766.4 852.4 872.3 878.3 862.6 864.8 865.0 866.8 868.3 638.3 646.8 647.6 648.2 653.0 14191.8 14512.8 14533.0 14554.4 14699.6 13072.9 13226.0 13332.3 13363.1 13497.4 10887.2 10953.0 11221.4 11238.8 11539.2 3544.9 3605.4 3615.2 3644.0 3726.0 93476.0 94686.0 94791.0 94893.0 95575.6 10187.9 10210.5 10221.9 10231.1 10266.4 19353.5 19889.0 19987.3 20226.3 20337.0 6180.2 7172.5 7327.2 7369.6 7527.7 4131.9 4134.8 4235.5 4246.8 4326.7 3252.8 3339.4 3376.0 3378.4 3379.7 573.2 623.8 634.0 653.0 659.9 535.6 589.3 639.9 645.3 670.6 8039.0 8718.0 9302.4 9474.7 9614.6 561.1 586.7 640.7 656.7 663.8 4159.7 4319.6 4353.2 4380.3 4406.1 68053.3 96464.0 98675.0 98925.0 99169.5 62206.1 65977.7 69464.3 86455.0 86752.6 26009.9 43496.6 61534.0 75491.6 75897.0 8194.9 8487.2 8508.0 8572.5 8601.1 42828.4 45070.5 52549.7 52643.0 54576.0 56049.7 68825.3 69860.7 71589.3 73104.6 10670.1 10923.7 11054.5 11116.3 11424.4 12115.8 12176.9 12426.6 12435.4 12541.0 11464.1 11489.9 11652.7 11729.8 11802.5 10127.4 10382.7 11484.9 11686.9 12159.6 11117.8 11358.8 11627.2 11641.2 12041.2 9142.5 9540.8 9703.5 9871.6 10446.5 9885.5 10031.4 10047.7 10051.6 10075.0 03:44:53 INFO - PROCESS | 1641 | -------- Summary: end -------- 03:44:53 INFO - PROCESS | 1641 | 03:44:53 INFO - TEST-INFO | 1641: exit 0 03:44:53 INFO - TEST-OK | dromaeo_css | took 1117521ms 03:44:53 INFO - TEST-START | kraken 03:44:53 INFO - operating with platform_type : mac_ 03:44:53 INFO - Initialising browser for kraken test... 03:44:53 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmp8TFX_7/profile http://localhost:49240/getInfo.html) 03:44:56 INFO - PROCESS | 1673 | 2017-01-10 03:44:56.744 plugin-container[1675:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x862f, name = 'com.apple.tsm.portname' 03:44:56 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:56 INFO - PROCESS | 1673 | 2017-01-10 03:44:56.745 plugin-container[1675:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 03:44:56 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:56 INFO - PROCESS | 1673 | 2017-01-10 03:44:56.745 plugin-container[1675:10047] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:44:56 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 03:44:56 INFO - PROCESS | 1673 | colorDepth:24 03:44:56 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 03:44:56 INFO - PROCESS | 1673 | __metrics 03:44:56 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:44:57 INFO - TEST-INFO | 1673: exit 0 03:44:57 INFO - Browser initialized. 03:44:57 INFO - Running cycle 1/1 for kraken test... 03:44:57 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmp8TFX_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:00 INFO - PROCESS | 1676 | 2017-01-10 03:45:00.423 plugin-container[1677:10166] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 03:45:00 INFO - PROCESS | 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:45:00 INFO - PROCESS | 1676 | 2017-01-10 03:45:00.424 plugin-container[1677:10166] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:45:00 INFO - PROCESS | 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:45:00 INFO - PROCESS | 1676 | 2017-01-10 03:45:00.424 plugin-container[1677:10166] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:45:09 INFO - PROCESS | 1676 | RSS: Main: 229142528 03:45:09 INFO - PROCESS | 1676 | 03:45:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:14 INFO - PROCESS | 1676 | RSS: Main: 241188864 03:45:14 INFO - PROCESS | 1676 | 03:45:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 03:45:17 INFO - PROCESS | 1676 | RSS: Main: 249397248 03:45:17 INFO - PROCESS | 1676 | 03:45:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 03:45:21 INFO - PROCESS | 1676 | RSS: Main: 252891136 03:45:21 INFO - PROCESS | 1676 | 03:45:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 03:45:23 INFO - PROCESS | 1676 | RSS: Main: 253444096 03:45:23 INFO - PROCESS | 1676 | 03:45:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:26 INFO - PROCESS | 1676 | RSS: Main: 254660608 03:45:26 INFO - PROCESS | 1676 | 03:45:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:29 INFO - PROCESS | 1676 | RSS: Main: 258625536 03:45:29 INFO - PROCESS | 1676 | 03:45:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:33 INFO - PROCESS | 1676 | RSS: Main: 257658880 03:45:33 INFO - PROCESS | 1676 | 03:45:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 03:45:37 INFO - PROCESS | 1676 | RSS: Main: 257896448 03:45:37 INFO - PROCESS | 1676 | 03:45:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:39 INFO - PROCESS | 1676 | RSS: Main: 257277952 03:45:39 INFO - PROCESS | 1676 | 03:45:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:42 INFO - PROCESS | 1676 | RSS: Main: 257273856 03:45:42 INFO - PROCESS | 1676 | 03:45:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:45 INFO - PROCESS | 1676 | RSS: Main: 257257472 03:45:45 INFO - PROCESS | 1676 | 03:45:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:49 INFO - PROCESS | 1676 | RSS: Main: 257581056 03:45:49 INFO - PROCESS | 1676 | 03:45:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:53 INFO - PROCESS | 1676 | RSS: Main: 257458176 03:45:53 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 03:45:54 INFO - PROCESS | 1676 | RSS: Main: 259280896 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | __start_tp_report 03:45:54 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:45:54 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:45:54 INFO - PROCESS | 1676 | |i|pagename|runs| 03:45:54 INFO - PROCESS | 1676 | |0;ai-astar;104;117;132;172;115;117;117;118;116;117 03:45:54 INFO - PROCESS | 1676 | |1;audio-beat-detection;141;112;113;146;113;126;144;123;144;115 03:45:54 INFO - PROCESS | 1676 | |2;audio-dft;189;199;195;189;195;193;201;197;197;195 03:45:54 INFO - PROCESS | 1676 | |3;audio-fft;83;58;60;88;60;58;60;60;79;62 03:45:54 INFO - PROCESS | 1676 | |4;audio-oscillator;78;71;93;104;100;81;85;70;71;89 03:45:54 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;113;134;133;135;94;105;138;86;90;89 03:45:54 INFO - PROCESS | 1676 | |6;imaging-darkroom;128;99;153;122;159;152;135;109;120;120 03:45:54 INFO - PROCESS | 1676 | |7;imaging-desaturate;96;93;96;143;94;97;147;94;140;72 03:45:54 INFO - PROCESS | 1676 | |8;json-parse-financial;58;56;58;80;92;61;61;60;66;72 03:45:54 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;71;71;76;71;74;71;68;70;60;105 03:45:54 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;84;83;88;89;77;71;74;112;104;103 03:45:54 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;164;171;156;150;173;214;178;157;272;175 03:45:54 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;172;240;164;210;230;172;167;171;176;170 03:45:54 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;64;64;70;67;67;68;61;80;86 03:45:54 INFO - PROCESS | 1676 | __end_tp_report 03:45:54 INFO - PROCESS | 1676 | __start_cc_report 03:45:54 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,989 03:45:54 INFO - PROCESS | 1676 | __end_cc_report 03:45:54 INFO - PROCESS | 1676 | __startTimestamp1484048754973__endTimestamp 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:45:54 INFO - PROCESS | 1676 | Number of tests: 14 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:122.50 Median:117.00 stddev:18.63 (15.9%) stddev-sans-first:18.51 03:45:54 INFO - PROCESS | 1676 | Values: 104.0 117.0 132.0 172.0 115.0 117.0 117.0 118.0 116.0 117.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:133.50 stddev:14.56 (10.9%) stddev-sans-first:14.63 03:45:54 INFO - PROCESS | 1676 | Values: 141.0 112.0 113.0 146.0 113.0 126.0 144.0 123.0 144.0 115.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:195.00 Median:196.00 stddev:3.89 (2.0%) stddev-sans-first:3.46 03:45:54 INFO - PROCESS | 1676 | Values: 189.0 199.0 195.0 189.0 195.0 193.0 201.0 197.0 197.0 195.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.00 stddev:11.66 (19.1%) stddev-sans-first:10.79 03:45:54 INFO - PROCESS | 1676 | Values: 83.0 58.0 60.0 88.0 60.0 58.0 60.0 60.0 79.0 62.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:79.50 stddev:12.21 (15.4%) stddev-sans-first:12.74 03:45:54 INFO - PROCESS | 1676 | Values: 78.0 71.0 93.0 104.0 100.0 81.0 85.0 70.0 71.0 89.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:111.70 Median:112.00 stddev:21.58 (19.3%) stddev-sans-first:22.89 03:45:54 INFO - PROCESS | 1676 | Values: 113.0 134.0 133.0 135.0 94.0 105.0 138.0 86.0 90.0 89.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:129.70 Median:143.50 stddev:19.86 (13.8%) stddev-sans-first:21.05 03:45:54 INFO - PROCESS | 1676 | Values: 128.0 99.0 153.0 122.0 159.0 152.0 135.0 109.0 120.0 120.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:107.20 Median:94.00 stddev:26.00 (27.7%) stddev-sans-first:27.26 03:45:54 INFO - PROCESS | 1676 | Values: 96.0 93.0 96.0 143.0 94.0 97.0 147.0 94.0 140.0 72.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:63.50 stddev:11.64 (18.3%) stddev-sans-first:11.95 03:45:54 INFO - PROCESS | 1676 | Values: 58.0 56.0 58.0 80.0 92.0 61.0 61.0 60.0 66.0 72.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:71.00 stddev:11.78 (16.6%) stddev-sans-first:12.45 03:45:54 INFO - PROCESS | 1676 | Values: 71.0 71.0 76.0 71.0 74.0 71.0 68.0 70.0 60.0 105.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:80.00 stddev:13.75 (17.2%) stddev-sans-first:14.49 03:45:54 INFO - PROCESS | 1676 | Values: 84.0 83.0 88.0 89.0 77.0 71.0 74.0 112.0 104.0 103.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:181.00 Median:174.00 stddev:36.56 (21.0%) stddev-sans-first:38.26 03:45:54 INFO - PROCESS | 1676 | Values: 164.0 171.0 156.0 150.0 173.0 214.0 178.0 157.0 272.0 175.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:174.00 stddev:28.35 (16.3%) stddev-sans-first:29.53 03:45:54 INFO - PROCESS | 1676 | Values: 172.0 240.0 164.0 210.0 230.0 172.0 167.0 171.0 176.0 170.0 03:45:54 INFO - PROCESS | 1676 | 03:45:54 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.50 stddev:7.68 (11.2%) stddev-sans-first:8.14 03:45:54 INFO - PROCESS | 1676 | Values: 69.0 64.0 64.0 70.0 67.0 67.0 68.0 61.0 80.0 86.0 03:45:54 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:45:54 INFO - PROCESS | 1676 | 03:45:56 INFO - TEST-INFO | 1676: exit 0 03:45:56 INFO - TEST-OK | kraken | took 62427ms 03:45:56 INFO - SUITE-END | took 1179s 03:45:56 INFO - Completed test suite (00:19:40) 03:45:56 INFO - javascript benchmark 03:45:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7172.036961636377, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.5051867479233, 3417.094469965458, 3422.229998250394, 3443.793372397655, 3466.653334666533, 5724.398938111501, 5749.396313387097, 5753.5109515691165, 5787.855303617401, 5802.158686990384, 5771.624844385112, 5889.381614930424, 5893.528517718583, 5905.881882362351, 5931.258592675905, 5241.86895327616, 5277.498637629419, 5312.389075256357, 5349.866253343658, 5355.169948657945, 5338.486683590586, 5349.9300139971965, 5359.7320133993335, 5379.1393377059485, 5415.702136382517, 5211.817586384477, 5214.739263036852, 5346.6524675896135, 5348.251244825728, 5354.250404943292, 4584.724916504987, 5247.895042099137, 5257.684538927677, 5325.094733895247, 5427.240186373911, 4280.507741609724, 5281.947180528184, 5294.205869119663, 5313.44208858072, 5329.493698098674, 5487.451254874521, 5694.572907031948, 5702.5723070769445, 5827.650340979512, 5843.678597677126, 6169.938300616981, 6191.628502289877, 6228.813135605939, 6247.468965137969, 6263.373662633746, 6243.8126856194385, 6277.2153480814895, 6286.4342209201395, 6286.591371560834, 6300.243970723543, 5913.674747888821, 5936.881262374772, 5941.851453713692, 5968.1644569760265, 6008.639481631116, 6198.0, 6296.0555916612875, 6327.240731112296, 6374.426301632875, 6383.776567820104, 6225.470834978987, 6230.096635987757, 6243.43809057187, 6249.6875156242, 6250.281217659936, 6205.565610407228, 6250.749970001149, 6261.154744109578, 6271.0, 6282.308946015934, 6039.275286965592, 6099.878002439927, 6115.510759139258, 6120.721420533258, 6175.783847565403, 6205.627662340184, 6235.688215589203, 6241.7191226394925, 6246.625202487774, 6285.340039295899, 4996.775145118479, 5031.924521132186, 5033.5469807716745, 5043.142665746832, 5060.468650791614, 4355.760433176206, 4426.114777044604, 4487.192305385062, 4515.1195516873895, 4542.568455996675, 5713.685747283939, 5899.528037756969, 5979.970100149471, 6000.0999850022845, 6067.0, 6246.562740608205, 6278.277998030194, 6278.811635650938, 6281.59169653971, 6307.085472606446, 5762.769489220468, 5836.066229403275, 5865.472107510344, 5914.822555323261, 5931.08068249422, 5425.104857698515, 5481.232627432163, 5493.835184944458, 5500.367457742331, 5505.421930697299, 6451.70967306463, 6505.0567667688865, 6506.0, 6521.413072823469, 6522.21733391996, 6144.003198960445, 6146.801373732079, 6152.292486364126, 6179.412955769195, 6266.248050234001, 6312.242530896322, 6338.080978258219, 6348.619082855043, 6366.108744775643, 6383.457406120532, 6144.969275153596, 6151.569390142647, 6168.691565421801, 6179.3820617937845, 6195.132681424514, 6147.231596050494, 6180.381961803783, 6222.81331560054, 6223.626582405071, 6245.000799871998, 6041.546883983631, 6116.969415152896, 6239.594426362272, 6244.500439964701, 6247.156633854372, 6154.907676384947, 6225.875482490415, 6230.252369715663, 6231.855815882387, 6252.656103914328, 5111.565516931102, 5879.382664820132, 5972.313183983723, 5985.042393217064, 6034.2155519782145, 6081.878362432815, 6117.204763380732, 6134.375358695159, 6135.35515879939, 6141.785037523665, 6005.3694362091355, 6005.549583781321, 6055.031195008777, 6067.332593414632, 6069.150318955261], "value": 5760.957179898452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.8467121178799, 453.95687409696086, 499.732643035976, 502.57783461892, 514.9315171020135, 31840.84079579602, 36257.63742362579, 38600.80699596505, 40974.59025409745, 43081.569184308224, 42231.57768422315, 42591.57408425915, 42667.35998960018, 42685.786571067176, 42789.572104278945, 8168.815521749372, 9359.0, 9504.619815207383, 9524.904750952472, 9535.189508891752, 9313.0, 9426.434413935185, 9431.24550035999, 9435.622575097022, 9454.054594540525, 8719.302455803552, 9390.62437502499, 9431.245500359955, 9440.81118377632, 9446.81106377872, 8748.518831464267, 8990.0, 9421.528923553864, 9425.76435589109, 9431.575579098888, 9420.717378478588, 9426.528673566294, 9449.055094490564, 9484.573194206278, 9522.381045232038, 34902.0, 39734.0, 40122.59877401218, 40125.799371002955, 40220.597794021975, 3281.835908204604, 3480.704140148065, 3887.688984881231, 3926.960730392688, 3946.7370441458743, 29211.269718257, 29278.70721292781, 29283.707162928524, 29373.853130734424, 31128.221794455094, 2413.698287714036, 2953.4536110819354, 3029.1366960416176, 3046.817190968549, 3053.618297712786, 402013.0, 402952.0, 403630.0, 404100.0, 405477.0, 58314.7084264576, 58416.415835841944, 58502.70748646229, 58575.0, 58664.0, 57744.42255577474, 58130.4186958125, 63670.0, 63828.68085659542, 63933.04100438497, 16286.429974950819, 16472.929259598328, 16474.09392483401, 16505.504834854975, 16523.421680241136, 12570.057245706608, 12618.0, 12634.178778379375, 12661.873381266254, 12671.049671274692, 18291.68756330472, 18904.432867014013, 18926.52683682919, 19003.0, 19066.142023608973, 7202.351788339075, 7316.817079573053, 7381.741639042715, 7417.814554636069, 7498.325150736351, 796.6614188969664, 837.535167981776, 972.0910948263396, 1031.2832581355885, 1122.5341483284346, 30144.0, 30603.0, 30688.232794180323, 30934.0719778407, 31130.377392452476, 1006.3509036671306, 1032.4321623107262, 1063.8723353197665, 1081.5944020992129, 1082.653550863716, 12634.620961371174, 13344.732250436193, 15503.069815811088, 15942.521724348288, 16012.679746405007, 646793.0, 651464.0, 653015.0, 654113.7294313498, 655298.0, 58427.41572584305, 58799.824003520545, 58965.0, 59030.70484647549, 59205.40794592085, 1344.7713888638955, 1345.0920628575673, 1364.733876894016, 1371.7119404925077, 1376.6695992961618, 29712.0, 30405.543916840823, 31310.68689313169, 32414.21721805229, 32910.83544582262, 55499.445005551046, 56124.0, 56160.0, 56303.0, 56331.71834140803, 549870.0, 551094.0, 553895.0, 554794.0, 554810.0, 42303.36544951767, 42419.57580424156, 42890.0, 42935.0, 43289.56710432981, 46570.53429465798, 47595.76202118967, 47652.52347476481, 47771.761141194074, 48294.03411931671, 30255.69744302529, 39436.04636731497, 39752.60247397489, 39938.00154996148, 40918.0, 39100.80449597734, 40190.0, 40470.392944105275, 40729.38905916354, 40749.79625101974, 37583.0, 37801.62198377981, 37804.43293350657, 37900.0, 38387.424188636636, 32833.50749738708, 33490.66037358576, 34190.658093418744, 34720.479192811625, 35258.8237058813, 23773.881130594236, 26026.479470410864, 26175.869120654275, 26203.082892098686, 26241.0], "value": 19998.683070602667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.564345359383, 380.7639263656533, 385.05277018534406, 390.51381030616886, 407.7614595461655, 18023.279068837248, 19029.238830446764, 19649.410517684457, 19901.900490497545, 20093.497662558424, 17319.307227710877, 17604.64790704185, 17627.64744705105, 18664.813351866476, 19804.900975495104, 5487.917681234785, 5692.459216374458, 5804.216430781854, 5925.081612350093, 5951.256092988377, 5736.881308144913, 5916.230889984296, 5918.112283157518, 5922.378150294222, 5925.762969481216, 5731.799387021455, 5811.506021988115, 5830.008898487246, 5858.76564937402, 6032.849178770544, 5347.037533244014, 6051.576389652726, 6053.848653783647, 6067.423594758513, 6070.392960703938, 5667.4615911488345, 5804.941950580483, 5844.181814545925, 5862.443067908542, 5871.882562348772, 13192.86807131926, 13417.194968301934, 13423.261720605362, 22361.0, 24727.0, 2159.8164156046755, 2182.181681869299, 2365.3377054424786, 2494.6133349330885, 2867.95319708305, 9521.333506654537, 10042.556576383076, 10290.02244786744, 10484.423356715377, 10489.108425783817, 1785.1074462768615, 1829.0, 1848.667239896818, 1848.9907550462297, 1860.265195247883, 124167.0, 124686.0, 125906.37046814707, 128907.35546322302, 129039.41921161619, 11274.54901803935, 11477.253978491372, 11931.761364772656, 12100.81848772269, 12135.0, 14682.41270349174, 14689.77965330521, 14705.852941470448, 14720.0, 14730.558083257305, 8177.877331840027, 8412.915870841336, 8448.183640517318, 8547.10255423184, 8559.272461840814, 8130.105688374274, 8175.182481751896, 8190.426670133153, 8211.95894020526, 8316.251537361666, 4458.5318541553315, 4541.205289074399, 4566.246569316092, 4595.4025976622825, 4601.44782626087, 1605.2054233154663, 1652.5538104711661, 1887.226237242724, 1950.9024548772504, 1959.7849333413376, 814.5316443045273, 861.3927181337142, 865.7056600755773, 879.6437442835662, 914.4787471141518, 15265.465708700141, 18992.905035474734, 20411.489712757004, 20457.0, 20967.58064838725, 909.3952521573212, 914.835329640671, 916.3768637326549, 953.50894289441, 963.6819849449665, 9086.591103400362, 9887.80224395508, 10718.35689858611, 10784.730381740519, 10801.189910756724, 548575.0, 558320.0, 561244.0, 572150.2784972097, 598217.0, 129719.0, 133219.00171497435, 134745.0, 137014.31492842472, 138221.0, 770.6300975531776, 974.2206235011962, 975.8828940527183, 992.4938281476354, 996.0637001218831, 17291.0, 18058.63882722312, 18352.81647183511, 18370.265189392274, 18378.264869405073, 41757.791211043754, 55041.44958550363, 55141.0, 55609.72195138998, 56571.434285658266, 78327.0, 79491.20508794839, 80270.0, 80798.0, 81401.0, 11556.537738490366, 11735.119866009913, 11750.11874109428, 11817.881821181678, 12001.939990300341, 12809.743805123659, 13352.933235333761, 13359.064865459713, 13754.174749515061, 13872.861271387157, 10809.621663241749, 11162.665120046411, 11409.771804563696, 11531.827022594836, 11791.941040295087, 9943.950280248842, 10358.119559837498, 10446.268761186644, 10487.213458990454, 10523.421211833424, 9360.812783744152, 11413.60052398162, 11621.88378116208, 11736.295822250693, 12011.339376334035, 12158.209716368408, 12165.75668486643, 12180.330081845583, 12217.69455763613, 12397.442115105023, 9961.252906032221, 10803.0, 11334.263272887236, 11771.293722376684, 11778.76442471163], "value": 9598.79272890263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.6810701645638, 1487.345567950102, 1553.69702907933, 1642.622196894714, 1726.214572369572, 7514.0607424071995, 7783.766487005385, 8012.238837310453, 8459.788505287363, 8497.660093596256, 8063.435559510836, 8314.750557483285, 8359.0, 8470.407071504997, 8505.74482765518, 2271.806896413803, 2301.0, 2301.861888286708, 2301.8835864605653, 2308.284431826139, 2327.5228578141523, 2336.5443738471004, 2386.689730335054, 2393.0906255622926, 2393.892274847636, 2316.4093156245217, 2317.385892738426, 2321.791038806507, 2331.0, 2356.210669425736, 2310.9306720798404, 2318.2813327868416, 2327.173853282086, 2345.6950596422525, 2346.9061237550477, 2348.5655153796433, 2374.9881250593808, 2379.1553998330514, 2381.2856143156982, 2388.4267775733874, 8362.414630975834, 8472.025717042496, 8507.957460212721, 8523.14768523149, 8698.47809131454, 5033.370828646419, 5086.491350864921, 5212.348456442945, 5268.92096618551, 5283.418823929364, 3268.4607039838397, 3400.506926495644, 3464.2725027744204, 3464.445688689823, 3471.1495683557437, 984.2126298960874, 1020.4387586827289, 1032.0969151992008, 1043.9060484556426, 1043.9791204175874, 10899.945500272528, 10958.0, 10964.890351096547, 10984.945075274572, 10996.945015274952, 4545.795439205243, 4681.625469962463, 4768.165571025057, 4787.712737235777, 4805.879853003703, 7785.18255583167, 8471.830563388698, 9474.763130921781, 9477.0, 9495.76260593477, 5124.92312615311, 5171.01750667372, 5210.166373380241, 5222.764975576109, 5228.137357336073, 4254.255505286563, 4281.357796330575, 4734.28985652148, 4758.643101767381, 4820.325154478376, 3805.353089974711, 3840.251151025579, 3920.745151565139, 3923.1757232886844, 3924.803759811998, 1282.3267784413258, 1287.2726909296218, 1287.6265882893856, 1293.909426340147, 1294.0682708449901, 887.5562218890555, 892.4110087342323, 893.5130353957109, 895.7088946092546, 907.3331101640289, 5063.240513922868, 5596.608237423341, 5657.688827114548, 5782.190493330937, 5881.676507792027, 888.4225253585221, 913.1462082952461, 935.1069728409353, 947.7156852944227, 960.1550635440767, 3748.5126933498473, 3813.389857622767, 3873.4189871518934, 3881.6118388160958, 3932.4494570760116, 7692.0, 10340.586376545005, 10354.585816567404, 10357.119644830123, 10362.740931476774, 10201.285909986229, 10322.845157322647, 10325.48372581368, 10326.22553308505, 10455.111315538112, 7409.0, 7871.645775940096, 8033.0360356757565, 8040.67837286502, 8072.878906816402, 5567.638103523258, 5774.105013722879, 5890.941090589039, 5918.0, 5940.0, 9275.86086208721, 9320.72037838866, 9361.204297634777, 9369.578368973276, 9432.339736218399, 9395.530223488935, 9536.761580960532, 9571.90428095738, 9630.614775409185, 9653.855192172263, 6653.700583473658, 6887.139107611549, 7078.4691148163065, 7193.424526037799, 7312.232215617283, 7809.648565814666, 7982.521048737094, 8025.15735847751, 8025.518468891885, 8030.196980301923, 7054.047703560159, 7213.567185968858, 7227.421806255592, 7237.529560578546, 7302.452316076209, 6962.443004559725, 7018.192907815666, 7057.541259818096, 7162.820929476597, 7189.460790440633, 6630.701618427279, 6669.433098186514, 6684.766033188815, 6745.3591908768585, 6749.055132281386, 4804.25534042224, 4862.05189987949, 4879.243717223836, 4881.316615673737, 4895.951040489549, 4819.108464933998, 4839.128956787812, 4897.436794768647, 4942.011597680406, 5001.574866136273], "value": 4446.692867849586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.29460162958384, 304.5477465963044, 310.9082820567932, 315.0454124004267, 318.90114064639965, 4803.5916947059495, 4951.479100802606, 4973.626977976657, 5488.545535433103, 5532.529734972527, 4572.9314060289125, 4590.724556526602, 4680.485146633868, 5164.657189130825, 5273.551748101407, 3459.9654003459896, 3491.493733408667, 3946.427767973642, 4176.770277634729, 4185.707000509966, 3943.5859234780364, 3975.463312452811, 4169.958300417003, 4215.894602634928, 4226.978865105671, 3518.9648103518894, 4103.343465045593, 4108.589141085882, 4114.753114813106, 4125.2780763366445, 3409.8465569049326, 3715.5727091384565, 3948.545917219528, 3968.3253846846105, 4120.608542188487, 3566.5185199997927, 3582.176099497104, 3586.605473397924, 3591.6947059499976, 3604.1710406606367, 4464.843730469418, 5066.873328166788, 5347.652402593819, 5388.407275199725, 5409.404965453797, 4667.906641867177, 4733.573978341966, 4742.2886567014875, 4744.715317080986, 4779.641526885497, 4813.029250868013, 5080.161773307437, 5618.747156377973, 5811.953848307303, 5879.206307148523, 3470.958712386274, 3795.3547896857326, 3866.8646597368956, 3877.263319969197, 3943.2507823513442, 5117.872053198663, 5882.058920556206, 5954.404559544054, 6062.242219722535, 6082.5742198046155, 3501.964980350215, 3960.4851369321805, 3962.405639154092, 3973.099637264813, 3985.4221137934837, 3049.969500305013, 3542.875999340011, 3714.257148570297, 3896.8636097736444, 3941.940870886882, 3752.380857158593, 4083.959160408358, 4643.628509719214, 4716.410448693913, 4723.339411955693, 5100.464451232567, 5299.4435584263865, 5820.534357251409, 5824.79613213544, 5892.998190307658, 1064.8935106489444, 1257.352463481308, 1315.7829008167407, 1317.2689157517477, 1364.911280766747, 780.6760194519211, 927.526961249754, 945.3571571331423, 953.7377221264207, 957.9760505987267, 4411.904345435956, 5150.845474635767, 5165.586753059746, 5210.853612205309, 5211.687298762086, 4838.709677419366, 5093.821716239914, 5648.491635752802, 5652.943470565324, 5683.943160568341, 4422.960604258061, 4919.2867034279825, 4939.703617782944, 5097.7629205454805, 5146.739048932961, 2464.322311364389, 2882.884684612592, 2899.246195989058, 2938.823670579772, 2953.9070543898897, 4737.336772851803, 5013.799448022111, 5217.869553261199, 5458.781648734006, 5768.06769732136, 4756.4541524004835, 4981.2030075187795, 5510.448955104457, 5590.692511911802, 5789.681567513743, 5002.498750624688, 5509.834704958777, 5844.26946631671, 5893.499052580579, 5919.67441790697, 4610.861674149781, 4908.779104940358, 5091.956148989522, 5165.9483405165465, 5497.1049636265925, 4244.434674872998, 4405.889852753707, 5032.597392208541, 5325.84303357141, 5330.013947419739, 4938.0, 5147.845564633067, 5713.742881570256, 5886.705664716833, 5921.3782552831335, 3787.8295476703065, 4004.5594984551094, 4011.217812526529, 4035.031592417857, 4074.449949256931, 4971.353724015855, 5921.348651648402, 6030.457258846549, 6030.969845150747, 6048.667323297261, 4903.803847846046, 5344.85085706575, 5552.5280351168985, 5801.94198058014, 5894.351621321737, 5395.3525576931015, 5653.671387223917, 5665.376808550974, 5795.420457954171, 5822.13691618678, 4898.697612122297, 5451.318585176853, 5537.861553461195, 5602.2717046783655, 5704.3725190228215, 4655.813767449399, 5813.76744930198, 5856.164212440688, 5858.5898987070495, 5882.647041177372, 4992.301077849032, 4998.925016124834, 5327.493888080781, 5705.62913410627, 5725.8568535786935], "value": 4047.204276120078, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.0906721392516, 689.593140047372, 692.0795342194879, 736.2269616902255, 779.2752739951846, 13958.441662333507, 14713.926430367834, 14833.0, 14884.25578721065, 15710.607234819136, 14566.927165364184, 14904.776428353556, 14995.47515836946, 14995.550133495984, 15018.849811501881, 649.8180509457336, 739.5394096659109, 771.9343855772266, 802.2739420824149, 827.2967977219375, 548.5200449606594, 620.8323752586799, 622.1973653986353, 711.5552779512805, 765.2118318132333, 753.0097921233561, 766.3639179481017, 852.3649880838784, 872.2629378175432, 878.2534845381407, 862.6204470033165, 864.788126908905, 864.952427616484, 866.8266346730679, 868.3227082875368, 638.3488841381811, 646.8382904273932, 647.5855452510397, 648.1994736500418, 653.0172091003058, 14191.78712319316, 14512.782308265385, 14533.0, 14554.417823287056, 14699.632509187355, 13072.934635326763, 13226.008049396238, 13332.266725330102, 13363.131396459296, 13497.392617332243, 10887.237893347468, 10953.0, 11221.438928053565, 11238.831417528743, 11539.192256542045, 3544.929101417983, 3605.369060414417, 3615.2407994321225, 3643.9979005773357, 3726.0498572864017, 93476.0, 94686.0, 94791.0, 94893.0, 95575.56636650456, 10187.898121018696, 10210.489475526194, 10221.897781022244, 10231.079202871777, 10266.384016958857, 19353.51616209606, 19889.0, 19987.300444484372, 20226.292079777137, 20336.9831508424, 6180.227471566054, 7172.533785303938, 7327.157376901618, 7369.594672292968, 7527.698892044257, 4131.855385061508, 4134.751914885116, 4235.53409124996, 4246.830126794894, 4326.697131200785, 3252.7885687430717, 3339.4322965095994, 3375.9831200843837, 3378.4256676365076, 3379.746519011084, 573.1889376532243, 623.7991865658589, 634.0236036503825, 652.9510286728514, 659.9076129341896, 535.5929493584904, 589.2840199158044, 639.8976163813768, 645.3224114679567, 670.5976414151568, 8038.995125609299, 8718.0, 9302.395344302598, 9474.715758527254, 9614.567344469515, 561.1386521689269, 586.652181427614, 640.7405000974612, 656.7471523463405, 663.7776344924408, 4159.688023398257, 4319.611234988866, 4353.238183317907, 4380.299152135707, 4406.0809069827465, 68053.29866753271, 96464.0, 98675.0, 98925.0, 99169.50415248022, 62206.0669089964, 65977.67011164913, 69464.30535694679, 86455.0, 86752.56623716967, 26009.869950650125, 43496.565034349886, 61534.0, 75491.62254188694, 75897.0, 8194.877076843972, 8487.151284871463, 8508.043150075393, 8572.52851093196, 8601.053884072622, 42828.357574637026, 45070.549294507946, 52549.7372513135, 52643.0, 54576.0, 56049.71975140098, 68825.31174688389, 69860.65069674619, 71589.28410715827, 73104.63447682727, 10670.146388288764, 10923.726906827393, 11054.502547385548, 11116.333020018825, 11424.428778560872, 12115.75768484643, 12176.939115304367, 12426.62720118398, 12435.378231088229, 12540.99672026254, 11464.067772988376, 11489.885101148882, 11652.708682283012, 11729.765404692029, 11802.52789888395, 10127.442990635585, 10382.740431489274, 11484.94257528707, 11686.94156529212, 12159.635210943687, 11117.833232501358, 11358.772824543297, 11627.244229125079, 11641.243319184226, 12041.157119001586, 9142.498418123369, 9540.761480963032, 9703.5148242589, 9871.555779989774, 10446.477676116316, 9885.505724713592, 10031.398116113056, 10047.748806279902, 10051.597936082768, 10075.021473717823], "value": 6837.5843320145095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 132.0, 172.0, 115.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 113.0, 146.0, 113.0, 126.0, 144.0, 123.0, 144.0, 115.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 199.0, 195.0, 189.0, 195.0, 193.0, 201.0, 197.0, 197.0, 195.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 88.0, 60.0, 58.0, 60.0, 60.0, 79.0, 62.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 93.0, 104.0, 100.0, 81.0, 85.0, 70.0, 71.0, 89.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 134.0, 133.0, 135.0, 94.0, 105.0, 138.0, 86.0, 90.0, 89.0], "value": 111.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 99.0, 153.0, 122.0, 159.0, 152.0, 135.0, 109.0, 120.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 96.0, 143.0, 94.0, 97.0, 147.0, 94.0, 140.0, 72.0], "value": 107.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 80.0, 92.0, 61.0, 61.0, 60.0, 66.0, 72.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 76.0, 71.0, 74.0, 71.0, 68.0, 70.0, 60.0, 105.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 88.0, 89.0, 77.0, 71.0, 74.0, 112.0, 104.0, 103.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 156.0, 150.0, 173.0, 214.0, 178.0, 157.0, 272.0, 175.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 240.0, 164.0, 210.0, 230.0, 172.0, 167.0, 171.0, 176.0, 170.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 64.0, 70.0, 67.0, 67.0, 68.0, 61.0, 80.0, 86.0], "value": 69.6, "unit": "score"}]}]} 03:45:56 INFO - Return code: 0 03:45:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:56 ERROR - # TBPL SUCCESS # 03:45:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:56 INFO - 2017-01-10 03:45:56.809 screenresolution[1681:10545] starting screenresolution argv=screenresolution get 03:45:56 INFO - 2017-01-10 03:45:56.812 screenresolution[1681:10545] Display 0: 1600x1200x32@60 03:45:56 INFO - 2017-01-10 03:45:56.818 screenresolution[1682:10548] starting screenresolution argv=screenresolution list 03:45:56 INFO - Available Modes on Display 0 03:45:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:57 INFO - Intel Iris: 03:45:57 INFO - Chipset Model: Intel Iris 03:45:57 INFO - Type: GPU 03:45:57 INFO - Bus: Built-In 03:45:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:57 INFO - Vendor: Intel (0x8086) 03:45:57 INFO - Device ID: 0x0a2e 03:45:57 INFO - Revision ID: 0x0009 03:45:57 INFO - Displays: 03:45:57 INFO - Display: 03:45:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:57 INFO - Display Serial Number: 1600x1200 60 03:45:57 INFO - Main Display: Yes 03:45:57 INFO - Mirror: Off 03:45:57 INFO - Online: Yes 03:45:57 INFO - Rotation: Supported 03:45:57 INFO - Return code: 0 03:45:57 INFO - Running post-action listener: _resource_record_post_action 03:45:57 INFO - [mozharness: 2017-01-10 11:45:57.055721Z] Finished run-tests step (success) 03:45:57 INFO - Running post-run listener: _resource_record_post_run 03:45:57 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 39061504; Write bytes: 660217856; Read time: 245; Write time: 1896 03:45:57 INFO - TinderboxPrint: CPU usage
54.3% 03:45:57 INFO - TinderboxPrint: I/O read bytes / time
39,061,504 / 245 03:45:57 INFO - TinderboxPrint: I/O write bytes / time
660,217,856 / 1,896 03:45:57 INFO - TinderboxPrint: CPU idle
2,216.4 (45.7%) 03:45:57 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 03:45:57 INFO - TinderboxPrint: CPU user
1,653.0 (34.1%) 03:45:57 INFO - TinderboxPrint: Swap in / out
388,407,296 / 0 03:45:57 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 353622528; Write bytes: 346080768; Read time: 27007; Write time: 704 03:45:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31690752; Write bytes: 306973184; Read time: 186; Write time: 1162 03:45:57 INFO - Running post-run listener: _upload_blobber_files 03:45:57 INFO - Blob upload gear active. 03:45:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:59 INFO - (blobuploader) - INFO - Done attempting. 03:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:00 INFO - (blobuploader) - INFO - Done attempting. 03:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:02 INFO - (blobuploader) - INFO - Done attempting. 03:46:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:02 INFO - Return code: 0 03:46:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84955a5544d66ab96519aa5f9933903dcf3a33ab9b83572fd0c221048c5754c51779fa8910c78f6e3ffd1b966fd12a841f72728bf08316a97896ec53f08efa7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18aff80397d37afd161b540ee9e930f86d63ce92c8aa9724a64eace4afc3da303590d106ca69b0939809d8bbbc4c4ded46be180f8e49809956b165546fa1f23b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/186385cfaede0f307106ae08dd4c8750f0b7d9f93323137eb821199f0947486d135b060f584d3102905b6e98e00117051d6093ba2e98425d66a889bbf2bd4f3e"} 03:46:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:02 INFO - Contents: 03:46:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84955a5544d66ab96519aa5f9933903dcf3a33ab9b83572fd0c221048c5754c51779fa8910c78f6e3ffd1b966fd12a841f72728bf08316a97896ec53f08efa7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18aff80397d37afd161b540ee9e930f86d63ce92c8aa9724a64eace4afc3da303590d106ca69b0939809d8bbbc4c4ded46be180f8e49809956b165546fa1f23b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/186385cfaede0f307106ae08dd4c8750f0b7d9f93323137eb821199f0947486d135b060f584d3102905b6e98e00117051d6093ba2e98425d66a889bbf2bd4f3e"} 03:46:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:02 INFO - Copying logs to upload dir... 03:46:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.351234 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-10 03:46:02.771645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 03:46:02.775791) ========= 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.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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/84955a5544d66ab96519aa5f9933903dcf3a33ab9b83572fd0c221048c5754c51779fa8910c78f6e3ffd1b966fd12a841f72728bf08316a97896ec53f08efa7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18aff80397d37afd161b540ee9e930f86d63ce92c8aa9724a64eace4afc3da303590d106ca69b0939809d8bbbc4c4ded46be180f8e49809956b165546fa1f23b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/186385cfaede0f307106ae08dd4c8750f0b7d9f93323137eb821199f0947486d135b060f584d3102905b6e98e00117051d6093ba2e98425d66a889bbf2bd4f3e"} build_url:https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/d4jrR9AxRPaDCU_CHvTQKA/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/84955a5544d66ab96519aa5f9933903dcf3a33ab9b83572fd0c221048c5754c51779fa8910c78f6e3ffd1b966fd12a841f72728bf08316a97896ec53f08efa7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18aff80397d37afd161b540ee9e930f86d63ce92c8aa9724a64eace4afc3da303590d106ca69b0939809d8bbbc4c4ded46be180f8e49809956b165546fa1f23b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/186385cfaede0f307106ae08dd4c8750f0b7d9f93323137eb821199f0947486d135b060f584d3102905b6e98e00117051d6093ba2e98425d66a889bbf2bd4f3e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 03:46:02.813250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:46:02.813608) ========= 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.UL6eoK53Ti/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.CVbp0RQy30/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.005294 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 03:46:02.862219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 03:46:02.865540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 03:46:02.865846) ========= ========= Total master_lag: 0.53 =========