builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1475333206.76 results: success (0) buildid: 20161001055158 builduid: 7d5e9f4357884735804ad4fee81e7e24 revision: 344920af45b92da6d4f5b84738e1c7a3fb582461 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:46.765061) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:46.765724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:46.766217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:46.813666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:46.814023) ========= 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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-01 07:46:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-10-01 07:46:47 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.527749 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:47.368587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:47.369281) ========= 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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.029023 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:47.421259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 07:46:47.421998) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 344920af45b92da6d4f5b84738e1c7a3fb582461 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 344920af45b92da6d4f5b84738e1c7a3fb582461 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-01 07:46:47,494 truncating revision to first 12 chars 2016-10-01 07:46:47,494 Setting DEBUG logging. 2016-10-01 07:46:47,494 attempt 1/10 2016-10-01 07:46:47,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/344920af45b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 07:46:48,456 unpacking tar archive at: mozilla-central-344920af45b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.229893 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 07:46:48.678262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:48.678891) ========= script_repo_revision: 344920af45b92da6d4f5b84738e1c7a3fb582461 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:48.679850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:48.680547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 07:46:48.700389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-01 07:46:48.701059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:46:48 INFO - MultiFileLogger online at 20161001 07:46:48 in /builds/slave/test 07:46:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:46:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:48 INFO - {'append_to_log': False, 07:46:48 INFO - 'base_work_dir': '/builds/slave/test', 07:46:48 INFO - 'blob_upload_branch': 'Firefox', 07:46:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:48 INFO - 'branch': 'Firefox', 07:46:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:48 INFO - 'config_files': ('talos/mac_config.py',), 07:46:48 INFO - 'default_actions': ('clobber', 07:46:48 INFO - 'read-buildbot-config', 07:46:48 INFO - 'download-and-extract', 07:46:48 INFO - 'populate-webroot', 07:46:48 INFO - 'create-virtualenv', 07:46:48 INFO - 'install', 07:46:48 INFO - 'run-tests'), 07:46:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:48 INFO - 'download_minidump_stackwalk': True, 07:46:48 INFO - 'download_symbols': 'ondemand', 07:46:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:48 INFO - 'installer_path': 'installer.exe', 07:46:48 INFO - 'log_level': 'info', 07:46:48 INFO - 'log_name': 'talos', 07:46:48 INFO - 'log_to_console': True, 07:46:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:48 INFO - 'opt_config_files': (), 07:46:48 INFO - 'pip_index': False, 07:46:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'run_cmd_checks_enabled': True, 07:46:48 INFO - 'sps_profile': False, 07:46:48 INFO - 'sps_profile_interval': 0, 07:46:48 INFO - 'suite': 'dromaeojs-e10s', 07:46:48 INFO - 'system_bits': '32', 07:46:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:48 INFO - 'title': 't-yosemite-r7-0082', 07:46:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:48 INFO - 'use_talos_json': True, 07:46:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:48 INFO - 'work_dir': 'build'} 07:46:48 INFO - [mozharness: 2016-10-01 14:46:48.913297Z] Running clobber step. 07:46:48 INFO - Running pre-action listener: _resource_record_pre_action 07:46:48 INFO - Running main action method: clobber 07:46:48 INFO - rmtree: /builds/slave/test/build 07:46:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:50 INFO - Running post-action listener: _resource_record_post_action 07:46:50 INFO - [mozharness: 2016-10-01 14:46:50.990258Z] Finished clobber step (success) 07:46:50 INFO - [mozharness: 2016-10-01 14:46:50.990399Z] Running read-buildbot-config step. 07:46:50 INFO - Running pre-action listener: _resource_record_pre_action 07:46:50 INFO - Running main action method: read_buildbot_config 07:46:50 INFO - Using buildbot properties: 07:46:50 INFO - { 07:46:50 INFO - "project": "", 07:46:50 INFO - "product": "firefox", 07:46:50 INFO - "script_repo_revision": "production", 07:46:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:46:50 INFO - "repository": "", 07:46:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:46:50 INFO - "buildid": "20161001055158", 07:46:50 INFO - "pgo_build": "False", 07:46:50 INFO - "basedir": "/builds/slave/test", 07:46:50 INFO - "buildnumber": 304, 07:46:50 INFO - "slavename": "t-yosemite-r7-0082", 07:46:50 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:46:50 INFO - "platform": "yosemite_r7", 07:46:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:46:50 INFO - "branch": "mozilla-central", 07:46:50 INFO - "repo_path": "mozilla-central", 07:46:50 INFO - "revision": "344920af45b92da6d4f5b84738e1c7a3fb582461", 07:46:50 INFO - "stage_platform": "macosx64", 07:46:50 INFO - "builduid": "7d5e9f4357884735804ad4fee81e7e24", 07:46:50 INFO - "slavebuilddir": "test" 07:46:50 INFO - } 07:46:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 07:46:50 INFO - Running post-action listener: _resource_record_post_action 07:46:50 INFO - [mozharness: 2016-10-01 14:46:50.993709Z] Finished read-buildbot-config step (success) 07:46:50 INFO - [mozharness: 2016-10-01 14:46:50.993847Z] Running download-and-extract step. 07:46:50 INFO - Running pre-action listener: _resource_record_pre_action 07:46:50 INFO - Running main action method: download_and_extract 07:46:50 INFO - mkdir: /builds/slave/test/build/tests 07:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:50 INFO - trying https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:50 INFO - Downloading https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 07:46:52 INFO - Downloaded 1199 bytes. 07:46:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:52 INFO - Using the following test package requirements: 07:46:52 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 07:46:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 07:46:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'jsshell-mac.zip'], 07:46:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 07:46:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 07:46:52 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 07:46:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 07:46:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:52 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 07:46:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:46:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:46:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:52 INFO - Fetch https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:46:52 INFO - Http code: 200 07:46:52 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 07:46:52 INFO - x-amz-cf-id: QvTHEs4KmS-4Tfm0skUgdwh3hsnPq-WIdsTqpXdZJN12_KhLA8nkrw== 07:46:52 INFO - x-amz-version-id: OeObvMcYREXsQQ.8x8J16wdc1os4rTcY 07:46:53 INFO - Expected file size: 16475655 07:46:53 INFO - Obtained file size: 16475655 07:47:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:47:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:47:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:47:00 INFO - Fetch https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:47:00 INFO - Http code: 200 07:47:00 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 07:47:00 INFO - x-amz-cf-id: 7cn4njKxtdkXciOGwVkryOhokHAJsdlcwnkAj8Ok2TJ0KLcThWrEzQ== 07:47:00 INFO - x-amz-version-id: OeObvMcYREXsQQ.8x8J16wdc1os4rTcY 07:47:01 INFO - Expected file size: 16475655 07:47:01 INFO - Obtained file size: 16475655 07:47:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 07:47:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:47:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 07:47:08 INFO - Http code: 200 07:47:08 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 07:47:08 INFO - x-amz-cf-id: IVCdjyPBRK-6Z_rptWDhXbeVYjzXNbDi8G99u8nOKxqWT2Ztf4xeJw== 07:47:08 INFO - x-amz-version-id: iMmWgeyktfXjV5gfg3OKejs4QsG6JPH8 07:47:09 INFO - Expected file size: 14408522 07:47:09 INFO - Obtained file size: 14408522 07:47:09 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')]} 07:47:09 INFO - trying https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:09 INFO - Downloading https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 07:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 07:47:13 INFO - Downloaded 111827062 bytes. 07:47:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:13 INFO - mkdir: /builds/slave/test/properties 07:47:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:13 INFO - Contents: 07:47:13 INFO - build_url:https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:13 INFO - Running post-action listener: _resource_record_post_action 07:47:13 INFO - Running post-action listener: set_extra_try_arguments 07:47:13 INFO - [mozharness: 2016-10-01 14:47:13.845508Z] Finished download-and-extract step (success) 07:47:13 INFO - [mozharness: 2016-10-01 14:47:13.845644Z] Running populate-webroot step. 07:47:13 INFO - Running pre-action listener: _resource_record_pre_action 07:47:13 INFO - Running main action method: populate_webroot 07:47:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:13 INFO - '--tppagecycles', 07:47:13 INFO - '7'], 07:47:13 INFO - 'tests': ['tsvgm']}}, 07:47:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['damp', 'tps']}, 07:47:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'tests': ['damp', 'tps']}, 07:47:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['dromaeo_dom']}, 07:47:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['basic_compositor_video']}, 07:47:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['a11yr', 07:47:13 INFO - 'ts_paint', 07:47:13 INFO - 'tpaint', 07:47:13 INFO - 'sessionrestore', 07:47:13 INFO - 'sessionrestore_no_auto_restore', 07:47:13 INFO - 'tabpaint']}, 07:47:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['tsvgx', 07:47:13 INFO - 'tsvgr_opacity', 07:47:13 INFO - 'tart', 07:47:13 INFO - 'tscrollx', 07:47:13 INFO - 'cart']}, 07:47:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:13 INFO - 'tsvgr_opacity', 07:47:13 INFO - 'tart', 07:47:13 INFO - 'tscrollx', 07:47:13 INFO - 'cart']}, 07:47:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'talos_options': ['--disable-e10s'], 07:47:13 INFO - 'tests': ['tp5o']}, 07:47:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'tests': ['tp5o']}, 07:47:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'talos_options': ['--disable-e10s', 07:47:13 INFO - '--xperf_path', 07:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:13 INFO - 'tests': ['tp5n']}, 07:47:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:13 INFO - 'talos_options': ['--xperf_path', 07:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:13 INFO - 'tests': ['tp5n']}}, 07:47:13 INFO - 'talos.zip': {'path': '', 07:47:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:13 INFO - Running post-action listener: _resource_record_post_action 07:47:13 INFO - [mozharness: 2016-10-01 14:47:13.864185Z] Finished populate-webroot step (success) 07:47:13 INFO - [mozharness: 2016-10-01 14:47:13.864294Z] Running create-virtualenv step. 07:47:13 INFO - Running pre-action listener: _resource_record_pre_action 07:47:13 INFO - Running main action method: create_virtualenv 07:47:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:13 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 07:47:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:13 INFO - Using real prefix '/tools/python27' 07:47:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:17 INFO - Installing pip.................done. 07:47:17 INFO - Return code: 0 07:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:47:17 INFO - Reading from file tmpfile_stdout 07:47:17 INFO - Output received: 07:47:17 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) 07:47:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:17 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:17 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 07:47:17 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 07:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:17 INFO - 'HOME': '/Users/cltbld', 07:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:17 INFO - 'LOGNAME': 'cltbld', 07:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:17 INFO - 'MOZ_NO_REMOTE': '1', 07:47:17 INFO - 'NO_EM_RESTART': '1', 07:47:17 INFO - 'PAGER': '/bin/cat', 07:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:17 INFO - 'PWD': '/builds/slave/test', 07:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:17 INFO - 'SHELL': '/bin/bash', 07:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:17 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:17 INFO - 'USER': 'cltbld', 07:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:17 INFO - 'XPC_FLAGS': '0x0', 07:47:17 INFO - 'XPC_SERVICE_NAME': '0', 07:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:18 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 07:47:18 INFO - Cleaning up... 07:47:18 INFO - Return code: 0 07:47:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:18 INFO - 'HOME': '/Users/cltbld', 07:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:18 INFO - 'LOGNAME': 'cltbld', 07:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:18 INFO - 'MOZ_NO_REMOTE': '1', 07:47:18 INFO - 'NO_EM_RESTART': '1', 07:47:18 INFO - 'PAGER': '/bin/cat', 07:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:18 INFO - 'PWD': '/builds/slave/test', 07:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:18 INFO - 'SHELL': '/bin/bash', 07:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:18 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:18 INFO - 'USER': 'cltbld', 07:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:18 INFO - 'XPC_FLAGS': '0x0', 07:47:18 INFO - 'XPC_SERVICE_NAME': '0', 07:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:18 INFO - Downloading/unpacking psutil>=3.1.1 07:47:18 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 07:47:18 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 07:47:18 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 07:47:18 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 07:47:18 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 07:47:18 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 07:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:22 INFO - Installing collected packages: psutil 07:47:22 INFO - Running setup.py install for psutil 07:47:22 INFO - building 'psutil._psutil_osx' extension 07:47:22 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 07:47:22 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 07:47:22 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 07:47:22 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 07:47:23 INFO - building 'psutil._psutil_posix' extension 07:47:23 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 07:47:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:47:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:47:23 INFO - ^ 07:47:23 INFO - 1 warning generated. 07:47:23 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 07:47:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:23 INFO - Successfully installed psutil 07:47:23 INFO - Cleaning up... 07:47:23 INFO - Return code: 0 07:47:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:23 INFO - 'HOME': '/Users/cltbld', 07:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:23 INFO - 'LOGNAME': 'cltbld', 07:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:23 INFO - 'MOZ_NO_REMOTE': '1', 07:47:23 INFO - 'NO_EM_RESTART': '1', 07:47:23 INFO - 'PAGER': '/bin/cat', 07:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:23 INFO - 'PWD': '/builds/slave/test', 07:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:23 INFO - 'SHELL': '/bin/bash', 07:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:23 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:23 INFO - 'USER': 'cltbld', 07:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:23 INFO - 'XPC_FLAGS': '0x0', 07:47:23 INFO - 'XPC_SERVICE_NAME': '0', 07:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:23 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 07:47:23 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 07:47:23 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 07:47:23 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 07:47:23 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 07:47:23 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 07:47:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:26 INFO - Installing collected packages: mozsystemmonitor 07:47:26 INFO - Running setup.py install for mozsystemmonitor 07:47:26 INFO - Successfully installed mozsystemmonitor 07:47:26 INFO - Cleaning up... 07:47:26 INFO - Return code: 0 07:47:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:26 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')]} 07:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:26 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')]} 07:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:26 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:26 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 07:47:26 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 07:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:26 INFO - 'HOME': '/Users/cltbld', 07:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:26 INFO - 'LOGNAME': 'cltbld', 07:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:26 INFO - 'MOZ_NO_REMOTE': '1', 07:47:26 INFO - 'NO_EM_RESTART': '1', 07:47:26 INFO - 'PAGER': '/bin/cat', 07:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:26 INFO - 'PWD': '/builds/slave/test', 07:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:26 INFO - 'SHELL': '/bin/bash', 07:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:26 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:26 INFO - 'USER': 'cltbld', 07:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:26 INFO - 'XPC_FLAGS': '0x0', 07:47:26 INFO - 'XPC_SERVICE_NAME': '0', 07:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:26 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:29 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 07:47:29 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 07:47:29 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 07:47:29 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 07:47:29 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 07:47:29 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 07:47:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:29 INFO - warning: no files found matching '*.txt' 07:47:29 INFO - no previously-included directories found matching 'build' 07:47:29 INFO - no previously-included directories found matching 'dist' 07:47:29 INFO - no previously-included directories found matching '.git*' 07:47:29 INFO - Installing collected packages: jsonschema, functools32 07:47:29 INFO - Running setup.py install for functools32 07:47:29 INFO - warning: no files found matching '*.txt' 07:47:29 INFO - no previously-included directories found matching 'build' 07:47:29 INFO - no previously-included directories found matching 'dist' 07:47:29 INFO - no previously-included directories found matching '.git*' 07:47:29 INFO - Successfully installed jsonschema functools32 07:47:29 INFO - Cleaning up... 07:47:29 INFO - Return code: 0 07:47:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:29 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')]} 07:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:29 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')]} 07:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:29 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:29 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 07:47:29 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 07:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:29 INFO - 'HOME': '/Users/cltbld', 07:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:29 INFO - 'LOGNAME': 'cltbld', 07:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:29 INFO - 'MOZ_NO_REMOTE': '1', 07:47:29 INFO - 'NO_EM_RESTART': '1', 07:47:29 INFO - 'PAGER': '/bin/cat', 07:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:29 INFO - 'PWD': '/builds/slave/test', 07:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:29 INFO - 'SHELL': '/bin/bash', 07:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:29 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:29 INFO - 'USER': 'cltbld', 07:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:29 INFO - 'XPC_FLAGS': '0x0', 07:47:29 INFO - 'XPC_SERVICE_NAME': '0', 07:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:30 INFO - Cleaning up... 07:47:30 INFO - Return code: 0 07:47:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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', '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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:47: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 blobuploader==1.2.4 07:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:30 INFO - 'HOME': '/Users/cltbld', 07:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:30 INFO - 'LOGNAME': 'cltbld', 07:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:30 INFO - 'MOZ_NO_REMOTE': '1', 07:47:30 INFO - 'NO_EM_RESTART': '1', 07:47:30 INFO - 'PAGER': '/bin/cat', 07:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:30 INFO - 'PWD': '/builds/slave/test', 07:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:30 INFO - 'SHELL': '/bin/bash', 07:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:30 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:30 INFO - 'USER': 'cltbld', 07:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:30 INFO - 'XPC_FLAGS': '0x0', 07:47:30 INFO - 'XPC_SERVICE_NAME': '0', 07:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:32 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:32 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 07:47:32 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 07:47:32 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 07:47:32 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 07:47:32 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 07:47:32 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 07:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:33 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 07:47:33 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 07:47:33 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 07:47:33 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 07:47:33 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 07:47:33 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 07:47:33 INFO - Downloading docopt-0.6.1.tar.gz 07:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:34 INFO - Running setup.py install for blobuploader 07:47:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:34 INFO - Running setup.py install for requests 07:47:34 INFO - Running setup.py install for docopt 07:47:34 INFO - Successfully installed blobuploader requests docopt 07:47:34 INFO - Cleaning up... 07:47:35 INFO - Return code: 0 07:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:35 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')]} 07:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:35 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')]} 07:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:35 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:35 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 07:47:35 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 07:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:35 INFO - 'HOME': '/Users/cltbld', 07:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:35 INFO - 'LOGNAME': 'cltbld', 07:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:35 INFO - 'MOZ_NO_REMOTE': '1', 07:47:35 INFO - 'NO_EM_RESTART': '1', 07:47:35 INFO - 'PAGER': '/bin/cat', 07:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:35 INFO - 'PWD': '/builds/slave/test', 07:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:35 INFO - 'SHELL': '/bin/bash', 07:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:35 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:35 INFO - 'USER': 'cltbld', 07:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:35 INFO - 'XPC_FLAGS': '0x0', 07:47:35 INFO - 'XPC_SERVICE_NAME': '0', 07:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-drqE43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-aoocXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-nfSbbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wJPODz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eKIQPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-P_5DHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-HdWSOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ll9MMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-LeQt_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ngzDAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-plZl_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QhKuup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-if_8Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-HUCIwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qqtLzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-3CVEvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-52dyPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:37 INFO - Running setup.py install for manifestparser 07:47:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozcrash 07:47:37 INFO - Running setup.py install for mozdebug 07:47:37 INFO - Running setup.py install for mozdevice 07:47:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozfile 07:47:37 INFO - Running setup.py install for mozhttpd 07:47:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozinfo 07:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for mozInstall 07:47:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for mozleak 07:47:38 INFO - Running setup.py install for mozlog 07:47:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for moznetwork 07:47:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for mozprocess 07:47:38 INFO - Running setup.py install for mozprofile 07:47:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for mozrunner 07:47:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:39 INFO - Running setup.py install for mozscreenshot 07:47:39 INFO - Running setup.py install for moztest 07:47:39 INFO - Running setup.py install for mozversion 07:47:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:39 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')]} 07:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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')]} 07:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:39 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 07:47:39 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 07:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:39 INFO - 'HOME': '/Users/cltbld', 07:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:39 INFO - 'LOGNAME': 'cltbld', 07:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:39 INFO - 'MOZ_NO_REMOTE': '1', 07:47:39 INFO - 'NO_EM_RESTART': '1', 07:47:39 INFO - 'PAGER': '/bin/cat', 07:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:39 INFO - 'PWD': '/builds/slave/test', 07:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:39 INFO - 'SHELL': '/bin/bash', 07:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:39 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:39 INFO - 'USER': 'cltbld', 07:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:39 INFO - 'XPC_FLAGS': '0x0', 07:47:39 INFO - 'XPC_SERVICE_NAME': '0', 07:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yP_ecX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:39 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)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Lahhgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-pFfJCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Skp68b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-RR2QF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-2pehZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-rJnvnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Cur5Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-VOFgSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_lUepJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:40 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)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jZuUar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:41 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-tedVqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:41 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_im3Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:41 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-z4ZMNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-dy_XCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:41 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jWbgcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:41 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)) 07:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_nTXit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:41 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)) 07:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:41 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)) 07:47:41 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)) 07:47:41 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)) 07:47:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:44 INFO - Downloading blessings-1.6.tar.gz 07:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:44 INFO - Installing collected packages: blessings 07:47:44 INFO - Running setup.py install for blessings 07:47:44 INFO - Successfully installed blessings 07:47:44 INFO - Cleaning up... 07:47:44 INFO - Return code: 0 07:47:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:44 INFO - Reading from file tmpfile_stdout 07:47:44 INFO - Current package versions: 07:47:44 INFO - blessings == 1.6 07:47:44 INFO - blobuploader == 1.2.4 07:47:44 INFO - docopt == 0.6.1 07:47:44 INFO - functools32 == 3.2.3-2 07:47:44 INFO - jsonschema == 2.5.1 07:47:44 INFO - manifestparser == 1.1 07:47:44 INFO - mozInstall == 1.12 07:47:44 INFO - mozcrash == 0.17 07:47:44 INFO - mozdebug == 0.1 07:47:44 INFO - mozdevice == 0.48 07:47:44 INFO - mozfile == 1.2 07:47:44 INFO - mozhttpd == 0.7 07:47:44 INFO - mozinfo == 0.9 07:47:44 INFO - mozleak == 0.1 07:47:44 INFO - mozlog == 3.4 07:47:44 INFO - moznetwork == 0.27 07:47:44 INFO - mozprocess == 0.23 07:47:44 INFO - mozprofile == 0.28 07:47:44 INFO - mozrunner == 6.12 07:47:44 INFO - mozscreenshot == 0.1 07:47:44 INFO - mozsystemmonitor == 0.3 07:47:44 INFO - moztest == 0.7 07:47:44 INFO - mozversion == 1.4 07:47:44 INFO - psutil == 3.1.1 07:47:44 INFO - requests == 1.2.3 07:47:44 INFO - wsgiref == 0.1.2 07:47:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:44 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:44 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 07:47:44 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 07:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:44 INFO - 'HOME': '/Users/cltbld', 07:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:44 INFO - 'LOGNAME': 'cltbld', 07:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:44 INFO - 'MOZ_NO_REMOTE': '1', 07:47:44 INFO - 'NO_EM_RESTART': '1', 07:47:44 INFO - 'PAGER': '/bin/cat', 07:47:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:44 INFO - 'PWD': '/builds/slave/test', 07:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:44 INFO - 'SHELL': '/bin/bash', 07:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:44 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:44 INFO - 'USER': 'cltbld', 07:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:44 INFO - 'XPC_FLAGS': '0x0', 07:47:44 INFO - 'XPC_SERVICE_NAME': '0', 07:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 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)) 07:47:45 INFO - Cleaning up... 07:47:45 INFO - Return code: 0 07:47:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:45 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')]} 07:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:45 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')]} 07:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:45 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 0x10b514490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b48a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb345ebc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, '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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 07:47:45 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 07:47:45 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 07:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:45 INFO - 'HOME': '/Users/cltbld', 07:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:45 INFO - 'LOGNAME': 'cltbld', 07:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:45 INFO - 'MOZ_NO_REMOTE': '1', 07:47:45 INFO - 'NO_EM_RESTART': '1', 07:47:45 INFO - 'PAGER': '/bin/cat', 07:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:45 INFO - 'PWD': '/builds/slave/test', 07:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:45 INFO - 'SHELL': '/bin/bash', 07:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:47:45 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:45 INFO - 'USER': 'cltbld', 07:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:45 INFO - 'XPC_FLAGS': '0x0', 07:47:45 INFO - 'XPC_SERVICE_NAME': '0', 07:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:45 INFO - Cleaning up... 07:47:45 INFO - Return code: 0 07:47:45 INFO - Running post-action listener: _resource_record_post_action 07:47:45 INFO - Running post-action listener: _start_resource_monitoring 07:47:45 INFO - Starting resource monitoring. 07:47:45 INFO - [mozharness: 2016-10-01 14:47:45.358507Z] Finished create-virtualenv step (success) 07:47:45 INFO - [mozharness: 2016-10-01 14:47:45.359499Z] Running install step. 07:47:45 INFO - Running pre-action listener: _resource_record_pre_action 07:47:45 INFO - Running main action method: install 07:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:45 INFO - Reading from file tmpfile_stdout 07:47:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:45 INFO - Reading from file tmpfile_stdout 07:47:45 INFO - Output received: 07:47:45 INFO - Usage: mozinstall [options] installer 07:47:45 INFO - Options: 07:47:45 INFO - -h, --help show this help message and exit 07:47:45 INFO - -d DEST, --destination=DEST 07:47:45 INFO - Directory to install application into. [default: 07:47:45 INFO - "/builds/slave/test"] 07:47:45 INFO - --app=APP Application being installed. [default: firefox] 07:47:45 INFO - mkdir: /builds/slave/test/build/application 07:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:48:20 INFO - Reading from file tmpfile_stdout 07:48:20 INFO - Output received: 07:48:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:48:20 INFO - Running post-action listener: _resource_record_post_action 07:48:20 INFO - [mozharness: 2016-10-01 14:48:20.106042Z] Finished install step (success) 07:48:20 INFO - [mozharness: 2016-10-01 14:48:20.106233Z] Running run-tests step. 07:48:20 INFO - Running pre-action listener: _resource_record_pre_action 07:48:20 INFO - Running main action method: run_tests 07:48:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:20 INFO - 2016-10-01 07:48:20.120 screenresolution[1650:8805] starting screenresolution argv=screenresolution get 07:48:20 INFO - 2016-10-01 07:48:20.123 screenresolution[1650:8805] Display 0: 1600x1200x32@60 07:48:20 INFO - 2016-10-01 07:48:20.128 screenresolution[1651:8807] starting screenresolution argv=screenresolution list 07:48:20 INFO - Available Modes on Display 0 07:48:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:20 INFO - Intel Iris: 07:48:20 INFO - Chipset Model: Intel Iris 07:48:20 INFO - Type: GPU 07:48:20 INFO - Bus: Built-In 07:48:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:20 INFO - Vendor: Intel (0x8086) 07:48:20 INFO - Device ID: 0x0a2e 07:48:20 INFO - Revision ID: 0x0009 07:48:20 INFO - Displays: 07:48:20 INFO - Display: 07:48:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:20 INFO - Display Serial Number: 1600x1200 60 07:48:20 INFO - Main Display: Yes 07:48:20 INFO - Mirror: Off 07:48:20 INFO - Online: Yes 07:48:20 INFO - Rotation: Supported 07:48:20 INFO - Return code: 0 07:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:20 INFO - Python 2.7.3 07:48:20 INFO - Return code: 0 07:48:20 INFO - grabbing minidump binary from tooltool 07:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:20 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 0x10b328d30>, '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 0x10b14edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b320b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:20 INFO - Return code: 0 07:48:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:48:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:48:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRWgKzdZrH/Render', 07:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:20 INFO - 'HOME': '/Users/cltbld', 07:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:20 INFO - 'LOGNAME': 'cltbld', 07:48:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:20 INFO - 'MOZ_NO_REMOTE': '1', 07:48:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:20 INFO - 'NO_EM_RESTART': '1', 07:48:20 INFO - 'PAGER': '/bin/cat', 07:48:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:20 INFO - 'PWD': '/builds/slave/test', 07:48:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:20 INFO - 'SHELL': '/bin/bash', 07:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8xixvQ0rN/Listeners', 07:48:20 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 07:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:20 INFO - 'USER': 'cltbld', 07:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:20 INFO - 'XPC_FLAGS': '0x0', 07:48:20 INFO - 'XPC_SERVICE_NAME': '0', 07:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:48:20 INFO - mozversion application_buildid: 20161001055158 07:48:20 INFO - mozversion application_changeset: 344920af45b92da6d4f5b84738e1c7a3fb582461 07:48:20 INFO - mozversion application_display_name: Nightly 07:48:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:20 INFO - mozversion application_name: Firefox 07:48:20 INFO - mozversion application_remotingname: firefox 07:48:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:48:20 INFO - mozversion application_vendor: Mozilla 07:48:20 INFO - mozversion application_version: 52.0a1 07:48:20 INFO - mozversion platform_buildid: 20161001055158 07:48:20 INFO - mozversion platform_changeset: 344920af45b92da6d4f5b84738e1c7a3fb582461 07:48:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:48:20 INFO - mozversion platform_version: 52.0a1 07:48:20 INFO - using testdate: 1475333300 07:48:20 INFO - actual date: 1475333300 07:48:20 INFO - starting webserver on 'localhost:49276' 07:48:20 INFO - SUITE-START | Running 2 tests 07:48:20 INFO - TEST-START | dromaeo_css 07:48:20 INFO - operating with platform_type : mac_ 07:48:20 INFO - Initialising browser for dromaeo_css test... 07:48:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpW4WIQY/profile http://localhost:49276/getInfo.html) 07:48:23 INFO - PROCESS | 1661 | 2016-10-01 07:48:23.470 plugin-container[1664:8984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 07:48:23 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:23 INFO - PROCESS | 1661 | 2016-10-01 07:48:23.473 plugin-container[1664:8984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9113, name = 'com.apple.CFPasteboardClient' 07:48:23 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:23 INFO - PROCESS | 1661 | 2016-10-01 07:48:23.473 plugin-container[1664:8984] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:23 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 07:48:23 INFO - PROCESS | 1661 | colorDepth:24 07:48:23 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 07:48:23 INFO - PROCESS | 1661 | __metrics 07:48:23 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 07:48:24 INFO - TEST-INFO | 1661: exit 0 07:48:24 INFO - Browser initialized. 07:48:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:24 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpW4WIQY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:26 INFO - PROCESS | 1665 | 2016-10-01 07:48:26.804 plugin-container[1666:9102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 07:48:26 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:26 INFO - PROCESS | 1665 | 2016-10-01 07:48:26.807 plugin-container[1666:9102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 07:48:26 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:26 INFO - PROCESS | 1665 | 2016-10-01 07:48:26.807 plugin-container[1666:9102] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:36 INFO - PROCESS | 1665 | RSS: Main: 240193536 07:48:36 INFO - PROCESS | 1665 | 07:49:26 INFO - PROCESS | 1665 | 1475333366163 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] 07:51:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:51:40 INFO - PROCESS | 1665 | RSS: Main: 251813888 07:51:40 INFO - PROCESS | 1665 | 07:54:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 07:54:43 INFO - PROCESS | 1665 | RSS: Main: 265781248 07:54:43 INFO - PROCESS | 1665 | 07:57:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 07:57:46 INFO - PROCESS | 1665 | RSS: Main: 270372864 07:57:46 INFO - PROCESS | 1665 | 08:00:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:00:48 INFO - PROCESS | 1665 | RSS: Main: 270180352 08:00:48 INFO - PROCESS | 1665 | 08:03:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:03:52 INFO - PROCESS | 1665 | RSS: Main: 275574784 08:03:52 INFO - PROCESS | 1665 | 08:06:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:06:55 INFO - PROCESS | 1665 | RSS: Main: 278339584 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | __start_tp_report 08:06:55 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 08:06:55 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 08:06:55 INFO - PROCESS | 1665 | |i|pagename|runs| 08:06:55 INFO - PROCESS | 1665 | |0;dojo.html;3276.6231883333426;3287.7698561100724;3305.917352066198;3338.449155889277;3344.398008358495;5309.5752339812725;5442.972785136074;5469.453054694533;5493.972530137354;5506.229127922089;5345.49217824307;5551.916721249175;5581.274434323543;5640.407757185498;5696.08862581987;4339.871633375314;5042.773075211615;5070.569001634865;5112.948870511303;5271.393789714174;3816.751911125782;3943.9014024649327;4248.575142485742;5112.182050871861;5147.510986456281;5050.444451110357;5072.568831649314;5074.746262686851;5147.996140752554;5158.638895277332;5156.071907056728;5159.019786240602;5160.277561141444;5171.250168725552;5236.083685355085;5093.617978651579;5139.229115632647;5151.974240128813;5167.354080739908;5204.817831375922;5421.159720243369;5467.20725494805;5531.751071201806;5551.694656793875;5555.388907220203;6136.519078024463;6164.938350616526;6193.969030154821;6196.380361963767;6225.066240063981;6154.199954005995;6216.844578885519;6254.812355629293;6265.060240963846;6270.717817698214;5615.354234263031;5660.462256085665;5690.658560486384;5692.260006199251;5834.387389324144;5288.444713305047;6151.6001459904965;6230;6231.813045608639;6280.623162610258;6049.425304596057;6061.575689701678;6065.787697430569;6074.817755467343;6110.052941793941;5975.43233392827;6027.78902738402;6217.285012223561;6231.158793562901;6244.46922011625;6040.577159598874;6076.939230607637;6107.633541987495;6107.977837958671;6189.164462797555;5493.121100623961;6170;6171.166892469549;6188.690565471708;6189.288231853395;4712.057588482248;4731;4761.761911904391;4816.927746083811;4838.927416088762;4299.398084268205;4312.137572485515;4366.956330436718;4368.2355587772645;4404.581564751344;5720.513756330759;5777.7977770777825;5806.129080637938;5832.650040997553;5842.883142337129;6027.367126451747;6089.177960975212;6207.782727604512;6229.813105606839;6284.717187726564;5583.078791999355;5767.567432442584;5772.220750198753;5775.624584402;5822.563307751935;5313.388960269618;5323.733813309319;5323.893522129613;5343.839684809384;5351.224072509464;6184.474319682878;6232.688365581612;6238.6880655967925;6251.062340648939;6253.937460625427;6134.8159555213415;6142.621558143092;6157.922363586444;6190.195274614452;6269.749210031548;6236.282827474898;6239.469645080219;6240.063990401476;6267.091271765477;6270.874582508415;6047.334793172836;6085.604435711664;6141.201643786279;6146.6004709693725;6177.413145751147;6068.180795592715;6107.643995706967;6114.206128133634;6141.539384546266;6169.722362493789;5129.512696293846;5405.999890020359;6059.242594675666;6079.270487541523;6114.938850611437;6034.336223015553;6040.275166979991;6046.606970546901;6058.363871793575;6098.237720284965;4808.663393562417;5562.97085039269;5702.657840529581;5806.912896306474;5879.353271140086;6019.307779605227;6036.486898613667;6047.727852246748;6053.061775424816;6099.603525770811;5736.913946290725;5872.354041055395;5877.147813567094;5908.881822363614;5922.052471604523 08:06:55 INFO - PROCESS | 1665 | |1;ext.html;459.7195710616525;508.31631455692093;517.0150862606736;529.838399288217;537.4356925228511;38294.617053829454;40392.394114088274;40498.39252411216;40615.39076913849;43189.35215971755;41587.96030099249;41951.370729439004;41971.580284197145;42021;42081.579184208145;7648.885266720976;9751.804963900719;9913;9946.701598952006;9970.551325190347;9240;9698.272629552777;9764.707058788248;9779.266555008368;9780.462074585896;8976.371653984224;9799.216062714966;9803.31376803624;9804.31369804114;9852.950735246313;9657.420554766737;9725.95137024314;9784.461854597994;9789.951050244774;9790.363626364335;9678.70963871078;9697.757556061155;9774;9784.412935223909;9811.313208075437;39942.001449963696;40024;40226;40382;40451;3366.8148251846137;3369.3261347730554;3415.282790613974;3570.1431656402538;3770.773753574767;30487.542686859713;30621.69378306233;30882;31030.827842051065;31698;3214.067920303109;3218.855151518164;3230.8223047732367;3261.5107733839877;3359.7144242739396;467279.6636016832;467947;474434.99999999657;475925;479325;58203;58383.70808145932;58469.830603388546;58488.707556462796;58631;61329.38670613237;61429;61623.691881540304;61936.380636193964;62017.75964480775;15978.920105399398;16096.517104486884;16181.757273640906;16214.75677864833;16239.756403653955;12422.937885310695;12489.812652810215;12496.625101246977;12512.49950002008;12550.74898502025;16180;16467.505974820775;16512.25694843711;16513.33946642145;16552.91723541399;6654.63940709948;6734.259231484532;6773.866232136861;6773.8983915241315;6821.69302381394;853.2534032721369;913.3469569258012;965.666844938495;1004.9145822605014;1047.7223535763028;23369.7663023371;24478;25986.610200847;26227.475450491263;28790.992315268864;932.440535678601;1011.3577878047346;1077.42357838556;1141.4406940599213;1146.7935771561033;15435.536933892;15609.3756249751;15644.296006679726;15989.760153597705;16069.196540172945;633408;633766;636217;638391;638504;56138.43861561332;56486.43513564812;56872.715636421555;56943.430565693816;56967.71516142393;1293.5407930184838;1344.8050032745393;1371.636516323175;1374.4502199120232;1388.4168649167375;28861;29627;29755.404891902475;30117.548236776027;30146;41195.58804411918;49836.75081624569;49906;49928.251076234614;49991.25013124733;550947;555519.6688198721;555800;557010;558435;32812.67187328191;38647.6135238644;38840.22319553536;39077.41383879187;39932;45600.08799824051;46393.76803115963;47082.529174707815;47175;47893.5210647889;38674.80662596669;38830.805845970586;38843;39947;40180.598194017686;34172.31655366829;38248.235035299695;38616.806915966365;39732;39857.60142398539;37269.4409583851;37496;37753.62246377501;38377.6162238374;38677.80661096676;30067.398652027274;34263;34553.30893382169;34723.82638086793;34796.47805282872;20113.899430502755;23321.650175247047;25265.368365791;25578.23265302044;25612.61581076248 08:06:55 INFO - PROCESS | 1665 | |2;jquery.html;356.0937414280655;369.4753450100857;372.18120135701446;375.50808440942353;396.1285172620236;19258;19937.903415312154;20148.39554813358;20674.89662551687;20872;19600.901995490003;19813.801861981377;19859.801401985977;19927.20291188351;20227.393178204642;4576.588107070363;5238.397584277809;5519.254900588429;5528.253685752412;6168.074788781696;3811.7331786774935;4038.09142942837;5776.653400795944;5913.970430147843;6075.878482430348;6071.119687645289;6111.602745821529;6122.020476723725;6122.387761223864;6146.139540464339;6215.098810672473;6677.764613546509;6707.496937729641;6712.765053223138;6723.159605049369;5639.928413601403;5765.625234359795;5803.854903627401;5919.733611987428;5951.22634057574;18192.27230910762;20057.699134512994;20785.480362990897;24465.87767061153;25192.874035629888;2236.6197746383154;2246.2362796649218;2325.8837058147024;2339.5203983183405;2362.444825466014;10136.341137826017;10287.639932602398;10392.220583456196;11721.472533735918;15357.462488812838;1630.7524743571178;1825.525363405511;1838.899647054726;1869.7008478643488;1879.9906000470046;105034.47482762614;107889.38165927517;111145;111449;114067;11232.775344493064;11336.376499292619;11557.422128893522;11580.36308003068;11704.946554810109;14417.13497190172;14431.567052988426;14446.927765361106;14450.783238251435;14483.203423811581;8299.917000830035;8433.451825631315;8471.576421178916;8482.151784821468;8554.61504232311;8335.416520843604;8347.916520834835;8353.16468353172;8454.1123182065;8525.40322177454;4507.706999045052;4521.344405061248;4526.253168227206;4555.521670224645;4664.510226426244;1268.7335659511607;1651.587103224194;1668.1409074326732;1892.7823300320365;1964.0768838645813;785.4580339565681;793.8412317536515;818.7216346442119;873.785922449004;1034.1674951663983;16115.19424028794;20851.58296834055;21676.45808854791;21886.562268754536;22136.889315553643;774.3998401239085;911.4713466189594;914.5381582301028;923.0630909626734;962.8988956159642;11016.567846179945;11388.886111138949;11479.426028698532;11488.310701357945;11563.132765042656;522781;533151;570007;591174;597130;126239;134121;134495;141819;145027;427.3952357414286;441.6290316134463;447.38484583697414;452.0281395000709;452.086784694921;9359.625614975324;10797.946010269898;11115.22193446451;11332.660020199408;11524.481398337262;52717;54272.45727542832;54647.45352546424;55170;56224.71887640536;64066.67966660137;77743;79774.60112699399;80802;84202.57898710467;8109.351251899951;8159.34725221969;8216.671333146607;8286.254237118446;8459;9678.661246856327;11967.31026857953;12475.376231188586;12589.559365422532;13120.540781072617;9763.951180244054;9831.508424578886;11296.322220666787;11531.538738450368;11633.975166456952;10722.51748671296;11192.272502287326;11225.49485273181;11275.830862536905;11334.886651133713;11348;11632.825507617561;11817.586384476503;11868.643940681794;11996.160268781101;7777.105632852295;8145.959270203611;8265;8438.704645337384;8498;6739.46084313244;7706.3449606781805;7842.803929901798;7855.253750893656;8134.959325203336 08:06:55 INFO - PROCESS | 1665 | |3;mootools.html;1501.1293449799118;1534.294224656658;1741.6603762266354;1836.2746715047565;1853.5180852978212;7053.329933656307;7474.925250747491;7503.624818759061;8000.599970001491;8227.300679442254;7579.507332023414;8484.066752657218;8764.03595604483;8792.736217913456;8803.251723603502;2330.347502699243;2367.029517897662;2370.300761275419;2370.6799582056374;2376.4415362389823;1855.4804654696638;1931.3529967460847;2009.437357539891;2381.368937231635;2382.927682542854;2362.633791762271;2368.83418160728;2376.3227480168157;2377.9048838046456;2379.7382287948312;2352.4824538601565;2357.905683772647;2362.1968530699473;2377.2392834292946;2377.465070359173;1938.5444420561157;2337.649352597107;2338.1348900906773;2345.6598793174894;2360.3980984848927;7538.623068846536;8901.332400069956;8943.821123577558;8948.194662480408;8968.68609598661;5187.610929180289;5448.4279150689;5451.100568406208;5456.809011684572;5457.617966742329;3115.517094850302;3551.449525323579;3608.6307715489907;3739.719521035933;3742;1061.4533515239657;1087.276960821053;1088.4013792414219;1101.553870682375;1112.7718817642365;11658.125640576991;11675.649730508097;11709.297442153413;11795.29228246308;11800.291982480992;4580.564846339593;4727.17274476972;4832.806687732522;4845.466998630148;4849.151398505247;10041.598336066621;10084.49577521121;10125.696229112991;10125.797484050277;10130.696079117639;5376.462353764592;5377.381601115843;5378.085725426687;5387.892242155135;5389.51494365509;4226.682998775104;4527.977360113178;4855.8057677692495;4906.975465122723;4912.336834527293;3932.9213415731524;3946.1515774108702;3946.3291240489184;4046.291898917678;4109.753414795122;1283.8395200599925;1287.3884904670206;1292.702678383977;1294.3981048812348;1305.9151155174884;807.8303556253135;887.9955600221957;913.1507697840939;925.0354448200984;940.6707652321633;4979.228219625964;5781.161731548902;5884.617499862581;6005.219321488178;6127;422.5478737750577;433.34132119179304;437.5864807756703;437.73298288044265;442.2768773056076;3609.909752256162;3811.6188381162215;3997.700172487075;4097.44684467599;4124.91750164995;10458.738531536772;10949.56201751921;10949.781004379867;10968.957948994832;10994.670159895217;10800.1899857511;10807.189460790472;10900.563977440814;10920.672379828618;10924.399158046224;8050.798730031796;8110.472819266729;8288.21261980111;8324.250817426582;8336;5791.652500849794;5827.825165245049;5884.941150588439;5954.851128721643;6023.849403764941;10074.244431667801;10089.041541053588;10141.847872281774;10143.847842282225;10181.84727229107;9360.595910613463;9984.301098923006;10310.587576496857;10400.791984160425;10435.269531132748;6940.236573976959;7168.53404528704;7314.341709246193;7583.924160758543;7634.160242373446;8138.064122625974;8395.328373729964;8406.201410865959;8414.158584141536;8416.200460956445;6674.899876501953;6990.671772363235;7413.221611730906;7486.251374862471;7655.425843061904;5639.8590035249445;6551.574147680385;7404.629768511661;7456.291652293024;7457.440691948017;6872.69072891711;6956.513044087068;7025.192102908231;7045.823854403476;7070;4273.850415235452;4396.384506169203;5053.84838454847;5101.260317253903;5141.305923700253;4941.357623508921;5042.773075211698;5067.670601410897;5114.232865070269;5159.355080614923 08:06:55 INFO - PROCESS | 1665 | |4;prototype.html;275.0538148768238;294.9056301983366;294.9498585240509;309.45844771649604;311.2266018942926;4764.856434455732;5045.621578381622;5064.468230835764;5316.5215130638235;5344.732763361831;5091;5221.112410890149;5344.331958505187;5398.757055932482;5440.238366628665;3927.70542209334;4093.8157782899693;4101.302778527657;4110.198511290299;4113.465249517559;3593.975716920678;3774.188549461865;4034.8184331704997;4108.794560271975;4117.732347397425;3996.8808733554506;4037.4953130858644;4038.8287396654937;4042.757434553936;4084.7957602119923;3456.6888979991795;3977.34373828318;4022.4368588397647;4045.231406032859;4062.1672557125717;2904.2158617173454;3512.929741405183;3536.6286539913453;3547.130952916526;3562.8574857005688;4030.694830239205;4822.71063736177;5189.532942035197;5195.766190521398;5244.79020839166;3635.381985062546;3783.9243215135816;4051.0682543015273;4658.161530924433;4658.930116048262;4940.777665005084;5610.382857885629;5693.092813907346;5713.885722285531;5726.226959360475;3201.583794106751;3363.562736844219;3392.506507716826;3397;3666.303402353571;5898.375223025755;5934.287885453773;5943.257092863392;5961.612495187842;6044.576879618385;3268.362669279468;3695.909706636549;3899.941500877489;3927.9018024549614;3939.5075615548058;3805.562360328542;3856.9971807329734;3923.489946306962;3939.330313846653;3979.9204015919518;3743.8689645862264;3761.5110035695184;4180.24755544005;4603.608693261111;4614.523352527226;4758.690685105457;5558.74928141165;5574.996500629844;5663.830085097371;5695.345035320908;1253.11029169289;1294.5274974634378;1307.1895424836662;1338.464614154346;1341.3293353323338;743.7471259771595;887.2547060469237;904.8461761500561;911.2527727263713;914.8381555424706;4092.7871620777546;4773.403324584427;5347.3583170019065;5376.731163441812;5376.903007826951;5782.190493330937;5784.3926387729525;5786.71066446676;5801.3038435388025;5815.389384114692;4663.650226233046;4991.825286115041;5339.83736586683;5346.021971870433;5346.518813306821;2343.8945247463903;2456.035171862503;2523.753859065433;2591.714911359749;2640.8811603477507;4248.877075349616;4597.448306203277;4608.9308660370125;4877.731724755173;4962.503749625009;4328.913421731548;4481.767513933629;4507.076049409863;4517.977410112929;5014.7994080236385;4398.670099742468;4459.910801783946;4506.81972721094;4616.376789133424;5109.033022286447;4622.815087396467;4658.930116048195;4850.587700045536;4882.2432522959;4893.119238537098;4353.477582690098;4483.686141970031;4566.443834769489;4822.577339684732;4839.935214252859;4592.127495775792;4823.781060712112;4886.706797592014;5108.489151084862;5141.640085194001;2977.2556860784803;3156.6527681955426;3248.3340915112817;3426.3147370525494;3428.400029994691;4400.933985990277;4469.329600559812;4798.280257961194;4812.8796780080775;5612.214289999485;4113.588641135862;5641.182028605911;5653.915191272216;5682.772689092555;5718.456746609232;4923.187674033744;5395.843431592562;5618.6628802272;5629.971850140723;5659.943400566106;4368.9126217476105;5215.982883337864;5442.156465747816;5535.25274087993;5570.387257401601;5610.85972850682;5612.915806262828;5671.972899241585;5673.60295770781;5708.54331653475;4725.385699858996;4940.308356830118;5494.9725251375085;5539.534906966362;5591.412901645269 08:06:55 INFO - PROCESS | 1665 | |5;yui.html;704.1585305559855;707.4340527577938;765.1850778920449;771.9150893401728;791.386675326622;13763.724725505497;15311.923440382796;16067.437639682614;16077;16086.919565402186;12609.558665446712;13752.555981621936;14395;14479.420823167087;14511.419543218259;615.4460985113411;670.2593634034395;830.2818062376032;834.7620928035511;853.6500034985658;842.806154584446;864.9091845356241;865.8398196333667;865.904750477447;866.3762091294258;932.9673461428852;937.2501998401286;941.0025373104497;942.9245660347156;943.0663642993455;935.2144198872945;935.9719208423758;936.6534382278533;938.6949241496507;940.5814412586402;685.0990946904805;689.6379400814562;692.8337199072237;694.3299715774302;694.7325279767275;15406.306716197798;15507.457238996582;15522.223888805514;15592.688146237126;15619.531414057596;14460.638484037878;14497.710045799025;14505.129692218396;14532;14549.78175327371;11720.238184518064;11888.762224755457;11979.760404791943;11988.580399685969;12044.939775301154;3757.1170774867883;3790.431435284702;3824.9808750956345;3842.3275926712713;3941.9211615767813;105721.47139264332;105923.99999999923;106080.46959765229;106226.46886765517;106489.93510064877;10823.891761082446;10936.617218397318;11071.040755536587;11102.2783519071;11557.653270401901;22836.543269134523;22846;22848.65727014096;22860.4284892879;22873.771262287497;7905.288524032865;8059.1134975153855;8179.4274400792565;8246.340292776564;8268.586570671443;4340.545981880331;4428.33574963758;4476.597106260452;4492.3710680504755;4557.1797076526545;3514.10390350459;3594.370985077601;3615.204654975954;3638.0541059324764;3638.690711289517;566.3430420712036;642.4121928435522;642.4635429416489;644.3717375558792;671.8253254153857;575.186111652016;627.7300760672863;629.8488362792897;647.7877158054282;653.8234676637281;8973.641054357882;9326.626934922662;9398.765030874283;9429.387089839138;9493.0981556752;599.9130126131773;649.6394501051867;663.177659701966;667.2893368562466;669.563785679724;4495.2582823834355;4628.83799067031;4632.119897219518;5138.486151384832;5142.794288228429;105541;131335.02997455045;152827.35863206795;155459.44540554675;157020;125268.37365813112;127271;130112;131334.37331253322;133672;117469.4126529379;120127;121579.3921030407;122749;126351;8302.00688187435;9965.152961998312;10096.34373765703;10107.241956853119;10141.29010969225;51830.96338073293;54679.08623198169;58166;58198;63184.05223921553;69319.96020059602;70687.64656176686;71833;88455;92960.14079718503;10953.945230273797;13037.543685970946;13372.665683357995;13664.93167534156;13970.650733731738;14591;14741.631459213177;14920.701585968436;15478.071315721092;15550.533483995498;13035.543755968496;13488.93255533716;13545.932270338586;13593.79609305881;14258.001939864525;11518;13591.388387522784;13851.86148138546;14035.438582456587;14087.859121408655;13190.406431710404;13673.726525469634;13683.657908552366;14080.788788168391;14171.291435427982;11309.71725706831;11319.434028298718;11324.6036388726;11352.432378380883;11840.335924416937;8961.820763584823;10421.583136674448;10647.463319073884;11358.54565817358;11718.355490448108 08:06:55 INFO - PROCESS | 1665 | __end_tp_report 08:06:55 INFO - PROCESS | 1665 | __start_cc_report 08:06:55 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,352 08:06:55 INFO - PROCESS | 1665 | __end_cc_report 08:06:55 INFO - PROCESS | 1665 | __startTimestamp1475334415005__endTimestamp 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | ------- Summary: start ------- 08:06:55 INFO - PROCESS | 1665 | Number of tests: 6 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5622.02 Median:5834.39 stddev:686.65 (11.8%) stddev-sans-first:663.64 08:06:55 INFO - PROCESS | 1665 | Values: 3276.6 3287.8 3305.9 3338.4 3344.4 5309.6 5443.0 5469.5 5494.0 5506.2 5345.5 5551.9 5581.3 5640.4 5696.1 4339.9 5042.8 5070.6 5112.9 5271.4 3816.8 3943.9 4248.6 5112.2 5147.5 5050.4 5072.6 5074.7 5148.0 5158.6 5156.1 5159.0 5160.3 5171.3 5236.1 5093.6 5139.2 5152.0 5167.4 5204.8 5421.2 5467.2 5531.8 5551.7 5555.4 6136.5 6164.9 6194.0 6196.4 6225.1 6154.2 6216.8 6254.8 6265.1 6270.7 5615.4 5660.5 5690.7 5692.3 5834.4 5288.4 6151.6 6230.0 6231.8 6280.6 6049.4 6061.6 6065.8 6074.8 6110.1 5975.4 6027.8 6217.3 6231.2 6244.5 6040.6 6076.9 6107.6 6108.0 6189.2 5493.1 6170.0 6171.2 6188.7 6189.3 4712.1 4731.0 4761.8 4816.9 4838.9 4299.4 4312.1 4367.0 4368.2 4404.6 5720.5 5777.8 5806.1 5832.7 5842.9 6027.4 6089.2 6207.8 6229.8 6284.7 5583.1 5767.6 5772.2 5775.6 5822.6 5313.4 5323.7 5323.9 5343.8 5351.2 6184.5 6232.7 6238.7 6251.1 6253.9 6134.8 6142.6 6157.9 6190.2 6269.7 6236.3 6239.5 6240.1 6267.1 6270.9 6047.3 6085.6 6141.2 6146.6 6177.4 6068.2 6107.6 6114.2 6141.5 6169.7 5129.5 5406.0 6059.2 6079.3 6114.9 6034.3 6040.3 6046.6 6058.4 6098.2 4808.7 5563.0 5702.7 5806.9 5879.4 6019.3 6036.5 6047.7 6053.1 6099.6 5736.9 5872.4 5877.1 5908.9 5922.1 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:68967.57 Median:40387.20 stddev:149231.46 (369.5%) stddev-sans-first:149561.45 08:06:55 INFO - PROCESS | 1665 | Values: 459.7 508.3 517.0 529.8 537.4 38294.6 40392.4 40498.4 40615.4 43189.4 41588.0 41951.4 41971.6 42021.0 42081.6 7648.9 9751.8 9913.0 9946.7 9970.6 9240.0 9698.3 9764.7 9779.3 9780.5 8976.4 9799.2 9803.3 9804.3 9853.0 9657.4 9726.0 9784.5 9790.0 9790.4 9678.7 9697.8 9774.0 9784.4 9811.3 39942.0 40024.0 40226.0 40382.0 40451.0 3366.8 3369.3 3415.3 3570.1 3770.8 30487.5 30621.7 30882.0 31030.8 31698.0 3214.1 3218.9 3230.8 3261.5 3359.7 467279.7 467947.0 474435.0 475925.0 479325.0 58203.0 58383.7 58469.8 58488.7 58631.0 61329.4 61429.0 61623.7 61936.4 62017.8 15978.9 16096.5 16181.8 16214.8 16239.8 12422.9 12489.8 12496.6 12512.5 12550.7 16180.0 16467.5 16512.3 16513.3 16552.9 6654.6 6734.3 6773.9 6773.9 6821.7 853.3 913.3 965.7 1004.9 1047.7 23369.8 24478.0 25986.6 26227.5 28791.0 932.4 1011.4 1077.4 1141.4 1146.8 15435.5 15609.4 15644.3 15989.8 16069.2 633408.0 633766.0 636217.0 638391.0 638504.0 56138.4 56486.4 56872.7 56943.4 56967.7 1293.5 1344.8 1371.6 1374.5 1388.4 28861.0 29627.0 29755.4 30117.5 30146.0 41195.6 49836.8 49906.0 49928.3 49991.3 550947.0 555519.7 555800.0 557010.0 558435.0 32812.7 38647.6 38840.2 39077.4 39932.0 45600.1 46393.8 47082.5 47175.0 47893.5 38674.8 38830.8 38843.0 39947.0 40180.6 34172.3 38248.2 38616.8 39732.0 39857.6 37269.4 37496.0 37753.6 38377.6 38677.8 30067.4 34263.0 34553.3 34723.8 34796.5 20113.9 23321.7 25265.4 25578.2 25612.6 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:33659.02 Median:2093.62 stddev:94566.23 (4516.9%) stddev-sans-first:94798.45 08:06:55 INFO - PROCESS | 1665 | Values: 356.1 369.5 372.2 375.5 396.1 19258.0 19937.9 20148.4 20674.9 20872.0 19600.9 19813.8 19859.8 19927.2 20227.4 4576.6 5238.4 5519.3 5528.3 6168.1 3811.7 4038.1 5776.7 5914.0 6075.9 6071.1 6111.6 6122.0 6122.4 6146.1 6215.1 6677.8 6707.5 6712.8 6723.2 5639.9 5765.6 5803.9 5919.7 5951.2 18192.3 20057.7 20785.5 24465.9 25192.9 2236.6 2246.2 2325.9 2339.5 2362.4 10136.3 10287.6 10392.2 11721.5 15357.5 1630.8 1825.5 1838.9 1869.7 1880.0 105034.5 107889.4 111145.0 111449.0 114067.0 11232.8 11336.4 11557.4 11580.4 11704.9 14417.1 14431.6 14446.9 14450.8 14483.2 8299.9 8433.5 8471.6 8482.2 8554.6 8335.4 8347.9 8353.2 8454.1 8525.4 4507.7 4521.3 4526.3 4555.5 4664.5 1268.7 1651.6 1668.1 1892.8 1964.1 785.5 793.8 818.7 873.8 1034.2 16115.2 20851.6 21676.5 21886.6 22136.9 774.4 911.5 914.5 923.1 962.9 11016.6 11388.9 11479.4 11488.3 11563.1 522781.0 533151.0 570007.0 591174.0 597130.0 126239.0 134121.0 134495.0 141819.0 145027.0 427.4 441.6 447.4 452.0 452.1 9359.6 10797.9 11115.2 11332.7 11524.5 52717.0 54272.5 54647.5 55170.0 56224.7 64066.7 77743.0 79774.6 80802.0 84202.6 8109.4 8159.3 8216.7 8286.3 8459.0 9678.7 11967.3 12475.4 12589.6 13120.5 9764.0 9831.5 11296.3 11531.5 11634.0 10722.5 11192.3 11225.5 11275.8 11334.9 11348.0 11632.8 11817.6 11868.6 11996.2 7777.1 8146.0 8265.0 8438.7 8498.0 6739.5 7706.3 7842.8 7855.3 8135.0 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5659.32 Median:2485.13 stddev:3222.23 (129.7%) stddev-sans-first:3216.12 08:06:55 INFO - PROCESS | 1665 | Values: 1501.1 1534.3 1741.7 1836.3 1853.5 7053.3 7474.9 7503.6 8000.6 8227.3 7579.5 8484.1 8764.0 8792.7 8803.3 2330.3 2367.0 2370.3 2370.7 2376.4 1855.5 1931.4 2009.4 2381.4 2382.9 2362.6 2368.8 2376.3 2377.9 2379.7 2352.5 2357.9 2362.2 2377.2 2377.5 1938.5 2337.6 2338.1 2345.7 2360.4 7538.6 8901.3 8943.8 8948.2 8968.7 5187.6 5448.4 5451.1 5456.8 5457.6 3115.5 3551.4 3608.6 3739.7 3742.0 1061.5 1087.3 1088.4 1101.6 1112.8 11658.1 11675.6 11709.3 11795.3 11800.3 4580.6 4727.2 4832.8 4845.5 4849.2 10041.6 10084.5 10125.7 10125.8 10130.7 5376.5 5377.4 5378.1 5387.9 5389.5 4226.7 4528.0 4855.8 4907.0 4912.3 3932.9 3946.2 3946.3 4046.3 4109.8 1283.8 1287.4 1292.7 1294.4 1305.9 807.8 888.0 913.2 925.0 940.7 4979.2 5781.2 5884.6 6005.2 6127.0 422.5 433.3 437.6 437.7 442.3 3609.9 3811.6 3997.7 4097.4 4124.9 10458.7 10949.6 10949.8 10969.0 10994.7 10800.2 10807.2 10900.6 10920.7 10924.4 8050.8 8110.5 8288.2 8324.3 8336.0 5791.7 5827.8 5884.9 5954.9 6023.8 10074.2 10089.0 10141.8 10143.8 10181.8 9360.6 9984.3 10310.6 10400.8 10435.3 6940.2 7168.5 7314.3 7583.9 7634.2 8138.1 8395.3 8406.2 8414.2 8416.2 6674.9 6990.7 7413.2 7486.3 7655.4 5639.9 6551.6 7404.6 7456.3 7457.4 6872.7 6956.5 7025.2 7045.8 7070.0 4273.9 4396.4 5053.8 5101.3 5141.3 4941.4 5042.8 5067.7 5114.2 5159.4 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4307.69 Median:4658.55 stddev:1343.17 (28.8%) stddev-sans-first:1312.39 08:06:55 INFO - PROCESS | 1665 | Values: 275.1 294.9 294.9 309.5 311.2 4764.9 5045.6 5064.5 5316.5 5344.7 5091.0 5221.1 5344.3 5398.8 5440.2 3927.7 4093.8 4101.3 4110.2 4113.5 3594.0 3774.2 4034.8 4108.8 4117.7 3996.9 4037.5 4038.8 4042.8 4084.8 3456.7 3977.3 4022.4 4045.2 4062.2 2904.2 3512.9 3536.6 3547.1 3562.9 4030.7 4822.7 5189.5 5195.8 5244.8 3635.4 3783.9 4051.1 4658.2 4658.9 4940.8 5610.4 5693.1 5713.9 5726.2 3201.6 3363.6 3392.5 3397.0 3666.3 5898.4 5934.3 5943.3 5961.6 6044.6 3268.4 3695.9 3899.9 3927.9 3939.5 3805.6 3857.0 3923.5 3939.3 3979.9 3743.9 3761.5 4180.2 4603.6 4614.5 4758.7 5558.7 5575.0 5663.8 5695.3 1253.1 1294.5 1307.2 1338.5 1341.3 743.7 887.3 904.8 911.3 914.8 4092.8 4773.4 5347.4 5376.7 5376.9 5782.2 5784.4 5786.7 5801.3 5815.4 4663.7 4991.8 5339.8 5346.0 5346.5 2343.9 2456.0 2523.8 2591.7 2640.9 4248.9 4597.4 4608.9 4877.7 4962.5 4328.9 4481.8 4507.1 4518.0 5014.8 4398.7 4459.9 4506.8 4616.4 5109.0 4622.8 4658.9 4850.6 4882.2 4893.1 4353.5 4483.7 4566.4 4822.6 4839.9 4592.1 4823.8 4886.7 5108.5 5141.6 2977.3 3156.7 3248.3 3426.3 3428.4 4400.9 4469.3 4798.3 4812.9 5612.2 4113.6 5641.2 5653.9 5682.8 5718.5 4923.2 5395.8 5618.7 5630.0 5659.9 4368.9 5216.0 5442.2 5535.3 5570.4 5610.9 5612.9 5672.0 5673.6 5708.5 4725.4 4940.3 5495.0 5539.5 5591.4 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:24458.15 Median:22867.10 stddev:38908.72 (170.2%) stddev-sans-first:38976.99 08:06:55 INFO - PROCESS | 1665 | Values: 704.2 707.4 765.2 771.9 791.4 13763.7 15311.9 16067.4 16077.0 16086.9 12609.6 13752.6 14395.0 14479.4 14511.4 615.4 670.3 830.3 834.8 853.7 842.8 864.9 865.8 865.9 866.4 933.0 937.3 941.0 942.9 943.1 935.2 936.0 936.7 938.7 940.6 685.1 689.6 692.8 694.3 694.7 15406.3 15507.5 15522.2 15592.7 15619.5 14460.6 14497.7 14505.1 14532.0 14549.8 11720.2 11888.8 11979.8 11988.6 12044.9 3757.1 3790.4 3825.0 3842.3 3941.9 105721.5 105924.0 106080.5 106226.5 106489.9 10823.9 10936.6 11071.0 11102.3 11557.7 22836.5 22846.0 22848.7 22860.4 22873.8 7905.3 8059.1 8179.4 8246.3 8268.6 4340.5 4428.3 4476.6 4492.4 4557.2 3514.1 3594.4 3615.2 3638.1 3638.7 566.3 642.4 642.5 644.4 671.8 575.2 627.7 629.8 647.8 653.8 8973.6 9326.6 9398.8 9429.4 9493.1 599.9 649.6 663.2 667.3 669.6 4495.3 4628.8 4632.1 5138.5 5142.8 105541.0 131335.0 152827.4 155459.4 157020.0 125268.4 127271.0 130112.0 131334.4 133672.0 117469.4 120127.0 121579.4 122749.0 126351.0 8302.0 9965.2 10096.3 10107.2 10141.3 51831.0 54679.1 58166.0 58198.0 63184.1 69320.0 70687.6 71833.0 88455.0 92960.1 10953.9 13037.5 13372.7 13664.9 13970.7 14591.0 14741.6 14920.7 15478.1 15550.5 13035.5 13488.9 13545.9 13593.8 14258.0 11518.0 13591.4 13851.9 14035.4 14087.9 13190.4 13673.7 13683.7 14080.8 14171.3 11309.7 11319.4 11324.6 11352.4 11840.3 8961.8 10421.6 10647.5 11358.5 11718.4 08:06:55 INFO - PROCESS | 1665 | -------- Summary: end -------- 08:06:55 INFO - PROCESS | 1665 | 08:06:55 INFO - TEST-INFO | 1665: exit 0 08:06:55 INFO - TEST-OK | dromaeo_css | took 1114954ms 08:06:55 INFO - TEST-START | kraken 08:06:55 INFO - operating with platform_type : mac_ 08:06:55 INFO - Initialising browser for kraken test... 08:06:55 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpa_1h_6/profile http://localhost:49276/getInfo.html) 08:06:58 INFO - PROCESS | 1675 | 2016-10-01 08:06:58.428 plugin-container[1676:11339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4313, name = 'com.apple.tsm.portname' 08:06:58 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:58 INFO - PROCESS | 1675 | 2016-10-01 08:06:58.431 plugin-container[1676:11339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1b, name = 'com.apple.CFPasteboardClient' 08:06:58 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:58 INFO - PROCESS | 1675 | 2016-10-01 08:06:58.431 plugin-container[1676:11339] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:58 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 08:06:58 INFO - PROCESS | 1675 | colorDepth:24 08:06:58 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 08:06:58 INFO - PROCESS | 1675 | __metrics 08:06:58 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 08:06:59 INFO - TEST-INFO | 1675: exit 0 08:06:59 INFO - Browser initialized. 08:06:59 INFO - Running cycle 1/1 for kraken test... 08:06:59 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpa_1h_6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:01 INFO - PROCESS | 1677 | 2016-10-01 08:07:01.808 plugin-container[1678:11449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 08:07:01 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:01 INFO - PROCESS | 1677 | 2016-10-01 08:07:01.814 plugin-container[1678:11449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 08:07:01 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:01 INFO - PROCESS | 1677 | 2016-10-01 08:07:01.814 plugin-container[1678:11449] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:07:11 INFO - PROCESS | 1677 | RSS: Main: 240689152 08:07:11 INFO - PROCESS | 1677 | 08:07:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:15 INFO - PROCESS | 1677 | RSS: Main: 254234624 08:07:15 INFO - PROCESS | 1677 | 08:07:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:07:18 INFO - PROCESS | 1677 | RSS: Main: 261726208 08:07:18 INFO - PROCESS | 1677 | 08:07:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:07:23 INFO - PROCESS | 1677 | RSS: Main: 262795264 08:07:23 INFO - PROCESS | 1677 | 08:07:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:07:25 INFO - PROCESS | 1677 | RSS: Main: 263823360 08:07:25 INFO - PROCESS | 1677 | 08:07:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:28 INFO - PROCESS | 1677 | RSS: Main: 264142848 08:07:28 INFO - PROCESS | 1677 | 08:07:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:31 INFO - PROCESS | 1677 | RSS: Main: 264495104 08:07:31 INFO - PROCESS | 1677 | 08:07:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:35 INFO - PROCESS | 1677 | RSS: Main: 266018816 08:07:35 INFO - PROCESS | 1677 | 08:07:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:07:38 INFO - PROCESS | 1677 | RSS: Main: 266051584 08:07:38 INFO - PROCESS | 1677 | 08:07:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:40 INFO - PROCESS | 1677 | RSS: Main: 265867264 08:07:40 INFO - PROCESS | 1677 | 08:07:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:43 INFO - PROCESS | 1677 | RSS: Main: 265920512 08:07:43 INFO - PROCESS | 1677 | 08:07:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:46 INFO - PROCESS | 1677 | RSS: Main: 265969664 08:07:46 INFO - PROCESS | 1677 | 08:07:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:50 INFO - PROCESS | 1677 | RSS: Main: 266473472 08:07:50 INFO - PROCESS | 1677 | 08:07:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:53 INFO - PROCESS | 1677 | RSS: Main: 266244096 08:07:53 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:07:55 INFO - PROCESS | 1677 | RSS: Main: 267702272 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | __start_tp_report 08:07:55 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:07:55 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:07:55 INFO - PROCESS | 1677 | |i|pagename|runs| 08:07:55 INFO - PROCESS | 1677 | |0;ai-astar;114;136;169;155;117;117;117;117;99;166 08:07:55 INFO - PROCESS | 1677 | |1;audio-beat-detection;149;115;119;184;147;114;122;147;176;126 08:07:55 INFO - PROCESS | 1677 | |2;audio-dft;221;247;281;234;198;275;287;200;195;200 08:07:55 INFO - PROCESS | 1677 | |3;audio-fft;80;56;58;83;60;60;59;58;76;58 08:07:55 INFO - PROCESS | 1677 | |4;audio-oscillator;87;72;88;72;70;70;90;69;71;84 08:07:55 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;110;86;87;85;88;95;88;100;135;111 08:07:55 INFO - PROCESS | 1677 | |6;imaging-darkroom;94;95;94;95;94;95;97;96;92;95 08:07:55 INFO - PROCESS | 1677 | |7;imaging-desaturate;114;145;116;94;94;92;93;92;94;92 08:07:55 INFO - PROCESS | 1677 | |8;json-parse-financial;59;57;55;56;56;55;59;56;56;56 08:07:55 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;67;73;77;83;85;76;63;70;61;97 08:07:55 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;96;81;88;80;113;79;99;111;75;105 08:07:55 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;149;168;159;148;168;160;149;147;208;192 08:07:55 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;175;176;177;173;172;174;171;172;154;209 08:07:55 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;71;73;68;71;69;69;71;71;70;68 08:07:55 INFO - PROCESS | 1677 | __end_tp_report 08:07:55 INFO - PROCESS | 1677 | __start_cc_report 08:07:55 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,959 08:07:55 INFO - PROCESS | 1677 | __end_cc_report 08:07:55 INFO - PROCESS | 1677 | __startTimestamp1475334475857__endTimestamp 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:07:55 INFO - PROCESS | 1677 | Number of tests: 14 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:130.70 Median:145.50 stddev:24.42 (16.8%) stddev-sans-first:25.14 08:07:55 INFO - PROCESS | 1677 | Values: 114.0 136.0 169.0 155.0 117.0 117.0 117.0 117.0 99.0 166.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:147.00 stddev:25.11 (17.1%) stddev-sans-first:26.41 08:07:55 INFO - PROCESS | 1677 | Values: 149.0 115.0 119.0 184.0 147.0 114.0 122.0 147.0 176.0 126.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:233.80 Median:240.50 stddev:36.77 (15.3%) stddev-sans-first:38.70 08:07:55 INFO - PROCESS | 1677 | Values: 221.0 247.0 281.0 234.0 198.0 275.0 287.0 200.0 195.0 200.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.00 stddev:10.45 (17.4%) stddev-sans-first:9.53 08:07:55 INFO - PROCESS | 1677 | Values: 80.0 56.0 58.0 83.0 60.0 60.0 59.0 58.0 76.0 58.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:8.73 (11.2%) stddev-sans-first:8.53 08:07:55 INFO - PROCESS | 1677 | Values: 87.0 72.0 88.0 72.0 70.0 70.0 90.0 69.0 71.0 84.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:86.50 stddev:16.08 (18.6%) stddev-sans-first:16.51 08:07:55 INFO - PROCESS | 1677 | Values: 110.0 86.0 87.0 85.0 88.0 95.0 88.0 100.0 135.0 111.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:1.34 (1.4%) stddev-sans-first:1.39 08:07:55 INFO - PROCESS | 1677 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 97.0 96.0 92.0 95.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:92.50 stddev:17.51 (18.9%) stddev-sans-first:18.08 08:07:55 INFO - PROCESS | 1677 | Values: 114.0 145.0 116.0 94.0 94.0 92.0 93.0 92.0 94.0 92.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.20 08:07:55 INFO - PROCESS | 1677 | Values: 59.0 57.0 55.0 56.0 56.0 55.0 59.0 56.0 56.0 56.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:76.50 stddev:10.98 (14.4%) stddev-sans-first:11.24 08:07:55 INFO - PROCESS | 1677 | Values: 67.0 73.0 77.0 83.0 85.0 76.0 63.0 70.0 61.0 97.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:80.50 stddev:14.02 (17.4%) stddev-sans-first:14.82 08:07:55 INFO - PROCESS | 1677 | Values: 96.0 81.0 88.0 80.0 113.0 79.0 99.0 111.0 75.0 105.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:164.80 Median:164.00 stddev:20.50 (12.5%) stddev-sans-first:20.93 08:07:55 INFO - PROCESS | 1677 | Values: 149.0 168.0 159.0 148.0 168.0 160.0 149.0 147.0 208.0 192.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:174.50 stddev:13.50 (7.7%) stddev-sans-first:14.32 08:07:55 INFO - PROCESS | 1677 | Values: 175.0 176.0 177.0 173.0 172.0 174.0 171.0 172.0 154.0 209.0 08:07:55 INFO - PROCESS | 1677 | 08:07:55 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:71.00 stddev:1.60 (2.2%) stddev-sans-first:1.66 08:07:55 INFO - PROCESS | 1677 | Values: 71.0 73.0 68.0 71.0 69.0 69.0 71.0 71.0 70.0 68.0 08:07:55 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:07:55 INFO - PROCESS | 1677 | 08:07:56 INFO - TEST-INFO | 1677: exit 0 08:07:56 INFO - TEST-OK | kraken | took 61033ms 08:07:56 INFO - SUITE-END | took 1175s 08:07:57 INFO - Completed test suite (00:19:36) 08:07:57 INFO - javascript benchmark 08:07:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7171.438044590818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.6231883333426, 3287.7698561100724, 3305.917352066198, 3338.449155889277, 3344.398008358495, 5309.5752339812725, 5442.972785136074, 5469.453054694533, 5493.972530137354, 5506.229127922089, 5345.49217824307, 5551.916721249175, 5581.274434323543, 5640.407757185498, 5696.08862581987, 4339.871633375314, 5042.773075211615, 5070.569001634865, 5112.948870511303, 5271.393789714174, 3816.751911125782, 3943.9014024649327, 4248.575142485742, 5112.182050871861, 5147.510986456281, 5050.444451110357, 5072.568831649314, 5074.746262686851, 5147.996140752554, 5158.638895277332, 5156.071907056728, 5159.019786240602, 5160.277561141444, 5171.250168725552, 5236.083685355085, 5093.617978651579, 5139.229115632647, 5151.974240128813, 5167.354080739908, 5204.817831375922, 5421.159720243369, 5467.20725494805, 5531.751071201806, 5551.694656793875, 5555.388907220203, 6136.519078024463, 6164.938350616526, 6193.969030154821, 6196.380361963767, 6225.066240063981, 6154.199954005995, 6216.844578885519, 6254.812355629293, 6265.060240963846, 6270.717817698214, 5615.354234263031, 5660.462256085665, 5690.658560486384, 5692.260006199251, 5834.387389324144, 5288.444713305047, 6151.6001459904965, 6230.0, 6231.813045608639, 6280.623162610258, 6049.425304596057, 6061.575689701678, 6065.787697430569, 6074.817755467343, 6110.052941793941, 5975.43233392827, 6027.78902738402, 6217.285012223561, 6231.158793562901, 6244.46922011625, 6040.577159598874, 6076.939230607637, 6107.633541987495, 6107.977837958671, 6189.164462797555, 5493.121100623961, 6170.0, 6171.166892469549, 6188.690565471708, 6189.288231853395, 4712.057588482248, 4731.0, 4761.761911904391, 4816.927746083811, 4838.927416088762, 4299.398084268205, 4312.137572485515, 4366.956330436718, 4368.2355587772645, 4404.581564751344, 5720.513756330759, 5777.7977770777825, 5806.129080637938, 5832.650040997553, 5842.883142337129, 6027.367126451747, 6089.177960975212, 6207.782727604512, 6229.813105606839, 6284.717187726564, 5583.078791999355, 5767.567432442584, 5772.220750198753, 5775.624584402, 5822.563307751935, 5313.388960269618, 5323.733813309319, 5323.893522129613, 5343.839684809384, 5351.224072509464, 6184.474319682878, 6232.688365581612, 6238.6880655967925, 6251.062340648939, 6253.937460625427, 6134.8159555213415, 6142.621558143092, 6157.922363586444, 6190.195274614452, 6269.749210031548, 6236.282827474898, 6239.469645080219, 6240.063990401476, 6267.091271765477, 6270.874582508415, 6047.334793172836, 6085.604435711664, 6141.201643786279, 6146.6004709693725, 6177.413145751147, 6068.180795592715, 6107.643995706967, 6114.206128133634, 6141.539384546266, 6169.722362493789, 5129.512696293846, 5405.999890020359, 6059.242594675666, 6079.270487541523, 6114.938850611437, 6034.336223015553, 6040.275166979991, 6046.606970546901, 6058.363871793575, 6098.237720284965, 4808.663393562417, 5562.97085039269, 5702.657840529581, 5806.912896306474, 5879.353271140086, 6019.307779605227, 6036.486898613667, 6047.727852246748, 6053.061775424816, 6099.603525770811, 5736.913946290725, 5872.354041055395, 5877.147813567094, 5908.881822363614, 5922.052471604523], "value": 5576.380688892966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.7195710616525, 508.31631455692093, 517.0150862606736, 529.838399288217, 537.4356925228511, 38294.617053829454, 40392.394114088274, 40498.39252411216, 40615.39076913849, 43189.35215971755, 41587.96030099249, 41951.370729439004, 41971.580284197145, 42021.0, 42081.579184208145, 7648.885266720976, 9751.804963900719, 9913.0, 9946.701598952006, 9970.551325190347, 9240.0, 9698.272629552777, 9764.707058788248, 9779.266555008368, 9780.462074585896, 8976.371653984224, 9799.216062714966, 9803.31376803624, 9804.31369804114, 9852.950735246313, 9657.420554766737, 9725.95137024314, 9784.461854597994, 9789.951050244774, 9790.363626364335, 9678.70963871078, 9697.757556061155, 9774.0, 9784.412935223909, 9811.313208075437, 39942.001449963696, 40024.0, 40226.0, 40382.0, 40451.0, 3366.8148251846137, 3369.3261347730554, 3415.282790613974, 3570.1431656402538, 3770.773753574767, 30487.542686859713, 30621.69378306233, 30882.0, 31030.827842051065, 31698.0, 3214.067920303109, 3218.855151518164, 3230.8223047732367, 3261.5107733839877, 3359.7144242739396, 467279.6636016832, 467947.0, 474434.99999999657, 475925.0, 479325.0, 58203.0, 58383.70808145932, 58469.830603388546, 58488.707556462796, 58631.0, 61329.38670613237, 61429.0, 61623.691881540304, 61936.380636193964, 62017.75964480775, 15978.920105399398, 16096.517104486884, 16181.757273640906, 16214.75677864833, 16239.756403653955, 12422.937885310695, 12489.812652810215, 12496.625101246977, 12512.49950002008, 12550.74898502025, 16180.0, 16467.505974820775, 16512.25694843711, 16513.33946642145, 16552.91723541399, 6654.63940709948, 6734.259231484532, 6773.866232136861, 6773.8983915241315, 6821.69302381394, 853.2534032721369, 913.3469569258012, 965.666844938495, 1004.9145822605014, 1047.7223535763028, 23369.7663023371, 24478.0, 25986.610200847, 26227.475450491263, 28790.992315268864, 932.440535678601, 1011.3577878047346, 1077.42357838556, 1141.4406940599213, 1146.7935771561033, 15435.536933892, 15609.3756249751, 15644.296006679726, 15989.760153597705, 16069.196540172945, 633408.0, 633766.0, 636217.0, 638391.0, 638504.0, 56138.43861561332, 56486.43513564812, 56872.715636421555, 56943.430565693816, 56967.71516142393, 1293.5407930184838, 1344.8050032745393, 1371.636516323175, 1374.4502199120232, 1388.4168649167375, 28861.0, 29627.0, 29755.404891902475, 30117.548236776027, 30146.0, 41195.58804411918, 49836.75081624569, 49906.0, 49928.251076234614, 49991.25013124733, 550947.0, 555519.6688198721, 555800.0, 557010.0, 558435.0, 32812.67187328191, 38647.6135238644, 38840.22319553536, 39077.41383879187, 39932.0, 45600.08799824051, 46393.76803115963, 47082.529174707815, 47175.0, 47893.5210647889, 38674.80662596669, 38830.805845970586, 38843.0, 39947.0, 40180.598194017686, 34172.31655366829, 38248.235035299695, 38616.806915966365, 39732.0, 39857.60142398539, 37269.4409583851, 37496.0, 37753.62246377501, 38377.6162238374, 38677.80661096676, 30067.398652027274, 34263.0, 34553.30893382169, 34723.82638086793, 34796.47805282872, 20113.899430502755, 23321.650175247047, 25265.368365791, 25578.23265302044, 25612.61581076248], "value": 19839.662329375667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0937414280655, 369.4753450100857, 372.18120135701446, 375.50808440942353, 396.1285172620236, 19258.0, 19937.903415312154, 20148.39554813358, 20674.89662551687, 20872.0, 19600.901995490003, 19813.801861981377, 19859.801401985977, 19927.20291188351, 20227.393178204642, 4576.588107070363, 5238.397584277809, 5519.254900588429, 5528.253685752412, 6168.074788781696, 3811.7331786774935, 4038.09142942837, 5776.653400795944, 5913.970430147843, 6075.878482430348, 6071.119687645289, 6111.602745821529, 6122.020476723725, 6122.387761223864, 6146.139540464339, 6215.098810672473, 6677.764613546509, 6707.496937729641, 6712.765053223138, 6723.159605049369, 5639.928413601403, 5765.625234359795, 5803.854903627401, 5919.733611987428, 5951.22634057574, 18192.27230910762, 20057.699134512994, 20785.480362990897, 24465.87767061153, 25192.874035629888, 2236.6197746383154, 2246.2362796649218, 2325.8837058147024, 2339.5203983183405, 2362.444825466014, 10136.341137826017, 10287.639932602398, 10392.220583456196, 11721.472533735918, 15357.462488812838, 1630.7524743571178, 1825.525363405511, 1838.899647054726, 1869.7008478643488, 1879.9906000470046, 105034.47482762614, 107889.38165927517, 111145.0, 111449.0, 114067.0, 11232.775344493064, 11336.376499292619, 11557.422128893522, 11580.36308003068, 11704.946554810109, 14417.13497190172, 14431.567052988426, 14446.927765361106, 14450.783238251435, 14483.203423811581, 8299.917000830035, 8433.451825631315, 8471.576421178916, 8482.151784821468, 8554.61504232311, 8335.416520843604, 8347.916520834835, 8353.16468353172, 8454.1123182065, 8525.40322177454, 4507.706999045052, 4521.344405061248, 4526.253168227206, 4555.521670224645, 4664.510226426244, 1268.7335659511607, 1651.587103224194, 1668.1409074326732, 1892.7823300320365, 1964.0768838645813, 785.4580339565681, 793.8412317536515, 818.7216346442119, 873.785922449004, 1034.1674951663983, 16115.19424028794, 20851.58296834055, 21676.45808854791, 21886.562268754536, 22136.889315553643, 774.3998401239085, 911.4713466189594, 914.5381582301028, 923.0630909626734, 962.8988956159642, 11016.567846179945, 11388.886111138949, 11479.426028698532, 11488.310701357945, 11563.132765042656, 522781.0, 533151.0, 570007.0, 591174.0, 597130.0, 126239.0, 134121.0, 134495.0, 141819.0, 145027.0, 427.3952357414286, 441.6290316134463, 447.38484583697414, 452.0281395000709, 452.086784694921, 9359.625614975324, 10797.946010269898, 11115.22193446451, 11332.660020199408, 11524.481398337262, 52717.0, 54272.45727542832, 54647.45352546424, 55170.0, 56224.71887640536, 64066.67966660137, 77743.0, 79774.60112699399, 80802.0, 84202.57898710467, 8109.351251899951, 8159.34725221969, 8216.671333146607, 8286.254237118446, 8459.0, 9678.661246856327, 11967.31026857953, 12475.376231188586, 12589.559365422532, 13120.540781072617, 9763.951180244054, 9831.508424578886, 11296.322220666787, 11531.538738450368, 11633.975166456952, 10722.51748671296, 11192.272502287326, 11225.49485273181, 11275.830862536905, 11334.886651133713, 11348.0, 11632.825507617561, 11817.586384476503, 11868.643940681794, 11996.160268781101, 7777.105632852295, 8145.959270203611, 8265.0, 8438.704645337384, 8498.0, 6739.46084313244, 7706.3449606781805, 7842.803929901798, 7855.253750893656, 8134.959325203336], "value": 9030.041900449496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.1293449799118, 1534.294224656658, 1741.6603762266354, 1836.2746715047565, 1853.5180852978212, 7053.329933656307, 7474.925250747491, 7503.624818759061, 8000.599970001491, 8227.300679442254, 7579.507332023414, 8484.066752657218, 8764.03595604483, 8792.736217913456, 8803.251723603502, 2330.347502699243, 2367.029517897662, 2370.300761275419, 2370.6799582056374, 2376.4415362389823, 1855.4804654696638, 1931.3529967460847, 2009.437357539891, 2381.368937231635, 2382.927682542854, 2362.633791762271, 2368.83418160728, 2376.3227480168157, 2377.9048838046456, 2379.7382287948312, 2352.4824538601565, 2357.905683772647, 2362.1968530699473, 2377.2392834292946, 2377.465070359173, 1938.5444420561157, 2337.649352597107, 2338.1348900906773, 2345.6598793174894, 2360.3980984848927, 7538.623068846536, 8901.332400069956, 8943.821123577558, 8948.194662480408, 8968.68609598661, 5187.610929180289, 5448.4279150689, 5451.100568406208, 5456.809011684572, 5457.617966742329, 3115.517094850302, 3551.449525323579, 3608.6307715489907, 3739.719521035933, 3742.0, 1061.4533515239657, 1087.276960821053, 1088.4013792414219, 1101.553870682375, 1112.7718817642365, 11658.125640576991, 11675.649730508097, 11709.297442153413, 11795.29228246308, 11800.291982480992, 4580.564846339593, 4727.17274476972, 4832.806687732522, 4845.466998630148, 4849.151398505247, 10041.598336066621, 10084.49577521121, 10125.696229112991, 10125.797484050277, 10130.696079117639, 5376.462353764592, 5377.381601115843, 5378.085725426687, 5387.892242155135, 5389.51494365509, 4226.682998775104, 4527.977360113178, 4855.8057677692495, 4906.975465122723, 4912.336834527293, 3932.9213415731524, 3946.1515774108702, 3946.3291240489184, 4046.291898917678, 4109.753414795122, 1283.8395200599925, 1287.3884904670206, 1292.702678383977, 1294.3981048812348, 1305.9151155174884, 807.8303556253135, 887.9955600221957, 913.1507697840939, 925.0354448200984, 940.6707652321633, 4979.228219625964, 5781.161731548902, 5884.617499862581, 6005.219321488178, 6127.0, 422.5478737750577, 433.34132119179304, 437.5864807756703, 437.73298288044265, 442.2768773056076, 3609.909752256162, 3811.6188381162215, 3997.700172487075, 4097.44684467599, 4124.91750164995, 10458.738531536772, 10949.56201751921, 10949.781004379867, 10968.957948994832, 10994.670159895217, 10800.1899857511, 10807.189460790472, 10900.563977440814, 10920.672379828618, 10924.399158046224, 8050.798730031796, 8110.472819266729, 8288.21261980111, 8324.250817426582, 8336.0, 5791.652500849794, 5827.825165245049, 5884.941150588439, 5954.851128721643, 6023.849403764941, 10074.244431667801, 10089.041541053588, 10141.847872281774, 10143.847842282225, 10181.84727229107, 9360.595910613463, 9984.301098923006, 10310.587576496857, 10400.791984160425, 10435.269531132748, 6940.236573976959, 7168.53404528704, 7314.341709246193, 7583.924160758543, 7634.160242373446, 8138.064122625974, 8395.328373729964, 8406.201410865959, 8414.158584141536, 8416.200460956445, 6674.899876501953, 6990.671772363235, 7413.221611730906, 7486.251374862471, 7655.425843061904, 5639.8590035249445, 6551.574147680385, 7404.629768511661, 7456.291652293024, 7457.440691948017, 6872.69072891711, 6956.513044087068, 7025.192102908231, 7045.823854403476, 7070.0, 4273.850415235452, 4396.384506169203, 5053.84838454847, 5101.260317253903, 5141.305923700253, 4941.357623508921, 5042.773075211698, 5067.670601410897, 5114.232865070269, 5159.355080614923], "value": 4466.0993022733655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.0538148768238, 294.9056301983366, 294.9498585240509, 309.45844771649604, 311.2266018942926, 4764.856434455732, 5045.621578381622, 5064.468230835764, 5316.5215130638235, 5344.732763361831, 5091.0, 5221.112410890149, 5344.331958505187, 5398.757055932482, 5440.238366628665, 3927.70542209334, 4093.8157782899693, 4101.302778527657, 4110.198511290299, 4113.465249517559, 3593.975716920678, 3774.188549461865, 4034.8184331704997, 4108.794560271975, 4117.732347397425, 3996.8808733554506, 4037.4953130858644, 4038.8287396654937, 4042.757434553936, 4084.7957602119923, 3456.6888979991795, 3977.34373828318, 4022.4368588397647, 4045.231406032859, 4062.1672557125717, 2904.2158617173454, 3512.929741405183, 3536.6286539913453, 3547.130952916526, 3562.8574857005688, 4030.694830239205, 4822.71063736177, 5189.532942035197, 5195.766190521398, 5244.79020839166, 3635.381985062546, 3783.9243215135816, 4051.0682543015273, 4658.161530924433, 4658.930116048262, 4940.777665005084, 5610.382857885629, 5693.092813907346, 5713.885722285531, 5726.226959360475, 3201.583794106751, 3363.562736844219, 3392.506507716826, 3397.0, 3666.303402353571, 5898.375223025755, 5934.287885453773, 5943.257092863392, 5961.612495187842, 6044.576879618385, 3268.362669279468, 3695.909706636549, 3899.941500877489, 3927.9018024549614, 3939.5075615548058, 3805.562360328542, 3856.9971807329734, 3923.489946306962, 3939.330313846653, 3979.9204015919518, 3743.8689645862264, 3761.5110035695184, 4180.24755544005, 4603.608693261111, 4614.523352527226, 4758.690685105457, 5558.74928141165, 5574.996500629844, 5663.830085097371, 5695.345035320908, 1253.11029169289, 1294.5274974634378, 1307.1895424836662, 1338.464614154346, 1341.3293353323338, 743.7471259771595, 887.2547060469237, 904.8461761500561, 911.2527727263713, 914.8381555424706, 4092.7871620777546, 4773.403324584427, 5347.3583170019065, 5376.731163441812, 5376.903007826951, 5782.190493330937, 5784.3926387729525, 5786.71066446676, 5801.3038435388025, 5815.389384114692, 4663.650226233046, 4991.825286115041, 5339.83736586683, 5346.021971870433, 5346.518813306821, 2343.8945247463903, 2456.035171862503, 2523.753859065433, 2591.714911359749, 2640.8811603477507, 4248.877075349616, 4597.448306203277, 4608.9308660370125, 4877.731724755173, 4962.503749625009, 4328.913421731548, 4481.767513933629, 4507.076049409863, 4517.977410112929, 5014.7994080236385, 4398.670099742468, 4459.910801783946, 4506.81972721094, 4616.376789133424, 5109.033022286447, 4622.815087396467, 4658.930116048195, 4850.587700045536, 4882.2432522959, 4893.119238537098, 4353.477582690098, 4483.686141970031, 4566.443834769489, 4822.577339684732, 4839.935214252859, 4592.127495775792, 4823.781060712112, 4886.706797592014, 5108.489151084862, 5141.640085194001, 2977.2556860784803, 3156.6527681955426, 3248.3340915112817, 3426.3147370525494, 3428.400029994691, 4400.933985990277, 4469.329600559812, 4798.280257961194, 4812.8796780080775, 5612.214289999485, 4113.588641135862, 5641.182028605911, 5653.915191272216, 5682.772689092555, 5718.456746609232, 4923.187674033744, 5395.843431592562, 5618.6628802272, 5629.971850140723, 5659.943400566106, 4368.9126217476105, 5215.982883337864, 5442.156465747816, 5535.25274087993, 5570.387257401601, 5610.85972850682, 5612.915806262828, 5671.972899241585, 5673.60295770781, 5708.54331653475, 4725.385699858996, 4940.308356830118, 5494.9725251375085, 5539.534906966362, 5591.412901645269], "value": 3888.3288018300827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.1585305559855, 707.4340527577938, 765.1850778920449, 771.9150893401728, 791.386675326622, 13763.724725505497, 15311.923440382796, 16067.437639682614, 16077.0, 16086.919565402186, 12609.558665446712, 13752.555981621936, 14395.0, 14479.420823167087, 14511.419543218259, 615.4460985113411, 670.2593634034395, 830.2818062376032, 834.7620928035511, 853.6500034985658, 842.806154584446, 864.9091845356241, 865.8398196333667, 865.904750477447, 866.3762091294258, 932.9673461428852, 937.2501998401286, 941.0025373104497, 942.9245660347156, 943.0663642993455, 935.2144198872945, 935.9719208423758, 936.6534382278533, 938.6949241496507, 940.5814412586402, 685.0990946904805, 689.6379400814562, 692.8337199072237, 694.3299715774302, 694.7325279767275, 15406.306716197798, 15507.457238996582, 15522.223888805514, 15592.688146237126, 15619.531414057596, 14460.638484037878, 14497.710045799025, 14505.129692218396, 14532.0, 14549.78175327371, 11720.238184518064, 11888.762224755457, 11979.760404791943, 11988.580399685969, 12044.939775301154, 3757.1170774867883, 3790.431435284702, 3824.9808750956345, 3842.3275926712713, 3941.9211615767813, 105721.47139264332, 105923.99999999923, 106080.46959765229, 106226.46886765517, 106489.93510064877, 10823.891761082446, 10936.617218397318, 11071.040755536587, 11102.2783519071, 11557.653270401901, 22836.543269134523, 22846.0, 22848.65727014096, 22860.4284892879, 22873.771262287497, 7905.288524032865, 8059.1134975153855, 8179.4274400792565, 8246.340292776564, 8268.586570671443, 4340.545981880331, 4428.33574963758, 4476.597106260452, 4492.3710680504755, 4557.1797076526545, 3514.10390350459, 3594.370985077601, 3615.204654975954, 3638.0541059324764, 3638.690711289517, 566.3430420712036, 642.4121928435522, 642.4635429416489, 644.3717375558792, 671.8253254153857, 575.186111652016, 627.7300760672863, 629.8488362792897, 647.7877158054282, 653.8234676637281, 8973.641054357882, 9326.626934922662, 9398.765030874283, 9429.387089839138, 9493.0981556752, 599.9130126131773, 649.6394501051867, 663.177659701966, 667.2893368562466, 669.563785679724, 4495.2582823834355, 4628.83799067031, 4632.119897219518, 5138.486151384832, 5142.794288228429, 105541.0, 131335.02997455045, 152827.35863206795, 155459.44540554675, 157020.0, 125268.37365813112, 127271.0, 130112.0, 131334.37331253322, 133672.0, 117469.4126529379, 120127.0, 121579.3921030407, 122749.0, 126351.0, 8302.00688187435, 9965.152961998312, 10096.34373765703, 10107.241956853119, 10141.29010969225, 51830.96338073293, 54679.08623198169, 58166.0, 58198.0, 63184.05223921553, 69319.96020059602, 70687.64656176686, 71833.0, 88455.0, 92960.14079718503, 10953.945230273797, 13037.543685970946, 13372.665683357995, 13664.93167534156, 13970.650733731738, 14591.0, 14741.631459213177, 14920.701585968436, 15478.071315721092, 15550.533483995498, 13035.543755968496, 13488.93255533716, 13545.932270338586, 13593.79609305881, 14258.001939864525, 11518.0, 13591.388387522784, 13851.86148138546, 14035.438582456587, 14087.859121408655, 13190.406431710404, 13673.726525469634, 13683.657908552366, 14080.788788168391, 14171.291435427982, 11309.71725706831, 11319.434028298718, 11324.6036388726, 11352.432378380883, 11840.335924416937, 8961.820763584823, 10421.583136674448, 10647.463319073884, 11358.54565817358, 11718.355490448108], "value": 7840.086678449882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 136.0, 169.0, 155.0, 117.0, 117.0, 117.0, 117.0, 99.0, 166.0], "value": 130.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 119.0, 184.0, 147.0, 114.0, 122.0, 147.0, 176.0, 126.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 247.0, 281.0, 234.0, 198.0, 275.0, 287.0, 200.0, 195.0, 200.0], "value": 233.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 58.0, 83.0, 60.0, 60.0, 59.0, 58.0, 76.0, 58.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 88.0, 72.0, 70.0, 70.0, 90.0, 69.0, 71.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 86.0, 87.0, 85.0, 88.0, 95.0, 88.0, 100.0, 135.0, 111.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 97.0, 96.0, 92.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 145.0, 116.0, 94.0, 94.0, 92.0, 93.0, 92.0, 94.0, 92.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 55.0, 56.0, 56.0, 55.0, 59.0, 56.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 77.0, 83.0, 85.0, 76.0, 63.0, 70.0, 61.0, 97.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 81.0, 88.0, 80.0, 113.0, 79.0, 99.0, 111.0, 75.0, 105.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 168.0, 159.0, 148.0, 168.0, 160.0, 149.0, 147.0, 208.0, 192.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 177.0, 173.0, 172.0, 174.0, 171.0, 172.0, 154.0, 209.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 68.0, 71.0, 69.0, 69.0, 71.0, 71.0, 70.0, 68.0], "value": 70.1, "unit": "score"}]}]} 08:07:57 INFO - Return code: 0 08:07:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:57 ERROR - # TBPL SUCCESS # 08:07:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:57 INFO - 2016-10-01 08:07:57.208 screenresolution[1682:11837] starting screenresolution argv=screenresolution get 08:07:57 INFO - 2016-10-01 08:07:57.210 screenresolution[1682:11837] Display 0: 1600x1200x32@60 08:07:57 INFO - 2016-10-01 08:07:57.216 screenresolution[1683:11840] starting screenresolution argv=screenresolution list 08:07:57 INFO - Available Modes on Display 0 08:07:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:57 INFO - Intel Iris: 08:07:57 INFO - Chipset Model: Intel Iris 08:07:57 INFO - Type: GPU 08:07:57 INFO - Bus: Built-In 08:07:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:57 INFO - Vendor: Intel (0x8086) 08:07:57 INFO - Device ID: 0x0a2e 08:07:57 INFO - Revision ID: 0x0009 08:07:57 INFO - Displays: 08:07:57 INFO - Display: 08:07:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:57 INFO - Display Serial Number: 1600x1200 60 08:07:57 INFO - Main Display: Yes 08:07:57 INFO - Mirror: Off 08:07:57 INFO - Online: Yes 08:07:57 INFO - Rotation: Supported 08:07:57 INFO - Return code: 0 08:07:57 INFO - Running post-action listener: _resource_record_post_action 08:07:57 INFO - [mozharness: 2016-10-01 15:07:57.452090Z] Finished run-tests step (success) 08:07:57 INFO - Running post-run listener: _resource_record_post_run 08:07:57 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 33800704; Write bytes: 713403392; Read time: 321; Write time: 1928 08:07:57 INFO - TinderboxPrint: CPU usage
54.7% 08:07:57 INFO - TinderboxPrint: I/O read bytes / time
33,800,704 / 321 08:07:57 INFO - TinderboxPrint: I/O write bytes / time
713,403,392 / 1,928 08:07:57 INFO - TinderboxPrint: CPU idle
2,195.4 (45.3%) 08:07:57 INFO - TinderboxPrint: CPU system
983.5 (20.3%) 08:07:57 INFO - TinderboxPrint: CPU user
1,666.8 (34.4%) 08:07:57 INFO - TinderboxPrint: Swap in / out
438,267,904 / 0 08:07:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393779712; Write bytes: 388691968; Read time: 29886; Write time: 692 08:07:57 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 32866816; Write bytes: 302502912; Read time: 306; Write time: 1189 08:07:57 INFO - Running post-run listener: _upload_blobber_files 08:07:57 INFO - Blob upload gear active. 08:07:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:59 INFO - (blobuploader) - INFO - Done attempting. 08:07:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:07:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:00 INFO - (blobuploader) - INFO - Done attempting. 08:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:03 INFO - (blobuploader) - INFO - Done attempting. 08:08:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:03 INFO - Return code: 0 08:08:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14b52057dc16cae0f3edd838b57400e3dd58bbae124f4ecf46bbcc77ca372218f56e0b4d9195e9fc1025d057428073c7b2105415156cc1d314aa00188c487a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca940ed8557ef985992f56af491230866b1154db83d342d8fa28363e9840b2c7bdcf14ab26682341cad93e74c2b076efb5f57cb546b9fa200a11af58f9e9c92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36c4322df9ca64d1eca127d6d6af69c696615854ed8af94d9ed4653b16eb2615c895c63d41b01e7be81edeb4babf56d1df40ca9b958a7f04406066ef58faba"} 08:08:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:03 INFO - Contents: 08:08:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14b52057dc16cae0f3edd838b57400e3dd58bbae124f4ecf46bbcc77ca372218f56e0b4d9195e9fc1025d057428073c7b2105415156cc1d314aa00188c487a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca940ed8557ef985992f56af491230866b1154db83d342d8fa28363e9840b2c7bdcf14ab26682341cad93e74c2b076efb5f57cb546b9fa200a11af58f9e9c92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36c4322df9ca64d1eca127d6d6af69c696615854ed8af94d9ed4653b16eb2615c895c63d41b01e7be81edeb4babf56d1df40ca9b958a7f04406066ef58faba"} 08:08:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:03 INFO - Copying logs to upload dir... 08:08:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.567259 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-01 08:08:03.307219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 08:08:03.310448) ========= 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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14b52057dc16cae0f3edd838b57400e3dd58bbae124f4ecf46bbcc77ca372218f56e0b4d9195e9fc1025d057428073c7b2105415156cc1d314aa00188c487a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca940ed8557ef985992f56af491230866b1154db83d342d8fa28363e9840b2c7bdcf14ab26682341cad93e74c2b076efb5f57cb546b9fa200a11af58f9e9c92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36c4322df9ca64d1eca127d6d6af69c696615854ed8af94d9ed4653b16eb2615c895c63d41b01e7be81edeb4babf56d1df40ca9b958a7f04406066ef58faba"} build_url:https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/RjCM3d1zS6KfhCiAVaqtEg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14b52057dc16cae0f3edd838b57400e3dd58bbae124f4ecf46bbcc77ca372218f56e0b4d9195e9fc1025d057428073c7b2105415156cc1d314aa00188c487a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca940ed8557ef985992f56af491230866b1154db83d342d8fa28363e9840b2c7bdcf14ab26682341cad93e74c2b076efb5f57cb546b9fa200a11af58f9e9c92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36c4322df9ca64d1eca127d6d6af69c696615854ed8af94d9ed4653b16eb2615c895c63d41b01e7be81edeb4babf56d1df40ca9b958a7f04406066ef58faba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 08:08:03.342715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 08:08:03.343068) ========= 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.rRWgKzdZrH/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.D8xixvQ0rN/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005034 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 08:08:03.391968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 08:08:03.392311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 08:08:03.392668) ========= ========= Total master_lag: 0.18 =========