builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1483418033.91 results: success (0) buildid: 20170102192820 builduid: 7e387bb9f62d44839255dcfec281dcce revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:53.914957) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:53.915436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:53.915762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:53.942251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:53.942607) ========= 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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-02 20:33:53-- 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% 14.0M=0.001s 2017-01-02 20:33:54 (14.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:54.133597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:54.133943) ========= 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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.031520 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:54.188704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 20:33:54.189079) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6f6cf4180980a74083cc03f611cc510eb15b5cc --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 a6f6cf4180980a74083cc03f611cc510eb15b5cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-02 20:33:54,295 truncating revision to first 12 chars 2017-01-02 20:33:54,295 Setting DEBUG logging. 2017-01-02 20:33:54,295 attempt 1/10 2017-01-02 20:33:54,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6f6cf418098?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 20:33:55,352 unpacking tar archive at: mozilla-aurora-a6f6cf418098/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 20:33:55.549419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:55.549743) ========= script_repo_revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:55.550171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:55.550449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 20:33:55.570688) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-02 20:33:55.571094) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:33:55 INFO - MultiFileLogger online at 20170102 20:33:55 in /builds/slave/test 20:33:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:33:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:33:55 INFO - {'append_to_log': False, 20:33:55 INFO - 'base_work_dir': '/builds/slave/test', 20:33:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:33:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:33:55 INFO - 'branch': 'Mozilla-Aurora', 20:33:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:33:55 INFO - 'config_files': ('talos/mac_config.py',), 20:33:55 INFO - 'default_actions': ('clobber', 20:33:55 INFO - 'read-buildbot-config', 20:33:55 INFO - 'download-and-extract', 20:33:55 INFO - 'populate-webroot', 20:33:55 INFO - 'create-virtualenv', 20:33:55 INFO - 'install', 20:33:55 INFO - 'run-tests'), 20:33:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:33:55 INFO - 'download_minidump_stackwalk': True, 20:33:55 INFO - 'download_symbols': 'ondemand', 20:33:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:33:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:33:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:33:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:33:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:33:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:33:55 INFO - 'installer_path': 'installer.exe', 20:33:55 INFO - 'log_level': 'info', 20:33:55 INFO - 'log_name': 'talos', 20:33:55 INFO - 'log_to_console': True, 20:33:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:33:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:33:55 INFO - 'opt_config_files': (), 20:33:55 INFO - 'pip_index': False, 20:33:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:33:55 INFO - 'cmd': ('bash', 20:33:55 INFO - '-c', 20:33:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:33:55 INFO - 'enabled': True, 20:33:55 INFO - 'halt_on_failure': False, 20:33:55 INFO - 'name': 'check_screen_resolution'},), 20:33:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:33:55 INFO - 'cmd': ('bash', 20:33:55 INFO - '-c', 20:33:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:33:55 INFO - 'enabled': True, 20:33:55 INFO - 'halt_on_failure': False, 20:33:55 INFO - 'name': 'check_screen_resolution'},), 20:33:55 INFO - 'run_cmd_checks_enabled': True, 20:33:55 INFO - 'sps_profile': False, 20:33:55 INFO - 'sps_profile_interval': 0, 20:33:55 INFO - 'suite': 'dromaeojs', 20:33:55 INFO - 'system_bits': '32', 20:33:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:33:55 INFO - 'title': 't-yosemite-r7-0258', 20:33:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:33:55 INFO - 'use_talos_json': True, 20:33:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:33:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:33:55 INFO - 'work_dir': 'build'} 20:33:55 INFO - [mozharness: 2017-01-03 04:33:55.782997Z] Running clobber step. 20:33:55 INFO - Running pre-action listener: _resource_record_pre_action 20:33:55 INFO - Running main action method: clobber 20:33:55 INFO - rmtree: /builds/slave/test/build 20:33:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:33:58 INFO - Running post-action listener: _resource_record_post_action 20:33:58 INFO - [mozharness: 2017-01-03 04:33:58.406164Z] Finished clobber step (success) 20:33:58 INFO - [mozharness: 2017-01-03 04:33:58.406322Z] Running read-buildbot-config step. 20:33:58 INFO - Running pre-action listener: _resource_record_pre_action 20:33:58 INFO - Running main action method: read_buildbot_config 20:33:58 INFO - Using buildbot properties: 20:33:58 INFO - { 20:33:58 INFO - "project": "", 20:33:58 INFO - "product": "firefox", 20:33:58 INFO - "script_repo_revision": "production", 20:33:58 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:33:58 INFO - "repository": "", 20:33:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:33:58 INFO - "buildid": "20170102192820", 20:33:58 INFO - "pgo_build": "False", 20:33:58 INFO - "basedir": "/builds/slave/test", 20:33:58 INFO - "buildnumber": 7, 20:33:58 INFO - "slavename": "t-yosemite-r7-0258", 20:33:58 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:33:58 INFO - "platform": "yosemite_r7", 20:33:58 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:33:58 INFO - "branch": "mozilla-aurora", 20:33:58 INFO - "repo_path": "releases/mozilla-aurora", 20:33:58 INFO - "revision": "a6f6cf4180980a74083cc03f611cc510eb15b5cc", 20:33:58 INFO - "stage_platform": "macosx64", 20:33:58 INFO - "builduid": "7e387bb9f62d44839255dcfec281dcce", 20:33:58 INFO - "slavebuilddir": "test" 20:33:58 INFO - } 20:33:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 20:33:58 INFO - Running post-action listener: _resource_record_post_action 20:33:58 INFO - [mozharness: 2017-01-03 04:33:58.409579Z] Finished read-buildbot-config step (success) 20:33:58 INFO - [mozharness: 2017-01-03 04:33:58.409692Z] Running download-and-extract step. 20:33:58 INFO - Running pre-action listener: _resource_record_pre_action 20:33:58 INFO - Running main action method: download_and_extract 20:33:58 INFO - mkdir: /builds/slave/test/build/tests 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:58 INFO - trying https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 20:33:58 INFO - Downloading https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/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 20:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/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 20:33:59 INFO - Downloaded 1199 bytes. 20:33:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 20:33:59 INFO - Using the following test package requirements: 20:33:59 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 20:33:59 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 20:33:59 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 20:33:59 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'jsshell-mac.zip'], 20:33:59 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 20:33:59 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 20:33:59 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 20:33:59 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 20:33:59 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 20:33:59 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:33:59 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 20:33:59 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:33:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 20:33:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:33:59 INFO - Fetch https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 20:34:00 INFO - Http code: 200 20:34:00 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 20:34:00 INFO - x-amz-cf-id: VKjMeRTnvuyu7Pg02XGXvzXHa1ubUawJz_xW5Lfjr8KAHt6fBBcoGw== 20:34:00 INFO - x-amz-version-id: FVLSqBmfYuDqiIkbNo2ssXm.N3CTUx3l 20:34:00 INFO - Expected file size: 16268365 20:34:00 INFO - Obtained file size: 16268365 20:34:07 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 20:34:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 20:34:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:34:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 20:34:07 INFO - Http code: 200 20:34:07 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:34:07 INFO - x-amz-cf-id: FVoEzxRS9bOaeZbp-wihTFRpOCTjS9jWHgXOel1_MYOElhOXIyBjag== 20:34:07 INFO - x-amz-version-id: FVLSqBmfYuDqiIkbNo2ssXm.N3CTUx3l 20:34:08 INFO - Expected file size: 16268365 20:34:08 INFO - Obtained file size: 16268365 20:34:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 20:34:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:34:14 INFO - Fetch https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 20:34:15 INFO - Http code: 200 20:34:15 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 20:34:15 INFO - x-amz-cf-id: UP0SVY730-6PDJgsX_wk3blPA09TTZWkp0-3pi-PmV3UG_oot8KX7A== 20:34:15 INFO - x-amz-version-id: hgt.55wxj7IUUOXiT.y3u7jsWmkgmNRd 20:34:15 INFO - Expected file size: 14409038 20:34:15 INFO - Obtained file size: 14409038 20:34: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')]} 20:34:15 INFO - trying https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:34:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 20:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/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 20:34:20 INFO - Downloaded 109829959 bytes. 20:34:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:34:20 INFO - mkdir: /builds/slave/test/properties 20:34:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:20 INFO - Contents: 20:34:20 INFO - build_url:https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:34:21 INFO - Running post-action listener: _resource_record_post_action 20:34:21 INFO - Running post-action listener: set_extra_try_arguments 20:34:21 INFO - [mozharness: 2017-01-03 04:34:21.218832Z] Finished download-and-extract step (success) 20:34:21 INFO - [mozharness: 2017-01-03 04:34:21.218970Z] Running populate-webroot step. 20:34:21 INFO - Running pre-action listener: _resource_record_pre_action 20:34:21 INFO - Running main action method: populate_webroot 20:34:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:21 INFO - '--tppagecycles', 20:34:21 INFO - '7'], 20:34:21 INFO - 'tests': ['tsvgm']}}, 20:34:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:34:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:34:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['damp', 'tps']}, 20:34:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['damp', 'tps']}, 20:34:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['dromaeo_dom']}, 20:34:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['basic_compositor_video']}, 20:34:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:34:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tsvgx', 20:34:21 INFO - 'tsvgr_opacity', 20:34:21 INFO - 'tart', 20:34:21 INFO - 'tscrollx', 20:34:21 INFO - 'cart']}, 20:34:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:34:21 INFO - 'tsvgr_opacity', 20:34:21 INFO - 'tart', 20:34:21 INFO - 'tscrollx', 20:34:21 INFO - 'cart']}, 20:34:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tp5o']}, 20:34:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['tp5o']}, 20:34:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s', 20:34:21 INFO - '--xperf_path', 20:34:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:21 INFO - 'tests': ['tp5n']}, 20:34:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--xperf_path', 20:34:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:21 INFO - 'tests': ['tp5n']}}, 20:34:21 INFO - 'talos.zip': {'path': '', 20:34:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:21 INFO - Running post-action listener: _resource_record_post_action 20:34:21 INFO - [mozharness: 2017-01-03 04:34:21.237571Z] Finished populate-webroot step (success) 20:34:21 INFO - [mozharness: 2017-01-03 04:34:21.237681Z] Running create-virtualenv step. 20:34:21 INFO - Running pre-action listener: _resource_record_pre_action 20:34:21 INFO - Running main action method: create_virtualenv 20:34:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:21 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 20:34:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:21 INFO - Using real prefix '/tools/python27' 20:34:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:34:22 INFO - Installing distribute.............................................................................................................................................................................................done. 20:34:24 INFO - Installing pip.................done. 20:34:24 INFO - Return code: 0 20:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:34:25 INFO - Reading from file tmpfile_stdout 20:34:25 INFO - Output received: 20:34:25 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) 20:34:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:25 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 20:34:25 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 20:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:25 INFO - 'HOME': '/Users/cltbld', 20:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PAGER': '/bin/cat', 20:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:25 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:25 INFO - 'XPC_FLAGS': '0x0', 20:34:25 INFO - 'XPC_SERVICE_NAME': '0', 20:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:25 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 20:34:25 INFO - Cleaning up... 20:34:25 INFO - Return code: 0 20:34:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:25 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 20:34:25 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 20:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:25 INFO - 'HOME': '/Users/cltbld', 20:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PAGER': '/bin/cat', 20:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:25 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:25 INFO - 'XPC_FLAGS': '0x0', 20:34:25 INFO - 'XPC_SERVICE_NAME': '0', 20:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:25 INFO - Downloading/unpacking psutil>=3.1.1 20:34:25 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 20:34:25 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 20:34:25 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 20:34:25 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 20:34:25 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 20:34:25 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 20:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:29 INFO - Installing collected packages: psutil 20:34:29 INFO - Running setup.py install for psutil 20:34:29 INFO - building 'psutil._psutil_osx' extension 20:34:29 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 20:34:30 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 20:34:30 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 20:34:30 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 20:34:30 INFO - building 'psutil._psutil_posix' extension 20:34:30 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 20:34:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:34:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:34:30 INFO - ^ 20:34:30 INFO - 1 warning generated. 20:34:30 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 20:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:30 INFO - Successfully installed psutil 20:34:30 INFO - Cleaning up... 20:34:30 INFO - Return code: 0 20:34:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:34:30 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')]} 20:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:30 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')]} 20:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:30 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:30 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 20:34:30 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 20:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:30 INFO - 'HOME': '/Users/cltbld', 20:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:30 INFO - 'LOGNAME': 'cltbld', 20:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:30 INFO - 'MOZ_NO_REMOTE': '1', 20:34:30 INFO - 'NO_EM_RESTART': '1', 20:34:30 INFO - 'PAGER': '/bin/cat', 20:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:30 INFO - 'PWD': '/builds/slave/test', 20:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:30 INFO - 'SHELL': '/bin/bash', 20:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:30 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:30 INFO - 'USER': 'cltbld', 20:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:30 INFO - 'XPC_FLAGS': '0x0', 20:34:30 INFO - 'XPC_SERVICE_NAME': '0', 20:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:34:33 INFO - Installing collected packages: mozsystemmonitor 20:34:33 INFO - Running setup.py install for mozsystemmonitor 20:34:33 INFO - Successfully installed mozsystemmonitor 20:34:33 INFO - Cleaning up... 20:34:34 INFO - Return code: 0 20:34:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:34 INFO - 'HOME': '/Users/cltbld', 20:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:34 INFO - 'LOGNAME': 'cltbld', 20:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:34 INFO - 'MOZ_NO_REMOTE': '1', 20:34:34 INFO - 'NO_EM_RESTART': '1', 20:34:34 INFO - 'PAGER': '/bin/cat', 20:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:34 INFO - 'PWD': '/builds/slave/test', 20:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:34 INFO - 'SHELL': '/bin/bash', 20:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:34 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:34 INFO - 'USER': 'cltbld', 20:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:34 INFO - 'XPC_FLAGS': '0x0', 20:34:34 INFO - 'XPC_SERVICE_NAME': '0', 20:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34:36 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 20:34:36 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 20:34:36 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 20:34:36 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 20:34:36 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 20:34:36 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 20:34:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:37 INFO - warning: no files found matching '*.txt' 20:34:37 INFO - no previously-included directories found matching 'build' 20:34:37 INFO - no previously-included directories found matching 'dist' 20:34:37 INFO - no previously-included directories found matching '.git*' 20:34:37 INFO - Installing collected packages: jsonschema, functools32 20:34:37 INFO - Running setup.py install for functools32 20:34:37 INFO - warning: no files found matching '*.txt' 20:34:37 INFO - no previously-included directories found matching 'build' 20:34:37 INFO - no previously-included directories found matching 'dist' 20:34:37 INFO - no previously-included directories found matching '.git*' 20:34:37 INFO - Successfully installed jsonschema functools32 20:34:37 INFO - Cleaning up... 20:34:37 INFO - Return code: 0 20:34:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:37 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:37 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 20:34:37 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 20:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:37 INFO - 'HOME': '/Users/cltbld', 20:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:37 INFO - 'LOGNAME': 'cltbld', 20:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:37 INFO - 'MOZ_NO_REMOTE': '1', 20:34:37 INFO - 'NO_EM_RESTART': '1', 20:34:37 INFO - 'PAGER': '/bin/cat', 20:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:37 INFO - 'PWD': '/builds/slave/test', 20:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:37 INFO - 'SHELL': '/bin/bash', 20:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:37 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:37 INFO - 'USER': 'cltbld', 20:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:37 INFO - 'XPC_FLAGS': '0x0', 20:34:37 INFO - 'XPC_SERVICE_NAME': '0', 20:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:34:37 INFO - Cleaning up... 20:34:37 INFO - Return code: 0 20:34:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:37 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:37 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 20:34:37 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 20:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:37 INFO - 'HOME': '/Users/cltbld', 20:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:37 INFO - 'LOGNAME': 'cltbld', 20:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:37 INFO - 'MOZ_NO_REMOTE': '1', 20:34:37 INFO - 'NO_EM_RESTART': '1', 20:34:37 INFO - 'PAGER': '/bin/cat', 20:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:37 INFO - 'PWD': '/builds/slave/test', 20:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:37 INFO - 'SHELL': '/bin/bash', 20:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:37 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:37 INFO - 'USER': 'cltbld', 20:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:37 INFO - 'XPC_FLAGS': '0x0', 20:34:37 INFO - 'XPC_SERVICE_NAME': '0', 20:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:34:38 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 20:34:38 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 20:34:38 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 20:34:38 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 20:34:38 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 20:34:38 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 20:34:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:34:41 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 20:34:41 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 20:34:41 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 20:34:41 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 20:34:41 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 20:34:41 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 20:34:41 INFO - Downloading docopt-0.6.1.tar.gz 20:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:42 INFO - Running setup.py install for blobuploader 20:34:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:34:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:34:42 INFO - Running setup.py install for requests 20:34:42 INFO - Running setup.py install for docopt 20:34:42 INFO - Successfully installed blobuploader requests docopt 20:34:42 INFO - Cleaning up... 20:34:42 INFO - Return code: 0 20:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:42 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:42 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 20:34:42 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 20:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:42 INFO - 'HOME': '/Users/cltbld', 20:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:42 INFO - 'LOGNAME': 'cltbld', 20:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:42 INFO - 'MOZ_NO_REMOTE': '1', 20:34:42 INFO - 'NO_EM_RESTART': '1', 20:34:42 INFO - 'PAGER': '/bin/cat', 20:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:42 INFO - 'PWD': '/builds/slave/test', 20:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:42 INFO - 'SHELL': '/bin/bash', 20:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:42 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:42 INFO - 'USER': 'cltbld', 20:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:42 INFO - 'XPC_FLAGS': '0x0', 20:34:42 INFO - 'XPC_SERVICE_NAME': '0', 20:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-T3ttO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-JmXUCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-hPwFrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-IyI2_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eyYLOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-k9oPMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-1uk_Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-09Dnx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cxEjgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-AL6_BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-AzoXW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-00SL5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wp80K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-bTIUjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-VlDjMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-mPEWTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:44 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-u9PwUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:34:44 INFO - Running setup.py install for manifestparser 20:34:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:34:45 INFO - Running setup.py install for mozcrash 20:34:45 INFO - Running setup.py install for mozdebug 20:34:45 INFO - Running setup.py install for mozdevice 20:34:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:34:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:34:45 INFO - Running setup.py install for mozfile 20:34:45 INFO - Running setup.py install for mozhttpd 20:34:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:34:45 INFO - Running setup.py install for mozinfo 20:34:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Running setup.py install for mozInstall 20:34:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Running setup.py install for mozleak 20:34:46 INFO - Running setup.py install for mozlog 20:34:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Running setup.py install for moznetwork 20:34:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Running setup.py install for mozprocess 20:34:46 INFO - Running setup.py install for mozprofile 20:34:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:34:46 INFO - Running setup.py install for mozrunner 20:34:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:34:47 INFO - Running setup.py install for mozscreenshot 20:34:47 INFO - Running setup.py install for moztest 20:34:47 INFO - Running setup.py install for mozversion 20:34:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:34:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:34:47 INFO - Cleaning up... 20:34:47 INFO - Return code: 0 20:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:47 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')]} 20:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:47 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')]} 20:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:47 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:47 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 20:34:47 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 20:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:47 INFO - 'HOME': '/Users/cltbld', 20:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:47 INFO - 'LOGNAME': 'cltbld', 20:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:47 INFO - 'MOZ_NO_REMOTE': '1', 20:34:47 INFO - 'NO_EM_RESTART': '1', 20:34:47 INFO - 'PAGER': '/bin/cat', 20:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:47 INFO - 'PWD': '/builds/slave/test', 20:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:47 INFO - 'SHELL': '/bin/bash', 20:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:47 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:47 INFO - 'USER': 'cltbld', 20:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:47 INFO - 'XPC_FLAGS': '0x0', 20:34:47 INFO - 'XPC_SERVICE_NAME': '0', 20:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-50ZK9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:47 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)) 20:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-yRSAbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-5hZdkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-giBHeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-C7B3Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jgABs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Gokq5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-l2Mkib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-lcgK7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-pehO3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:48 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)) 20:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:48 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-b9tT6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:49 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)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Q7b22m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:49 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)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-C4oQMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:49 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)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-BpAmsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:49 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)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-oz38pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:49 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)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-PZ3CUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-2J77Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:49 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)) 20:34:49 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)) 20:34:49 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)) 20:34:49 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)) 20:34:49 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)) 20:34:49 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)) 20:34:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - Downloading blessings-1.6.tar.gz 20:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:34:52 INFO - Installing collected packages: blessings 20:34:52 INFO - Running setup.py install for blessings 20:34:52 INFO - Successfully installed blessings 20:34:52 INFO - Cleaning up... 20:34:52 INFO - Return code: 0 20:34:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:52 INFO - Reading from file tmpfile_stdout 20:34:52 INFO - Current package versions: 20:34:52 INFO - blessings == 1.6 20:34:52 INFO - blobuploader == 1.2.4 20:34:52 INFO - docopt == 0.6.1 20:34:52 INFO - functools32 == 3.2.3-2 20:34:52 INFO - jsonschema == 2.5.1 20:34:52 INFO - manifestparser == 1.1 20:34:52 INFO - mozInstall == 1.12 20:34:52 INFO - mozcrash == 1.0 20:34:52 INFO - mozdebug == 0.1 20:34:52 INFO - mozdevice == 0.48 20:34:52 INFO - mozfile == 1.2 20:34:52 INFO - mozhttpd == 0.7 20:34:52 INFO - mozinfo == 0.9 20:34:52 INFO - mozleak == 0.1 20:34:52 INFO - mozlog == 3.4 20:34:52 INFO - moznetwork == 0.27 20:34:52 INFO - mozprocess == 0.23 20:34:52 INFO - mozprofile == 0.28 20:34:52 INFO - mozrunner == 6.13 20:34:52 INFO - mozscreenshot == 0.1 20:34:52 INFO - mozsystemmonitor == 0.3 20:34:52 INFO - moztest == 0.7 20:34:52 INFO - mozversion == 1.4 20:34:52 INFO - psutil == 3.1.1 20:34:52 INFO - requests == 1.2.3 20:34:52 INFO - wsgiref == 0.1.2 20:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:52 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:52 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 20:34:52 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 20:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:52 INFO - 'HOME': '/Users/cltbld', 20:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:52 INFO - 'LOGNAME': 'cltbld', 20:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:52 INFO - 'MOZ_NO_REMOTE': '1', 20:34:52 INFO - 'NO_EM_RESTART': '1', 20:34:52 INFO - 'PAGER': '/bin/cat', 20:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:52 INFO - 'PWD': '/builds/slave/test', 20:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:52 INFO - 'SHELL': '/bin/bash', 20:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:52 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:52 INFO - 'USER': 'cltbld', 20:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:52 INFO - 'XPC_FLAGS': '0x0', 20:34:52 INFO - 'XPC_SERVICE_NAME': '0', 20:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 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)) 20:34:53 INFO - Cleaning up... 20:34:53 INFO - Return code: 0 20:34:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:34:53 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')]} 20:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:53 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')]} 20:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:53 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 0x109fc2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f38570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4e3d7ead0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, '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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 20:34:53 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 20:34:53 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 20:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:53 INFO - 'HOME': '/Users/cltbld', 20:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:53 INFO - 'LOGNAME': 'cltbld', 20:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:53 INFO - 'MOZ_NO_REMOTE': '1', 20:34:53 INFO - 'NO_EM_RESTART': '1', 20:34:53 INFO - 'PAGER': '/bin/cat', 20:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:53 INFO - 'PWD': '/builds/slave/test', 20:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:53 INFO - 'SHELL': '/bin/bash', 20:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:34:53 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:53 INFO - 'USER': 'cltbld', 20:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:53 INFO - 'XPC_FLAGS': '0x0', 20:34:53 INFO - 'XPC_SERVICE_NAME': '0', 20:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:34:53 INFO - Cleaning up... 20:34:53 INFO - Return code: 0 20:34:53 INFO - Running post-action listener: _resource_record_post_action 20:34:53 INFO - Running post-action listener: _start_resource_monitoring 20:34:53 INFO - Starting resource monitoring. 20:34:53 INFO - [mozharness: 2017-01-03 04:34:53.527890Z] Finished create-virtualenv step (success) 20:34:53 INFO - [mozharness: 2017-01-03 04:34:53.528942Z] Running install step. 20:34:53 INFO - Running pre-action listener: _resource_record_pre_action 20:34:53 INFO - Running main action method: install 20:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:53 INFO - Reading from file tmpfile_stdout 20:34:53 INFO - Detecting whether we're running mozinstall >=1.0... 20:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:34:53 INFO - Reading from file tmpfile_stdout 20:34:53 INFO - Output received: 20:34:53 INFO - Usage: mozinstall [options] installer 20:34:53 INFO - Options: 20:34:53 INFO - -h, --help show this help message and exit 20:34:53 INFO - -d DEST, --destination=DEST 20:34:53 INFO - Directory to install application into. [default: 20:34:53 INFO - "/builds/slave/test"] 20:34:53 INFO - --app=APP Application being installed. [default: firefox] 20:34:53 INFO - mkdir: /builds/slave/test/build/application 20:34:53 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'] 20:34:53 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 20:35:25 INFO - Reading from file tmpfile_stdout 20:35:25 INFO - Output received: 20:35:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:35:25 INFO - Running post-action listener: _resource_record_post_action 20:35:25 INFO - [mozharness: 2017-01-03 04:35:25.099974Z] Finished install step (success) 20:35:25 INFO - [mozharness: 2017-01-03 04:35:25.100149Z] Running run-tests step. 20:35:25 INFO - Running pre-action listener: _resource_record_pre_action 20:35:25 INFO - Running main action method: run_tests 20:35:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:35:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:35:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:35:25 INFO - 2017-01-02 20:35:25.115 screenresolution[1688:8104] starting screenresolution argv=screenresolution get 20:35:25 INFO - 2017-01-02 20:35:25.117 screenresolution[1688:8104] Display 0: 1600x1200x32@60 20:35:25 INFO - 2017-01-02 20:35:25.123 screenresolution[1689:8107] starting screenresolution argv=screenresolution list 20:35:25 INFO - Available Modes on Display 0 20:35:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:35:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:35:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:35:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:35:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:35:25 INFO - Intel Iris: 20:35:25 INFO - Chipset Model: Intel Iris 20:35:25 INFO - Type: GPU 20:35:25 INFO - Bus: Built-In 20:35:25 INFO - VRAM (Dynamic, Max): 1536 MB 20:35:25 INFO - Vendor: Intel (0x8086) 20:35:25 INFO - Device ID: 0x0a2e 20:35:25 INFO - Revision ID: 0x0009 20:35:25 INFO - Displays: 20:35:25 INFO - Display: 20:35:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:35:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:35:25 INFO - Display Serial Number: 1600x1200 60 20:35:25 INFO - Main Display: Yes 20:35:25 INFO - Mirror: Off 20:35:25 INFO - Online: Yes 20:35:25 INFO - Rotation: Supported 20:35:25 INFO - Return code: 0 20:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:25 INFO - Python 2.7.3 20:35:25 INFO - Return code: 0 20:35:25 INFO - grabbing minidump binary from tooltool 20:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:25 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 0x109dd6d30>, '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 0x109c3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:25 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 20:35:25 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 20:35:25 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 20:35:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:25 INFO - Return code: 0 20:35:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:25 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:35:25 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.579Z0UJqJT/Render', 20:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:35:25 INFO - 'HOME': '/Users/cltbld', 20:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:35:25 INFO - 'LOGNAME': 'cltbld', 20:35:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:25 INFO - 'MOZ_NO_REMOTE': '1', 20:35:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:25 INFO - 'NO_EM_RESTART': '1', 20:35:25 INFO - 'PAGER': '/bin/cat', 20:35:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:25 INFO - 'PWD': '/builds/slave/test', 20:35:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:35:25 INFO - 'SHELL': '/bin/bash', 20:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vx5kjE14Mb/Listeners', 20:35:25 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 20:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:35:25 INFO - 'USER': 'cltbld', 20:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:25 INFO - 'XPC_FLAGS': '0x0', 20:35:25 INFO - 'XPC_SERVICE_NAME': '0', 20:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:35:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:35:25 INFO - mozversion application_buildid: 20170102192820 20:35:25 INFO - mozversion application_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 20:35:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:35:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:25 INFO - mozversion application_name: Firefox 20:35:25 INFO - mozversion application_remotingname: firefox-dev 20:35:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:35:25 INFO - mozversion application_vendor: Mozilla 20:35:25 INFO - mozversion application_version: 52.0a2 20:35:25 INFO - mozversion platform_buildid: 20170102192820 20:35:25 INFO - mozversion platform_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 20:35:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:35:25 INFO - mozversion platform_version: 52.0a2 20:35:25 INFO - using testdate: 1483418125 20:35:25 INFO - actual date: 1483418125 20:35:25 INFO - starting webserver on 'localhost:49248' 20:35:25 INFO - SUITE-START | Running 2 tests 20:35:25 INFO - TEST-START | dromaeo_css 20:35:25 INFO - operating with platform_type : mac_ 20:35:25 INFO - Initialising browser for dromaeo_css test... 20:35:25 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpnI7qtT/profile http://localhost:49248/getInfo.html) 20:35:28 INFO - PROCESS | 1699 | __metrics Screen width/height:1600/1200 20:35:28 INFO - PROCESS | 1699 | colorDepth:24 20:35:28 INFO - PROCESS | 1699 | Browser inner width/height: 1024/689 20:35:28 INFO - PROCESS | 1699 | __metrics 20:35:28 INFO - PROCESS | 1699 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:35:28 INFO - PROCESS | 1699 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:29 INFO - TEST-INFO | 1699: exit 0 20:35:29 INFO - Browser initialized. 20:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:29 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpnI7qtT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:41 INFO - PROCESS | 1702 | RSS: Main: 222765056 20:35:41 INFO - PROCESS | 1702 | 20:36:32 INFO - PROCESS | 1702 | 1483418192712 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:38:46 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 20:38:49 INFO - PROCESS | 1702 | RSS: Main: 303144960 20:38:49 INFO - PROCESS | 1702 | 20:41:52 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 20:41:52 INFO - PROCESS | 1702 | RSS: Main: 348872704 20:41:52 INFO - PROCESS | 1702 | 20:44:55 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 20:44:55 INFO - PROCESS | 1702 | RSS: Main: 317222912 20:44:55 INFO - PROCESS | 1702 | 20:47:58 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 20:47:58 INFO - PROCESS | 1702 | RSS: Main: 312242176 20:47:58 INFO - PROCESS | 1702 | 20:51:02 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 20:51:02 INFO - PROCESS | 1702 | RSS: Main: 306761728 20:51:02 INFO - PROCESS | 1702 | 20:54:05 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 20:54:06 INFO - PROCESS | 1702 | RSS: Main: 356360192 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | __start_tp_report 20:54:06 INFO - PROCESS | 1702 | _x_x_mozilla_page_load 20:54:06 INFO - PROCESS | 1702 | _x_x_mozilla_page_load_details 20:54:06 INFO - PROCESS | 1702 | |i|pagename|runs| 20:54:06 INFO - PROCESS | 1702 | |0;dojo.html;3346.9665303346965;3359.2777552826137;3367.5285460035598;3384.289299247158;3424.2466657335376;5697.145428185774;5737.971310143449;5739.770409183628;5742.052561327376;5759.625624334415;5687.345955215152;5768.653880767157;5782.248307720001;5796.362400135981;5801.216835727176;5218.034663587229;5239.738013099349;5276.103062479368;5278.102722537178;5302.946970530304;5098.235264710304;5115.718635475047;5123.923141152885;5191.740412979336;5327.254184414185;5190.039842629126;5190.870228244286;5207.505286997748;5208.895822083556;5209.244659524366;5147.536721695046;5174.508421699932;5176.482351764831;5190.403103643054;5207.166853303473;5043.873903152414;5155.613329000303;5158.3552055993005;5170.948290517084;5194.870128246824;5695.772169113272;5707.1153971134545;5710.428957104298;5717.656940583578;5727.341355744101;6127.9031502109065;6140.232470941132;6145.893739126956;6147.463134216446;6154.569180157391;6185.907211391833;6221.160143380631;6234.376562343775;6251.249850018027;6281.623102613812;5727.742251598646;5736.541076713895;5740.425957404268;5774.826755197309;5779.595428320019;5674.779922316722;6129.908051379233;6190.50475961931;6191.783287584913;6285.59143655661;5350.892982140335;6105.938940610626;6108.6029408089225;6116.633002019893;6157.230346206724;6243.625382477066;6298.338674439209;6310.5267104967315;6313.526485513605;6325.177726895474;6109.868257519264;6235.407636274546;6246.531510136758;6265.624062556261;6278.30938596754;5808.767649294065;6151.66165860873;6160.568760186834;6188.381161883865;6244.250689917239;4908.263760435963;4910.533499317559;4917.557419832232;4931.432885218174;4944.011197760462;4243.045314804144;4382.802773875183;4436.0462500562535;4436.64506839452;4450.35469856869;4909.214525675875;5692.345380281238;5731.484166425042;5738.655680659173;5738.684372359477;4588.0135770808765;6214.751409943642;6292.307846136921;6312.936870631327;6326.557141000086;5762.7694892203845;5766.772924613256;5791.478766910998;5799.2750906136735;5802.622829516068;5278.709670968057;5285.101532739521;5404;5410.540104091117;5430.67415955044;6183.721732521957;6287.74849006053;6292.559520833498;6325;6338.492920566251;6273.560850740404;6284.465820405317;6286.6856657166045;6308.306086330408;6310.7475700971445;5218.26944227816;6208.161898143873;6284.24589049317;6289.150964619717;6309.305976342691;5999.610025348513;6085.817425477243;6130.938690613215;6134.478569321657;6138.723757431016;6283.403076707706;6299.370062993848;6310.6213627182515;6320.399562041599;6322.462590679844;6054.982715014727;6104.603200791934;6139.29398119222;6156.846078848064;6158.938410615837;5962.52299816005;6014.699265036818;6035;6150.7847225346895;6152.969235153795;5899.91150132757;5935.525157987437;5951.434613711691;5981.581289309706;6044.15381846533;5934.732937017931;6141.815745527641;6144.170536977451;6159.81520554384;6162.014077747718;5826.82519524415;5843.532517398683;5870.853228669317;5999.5500337473995;6001.189839371629 20:54:06 INFO - PROCESS | 1702 | |1;ext.html;518.4944678938035;520.4743209358546;525.5742848292882;528.4213785904436;567.6480582039136;38733.41899871504;40072.59927400729;40204.59795402041;42071.73784786453;42084.57915420845;41035.38446923299;41616;41712.791436042775;41779.79110104453;41868.95327616804;8346.582670866463;8350.498970061815;9361.67234146805;9549.47477888716;9549.761255968622;8395.62219700115;8582.356323275748;8593.656253749843;8602.225799678028;11124.276922000085;11132.33206007638;11309.925557072065;11314.094872410229;11336.603218887341;11337.979581837633;11324.716882077973;11411.94294028533;11419.31484110956;11442.599509017144;11450.312981221112;8409.873851892227;8640.65437382504;10977.341359518454;11272.210945233837;11338.71653208668;37904.86285411442;39589;39622.80188599067;39641.80179099086;39649.80175099135;3230.8223047732367;3261.7879837810465;3446.7759595626203;3830.2148059647707;3844.1735026969336;28367;28429.857850710614;29336.119916402542;29701.405971880442;30510.08469745911;3175.190326466736;3210.325831575372;3218.211538173139;3221.3235220603465;3221.5167724841226;491331;496248;496729;497041;502863;49382;50583;58027;58240.96156634497;58393;63447.6827615859;63866.68066659637;63874.0418893717;63888;64102;15620.375184992474;15744.212789360487;15758.133302668233;15780.289886955115;15830.683386332208;12007.459664315127;12079.456424460921;12090.758184836253;12248.81626775599;12252.387380630933;15953.245143034257;16266.674666506604;16280.511584652479;16598.336066557204;18340.54148646268;5731.914021289684;6712;6863.931360686429;7716.2221600223875;7850.489718168301;695.7540147289482;900.4417261297906;913.1325241020924;926.935114541989;1039.7868436970555;28218.85890570575;29131.41737165287;29246.853765731033;29763.70236297609;29909.40181196364;1049.9212559057949;1074.0065439468617;1085.3867564825848;1138.6520150162876;1144.3019757947645;15225.695486090217;15274.694506109816;15421.686746988042;15630.609234768994;15635.530934071996;658520;661477;664446;666922;667900;47237;48227.276590851165;55931.60170995676;56133.43866561364;57725.71137144287;1331.301066939845;1353.8036984637172;1368.5004973184914;1368.50733735857;1373.1006190944747;29193.85403072971;29941.70058299389;30110.69889301079;30175.84174243111;30587.388252234385;49178;49702.25446618231;49747.50757477281;49814.50185498098;49966.00067998547;554765;803215;821674;837733;842285;37954.8102259498;38081.80959095187;38396.42405363978;38737.80631096826;38795.806020969714;43346.566534334255;43415.78292108519;43699.78150109229;44002.33996489991;44024.45914392981;35576;35866.28267434584;36169.81915090408;36493.45259821052;40545.391819122146;38909;39315.82052538428;40488.987775304675;40992.30008688627;42100;39579;39582;40015.79992100021;40079.1984160321;40247;39347;39539.04609539023;39833.80083099682;39864.800675996434;40596.3910541348;24545.50908981846;25748.227553173434;26439;26821.329466763487;26861 20:54:06 INFO - PROCESS | 1702 | |2;jquery.html;353.7965669739897;369.60083110240936;377.78088708549046;385.8340913407234;407.44180472752333;14810.851891481081;14904.552863414088;19079.23683052678;21069.94650267488;21182.470438239052;19385;19486.610267794636;19696.409107726755;20184.19263229469;20419.591608167866;5694.5729070319785;6033.607815492001;6043.516518678495;6048.304444988838;6054.061620448815;5721.7711291548285;5918.763249470016;6040.063790112539;6058.697065146747;6078.969605151968;6105;6112.572119951606;6117.755289788403;6124.724387402578;6128.356522565134;5937.4656280934705;6564.671766411684;6662.10061641677;6683.732650693991;6685.565438246498;5628.577856660767;5875.177475153482;5876.500497457721;5897.675627840467;5912.113183022538;12931.48274069036;12968.935155324258;13163.07858449909;13165.60503184906;13189.274589897552;2196.626573482512;2303.4126297794123;2344.10923848938;2568.2808813532242;2663.440677457736;9732.951335243279;9861.260405469548;10181;10400.791984160274;14473.27633618315;1832.7892292386414;1849.2140840142886;1869.242956602578;1901.3607292836202;1925.7482636286386;116951.4152429241;118212;122741;122781;125407.37296313551;11071.446427678584;11336.886631133748;11402.491451880573;11412.600558980395;11627.360495172677;10386.896131038593;13338.466461341632;13345.199288042555;13405.597832065054;14181.716365672628;7604.2395760423515;7924.722634707758;8023.277904988462;8293.295069919124;8560.272376847914;6888.724451022003;8312.5428101455;8315.210055044761;8331.29184019353;8455.873161902577;4144.958550414457;4159.292920203573;4374.562543745664;4437.667174961891;4498.257787465097;1834.7523084383438;1885.8684789126414;1887.7262796894374;1891.328578354692;1892.9494130757287;824.2375802382772;910.6266430763487;939.8966113727485;953.1993125774383;958.6117622362954;19403.4178974631;20612.896935515226;20726.274580389916;20745.481362965744;20996.580068398853;873.8203425375692;892.6964831957166;896.0233345653269;913.5523593439167;934.9995504809924;8886.555672216364;10161.4919254037;10506.579736810594;10625.362478251329;10647.73380665474;600242.998785012;601766;615921;625760;625933;111763;125542;128936;130388.3480582591;133351;822.0505316359614;837.5895811052541;839.2321026261025;952.5284983932997;1024.4826362686945;18141.45575632733;18615.813841861407;19061.142248598568;19093;19442.708359374337;52530.212046820096;56715;59121.22636320917;59393.406065940515;59584.70207648934;77029;79788.60105699435;79841.20158798338;79994.6000269995;82867.5856620713;5702.0306547887785;5894.469497745224;7837.49056311338;8013.038435387791;8122.796930076795;10481.475926203811;10590.576376945144;12393.504259829506;12557.874421256036;12628.431720572413;11094.15976148459;11323.943380283046;11344.432778360884;11359.659210223706;11472.770544589228;9809.460479673686;10131.290809643255;10599.258051936291;10881.836772448261;11319.490622921823;10574.744693457904;11486;11757.235779674294;11764.764704706029;11788.646340609796;6558.245801732671;7782.571958542335;8036.437449378721;8187.79530511742;8244.175582441709;10338;10958.287711299059;11100.61147859821;11281.661550153509;11395.772084558097 20:54:06 INFO - PROCESS | 1702 | |3;mootools.html;1298.5260379961317;1439.2803598200903;1451.1728314860527;1597.4089586852858;1802;7404.259574042593;7770;8099.919000809998;8324.709670001144;8326.83346333073;8139.38954578406;8205;8218.95890520548;8223.34213262939;8244.876326855101;2280.5438912217583;2313.0516488239823;2313.3291345509783;2317.9768202318014;2318.1770471482632;2220.7224096987875;2298.8965496552696;2339.263132113379;2359.539889721505;2367.3253122859987;2259.3560835161984;2270.12600148943;2303;2326.6510023496526;2331.8134549236106;1910.703840904662;2268.875211863347;2277.055022165799;2308.3998160478313;2317.188983855654;2309;2328.836981411285;2331.370529956919;2332.486852892361;2340.5318936212825;8110.594470276522;8273.255407013397;8295.294899933513;8335.249827515492;8352.791180220482;4996.200607902754;5199.688018718851;5204.29741984831;5225.425203227642;5233.633645644806;3294.1929227339215;3533.9646603533893;3581.230035542371;3599.1002249437643;3605.9459108113138;1042.2599954032646;1064.4784055812595;1089.4661615808277;1097.2648325621853;1103.4593049405814;10727.195460340428;10784.514696838662;10835.512401941853;10854.565817367296;10865.40240286784;4213.115245798355;4387.254166791589;4458.665600079942;4467.30756732707;4474.485434175046;8516.659333626585;8520.872186917077;8523.957380213184;8541.615627296787;8543.35924805642;5080.110980578384;5081.669691470042;5082.745862706924;5088.847334579968;5092.363454568179;4038.374052021941;4259.1268789897995;4414.1171765647;4419;4698.060387922429;2988.6413630364495;3060.877564897379;3610.5306310180035;3692.6861216796874;3700.796456194935;956.4309236004566;1114.8383484394878;1125.2629527659396;1127.8533790607169;1142.8914253145938;681.0871542985481;871.285545852395;881.7487016200353;899.7480705402367;906.3972458315278;4736.621070314367;5203.219517072469;5224.0074385866565;5411;5586.1062230043;425.89991352032246;432.0904496035862;432.0947614747163;443.58303194996597;444.03865630908723;3225.8387080645875;3722.925541489155;3740.102375429877;3745.138618117848;3746.8875933722034;9691.030896910253;9953.950230248802;10033.046860548237;10039.598416063422;10045.598176073021;9679.92588386478;9967.352122112039;10020.048095430922;10023.14803241718;10030.297879148535;7629.8855517167285;7853.332466740277;7868.173841746649;7869.48848324857;7871.48835325702;5250.369955605199;5387.272718182995;5417.1874218865905;5465.72671366438;5514.310711161105;9073;9315.953420232856;9328.113829186217;9381.202597778993;9425.01037391064;9060;9340.906590934004;9484.336096473457;9555.426674399558;9560.904390956;7060.505764596429;7105.431565474853;7189.496735228484;7195.352418282379;7201.13586369639;7664.501807382502;7666.769996900102;7722.652480638272;7734.342580880463;7737.381009519112;6869.7595584154315;6975.407090397373;7043.154821421463;7076.2923707628825;7091.078159839188;6899.827504312432;6970.721171153097;6979.651017449006;7003.3346832050875;7018.052562904147;6519.8044058678315;6528.869422611616;6534.215894092739;6607.702653380706;6617.305182955721;4635.791389387418;4681.302554339155;4770.856874293777;4797.136515427256;4816.735079570517;4621.537846215351;4675.181843177363;4684.812607495662;4785.258284965836;4886.828960986349 20:54:06 INFO - PROCESS | 1702 | |4;prototype.html;299.9505081661526;305.03456559987643;308.47097228253546;312.5902181162956;315.76002238298884;4503.437070366204;4537.546245375461;5068.923966140506;5086.872828179288;5113.233015047745;4589.908201835961;4782.450018247902;4988.50114988501;5016.122178618736;5124.923126153101;3603.6576525230194;3853.49904512413;3857.4406711026886;3901.3912131278453;3992.2414741199223;3259.902202933904;3499.860005599773;3942.8225729842084;3947.743396679221;3963.246983073221;3415.453527435611;3631.836567354462;3893.1629699614577;3925.1551770667884;3977.224441233946;3548.5741710994716;3554.662307080823;3633.6184700606586;3733.533308336458;3988.088695252453;3430.9485357719655;3455.378031954247;3494.5107684924133;3498.915336245772;3524.207053412987;4961.925571116436;4963.726995015273;4964.808445972976;5004.84985450437;5011.473795251519;4261.808218630169;4355.128974205171;4451.599356057938;4474.261746811772;4474.6867719259335;5144.639875208737;5343.839684809462;5393;5422.9728851355885;5431.812618948894;3811.6188381161937;3849.9037524062123;3851.499305090348;3854.036490877281;3864.6908247340425;5235.65968212065;5674.177244299594;5697.344805347397;5703.572232082569;5714.914276285859;3706.3884459064493;3777.6411240932616;3781.3740091760255;3800.3539398302355;3806;3423.3837909176586;3562.4300111982475;3755.1550901047044;3865.3042452358845;3865.632764887331;4020.0954785173103;4412;4422.469303683579;4428.955710442854;4531.116432295671;4392.978035109868;4892.657513974059;5331.880305135887;5388.622796404214;5423.918641220384;1144.5135817277624;1236.6908272931767;1236.8824961628632;1246.5823948977013;1250.4435526190757;720.6396801599201;837.6053870305994;845.6067928413318;850.2050582705191;854.833307505043;3945.763254204757;4810.037992401533;4914.754262286871;4978.402591688948;5001.699898006132;5513;5583.218349431083;5584.375343588507;5586.301712285965;5605.355384130796;4115.7324773890205;4136.234796562646;4306.289462238696;5041.722705251246;5043.621728370387;2420.830541862088;2542.5677634802128;2596.7792737617137;2758.255271076838;2765.7510824025935;5021.322121513622;5076.238564215323;5348.384935732441;5363.758630861621;5371.543418809445;4441.888952776142;4968.577670897942;5088.837244171286;5163;5405.891882162335;4754.619630429557;5379.557083466662;5389.353277606712;5401.729913504388;5414.8917021659345;4380.9780951095045;4868.561829435368;5229.555487783581;5251.422343542284;5273.312539987167;4360.127974405195;4790.760461976817;5015.3730783652045;5193.532582067632;5253.395859476209;4544.6818722689095;4875.414950205856;5236.266922630759;5329.067413202596;5361.624686271924;3263.379957808009;3532.735044871696;3553.3781588222473;3631.455281707765;3642.6357364263363;4687.859364219079;4847.927281090716;5232.712200828991;5301.310829592283;5315.681059136464;4335.609795118455;5090.287359769709;5097.745112744422;5105;5187.939115921474;4629.722216666876;4664.626829853672;4746.596539294199;5059.876200896258;5086.21163719624;4595.747233902168;4978.27814966835;4982.701037937735;4984.42679091909;5049.495050494921;4086.938695919504;4899.951000489949;4966.155753521982;5093.847184584469;5118.692878427306;4887.828925987574;5196.32447781786;5258.31825768853;5276.997370499593;5315.3090098286975 20:54:06 INFO - PROCESS | 1702 | |5;yui.html;705.1855107351009;762.5882023707195;764.5107131435879;803.2730379006999;804.1717031457594;15789.28948197331;16014;16360;16420.425285115023;16456;14993.85006149938;15010.249487525607;15051.397944082224;15129.167895765728;15151.318190681419;645.6352161029027;660.2044536333731;709.3580309819622;810.6068556749987;829.5603330234985;828.6768160417442;833.6373677450329;840.9411341206118;843.7384410832661;844.9535275559841;879.6525372477868;880.8766772651834;883.5273128876053;886.3086792302015;886.7916039730658;670.9597424154566;690.9412699920513;877.3376101043672;878.0692465986043;879.5734068976541;515.889083846971;516.0427407159702;517.4075683342552;587.4976894755008;626.4487251218944;14160.716785664228;14239.430422783076;14267;14279;14284.214368209745;12557.372131393393;12631.621051368473;12793.744125117446;12807.295598742065;12810.871891281062;11744;12045.156839021272;12097.274163550215;12202.633920982385;12225;4306.676999225071;4336.262835318003;4343.761093139876;4423.491298500681;4524.660650451229;84734;85304.7204291936;86345.27309453838;88530;90747;9868.358556693793;10108.29241953071;10146.695599132037;10200.132988696045;10292.639757608447;19157.8084219156;19198.904005479882;19234.519137021685;19235.230590776213;19909.402717918485;7408.696690006348;7569.318761311509;7658.846823063507;7697;7762.961185194038;3657.579378371521;4254.7659878706345;4338.327559228324;4374.103308821747;4375.78121093944;3403.897883063512;3516.962496063616;3517.698451572883;3531.94702079469;3534.91162720934;655.4592461219513;658.236445722959;661.9404253617101;664.0669858848325;665.8235567574596;547.6960287040731;575.4303239792658;631.1605564599072;631.2362041929317;663.7345061975249;8385.923841306903;8649.0050347639;8697.260732837653;8824.249938755278;9000.09999000108;548.1093223511793;578.1876463568693;594.5808205215313;645.7965740791635;660.3297652882328;4046.089629833264;4146.751194928314;4202.474690663667;4215.515215750167;4295.871123866289;111673.44163279132;113141.86858131477;113294;114562;122419;98080.50959745156;98248;99337;101619.98380016105;105659.47170264099;55939;56516.43483565112;57240;58318.99999999915;69915;7051.330123638246;7987.800304992422;8088.150744171778;8185.4270201085355;8394.202550757669;39010.6098939007;47304.290435642804;49172.26241606307;49210.75394623004;55862.16206756983;57567;75062.62468687621;77191.22808771841;77541.61229193817;78970.6051469739;11623.941880290544;11663.300201987908;11764.822536105243;11794.823077654013;12142.028637709138;13101.803472948104;13350.399232034388;13518;13632.93183534076;13759.862401375858;12399.25604463735;12416.379181040731;12464.626061218178;12478.313692746622;12856.357182140668;10562.683119506428;11769.117316201491;11915.404229788302;12035.097367697283;12452.31512266834;11857.40712964331;12117.394130293274;12197.573084941985;12290.815637765261;12525.123241373016;10213.693589192337;10311.381317120997;10337.431441270803;10472.68581942543;10744.892551074701;10212.131968782736;10457.790844183226;10734.248602598056;10788.244822862638;10805 20:54:06 INFO - PROCESS | 1702 | __end_tp_report 20:54:06 INFO - PROCESS | 1702 | __start_cc_report 20:54:06 INFO - PROCESS | 1702 | _x_x_mozilla_cycle_collect,2495 20:54:06 INFO - PROCESS | 1702 | __end_cc_report 20:54:06 INFO - PROCESS | 1702 | __startTimestamp1483419246110__endTimestamp 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | ------- Summary: start ------- 20:54:06 INFO - PROCESS | 1702 | Number of tests: 6 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#0] dojo.html Cycles:165 Average:5713.85 Median:5870.85 stddev:645.21 (11.0%) stddev-sans-first:619.89 20:54:06 INFO - PROCESS | 1702 | Values: 3347.0 3359.3 3367.5 3384.3 3424.2 5697.1 5738.0 5739.8 5742.1 5759.6 5687.3 5768.7 5782.2 5796.4 5801.2 5218.0 5239.7 5276.1 5278.1 5302.9 5098.2 5115.7 5123.9 5191.7 5327.3 5190.0 5190.9 5207.5 5208.9 5209.2 5147.5 5174.5 5176.5 5190.4 5207.2 5043.9 5155.6 5158.4 5170.9 5194.9 5695.8 5707.1 5710.4 5717.7 5727.3 6127.9 6140.2 6145.9 6147.5 6154.6 6185.9 6221.2 6234.4 6251.2 6281.6 5727.7 5736.5 5740.4 5774.8 5779.6 5674.8 6129.9 6190.5 6191.8 6285.6 5350.9 6105.9 6108.6 6116.6 6157.2 6243.6 6298.3 6310.5 6313.5 6325.2 6109.9 6235.4 6246.5 6265.6 6278.3 5808.8 6151.7 6160.6 6188.4 6244.3 4908.3 4910.5 4917.6 4931.4 4944.0 4243.0 4382.8 4436.0 4436.6 4450.4 4909.2 5692.3 5731.5 5738.7 5738.7 4588.0 6214.8 6292.3 6312.9 6326.6 5762.8 5766.8 5791.5 5799.3 5802.6 5278.7 5285.1 5404.0 5410.5 5430.7 6183.7 6287.7 6292.6 6325.0 6338.5 6273.6 6284.5 6286.7 6308.3 6310.7 5218.3 6208.2 6284.2 6289.2 6309.3 5999.6 6085.8 6130.9 6134.5 6138.7 6283.4 6299.4 6310.6 6320.4 6322.5 6055.0 6104.6 6139.3 6156.8 6158.9 5962.5 6014.7 6035.0 6150.8 6153.0 5899.9 5935.5 5951.4 5981.6 6044.2 5934.7 6141.8 6144.2 6159.8 6162.0 5826.8 5843.5 5870.9 5999.6 6001.2 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#1] ext.html Cycles:180 Average:76607.86 Median:39580.50 stddev:176549.27 (446.1%) stddev-sans-first:176952.11 20:54:06 INFO - PROCESS | 1702 | Values: 518.5 520.5 525.6 528.4 567.6 38733.4 40072.6 40204.6 42071.7 42084.6 41035.4 41616.0 41712.8 41779.8 41869.0 8346.6 8350.5 9361.7 9549.5 9549.8 8395.6 8582.4 8593.7 8602.2 11124.3 11132.3 11309.9 11314.1 11336.6 11338.0 11324.7 11411.9 11419.3 11442.6 11450.3 8409.9 8640.7 10977.3 11272.2 11338.7 37904.9 39589.0 39622.8 39641.8 39649.8 3230.8 3261.8 3446.8 3830.2 3844.2 28367.0 28429.9 29336.1 29701.4 30510.1 3175.2 3210.3 3218.2 3221.3 3221.5 491331.0 496248.0 496729.0 497041.0 502863.0 49382.0 50583.0 58027.0 58241.0 58393.0 63447.7 63866.7 63874.0 63888.0 64102.0 15620.4 15744.2 15758.1 15780.3 15830.7 12007.5 12079.5 12090.8 12248.8 12252.4 15953.2 16266.7 16280.5 16598.3 18340.5 5731.9 6712.0 6863.9 7716.2 7850.5 695.8 900.4 913.1 926.9 1039.8 28218.9 29131.4 29246.9 29763.7 29909.4 1049.9 1074.0 1085.4 1138.7 1144.3 15225.7 15274.7 15421.7 15630.6 15635.5 658520.0 661477.0 664446.0 666922.0 667900.0 47237.0 48227.3 55931.6 56133.4 57725.7 1331.3 1353.8 1368.5 1368.5 1373.1 29193.9 29941.7 30110.7 30175.8 30587.4 49178.0 49702.3 49747.5 49814.5 49966.0 554765.0 803215.0 821674.0 837733.0 842285.0 37954.8 38081.8 38396.4 38737.8 38795.8 43346.6 43415.8 43699.8 44002.3 44024.5 35576.0 35866.3 36169.8 36493.5 40545.4 38909.0 39315.8 40489.0 40992.3 42100.0 39579.0 39582.0 40015.8 40079.2 40247.0 39347.0 39539.0 39833.8 39864.8 40596.4 24545.5 25748.2 26439.0 26821.3 26861.0 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#2] jquery.html Cycles:180 Average:35152.66 Median:2615.86 stddev:102507.16 (3918.7%) stddev-sans-first:102761.42 20:54:06 INFO - PROCESS | 1702 | Values: 353.8 369.6 377.8 385.8 407.4 14810.9 14904.6 19079.2 21069.9 21182.5 19385.0 19486.6 19696.4 20184.2 20419.6 5694.6 6033.6 6043.5 6048.3 6054.1 5721.8 5918.8 6040.1 6058.7 6079.0 6105.0 6112.6 6117.8 6124.7 6128.4 5937.5 6564.7 6662.1 6683.7 6685.6 5628.6 5875.2 5876.5 5897.7 5912.1 12931.5 12968.9 13163.1 13165.6 13189.3 2196.6 2303.4 2344.1 2568.3 2663.4 9733.0 9861.3 10181.0 10400.8 14473.3 1832.8 1849.2 1869.2 1901.4 1925.7 116951.4 118212.0 122741.0 122781.0 125407.4 11071.4 11336.9 11402.5 11412.6 11627.4 10386.9 13338.5 13345.2 13405.6 14181.7 7604.2 7924.7 8023.3 8293.3 8560.3 6888.7 8312.5 8315.2 8331.3 8455.9 4145.0 4159.3 4374.6 4437.7 4498.3 1834.8 1885.9 1887.7 1891.3 1892.9 824.2 910.6 939.9 953.2 958.6 19403.4 20612.9 20726.3 20745.5 20996.6 873.8 892.7 896.0 913.6 935.0 8886.6 10161.5 10506.6 10625.4 10647.7 600243.0 601766.0 615921.0 625760.0 625933.0 111763.0 125542.0 128936.0 130388.3 133351.0 822.1 837.6 839.2 952.5 1024.5 18141.5 18615.8 19061.1 19093.0 19442.7 52530.2 56715.0 59121.2 59393.4 59584.7 77029.0 79788.6 79841.2 79994.6 82867.6 5702.0 5894.5 7837.5 8013.0 8122.8 10481.5 10590.6 12393.5 12557.9 12628.4 11094.2 11323.9 11344.4 11359.7 11472.8 9809.5 10131.3 10599.3 10881.8 11319.5 10574.7 11486.0 11757.2 11764.8 11788.6 6558.2 7782.6 8036.4 8187.8 8244.2 10338.0 10958.3 11100.6 11281.7 11395.8 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#3] mootools.html Cycles:180 Average:5327.12 Median:4941.51 stddev:2967.53 (60.1%) stddev-sans-first:2960.41 20:54:06 INFO - PROCESS | 1702 | Values: 1298.5 1439.3 1451.2 1597.4 1802.0 7404.3 7770.0 8099.9 8324.7 8326.8 8139.4 8205.0 8219.0 8223.3 8244.9 2280.5 2313.1 2313.3 2318.0 2318.2 2220.7 2298.9 2339.3 2359.5 2367.3 2259.4 2270.1 2303.0 2326.7 2331.8 1910.7 2268.9 2277.1 2308.4 2317.2 2309.0 2328.8 2331.4 2332.5 2340.5 8110.6 8273.3 8295.3 8335.2 8352.8 4996.2 5199.7 5204.3 5225.4 5233.6 3294.2 3534.0 3581.2 3599.1 3605.9 1042.3 1064.5 1089.5 1097.3 1103.5 10727.2 10784.5 10835.5 10854.6 10865.4 4213.1 4387.3 4458.7 4467.3 4474.5 8516.7 8520.9 8524.0 8541.6 8543.4 5080.1 5081.7 5082.7 5088.8 5092.4 4038.4 4259.1 4414.1 4419.0 4698.1 2988.6 3060.9 3610.5 3692.7 3700.8 956.4 1114.8 1125.3 1127.9 1142.9 681.1 871.3 881.7 899.7 906.4 4736.6 5203.2 5224.0 5411.0 5586.1 425.9 432.1 432.1 443.6 444.0 3225.8 3722.9 3740.1 3745.1 3746.9 9691.0 9954.0 10033.0 10039.6 10045.6 9679.9 9967.4 10020.0 10023.1 10030.3 7629.9 7853.3 7868.2 7869.5 7871.5 5250.4 5387.3 5417.2 5465.7 5514.3 9073.0 9316.0 9328.1 9381.2 9425.0 9060.0 9340.9 9484.3 9555.4 9560.9 7060.5 7105.4 7189.5 7195.4 7201.1 7664.5 7666.8 7722.7 7734.3 7737.4 6869.8 6975.4 7043.2 7076.3 7091.1 6899.8 6970.7 6979.7 7003.3 7018.1 6519.8 6528.9 6534.2 6607.7 6617.3 4635.8 4681.3 4770.9 4797.1 4816.7 4621.5 4675.2 4684.8 4785.3 4886.8 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#4] prototype.html Cycles:180 Average:4250.66 Median:4786.61 stddev:1277.57 (26.7%) stddev-sans-first:1246.27 20:54:06 INFO - PROCESS | 1702 | Values: 300.0 305.0 308.5 312.6 315.8 4503.4 4537.5 5068.9 5086.9 5113.2 4589.9 4782.5 4988.5 5016.1 5124.9 3603.7 3853.5 3857.4 3901.4 3992.2 3259.9 3499.9 3942.8 3947.7 3963.2 3415.5 3631.8 3893.2 3925.2 3977.2 3548.6 3554.7 3633.6 3733.5 3988.1 3430.9 3455.4 3494.5 3498.9 3524.2 4961.9 4963.7 4964.8 5004.8 5011.5 4261.8 4355.1 4451.6 4474.3 4474.7 5144.6 5343.8 5393.0 5423.0 5431.8 3811.6 3849.9 3851.5 3854.0 3864.7 5235.7 5674.2 5697.3 5703.6 5714.9 3706.4 3777.6 3781.4 3800.4 3806.0 3423.4 3562.4 3755.2 3865.3 3865.6 4020.1 4412.0 4422.5 4429.0 4531.1 4393.0 4892.7 5331.9 5388.6 5423.9 1144.5 1236.7 1236.9 1246.6 1250.4 720.6 837.6 845.6 850.2 854.8 3945.8 4810.0 4914.8 4978.4 5001.7 5513.0 5583.2 5584.4 5586.3 5605.4 4115.7 4136.2 4306.3 5041.7 5043.6 2420.8 2542.6 2596.8 2758.3 2765.8 5021.3 5076.2 5348.4 5363.8 5371.5 4441.9 4968.6 5088.8 5163.0 5405.9 4754.6 5379.6 5389.4 5401.7 5414.9 4381.0 4868.6 5229.6 5251.4 5273.3 4360.1 4790.8 5015.4 5193.5 5253.4 4544.7 4875.4 5236.3 5329.1 5361.6 3263.4 3532.7 3553.4 3631.5 3642.6 4687.9 4847.9 5232.7 5301.3 5315.7 4335.6 5090.3 5097.7 5105.0 5187.9 4629.7 4664.6 4746.6 5059.9 5086.2 4595.7 4978.3 4982.7 4984.4 5049.5 4086.9 4900.0 4966.2 5093.8 5118.7 4887.8 5196.3 5258.3 5277.0 5315.3 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - PROCESS | 1702 | [#5] yui.html Cycles:180 Average:19811.74 Median:4337.30 stddev:29389.07 (677.6%) stddev-sans-first:29436.49 20:54:06 INFO - PROCESS | 1702 | Values: 705.2 762.6 764.5 803.3 804.2 15789.3 16014.0 16360.0 16420.4 16456.0 14993.9 15010.2 15051.4 15129.2 15151.3 645.6 660.2 709.4 810.6 829.6 828.7 833.6 840.9 843.7 845.0 879.7 880.9 883.5 886.3 886.8 671.0 690.9 877.3 878.1 879.6 515.9 516.0 517.4 587.5 626.4 14160.7 14239.4 14267.0 14279.0 14284.2 12557.4 12631.6 12793.7 12807.3 12810.9 11744.0 12045.2 12097.3 12202.6 12225.0 4306.7 4336.3 4343.8 4423.5 4524.7 84734.0 85304.7 86345.3 88530.0 90747.0 9868.4 10108.3 10146.7 10200.1 10292.6 19157.8 19198.9 19234.5 19235.2 19909.4 7408.7 7569.3 7658.8 7697.0 7763.0 3657.6 4254.8 4338.3 4374.1 4375.8 3403.9 3517.0 3517.7 3531.9 3534.9 655.5 658.2 661.9 664.1 665.8 547.7 575.4 631.2 631.2 663.7 8385.9 8649.0 8697.3 8824.2 9000.1 548.1 578.2 594.6 645.8 660.3 4046.1 4146.8 4202.5 4215.5 4295.9 111673.4 113141.9 113294.0 114562.0 122419.0 98080.5 98248.0 99337.0 101620.0 105659.5 55939.0 56516.4 57240.0 58319.0 69915.0 7051.3 7987.8 8088.2 8185.4 8394.2 39010.6 47304.3 49172.3 49210.8 55862.2 57567.0 75062.6 77191.2 77541.6 78970.6 11623.9 11663.3 11764.8 11794.8 12142.0 13101.8 13350.4 13518.0 13632.9 13759.9 12399.3 12416.4 12464.6 12478.3 12856.4 10562.7 11769.1 11915.4 12035.1 12452.3 11857.4 12117.4 12197.6 12290.8 12525.1 10213.7 10311.4 10337.4 10472.7 10744.9 10212.1 10457.8 10734.2 10788.2 10805.0 20:54:06 INFO - PROCESS | 1702 | -------- Summary: end -------- 20:54:06 INFO - PROCESS | 1702 | 20:54:06 INFO - TEST-INFO | 1702: exit 0 20:54:06 INFO - TEST-OK | dromaeo_css | took 1121060ms 20:54:06 INFO - TEST-START | kraken 20:54:06 INFO - operating with platform_type : mac_ 20:54:06 INFO - Initialising browser for kraken test... 20:54:06 INFO - TEST-INFO | started process 1819 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpCAjgux/profile http://localhost:49248/getInfo.html) 20:54:09 INFO - PROCESS | 1819 | __metrics Screen width/height:1600/1200 20:54:09 INFO - PROCESS | 1819 | colorDepth:24 20:54:09 INFO - PROCESS | 1819 | Browser inner width/height: 1024/689 20:54:09 INFO - PROCESS | 1819 | __metrics 20:54:09 INFO - PROCESS | 1819 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:54:09 INFO - PROCESS | 1819 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:54:10 INFO - TEST-INFO | 1819: exit 0 20:54:10 INFO - Browser initialized. 20:54:10 INFO - Running cycle 1/1 for kraken test... 20:54:10 INFO - TEST-INFO | started process 1820 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpCAjgux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:22 INFO - PROCESS | 1820 | RSS: Main: 222724096 20:54:22 INFO - PROCESS | 1820 | 20:54:25 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:26 INFO - PROCESS | 1820 | RSS: Main: 272384000 20:54:26 INFO - PROCESS | 1820 | 20:54:29 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 20:54:29 INFO - PROCESS | 1820 | RSS: Main: 283127808 20:54:29 INFO - PROCESS | 1820 | 20:54:32 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 20:54:33 INFO - PROCESS | 1820 | RSS: Main: 380821504 20:54:33 INFO - PROCESS | 1820 | 20:54:35 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 20:54:36 INFO - PROCESS | 1820 | RSS: Main: 282906624 20:54:36 INFO - PROCESS | 1820 | 20:54:38 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:38 INFO - PROCESS | 1820 | RSS: Main: 283648000 20:54:38 INFO - PROCESS | 1820 | 20:54:41 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:42 INFO - PROCESS | 1820 | RSS: Main: 323923968 20:54:42 INFO - PROCESS | 1820 | 20:54:45 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:45 INFO - PROCESS | 1820 | RSS: Main: 325627904 20:54:45 INFO - PROCESS | 1820 | 20:54:48 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 20:54:48 INFO - PROCESS | 1820 | RSS: Main: 320921600 20:54:48 INFO - PROCESS | 1820 | 20:54:50 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:51 INFO - PROCESS | 1820 | RSS: Main: 300417024 20:54:51 INFO - PROCESS | 1820 | 20:54:53 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:53 INFO - PROCESS | 1820 | RSS: Main: 301203456 20:54:53 INFO - PROCESS | 1820 | 20:54:55 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:54:56 INFO - PROCESS | 1820 | RSS: Main: 303656960 20:54:56 INFO - PROCESS | 1820 | 20:54:59 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:55:00 INFO - PROCESS | 1820 | RSS: Main: 313331712 20:55:00 INFO - PROCESS | 1820 | 20:55:03 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:55:03 INFO - PROCESS | 1820 | RSS: Main: 313135104 20:55:03 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 20:55:05 INFO - PROCESS | 1820 | RSS: Main: 356904960 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | __start_tp_report 20:55:05 INFO - PROCESS | 1820 | _x_x_mozilla_page_load 20:55:05 INFO - PROCESS | 1820 | _x_x_mozilla_page_load_details 20:55:05 INFO - PROCESS | 1820 | |i|pagename|runs| 20:55:05 INFO - PROCESS | 1820 | |0;ai-astar;116;115;115;115;117;114;114;116;115;115 20:55:05 INFO - PROCESS | 1820 | |1;audio-beat-detection;144;110;108;143;111;109;120;126;173;144 20:55:05 INFO - PROCESS | 1820 | |2;audio-dft;185;187;182;184;184;182;187;182;185;184 20:55:05 INFO - PROCESS | 1820 | |3;audio-fft;80;61;58;91;60;58;61;59;83;58 20:55:05 INFO - PROCESS | 1820 | |4;audio-oscillator;88;71;94;70;69;71;92;92;99;93 20:55:05 INFO - PROCESS | 1820 | |5;imaging-gaussian-blur;87;84;90;86;88;84;86;84;86;84 20:55:05 INFO - PROCESS | 1820 | |6;imaging-darkroom;94;93;93;92;98;93;93;92;93;93 20:55:05 INFO - PROCESS | 1820 | |7;imaging-desaturate;85;82;79;81;80;80;84;85;80;80 20:55:05 INFO - PROCESS | 1820 | |8;json-parse-financial;56;53;55;53;57;58;57;58;57;58 20:55:05 INFO - PROCESS | 1820 | |9;json-stringify-tinderbox;66;81;78;75;73;71;70;71;71;71 20:55:05 INFO - PROCESS | 1820 | |10;stanford-crypto-aes;84;84;84;85;84;82;84;86;84;85 20:55:05 INFO - PROCESS | 1820 | |11;stanford-crypto-ccm;144;142;147;154;145;141;143;139;185;151 20:55:05 INFO - PROCESS | 1820 | |12;stanford-crypto-pbkdf2;167;162;164;167;165;166;181;226;180;166 20:55:05 INFO - PROCESS | 1820 | |13;stanford-crypto-sha256-iterative;60;63;86;68;67;68;67;66;68;68 20:55:05 INFO - PROCESS | 1820 | __end_tp_report 20:55:05 INFO - PROCESS | 1820 | __start_cc_report 20:55:05 INFO - PROCESS | 1820 | _x_x_mozilla_cycle_collect,2018 20:55:05 INFO - PROCESS | 1820 | __end_cc_report 20:55:05 INFO - PROCESS | 1820 | __startTimestamp1483419305677__endTimestamp 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | ------- Summary: start ------- 20:55:05 INFO - PROCESS | 1820 | Number of tests: 14 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 20:55:05 INFO - PROCESS | 1820 | Values: 116.0 115.0 115.0 115.0 117.0 114.0 114.0 116.0 115.0 115.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:134.50 stddev:21.60 (16.1%) stddev-sans-first:22.19 20:55:05 INFO - PROCESS | 1820 | Values: 144.0 110.0 108.0 143.0 111.0 109.0 120.0 126.0 173.0 144.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.87 (1.0%) stddev-sans-first:1.96 20:55:05 INFO - PROCESS | 1820 | Values: 185.0 187.0 182.0 184.0 184.0 182.0 187.0 182.0 185.0 184.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.00 stddev:12.60 (20.7%) stddev-sans-first:12.44 20:55:05 INFO - PROCESS | 1820 | Values: 80.0 61.0 58.0 91.0 60.0 58.0 61.0 59.0 83.0 58.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:92.00 stddev:12.06 (13.1%) stddev-sans-first:12.70 20:55:05 INFO - PROCESS | 1820 | Values: 88.0 71.0 94.0 70.0 69.0 71.0 92.0 92.0 99.0 93.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.00 stddev:2.02 (2.4%) stddev-sans-first:2.11 20:55:05 INFO - PROCESS | 1820 | Values: 87.0 84.0 90.0 86.0 88.0 84.0 86.0 84.0 86.0 84.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.71 (1.8%) stddev-sans-first:1.80 20:55:05 INFO - PROCESS | 1820 | Values: 94.0 93.0 93.0 92.0 98.0 93.0 93.0 92.0 93.0 93.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:81.50 stddev:2.27 (2.8%) stddev-sans-first:2.05 20:55:05 INFO - PROCESS | 1820 | Values: 85.0 82.0 79.0 81.0 80.0 80.0 84.0 85.0 80.0 80.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.93 (3.4%) stddev-sans-first:2.05 20:55:05 INFO - PROCESS | 1820 | Values: 56.0 53.0 55.0 53.0 57.0 58.0 57.0 58.0 57.0 58.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.00 stddev:4.30 (6.0%) stddev-sans-first:3.81 20:55:05 INFO - PROCESS | 1820 | Values: 66.0 81.0 78.0 75.0 73.0 71.0 70.0 71.0 71.0 71.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 20:55:05 INFO - PROCESS | 1820 | Values: 84.0 84.0 84.0 85.0 84.0 82.0 84.0 86.0 84.0 85.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:146.00 stddev:13.41 (9.2%) stddev-sans-first:14.10 20:55:05 INFO - PROCESS | 1820 | Values: 144.0 142.0 147.0 154.0 145.0 141.0 143.0 139.0 185.0 151.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:167.00 stddev:19.26 (11.5%) stddev-sans-first:20.24 20:55:05 INFO - PROCESS | 1820 | Values: 167.0 162.0 164.0 167.0 165.0 166.0 181.0 226.0 180.0 166.0 20:55:05 INFO - PROCESS | 1820 | 20:55:05 INFO - PROCESS | 1820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:6.82 (10.0%) stddev-sans-first:6.58 20:55:05 INFO - PROCESS | 1820 | Values: 60.0 63.0 86.0 68.0 67.0 68.0 67.0 66.0 68.0 68.0 20:55:05 INFO - PROCESS | 1820 | -------- Summary: end -------- 20:55:05 INFO - PROCESS | 1820 | 20:55:06 INFO - TEST-INFO | 1820: exit 0 20:55:06 INFO - TEST-OK | kraken | took 59970ms 20:55:06 INFO - SUITE-END | took 1181s 20:55:06 INFO - Completed test suite (00:19:41) 20:55:06 INFO - javascript benchmark 20:55:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.9665303346965, 3359.2777552826137, 3367.5285460035598, 3384.289299247158, 3424.2466657335376, 5697.145428185774, 5737.971310143449, 5739.770409183628, 5742.052561327376, 5759.625624334415, 5687.345955215152, 5768.653880767157, 5782.248307720001, 5796.362400135981, 5801.216835727176, 5218.034663587229, 5239.738013099349, 5276.103062479368, 5278.102722537178, 5302.946970530304, 5098.235264710304, 5115.718635475047, 5123.923141152885, 5191.740412979336, 5327.254184414185, 5190.039842629126, 5190.870228244286, 5207.505286997748, 5208.895822083556, 5209.244659524366, 5147.536721695046, 5174.508421699932, 5176.482351764831, 5190.403103643054, 5207.166853303473, 5043.873903152414, 5155.613329000303, 5158.3552055993005, 5170.948290517084, 5194.870128246824, 5695.772169113272, 5707.1153971134545, 5710.428957104298, 5717.656940583578, 5727.341355744101, 6127.9031502109065, 6140.232470941132, 6145.893739126956, 6147.463134216446, 6154.569180157391, 6185.907211391833, 6221.160143380631, 6234.376562343775, 6251.249850018027, 6281.623102613812, 5727.742251598646, 5736.541076713895, 5740.425957404268, 5774.826755197309, 5779.595428320019, 5674.779922316722, 6129.908051379233, 6190.50475961931, 6191.783287584913, 6285.59143655661, 5350.892982140335, 6105.938940610626, 6108.6029408089225, 6116.633002019893, 6157.230346206724, 6243.625382477066, 6298.338674439209, 6310.5267104967315, 6313.526485513605, 6325.177726895474, 6109.868257519264, 6235.407636274546, 6246.531510136758, 6265.624062556261, 6278.30938596754, 5808.767649294065, 6151.66165860873, 6160.568760186834, 6188.381161883865, 6244.250689917239, 4908.263760435963, 4910.533499317559, 4917.557419832232, 4931.432885218174, 4944.011197760462, 4243.045314804144, 4382.802773875183, 4436.0462500562535, 4436.64506839452, 4450.35469856869, 4909.214525675875, 5692.345380281238, 5731.484166425042, 5738.655680659173, 5738.684372359477, 4588.0135770808765, 6214.751409943642, 6292.307846136921, 6312.936870631327, 6326.557141000086, 5762.7694892203845, 5766.772924613256, 5791.478766910998, 5799.2750906136735, 5802.622829516068, 5278.709670968057, 5285.101532739521, 5404.0, 5410.540104091117, 5430.67415955044, 6183.721732521957, 6287.74849006053, 6292.559520833498, 6325.0, 6338.492920566251, 6273.560850740404, 6284.465820405317, 6286.6856657166045, 6308.306086330408, 6310.7475700971445, 5218.26944227816, 6208.161898143873, 6284.24589049317, 6289.150964619717, 6309.305976342691, 5999.610025348513, 6085.817425477243, 6130.938690613215, 6134.478569321657, 6138.723757431016, 6283.403076707706, 6299.370062993848, 6310.6213627182515, 6320.399562041599, 6322.462590679844, 6054.982715014727, 6104.603200791934, 6139.29398119222, 6156.846078848064, 6158.938410615837, 5962.52299816005, 6014.699265036818, 6035.0, 6150.7847225346895, 6152.969235153795, 5899.91150132757, 5935.525157987437, 5951.434613711691, 5981.581289309706, 6044.15381846533, 5934.732937017931, 6141.815745527641, 6144.170536977451, 6159.81520554384, 6162.014077747718, 5826.82519524415, 5843.532517398683, 5870.853228669317, 5999.5500337473995, 6001.189839371629], "value": 5673.767139264691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.4944678938035, 520.4743209358546, 525.5742848292882, 528.4213785904436, 567.6480582039136, 38733.41899871504, 40072.59927400729, 40204.59795402041, 42071.73784786453, 42084.57915420845, 41035.38446923299, 41616.0, 41712.791436042775, 41779.79110104453, 41868.95327616804, 8346.582670866463, 8350.498970061815, 9361.67234146805, 9549.47477888716, 9549.761255968622, 8395.62219700115, 8582.356323275748, 8593.656253749843, 8602.225799678028, 11124.276922000085, 11132.33206007638, 11309.925557072065, 11314.094872410229, 11336.603218887341, 11337.979581837633, 11324.716882077973, 11411.94294028533, 11419.31484110956, 11442.599509017144, 11450.312981221112, 8409.873851892227, 8640.65437382504, 10977.341359518454, 11272.210945233837, 11338.71653208668, 37904.86285411442, 39589.0, 39622.80188599067, 39641.80179099086, 39649.80175099135, 3230.8223047732367, 3261.7879837810465, 3446.7759595626203, 3830.2148059647707, 3844.1735026969336, 28367.0, 28429.857850710614, 29336.119916402542, 29701.405971880442, 30510.08469745911, 3175.190326466736, 3210.325831575372, 3218.211538173139, 3221.3235220603465, 3221.5167724841226, 491331.0, 496248.0, 496729.0, 497041.0, 502863.0, 49382.0, 50583.0, 58027.0, 58240.96156634497, 58393.0, 63447.6827615859, 63866.68066659637, 63874.0418893717, 63888.0, 64102.0, 15620.375184992474, 15744.212789360487, 15758.133302668233, 15780.289886955115, 15830.683386332208, 12007.459664315127, 12079.456424460921, 12090.758184836253, 12248.81626775599, 12252.387380630933, 15953.245143034257, 16266.674666506604, 16280.511584652479, 16598.336066557204, 18340.54148646268, 5731.914021289684, 6712.0, 6863.931360686429, 7716.2221600223875, 7850.489718168301, 695.7540147289482, 900.4417261297906, 913.1325241020924, 926.935114541989, 1039.7868436970555, 28218.85890570575, 29131.41737165287, 29246.853765731033, 29763.70236297609, 29909.40181196364, 1049.9212559057949, 1074.0065439468617, 1085.3867564825848, 1138.6520150162876, 1144.3019757947645, 15225.695486090217, 15274.694506109816, 15421.686746988042, 15630.609234768994, 15635.530934071996, 658520.0, 661477.0, 664446.0, 666922.0, 667900.0, 47237.0, 48227.276590851165, 55931.60170995676, 56133.43866561364, 57725.71137144287, 1331.301066939845, 1353.8036984637172, 1368.5004973184914, 1368.50733735857, 1373.1006190944747, 29193.85403072971, 29941.70058299389, 30110.69889301079, 30175.84174243111, 30587.388252234385, 49178.0, 49702.25446618231, 49747.50757477281, 49814.50185498098, 49966.00067998547, 554765.0, 803215.0, 821674.0, 837733.0, 842285.0, 37954.8102259498, 38081.80959095187, 38396.42405363978, 38737.80631096826, 38795.806020969714, 43346.566534334255, 43415.78292108519, 43699.78150109229, 44002.33996489991, 44024.45914392981, 35576.0, 35866.28267434584, 36169.81915090408, 36493.45259821052, 40545.391819122146, 38909.0, 39315.82052538428, 40488.987775304675, 40992.30008688627, 42100.0, 39579.0, 39582.0, 40015.79992100021, 40079.1984160321, 40247.0, 39347.0, 39539.04609539023, 39833.80083099682, 39864.800675996434, 40596.3910541348, 24545.50908981846, 25748.227553173434, 26439.0, 26821.329466763487, 26861.0], "value": 20326.86578054343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7965669739897, 369.60083110240936, 377.78088708549046, 385.8340913407234, 407.44180472752333, 14810.851891481081, 14904.552863414088, 19079.23683052678, 21069.94650267488, 21182.470438239052, 19385.0, 19486.610267794636, 19696.409107726755, 20184.19263229469, 20419.591608167866, 5694.5729070319785, 6033.607815492001, 6043.516518678495, 6048.304444988838, 6054.061620448815, 5721.7711291548285, 5918.763249470016, 6040.063790112539, 6058.697065146747, 6078.969605151968, 6105.0, 6112.572119951606, 6117.755289788403, 6124.724387402578, 6128.356522565134, 5937.4656280934705, 6564.671766411684, 6662.10061641677, 6683.732650693991, 6685.565438246498, 5628.577856660767, 5875.177475153482, 5876.500497457721, 5897.675627840467, 5912.113183022538, 12931.48274069036, 12968.935155324258, 13163.07858449909, 13165.60503184906, 13189.274589897552, 2196.626573482512, 2303.4126297794123, 2344.10923848938, 2568.2808813532242, 2663.440677457736, 9732.951335243279, 9861.260405469548, 10181.0, 10400.791984160274, 14473.27633618315, 1832.7892292386414, 1849.2140840142886, 1869.242956602578, 1901.3607292836202, 1925.7482636286386, 116951.4152429241, 118212.0, 122741.0, 122781.0, 125407.37296313551, 11071.446427678584, 11336.886631133748, 11402.491451880573, 11412.600558980395, 11627.360495172677, 10386.896131038593, 13338.466461341632, 13345.199288042555, 13405.597832065054, 14181.716365672628, 7604.2395760423515, 7924.722634707758, 8023.277904988462, 8293.295069919124, 8560.272376847914, 6888.724451022003, 8312.5428101455, 8315.210055044761, 8331.29184019353, 8455.873161902577, 4144.958550414457, 4159.292920203573, 4374.562543745664, 4437.667174961891, 4498.257787465097, 1834.7523084383438, 1885.8684789126414, 1887.7262796894374, 1891.328578354692, 1892.9494130757287, 824.2375802382772, 910.6266430763487, 939.8966113727485, 953.1993125774383, 958.6117622362954, 19403.4178974631, 20612.896935515226, 20726.274580389916, 20745.481362965744, 20996.580068398853, 873.8203425375692, 892.6964831957166, 896.0233345653269, 913.5523593439167, 934.9995504809924, 8886.555672216364, 10161.4919254037, 10506.579736810594, 10625.362478251329, 10647.73380665474, 600242.998785012, 601766.0, 615921.0, 625760.0, 625933.0, 111763.0, 125542.0, 128936.0, 130388.3480582591, 133351.0, 822.0505316359614, 837.5895811052541, 839.2321026261025, 952.5284983932997, 1024.4826362686945, 18141.45575632733, 18615.813841861407, 19061.142248598568, 19093.0, 19442.708359374337, 52530.212046820096, 56715.0, 59121.22636320917, 59393.406065940515, 59584.70207648934, 77029.0, 79788.60105699435, 79841.20158798338, 79994.6000269995, 82867.5856620713, 5702.0306547887785, 5894.469497745224, 7837.49056311338, 8013.038435387791, 8122.796930076795, 10481.475926203811, 10590.576376945144, 12393.504259829506, 12557.874421256036, 12628.431720572413, 11094.15976148459, 11323.943380283046, 11344.432778360884, 11359.659210223706, 11472.770544589228, 9809.460479673686, 10131.290809643255, 10599.258051936291, 10881.836772448261, 11319.490622921823, 10574.744693457904, 11486.0, 11757.235779674294, 11764.764704706029, 11788.646340609796, 6558.245801732671, 7782.571958542335, 8036.437449378721, 8187.79530511742, 8244.175582441709, 10338.0, 10958.287711299059, 11100.61147859821, 11281.661550153509, 11395.772084558097], "value": 9289.534743101667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.5260379961317, 1439.2803598200903, 1451.1728314860527, 1597.4089586852858, 1802.0, 7404.259574042593, 7770.0, 8099.919000809998, 8324.709670001144, 8326.83346333073, 8139.38954578406, 8205.0, 8218.95890520548, 8223.34213262939, 8244.876326855101, 2280.5438912217583, 2313.0516488239823, 2313.3291345509783, 2317.9768202318014, 2318.1770471482632, 2220.7224096987875, 2298.8965496552696, 2339.263132113379, 2359.539889721505, 2367.3253122859987, 2259.3560835161984, 2270.12600148943, 2303.0, 2326.6510023496526, 2331.8134549236106, 1910.703840904662, 2268.875211863347, 2277.055022165799, 2308.3998160478313, 2317.188983855654, 2309.0, 2328.836981411285, 2331.370529956919, 2332.486852892361, 2340.5318936212825, 8110.594470276522, 8273.255407013397, 8295.294899933513, 8335.249827515492, 8352.791180220482, 4996.200607902754, 5199.688018718851, 5204.29741984831, 5225.425203227642, 5233.633645644806, 3294.1929227339215, 3533.9646603533893, 3581.230035542371, 3599.1002249437643, 3605.9459108113138, 1042.2599954032646, 1064.4784055812595, 1089.4661615808277, 1097.2648325621853, 1103.4593049405814, 10727.195460340428, 10784.514696838662, 10835.512401941853, 10854.565817367296, 10865.40240286784, 4213.115245798355, 4387.254166791589, 4458.665600079942, 4467.30756732707, 4474.485434175046, 8516.659333626585, 8520.872186917077, 8523.957380213184, 8541.615627296787, 8543.35924805642, 5080.110980578384, 5081.669691470042, 5082.745862706924, 5088.847334579968, 5092.363454568179, 4038.374052021941, 4259.1268789897995, 4414.1171765647, 4419.0, 4698.060387922429, 2988.6413630364495, 3060.877564897379, 3610.5306310180035, 3692.6861216796874, 3700.796456194935, 956.4309236004566, 1114.8383484394878, 1125.2629527659396, 1127.8533790607169, 1142.8914253145938, 681.0871542985481, 871.285545852395, 881.7487016200353, 899.7480705402367, 906.3972458315278, 4736.621070314367, 5203.219517072469, 5224.0074385866565, 5411.0, 5586.1062230043, 425.89991352032246, 432.0904496035862, 432.0947614747163, 443.58303194996597, 444.03865630908723, 3225.8387080645875, 3722.925541489155, 3740.102375429877, 3745.138618117848, 3746.8875933722034, 9691.030896910253, 9953.950230248802, 10033.046860548237, 10039.598416063422, 10045.598176073021, 9679.92588386478, 9967.352122112039, 10020.048095430922, 10023.14803241718, 10030.297879148535, 7629.8855517167285, 7853.332466740277, 7868.173841746649, 7869.48848324857, 7871.48835325702, 5250.369955605199, 5387.272718182995, 5417.1874218865905, 5465.72671366438, 5514.310711161105, 9073.0, 9315.953420232856, 9328.113829186217, 9381.202597778993, 9425.01037391064, 9060.0, 9340.906590934004, 9484.336096473457, 9555.426674399558, 9560.904390956, 7060.505764596429, 7105.431565474853, 7189.496735228484, 7195.352418282379, 7201.13586369639, 7664.501807382502, 7666.769996900102, 7722.652480638272, 7734.342580880463, 7737.381009519112, 6869.7595584154315, 6975.407090397373, 7043.154821421463, 7076.2923707628825, 7091.078159839188, 6899.827504312432, 6970.721171153097, 6979.651017449006, 7003.3346832050875, 7018.052562904147, 6519.8044058678315, 6528.869422611616, 6534.215894092739, 6607.702653380706, 6617.305182955721, 4635.791389387418, 4681.302554339155, 4770.856874293777, 4797.136515427256, 4816.735079570517, 4621.537846215351, 4675.181843177363, 4684.812607495662, 4785.258284965836, 4886.828960986349], "value": 4229.893751846059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9505081661526, 305.03456559987643, 308.47097228253546, 312.5902181162956, 315.76002238298884, 4503.437070366204, 4537.546245375461, 5068.923966140506, 5086.872828179288, 5113.233015047745, 4589.908201835961, 4782.450018247902, 4988.50114988501, 5016.122178618736, 5124.923126153101, 3603.6576525230194, 3853.49904512413, 3857.4406711026886, 3901.3912131278453, 3992.2414741199223, 3259.902202933904, 3499.860005599773, 3942.8225729842084, 3947.743396679221, 3963.246983073221, 3415.453527435611, 3631.836567354462, 3893.1629699614577, 3925.1551770667884, 3977.224441233946, 3548.5741710994716, 3554.662307080823, 3633.6184700606586, 3733.533308336458, 3988.088695252453, 3430.9485357719655, 3455.378031954247, 3494.5107684924133, 3498.915336245772, 3524.207053412987, 4961.925571116436, 4963.726995015273, 4964.808445972976, 5004.84985450437, 5011.473795251519, 4261.808218630169, 4355.128974205171, 4451.599356057938, 4474.261746811772, 4474.6867719259335, 5144.639875208737, 5343.839684809462, 5393.0, 5422.9728851355885, 5431.812618948894, 3811.6188381161937, 3849.9037524062123, 3851.499305090348, 3854.036490877281, 3864.6908247340425, 5235.65968212065, 5674.177244299594, 5697.344805347397, 5703.572232082569, 5714.914276285859, 3706.3884459064493, 3777.6411240932616, 3781.3740091760255, 3800.3539398302355, 3806.0, 3423.3837909176586, 3562.4300111982475, 3755.1550901047044, 3865.3042452358845, 3865.632764887331, 4020.0954785173103, 4412.0, 4422.469303683579, 4428.955710442854, 4531.116432295671, 4392.978035109868, 4892.657513974059, 5331.880305135887, 5388.622796404214, 5423.918641220384, 1144.5135817277624, 1236.6908272931767, 1236.8824961628632, 1246.5823948977013, 1250.4435526190757, 720.6396801599201, 837.6053870305994, 845.6067928413318, 850.2050582705191, 854.833307505043, 3945.763254204757, 4810.037992401533, 4914.754262286871, 4978.402591688948, 5001.699898006132, 5513.0, 5583.218349431083, 5584.375343588507, 5586.301712285965, 5605.355384130796, 4115.7324773890205, 4136.234796562646, 4306.289462238696, 5041.722705251246, 5043.621728370387, 2420.830541862088, 2542.5677634802128, 2596.7792737617137, 2758.255271076838, 2765.7510824025935, 5021.322121513622, 5076.238564215323, 5348.384935732441, 5363.758630861621, 5371.543418809445, 4441.888952776142, 4968.577670897942, 5088.837244171286, 5163.0, 5405.891882162335, 4754.619630429557, 5379.557083466662, 5389.353277606712, 5401.729913504388, 5414.8917021659345, 4380.9780951095045, 4868.561829435368, 5229.555487783581, 5251.422343542284, 5273.312539987167, 4360.127974405195, 4790.760461976817, 5015.3730783652045, 5193.532582067632, 5253.395859476209, 4544.6818722689095, 4875.414950205856, 5236.266922630759, 5329.067413202596, 5361.624686271924, 3263.379957808009, 3532.735044871696, 3553.3781588222473, 3631.455281707765, 3642.6357364263363, 4687.859364219079, 4847.927281090716, 5232.712200828991, 5301.310829592283, 5315.681059136464, 4335.609795118455, 5090.287359769709, 5097.745112744422, 5105.0, 5187.939115921474, 4629.722216666876, 4664.626829853672, 4746.596539294199, 5059.876200896258, 5086.21163719624, 4595.747233902168, 4978.27814966835, 4982.701037937735, 4984.42679091909, 5049.495050494921, 4086.938695919504, 4899.951000489949, 4966.155753521982, 5093.847184584469, 5118.692878427306, 4887.828925987574, 5196.32447781786, 5258.31825768853, 5276.997370499593, 5315.3090098286975], "value": 3845.8103377243706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.1855107351009, 762.5882023707195, 764.5107131435879, 803.2730379006999, 804.1717031457594, 15789.28948197331, 16014.0, 16360.0, 16420.425285115023, 16456.0, 14993.85006149938, 15010.249487525607, 15051.397944082224, 15129.167895765728, 15151.318190681419, 645.6352161029027, 660.2044536333731, 709.3580309819622, 810.6068556749987, 829.5603330234985, 828.6768160417442, 833.6373677450329, 840.9411341206118, 843.7384410832661, 844.9535275559841, 879.6525372477868, 880.8766772651834, 883.5273128876053, 886.3086792302015, 886.7916039730658, 670.9597424154566, 690.9412699920513, 877.3376101043672, 878.0692465986043, 879.5734068976541, 515.889083846971, 516.0427407159702, 517.4075683342552, 587.4976894755008, 626.4487251218944, 14160.716785664228, 14239.430422783076, 14267.0, 14279.0, 14284.214368209745, 12557.372131393393, 12631.621051368473, 12793.744125117446, 12807.295598742065, 12810.871891281062, 11744.0, 12045.156839021272, 12097.274163550215, 12202.633920982385, 12225.0, 4306.676999225071, 4336.262835318003, 4343.761093139876, 4423.491298500681, 4524.660650451229, 84734.0, 85304.7204291936, 86345.27309453838, 88530.0, 90747.0, 9868.358556693793, 10108.29241953071, 10146.695599132037, 10200.132988696045, 10292.639757608447, 19157.8084219156, 19198.904005479882, 19234.519137021685, 19235.230590776213, 19909.402717918485, 7408.696690006348, 7569.318761311509, 7658.846823063507, 7697.0, 7762.961185194038, 3657.579378371521, 4254.7659878706345, 4338.327559228324, 4374.103308821747, 4375.78121093944, 3403.897883063512, 3516.962496063616, 3517.698451572883, 3531.94702079469, 3534.91162720934, 655.4592461219513, 658.236445722959, 661.9404253617101, 664.0669858848325, 665.8235567574596, 547.6960287040731, 575.4303239792658, 631.1605564599072, 631.2362041929317, 663.7345061975249, 8385.923841306903, 8649.0050347639, 8697.260732837653, 8824.249938755278, 9000.09999000108, 548.1093223511793, 578.1876463568693, 594.5808205215313, 645.7965740791635, 660.3297652882328, 4046.089629833264, 4146.751194928314, 4202.474690663667, 4215.515215750167, 4295.871123866289, 111673.44163279132, 113141.86858131477, 113294.0, 114562.0, 122419.0, 98080.50959745156, 98248.0, 99337.0, 101619.98380016105, 105659.47170264099, 55939.0, 56516.43483565112, 57240.0, 58318.99999999915, 69915.0, 7051.330123638246, 7987.800304992422, 8088.150744171778, 8185.4270201085355, 8394.202550757669, 39010.6098939007, 47304.290435642804, 49172.26241606307, 49210.75394623004, 55862.16206756983, 57567.0, 75062.62468687621, 77191.22808771841, 77541.61229193817, 78970.6051469739, 11623.941880290544, 11663.300201987908, 11764.822536105243, 11794.823077654013, 12142.028637709138, 13101.803472948104, 13350.399232034388, 13518.0, 13632.93183534076, 13759.862401375858, 12399.25604463735, 12416.379181040731, 12464.626061218178, 12478.313692746622, 12856.357182140668, 10562.683119506428, 11769.117316201491, 11915.404229788302, 12035.097367697283, 12452.31512266834, 11857.40712964331, 12117.394130293274, 12197.573084941985, 12290.815637765261, 12525.123241373016, 10213.693589192337, 10311.381317120997, 10337.431441270803, 10472.68581942543, 10744.892551074701, 10212.131968782736, 10457.790844183226, 10734.248602598056, 10788.244822862638, 10805.0], "value": 7103.162383628246, "unit": "score"}], "name": "dromaeo_css", "value": 7059.807734537149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 117.0, 114.0, 114.0, 116.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 108.0, 143.0, 111.0, 109.0, 120.0, 126.0, 173.0, 144.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 182.0, 184.0, 184.0, 182.0, 187.0, 182.0, 185.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 58.0, 91.0, 60.0, 58.0, 61.0, 59.0, 83.0, 58.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 70.0, 69.0, 71.0, 92.0, 92.0, 99.0, 93.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 90.0, 86.0, 88.0, 84.0, 86.0, 84.0, 86.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 92.0, 98.0, 93.0, 93.0, 92.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 79.0, 81.0, 80.0, 80.0, 84.0, 85.0, 80.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 53.0, 57.0, 58.0, 57.0, 58.0, 57.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 78.0, 75.0, 73.0, 71.0, 70.0, 71.0, 71.0, 71.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 82.0, 84.0, 86.0, 84.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 147.0, 154.0, 145.0, 141.0, 143.0, 139.0, 185.0, 151.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 164.0, 167.0, 165.0, 166.0, 181.0, 226.0, 180.0, 166.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 86.0, 68.0, 67.0, 68.0, 67.0, 66.0, 68.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1444.6, "alertThreshold": 2.0}]} 20:55:06 INFO - Return code: 0 20:55:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:55:06 INFO - # TBPL SUCCESS # 20:55:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:55:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:55:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:55:06 INFO - 2017-01-02 20:55:06.990 screenresolution[1830:10422] starting screenresolution argv=screenresolution get 20:55:06 INFO - 2017-01-02 20:55:06.994 screenresolution[1830:10422] Display 0: 1600x1200x32@60 20:55:07 INFO - 2017-01-02 20:55:07.000 screenresolution[1831:10425] starting screenresolution argv=screenresolution list 20:55:07 INFO - Available Modes on Display 0 20:55:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:55:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:55:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:55:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:55:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:55:07 INFO - Intel Iris: 20:55:07 INFO - Chipset Model: Intel Iris 20:55:07 INFO - Type: GPU 20:55:07 INFO - Bus: Built-In 20:55:07 INFO - VRAM (Dynamic, Max): 1536 MB 20:55:07 INFO - Vendor: Intel (0x8086) 20:55:07 INFO - Device ID: 0x0a2e 20:55:07 INFO - Revision ID: 0x0009 20:55:07 INFO - Displays: 20:55:07 INFO - Display: 20:55:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:55:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:55:07 INFO - Display Serial Number: 1600x1200 60 20:55:07 INFO - Main Display: Yes 20:55:07 INFO - Mirror: Off 20:55:07 INFO - Online: Yes 20:55:07 INFO - Rotation: Supported 20:55:07 INFO - Return code: 0 20:55:07 INFO - Running post-action listener: _resource_record_post_action 20:55:07 INFO - [mozharness: 2017-01-03 04:55:07.246678Z] Finished run-tests step (success) 20:55:07 INFO - Running post-run listener: _resource_record_post_run 20:55:07 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31329280; Write bytes: 664484352; Read time: 190; Write time: 1999 20:55:07 INFO - TinderboxPrint: CPU usage
53.6% 20:55:07 INFO - TinderboxPrint: I/O read bytes / time
31,329,280 / 190 20:55:07 INFO - TinderboxPrint: I/O write bytes / time
664,484,352 / 1,999 20:55:07 INFO - TinderboxPrint: CPU idle
2,254.2 (46.4%) 20:55:07 INFO - TinderboxPrint: CPU system
972.4 (20.0%) 20:55:07 INFO - TinderboxPrint: CPU user
1,626.9 (33.5%) 20:55:07 INFO - TinderboxPrint: Swap in / out
376,131,584 / 0 20:55:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344695296; Write bytes: 347316736; Read time: 27289; Write time: 752 20:55:07 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29416448; Write bytes: 310298624; Read time: 174; Write time: 1220 20:55:07 INFO - Running post-run listener: _upload_blobber_files 20:55:07 INFO - Blob upload gear active. 20:55:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:07 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 20:55:07 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'] 20:55:07 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 20:55:08 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:09 INFO - (blobuploader) - INFO - Done attempting. 20:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:09 INFO - (blobuploader) - INFO - Done attempting. 20:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:12 INFO - (blobuploader) - INFO - Done attempting. 20:55:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:12 INFO - Return code: 0 20:55:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e409e282caf52e6fb5f866153ef3597f745cad43dd1580626b0f96da9422cd2cfd7d9ad23b5e38e9db41cef2899bed8450260a5672eb6d61327321dd0eca3a22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2245e6ec377a9c37319a844fe69b59a6f5f3d6fd2b5c6de0ee487ad972579f9faf78e1a5313ae00aacd0b9c89f2f2227c2e00e0fdac042288051f12d94f3cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b05af81c8ccb551f3c7b05a08d137ba18e7af7c26a95d33b9e179aef1017038a19d4ae7953f93a19073127b404840037499dc4dd5e487b85b1aad37af5eebd"} 20:55:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:12 INFO - Contents: 20:55:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e409e282caf52e6fb5f866153ef3597f745cad43dd1580626b0f96da9422cd2cfd7d9ad23b5e38e9db41cef2899bed8450260a5672eb6d61327321dd0eca3a22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2245e6ec377a9c37319a844fe69b59a6f5f3d6fd2b5c6de0ee487ad972579f9faf78e1a5313ae00aacd0b9c89f2f2227c2e00e0fdac042288051f12d94f3cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b05af81c8ccb551f3c7b05a08d137ba18e7af7c26a95d33b9e179aef1017038a19d4ae7953f93a19073127b404840037499dc4dd5e487b85b1aad37af5eebd"} 20:55:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:12 INFO - Copying logs to upload dir... 20:55:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.565125 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-02 20:55:12.176830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 20:55:12.180296) ========= 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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e409e282caf52e6fb5f866153ef3597f745cad43dd1580626b0f96da9422cd2cfd7d9ad23b5e38e9db41cef2899bed8450260a5672eb6d61327321dd0eca3a22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2245e6ec377a9c37319a844fe69b59a6f5f3d6fd2b5c6de0ee487ad972579f9faf78e1a5313ae00aacd0b9c89f2f2227c2e00e0fdac042288051f12d94f3cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b05af81c8ccb551f3c7b05a08d137ba18e7af7c26a95d33b9e179aef1017038a19d4ae7953f93a19073127b404840037499dc4dd5e487b85b1aad37af5eebd"} build_url:https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/SV04I-fNQ0i5npKW0Zz1Sg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e409e282caf52e6fb5f866153ef3597f745cad43dd1580626b0f96da9422cd2cfd7d9ad23b5e38e9db41cef2899bed8450260a5672eb6d61327321dd0eca3a22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2245e6ec377a9c37319a844fe69b59a6f5f3d6fd2b5c6de0ee487ad972579f9faf78e1a5313ae00aacd0b9c89f2f2227c2e00e0fdac042288051f12d94f3cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b05af81c8ccb551f3c7b05a08d137ba18e7af7c26a95d33b9e179aef1017038a19d4ae7953f93a19073127b404840037499dc4dd5e487b85b1aad37af5eebd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 20:55:12.223300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:55:12.223909) ========= 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.579Z0UJqJT/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.Vx5kjE14Mb/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005026 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:55:12.274884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 20:55:12.275238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 20:55:12.275617) ========= ========= Total master_lag: 0.19 =========