builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0355 starttime: 1488214191.64 results: success (0) buildid: 20170227061809 builduid: 9ce775348cba4aa9abbd67df0d871ff4 revision: 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.636565) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.637019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.637331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.663948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.664329) ========= 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.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-27 08:49:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-02-27 08:49:51 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122774 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.812161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.812529) ========= 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.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.026150 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:51.862318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 08:49:51.862713) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-27 08:49:51,894 truncating revision to first 12 chars 2017-02-27 08:49:51,895 Setting DEBUG logging. 2017-02-27 08:49:51,895 attempt 1/10 2017-02-27 08:49:51,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4bd2e5d2ac0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 08:49:53,347 unpacking tar archive at: mozilla-beta-4bd2e5d2ac0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.735594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 08:49:53.621958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:53.622273) ========= script_repo_revision: 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:53.622696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:53.622967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:49:53.643136) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-27 08:49:53.643557) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:49:53 INFO - MultiFileLogger online at 20170227 08:49:53 in /builds/slave/test 08:49:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:49:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:53 INFO - {'append_to_log': False, 08:49:53 INFO - 'base_work_dir': '/builds/slave/test', 08:49:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:49:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:53 INFO - 'branch': 'Mozilla-Beta', 08:49:53 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:53 INFO - 'config_files': ('talos/mac_config.py',), 08:49:53 INFO - 'default_actions': ('clobber', 08:49:53 INFO - 'read-buildbot-config', 08:49:53 INFO - 'download-and-extract', 08:49:53 INFO - 'populate-webroot', 08:49:53 INFO - 'create-virtualenv', 08:49:53 INFO - 'install', 08:49:53 INFO - 'run-tests'), 08:49:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:53 INFO - 'download_minidump_stackwalk': True, 08:49:53 INFO - 'download_symbols': 'ondemand', 08:49:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:53 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:53 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:53 INFO - 'installer_path': 'installer.exe', 08:49:53 INFO - 'log_level': 'info', 08:49:53 INFO - 'log_name': 'talos', 08:49:53 INFO - 'log_to_console': True, 08:49:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:53 INFO - 'opt_config_files': (), 08:49:53 INFO - 'pip_index': False, 08:49:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:53 INFO - 'cmd': ('bash', 08:49:53 INFO - '-c', 08:49:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:53 INFO - 'enabled': True, 08:49:53 INFO - 'halt_on_failure': False, 08:49:53 INFO - 'name': 'check_screen_resolution'},), 08:49:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:53 INFO - 'cmd': ('bash', 08:49:53 INFO - '-c', 08:49:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:53 INFO - 'enabled': True, 08:49:53 INFO - 'halt_on_failure': False, 08:49:53 INFO - 'name': 'check_screen_resolution'},), 08:49:53 INFO - 'run_cmd_checks_enabled': True, 08:49:53 INFO - 'sps_profile': False, 08:49:53 INFO - 'sps_profile_interval': 0, 08:49:53 INFO - 'suite': 'dromaeojs', 08:49:53 INFO - 'system_bits': '32', 08:49:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:53 INFO - 'title': 't-yosemite-r7-0355', 08:49:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:53 INFO - 'use_talos_json': True, 08:49:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:53 INFO - 'work_dir': 'build'} 08:49:53 INFO - [mozharness: 2017-02-27 16:49:53.783624Z] Running clobber step. 08:49:53 INFO - Running pre-action listener: _resource_record_pre_action 08:49:53 INFO - Running main action method: clobber 08:49:53 INFO - rmtree: /builds/slave/test/build 08:49:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - [mozharness: 2017-02-27 16:49:56.300037Z] Finished clobber step (success) 08:49:56 INFO - [mozharness: 2017-02-27 16:49:56.300166Z] Running read-buildbot-config step. 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: read_buildbot_config 08:49:56 INFO - Using buildbot properties: 08:49:56 INFO - { 08:49:56 INFO - "project": "", 08:49:56 INFO - "product": "firefox", 08:49:56 INFO - "script_repo_revision": "production", 08:49:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:49:56 INFO - "repository": "", 08:49:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:49:56 INFO - "buildid": "20170227061809", 08:49:56 INFO - "pgo_build": "False", 08:49:56 INFO - "basedir": "/builds/slave/test", 08:49:56 INFO - "buildnumber": 46, 08:49:56 INFO - "slavename": "t-yosemite-r7-0355", 08:49:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:49:56 INFO - "platform": "yosemite_r7", 08:49:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:49:56 INFO - "branch": "mozilla-beta", 08:49:56 INFO - "repo_path": "releases/mozilla-beta", 08:49:56 INFO - "revision": "4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46", 08:49:56 INFO - "stage_platform": "macosx64", 08:49:56 INFO - "builduid": "9ce775348cba4aa9abbd67df0d871ff4", 08:49:56 INFO - "slavebuilddir": "test" 08:49:56 INFO - } 08:49:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - [mozharness: 2017-02-27 16:49:56.303562Z] Finished read-buildbot-config step (success) 08:49:56 INFO - [mozharness: 2017-02-27 16:49:56.303664Z] Running download-and-extract step. 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: download_and_extract 08:49:56 INFO - mkdir: /builds/slave/test/build/tests 08:49:56 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')]} 08:49:56 INFO - trying https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:49:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:49:57 INFO - Downloaded 1165 bytes. 08:49:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:49:57 INFO - Using the following test package requirements: 08:49:57 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:49:57 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:49:57 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:49:57 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:49:57 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:49:57 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:49:57 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:49:57 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:49:57 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:49:57 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:49:57 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:49:57 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:49:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:49:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:49:58 INFO - Http code: 200 08:49:58 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:49:58 INFO - x-amz-cf-id: HTG155ppxfv1j3yP_8xuczLvCzno0ZtSgGJEKA1HLXK4onDmXMQt0Q== 08:49:58 INFO - x-amz-version-id: RnV4jFCncu9sdYQkRlDbAP6_uhFilyqt 08:49:58 INFO - Expected file size: 16093392 08:49:58 INFO - Obtained file size: 16093392 08:50:05 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:50:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:50:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:50:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:50:05 INFO - Http code: 200 08:50:05 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:50:05 INFO - x-amz-cf-id: GMxLFgW_8A_WADapBj_aA68GWeSD8-oUja37tdw9Lk1tfHii8Spn_w== 08:50:05 INFO - x-amz-version-id: RnV4jFCncu9sdYQkRlDbAP6_uhFilyqt 08:50:05 INFO - Expected file size: 16093392 08:50:05 INFO - Obtained file size: 16093392 08:50:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:50:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:50:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:50:13 INFO - Http code: 200 08:50:13 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 08:50:13 INFO - x-amz-cf-id: AN3FQcFnEOeiJHQbe77mvbcQvnpVlUrzdmuOw_EOO1pysoGthfi6Lw== 08:50:13 INFO - x-amz-version-id: 5L2v074mN0zpgKimYZmXv603EJuxuk4F 08:50:14 INFO - Expected file size: 14402992 08:50:14 INFO - Obtained file size: 14402992 08:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:14 INFO - trying https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:50:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:50:16 INFO - Downloaded 82112530 bytes. 08:50:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:50:16 INFO - mkdir: /builds/slave/test/properties 08:50:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:16 INFO - Contents: 08:50:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:50:17 INFO - Running post-action listener: _resource_record_post_action 08:50:17 INFO - Running post-action listener: set_extra_try_arguments 08:50:17 INFO - [mozharness: 2017-02-27 16:50:17.293409Z] Finished download-and-extract step (success) 08:50:17 INFO - [mozharness: 2017-02-27 16:50:17.293537Z] Running populate-webroot step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: populate_webroot 08:50:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:17 INFO - '--tppagecycles', 08:50:17 INFO - '7'], 08:50:17 INFO - 'tests': ['tsvgm']}}, 08:50:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['damp', 'tps']}, 08:50:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'tests': ['damp', 'tps']}, 08:50:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['dromaeo_dom']}, 08:50:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['basic_compositor_video']}, 08:50:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:50:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['a11yr', 08:50:17 INFO - 'ts_paint', 08:50:17 INFO - 'tpaint', 08:50:17 INFO - 'sessionrestore', 08:50:17 INFO - 'sessionrestore_no_auto_restore', 08:50:17 INFO - 'tabpaint']}, 08:50:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['tsvgx', 08:50:17 INFO - 'tsvgr_opacity', 08:50:17 INFO - 'tart', 08:50:17 INFO - 'tscrollx', 08:50:17 INFO - 'cart']}, 08:50:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:17 INFO - 'tsvgr_opacity', 08:50:17 INFO - 'tart', 08:50:17 INFO - 'tscrollx', 08:50:17 INFO - 'cart']}, 08:50:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'talos_options': ['--disable-e10s'], 08:50:17 INFO - 'tests': ['tp5o']}, 08:50:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'tests': ['tp5o']}, 08:50:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'talos_options': ['--disable-e10s', 08:50:17 INFO - '--xperf_path', 08:50:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:17 INFO - 'tests': ['tp5n']}, 08:50:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:17 INFO - 'talos_options': ['--xperf_path', 08:50:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:17 INFO - 'tests': ['tp5n']}}, 08:50:17 INFO - 'talos.zip': {'path': '', 08:50:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:17 INFO - Running post-action listener: _resource_record_post_action 08:50:17 INFO - [mozharness: 2017-02-27 16:50:17.312290Z] Finished populate-webroot step (success) 08:50:17 INFO - [mozharness: 2017-02-27 16:50:17.312428Z] Running create-virtualenv step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: create_virtualenv 08:50:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:17 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 08:50:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:17 INFO - Using real prefix '/tools/python27' 08:50:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:21 INFO - Installing pip.................done. 08:50:21 INFO - Return code: 0 08:50:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:21 INFO - Reading from file tmpfile_stdout 08:50:21 INFO - Output received: 08:50:21 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) 08:50:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:21 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 08:50:21 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 08:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:21 INFO - 'HOME': '/Users/cltbld', 08:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:21 INFO - 'LOGNAME': 'cltbld', 08:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:21 INFO - 'MOZ_NO_REMOTE': '1', 08:50:21 INFO - 'NO_EM_RESTART': '1', 08:50:21 INFO - 'PAGER': '/bin/cat', 08:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:21 INFO - 'PWD': '/builds/slave/test', 08:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:21 INFO - 'SHELL': '/bin/bash', 08:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:21 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:21 INFO - 'USER': 'cltbld', 08:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:21 INFO - 'XPC_FLAGS': '0x0', 08:50:21 INFO - 'XPC_SERVICE_NAME': '0', 08:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:21 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 08:50:21 INFO - Cleaning up... 08:50:21 INFO - Return code: 0 08:50:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:21 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 08:50:21 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 08:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:21 INFO - 'HOME': '/Users/cltbld', 08:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:21 INFO - 'LOGNAME': 'cltbld', 08:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:21 INFO - 'MOZ_NO_REMOTE': '1', 08:50:21 INFO - 'NO_EM_RESTART': '1', 08:50:21 INFO - 'PAGER': '/bin/cat', 08:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:21 INFO - 'PWD': '/builds/slave/test', 08:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:21 INFO - 'SHELL': '/bin/bash', 08:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:21 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:21 INFO - 'USER': 'cltbld', 08:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:21 INFO - 'XPC_FLAGS': '0x0', 08:50:21 INFO - 'XPC_SERVICE_NAME': '0', 08:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:21 INFO - Downloading/unpacking psutil>=3.1.1 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:25 INFO - Installing collected packages: psutil 08:50:25 INFO - Running setup.py install for psutil 08:50:25 INFO - building 'psutil._psutil_osx' extension 08:50:25 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 08:50:26 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 08:50:26 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 08:50:26 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 08:50:26 INFO - building 'psutil._psutil_posix' extension 08:50:26 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 08:50:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:26 INFO - ^ 08:50:26 INFO - 1 warning generated. 08:50:26 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 08:50:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:26 INFO - Successfully installed psutil 08:50:26 INFO - Cleaning up... 08:50:26 INFO - Return code: 0 08:50:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50: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 mozsystemmonitor==0.3 08:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:26 INFO - 'HOME': '/Users/cltbld', 08:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:26 INFO - 'LOGNAME': 'cltbld', 08:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:26 INFO - 'MOZ_NO_REMOTE': '1', 08:50:26 INFO - 'NO_EM_RESTART': '1', 08:50:26 INFO - 'PAGER': '/bin/cat', 08:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:26 INFO - 'PWD': '/builds/slave/test', 08:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:26 INFO - 'SHELL': '/bin/bash', 08:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:26 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:26 INFO - 'USER': 'cltbld', 08:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:26 INFO - 'XPC_FLAGS': '0x0', 08:50:26 INFO - 'XPC_SERVICE_NAME': '0', 08:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:29 INFO - Installing collected packages: mozsystemmonitor 08:50:29 INFO - Running setup.py install for mozsystemmonitor 08:50:29 INFO - Successfully installed mozsystemmonitor 08:50:29 INFO - Cleaning up... 08:50:29 INFO - Return code: 0 08:50:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', '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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:50: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 jsonschema==2.5.1 08:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:29 INFO - 'HOME': '/Users/cltbld', 08:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:29 INFO - 'LOGNAME': 'cltbld', 08:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:29 INFO - 'MOZ_NO_REMOTE': '1', 08:50:29 INFO - 'NO_EM_RESTART': '1', 08:50:29 INFO - 'PAGER': '/bin/cat', 08:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:29 INFO - 'PWD': '/builds/slave/test', 08:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:29 INFO - 'SHELL': '/bin/bash', 08:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:29 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:29 INFO - 'USER': 'cltbld', 08:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:29 INFO - 'XPC_FLAGS': '0x0', 08:50:29 INFO - 'XPC_SERVICE_NAME': '0', 08:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:30 INFO - Downloading/unpacking jsonschema==2.5.1 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:33 INFO - warning: no files found matching '*.txt' 08:50:33 INFO - no previously-included directories found matching 'build' 08:50:33 INFO - no previously-included directories found matching 'dist' 08:50:33 INFO - no previously-included directories found matching '.git*' 08:50:33 INFO - Installing collected packages: jsonschema, functools32 08:50:33 INFO - Running setup.py install for functools32 08:50:33 INFO - warning: no files found matching '*.txt' 08:50:33 INFO - no previously-included directories found matching 'build' 08:50:33 INFO - no previously-included directories found matching 'dist' 08:50:33 INFO - no previously-included directories found matching '.git*' 08:50:33 INFO - Successfully installed jsonschema functools32 08:50:33 INFO - Cleaning up... 08:50:33 INFO - Return code: 0 08:50:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:33 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:33 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 08:50:33 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 08:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:33 INFO - 'HOME': '/Users/cltbld', 08:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:33 INFO - 'LOGNAME': 'cltbld', 08:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:33 INFO - 'MOZ_NO_REMOTE': '1', 08:50:33 INFO - 'NO_EM_RESTART': '1', 08:50:33 INFO - 'PAGER': '/bin/cat', 08:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:33 INFO - 'PWD': '/builds/slave/test', 08:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:33 INFO - 'SHELL': '/bin/bash', 08:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:33 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:33 INFO - 'USER': 'cltbld', 08:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:33 INFO - 'XPC_FLAGS': '0x0', 08:50:33 INFO - 'XPC_SERVICE_NAME': '0', 08:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:33 INFO - Cleaning up... 08:50:33 INFO - Return code: 0 08:50:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:33 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:33 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 08:50:33 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 08:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:33 INFO - 'HOME': '/Users/cltbld', 08:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:33 INFO - 'LOGNAME': 'cltbld', 08:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:33 INFO - 'MOZ_NO_REMOTE': '1', 08:50:33 INFO - 'NO_EM_RESTART': '1', 08:50:33 INFO - 'PAGER': '/bin/cat', 08:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:33 INFO - 'PWD': '/builds/slave/test', 08:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:33 INFO - 'SHELL': '/bin/bash', 08:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:33 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:33 INFO - 'USER': 'cltbld', 08:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:33 INFO - 'XPC_FLAGS': '0x0', 08:50:33 INFO - 'XPC_SERVICE_NAME': '0', 08:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:37 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 08:50:37 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 08:50:37 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 08:50:37 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 08:50:37 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 08:50:37 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 08:50:37 INFO - Downloading docopt-0.6.1.tar.gz 08:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:37 INFO - Running setup.py install for blobuploader 08:50:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:38 INFO - Running setup.py install for requests 08:50:38 INFO - Running setup.py install for docopt 08:50:38 INFO - Successfully installed blobuploader requests docopt 08:50:38 INFO - Cleaning up... 08:50:38 INFO - Return code: 0 08:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:38 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:38 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 08:50:38 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 08:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:38 INFO - 'HOME': '/Users/cltbld', 08:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:38 INFO - 'LOGNAME': 'cltbld', 08:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:38 INFO - 'MOZ_NO_REMOTE': '1', 08:50:38 INFO - 'NO_EM_RESTART': '1', 08:50:38 INFO - 'PAGER': '/bin/cat', 08:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:38 INFO - 'PWD': '/builds/slave/test', 08:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:38 INFO - 'SHELL': '/bin/bash', 08:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:38 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:38 INFO - 'USER': 'cltbld', 08:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:38 INFO - 'XPC_FLAGS': '0x0', 08:50:38 INFO - 'XPC_SERVICE_NAME': '0', 08:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-eliybF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-uiNIZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-q4uy33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-A83kM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-JcCn4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-pGvrmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-LBJ4hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-SFf2qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-zwe6nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-ezvyJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-z_XQK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-66SWOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-T0429_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-X3xGRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-MXLOLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-FFklzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-nqenZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:40 INFO - Running setup.py install for manifestparser 08:50:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:40 INFO - Running setup.py install for mozcrash 08:50:41 INFO - Running setup.py install for mozdebug 08:50:41 INFO - Running setup.py install for mozdevice 08:50:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Running setup.py install for mozfile 08:50:41 INFO - Running setup.py install for mozhttpd 08:50:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Running setup.py install for mozinfo 08:50:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Running setup.py install for mozInstall 08:50:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:41 INFO - Running setup.py install for mozleak 08:50:42 INFO - Running setup.py install for mozlog 08:50:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Running setup.py install for moznetwork 08:50:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Running setup.py install for mozprocess 08:50:42 INFO - Running setup.py install for mozprofile 08:50:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Running setup.py install for mozrunner 08:50:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:42 INFO - Running setup.py install for mozscreenshot 08:50:43 INFO - Running setup.py install for moztest 08:50:43 INFO - Running setup.py install for mozversion 08:50:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:43 INFO - Cleaning up... 08:50:43 INFO - Return code: 0 08:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:43 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:43 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 08:50:43 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 08:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:43 INFO - 'HOME': '/Users/cltbld', 08:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:43 INFO - 'LOGNAME': 'cltbld', 08:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:43 INFO - 'MOZ_NO_REMOTE': '1', 08:50:43 INFO - 'NO_EM_RESTART': '1', 08:50:43 INFO - 'PAGER': '/bin/cat', 08:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:43 INFO - 'PWD': '/builds/slave/test', 08:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:43 INFO - 'SHELL': '/bin/bash', 08:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:43 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:43 INFO - 'USER': 'cltbld', 08:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:43 INFO - 'XPC_FLAGS': '0x0', 08:50:43 INFO - 'XPC_SERVICE_NAME': '0', 08:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:43 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-QlnaBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:43 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)) 08:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:43 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-pZ8cQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:43 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-0ONdjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:43 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)) 08:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:43 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-GsOYL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-j7XKPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Xc1wqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-32Zf9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-XV8WVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-pa1qxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-HusOwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-8C7beq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Nd9vzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:44 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)) 08:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:44 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-TE_Pb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:45 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)) 08:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:45 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-tTS7ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:45 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-OEySTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:45 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)) 08:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:45 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-aVvbWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:45 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-ZqgBHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:45 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)) 08:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:45 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)) 08:50:45 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)) 08:50:45 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)) 08:50:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:45 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 08:50:45 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 08:50:45 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 08:50:45 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 08:50:45 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 08:50:45 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 08:50:48 INFO - Downloading blessings-1.6.tar.gz 08:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:48 INFO - Installing collected packages: blessings 08:50:48 INFO - Running setup.py install for blessings 08:50:48 INFO - Successfully installed blessings 08:50:48 INFO - Cleaning up... 08:50:48 INFO - Return code: 0 08:50:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:48 INFO - Reading from file tmpfile_stdout 08:50:48 INFO - Current package versions: 08:50:48 INFO - blessings == 1.6 08:50:48 INFO - blobuploader == 1.2.4 08:50:48 INFO - docopt == 0.6.1 08:50:48 INFO - functools32 == 3.2.3-2 08:50:48 INFO - jsonschema == 2.5.1 08:50:48 INFO - manifestparser == 1.1 08:50:48 INFO - mozInstall == 1.12 08:50:48 INFO - mozcrash == 1.0 08:50:48 INFO - mozdebug == 0.1 08:50:48 INFO - mozdevice == 0.48 08:50:48 INFO - mozfile == 1.2 08:50:48 INFO - mozhttpd == 0.7 08:50:48 INFO - mozinfo == 0.9 08:50:48 INFO - mozleak == 0.1 08:50:48 INFO - mozlog == 3.4 08:50:48 INFO - moznetwork == 0.27 08:50:48 INFO - mozprocess == 0.23 08:50:48 INFO - mozprofile == 0.28 08:50:48 INFO - mozrunner == 6.13 08:50:48 INFO - mozscreenshot == 0.1 08:50:48 INFO - mozsystemmonitor == 0.3 08:50:48 INFO - moztest == 0.8 08:50:48 INFO - mozversion == 1.4 08:50:48 INFO - psutil == 3.1.1 08:50:48 INFO - requests == 1.2.3 08:50:48 INFO - wsgiref == 0.1.2 08:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:48 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')]} 08:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:49 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 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:49 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 08:50:49 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 08:50:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:49 INFO - 'HOME': '/Users/cltbld', 08:50:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:49 INFO - 'LOGNAME': 'cltbld', 08:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:49 INFO - 'MOZ_NO_REMOTE': '1', 08:50:49 INFO - 'NO_EM_RESTART': '1', 08:50:49 INFO - 'PAGER': '/bin/cat', 08:50:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:49 INFO - 'PWD': '/builds/slave/test', 08:50:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:49 INFO - 'SHELL': '/bin/bash', 08:50:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:49 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:49 INFO - 'USER': 'cltbld', 08:50:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:49 INFO - 'XPC_FLAGS': '0x0', 08:50:49 INFO - 'XPC_SERVICE_NAME': '0', 08:50:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 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)) 08:50:49 INFO - Cleaning up... 08:50:49 INFO - Return code: 0 08:50:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017b1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101727570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333548420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, '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.mNJw4GbNpo/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.H3r5IukGER/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 08:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:50 INFO - 'HOME': '/Users/cltbld', 08:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:50 INFO - 'LOGNAME': 'cltbld', 08:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:50 INFO - 'MOZ_NO_REMOTE': '1', 08:50:50 INFO - 'NO_EM_RESTART': '1', 08:50:50 INFO - 'PAGER': '/bin/cat', 08:50:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:50 INFO - 'PWD': '/builds/slave/test', 08:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:50 INFO - 'SHELL': '/bin/bash', 08:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:50:50 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:50 INFO - 'USER': 'cltbld', 08:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:50 INFO - 'XPC_FLAGS': '0x0', 08:50:50 INFO - 'XPC_SERVICE_NAME': '0', 08:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:50 INFO - Cleaning up... 08:50:50 INFO - Return code: 0 08:50:50 INFO - Running post-action listener: _resource_record_post_action 08:50:50 INFO - Running post-action listener: _start_resource_monitoring 08:50:50 INFO - Starting resource monitoring. 08:50:50 INFO - [mozharness: 2017-02-27 16:50:50.437908Z] Finished create-virtualenv step (success) 08:50:50 INFO - [mozharness: 2017-02-27 16:50:50.438893Z] Running install step. 08:50:50 INFO - Running pre-action listener: _resource_record_pre_action 08:50:50 INFO - Running main action method: install 08:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Output received: 08:50:50 INFO - Usage: mozinstall [options] installer 08:50:50 INFO - Options: 08:50:50 INFO - -h, --help show this help message and exit 08:50:50 INFO - -d DEST, --destination=DEST 08:50:50 INFO - Directory to install application into. [default: 08:50:50 INFO - "/builds/slave/test"] 08:50:50 INFO - --app=APP Application being installed. [default: firefox] 08:50:50 INFO - mkdir: /builds/slave/test/build/application 08:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:51:12 INFO - Reading from file tmpfile_stdout 08:51:12 INFO - Output received: 08:51:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:51:12 INFO - Running post-action listener: _resource_record_post_action 08:51:12 INFO - [mozharness: 2017-02-27 16:51:12.584751Z] Finished install step (success) 08:51:12 INFO - [mozharness: 2017-02-27 16:51:12.584894Z] Running run-tests step. 08:51:12 INFO - Running pre-action listener: _resource_record_pre_action 08:51:12 INFO - Running main action method: run_tests 08:51:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:12 INFO - 2017-02-27 08:51:12.599 screenresolution[1634:7261] starting screenresolution argv=screenresolution get 08:51:12 INFO - 2017-02-27 08:51:12.602 screenresolution[1634:7261] Display 0: 1600x1200x32@60 08:51:12 INFO - 2017-02-27 08:51:12.608 screenresolution[1635:7264] starting screenresolution argv=screenresolution list 08:51:12 INFO - Available Modes on Display 0 08:51:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:12 INFO - Intel Iris: 08:51:12 INFO - Chipset Model: Intel Iris 08:51:12 INFO - Type: GPU 08:51:12 INFO - Bus: Built-In 08:51:12 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:12 INFO - Vendor: Intel (0x8086) 08:51:12 INFO - Device ID: 0x0a2e 08:51:12 INFO - Revision ID: 0x0009 08:51:12 INFO - Displays: 08:51:12 INFO - Display: 08:51:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:12 INFO - Display Serial Number: 1600x1200 60 08:51:12 INFO - Main Display: Yes 08:51:12 INFO - Mirror: Off 08:51:12 INFO - Online: Yes 08:51:12 INFO - Rotation: Supported 08:51:12 INFO - Return code: 0 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:12 INFO - Python 2.7.3 08:51:12 INFO - Return code: 0 08:51:12 INFO - grabbing minidump binary from tooltool 08:51:12 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')]} 08:51:12 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 0x1015c5d30>, '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 0x10142bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:12 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 08:51:12 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 08:51:12 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 08:51:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:12 INFO - Return code: 0 08:51:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:51:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:51:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0355 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mNJw4GbNpo/Render', 08:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:12 INFO - 'HOME': '/Users/cltbld', 08:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:12 INFO - 'LOGNAME': 'cltbld', 08:51:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:12 INFO - 'MOZ_NO_REMOTE': '1', 08:51:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:12 INFO - 'NO_EM_RESTART': '1', 08:51:12 INFO - 'PAGER': '/bin/cat', 08:51:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:12 INFO - 'PWD': '/builds/slave/test', 08:51:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:12 INFO - 'SHELL': '/bin/bash', 08:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3r5IukGER/Listeners', 08:51:12 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 08:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:12 INFO - 'USER': 'cltbld', 08:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:12 INFO - 'XPC_FLAGS': '0x0', 08:51:12 INFO - 'XPC_SERVICE_NAME': '0', 08:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:51:13 INFO - mozversion application_buildid: 20170227061809 08:51:13 INFO - mozversion application_changeset: 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 08:51:13 INFO - mozversion application_display_name: Firefox 08:51:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:13 INFO - mozversion application_name: Firefox 08:51:13 INFO - mozversion application_remotingname: firefox 08:51:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:51:13 INFO - mozversion application_vendor: Mozilla 08:51:13 INFO - mozversion application_version: 52.0 08:51:13 INFO - mozversion platform_buildid: 20170227061809 08:51:13 INFO - mozversion platform_changeset: 4bd2e5d2ac0d0b15b4446fca5647bfa821b52d46 08:51:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:51:13 INFO - mozversion platform_version: 52.0 08:51:13 INFO - using testdate: 1488214273 08:51:13 INFO - actual date: 1488214273 08:51:13 INFO - starting webserver on 'localhost:49236' 08:51:13 INFO - SUITE-START | Running 2 tests 08:51:13 INFO - TEST-START | dromaeo_css 08:51:13 INFO - operating with platform_type : mac_ 08:51:13 INFO - Initialising browser for dromaeo_css test... 08:51:13 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpDzvtks/profile http://localhost:49236/getInfo.html) 08:51:15 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:51:15 INFO - PROCESS | 1645 | colorDepth:24 08:51:15 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:51:15 INFO - PROCESS | 1645 | __metrics 08:51:16 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:16 INFO - PROCESS | 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:16 INFO - TEST-INFO | 1645: exit 0 08:51:16 INFO - Browser initialized. 08:51:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:16 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpDzvtks/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:28 INFO - PROCESS | 1648 | RSS: Main: 167747584 08:51:28 INFO - PROCESS | 1648 | 08:54:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:54:34 INFO - PROCESS | 1648 | RSS: Main: 309198848 08:54:34 INFO - PROCESS | 1648 | 08:57:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:57:37 INFO - PROCESS | 1648 | RSS: Main: 316997632 08:57:37 INFO - PROCESS | 1648 | 09:00:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 09:00:41 INFO - PROCESS | 1648 | RSS: Main: 264351744 09:00:41 INFO - PROCESS | 1648 | 09:03:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 09:03:43 INFO - PROCESS | 1648 | RSS: Main: 294895616 09:03:43 INFO - PROCESS | 1648 | 09:06:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 09:06:47 INFO - PROCESS | 1648 | RSS: Main: 262782976 09:06:47 INFO - PROCESS | 1648 | 09:09:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 09:09:51 INFO - PROCESS | 1648 | RSS: Main: 316514304 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | __start_tp_report 09:09:51 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:09:51 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:09:51 INFO - PROCESS | 1648 | |i|pagename|runs| 09:09:51 INFO - PROCESS | 1648 | |0;dojo.html;3522.6829585337314;3552.609212986573;3565.6434356564337;3583.8208089595514;3599.7840129592228;5921.467067963882;5978.760849566023;6027.216461859963;6027.336992930774;6028.45743883051;5969.522438204944;6039.456448919596;6041.546883983708;6043.244594425697;6046.455818976291;4405.964598319409;5314.3091398118195;5316.9734151329185;5335.1997200420055;5423.457654234585;5289.471052894718;5307.814226502073;5312;5432.320959880015;5438.782448702047;5347.331583552056;5371.919421208685;5415.458454154593;5419.105847535152;5422.37642671092;5358.812441564526;5374.4625537445945;5383.0041442333295;5385.596080293974;5424.511793938565;5292.020976119392;5354.303940487751;5369.114096174127;5386.569074474032;5395.082835917903;5748.798792042258;5784.68184249866;5789.363170051291;5987.37132601075;6007.15899774032;6288.654124023177;6306.0225665022;6316.210473690789;6326.778562750282;6338.968305158444;6343;6347.111404403341;6350.460210882081;6365.713542890581;6368.044793280998;5874.0601503760045;5955.553333499918;6049.183360246355;6049.606775559574;6051.485623722033;6375.681215939185;6399.104125422445;6411.102445657519;6496.837579060561;6523.445507131947;6324.810255692337;6328.050792381087;6340.953742632414;6341.904871426932;6351.523635727339;6283.371662833772;6297.96851015742;6299.559030867796;6360.554761166766;6379.55343125986;6283.622982621057;6309.716062777186;6327.683615819191;6340.556161068773;6382.138411314506;6354.26925903527;6354.523410744213;6364.077208804697;6364.554481186365;6368.076628888785;5042.747862606855;5091.1854103343285;5099.337086178847;5105.9489405106215;5133.666311689728;4460.77696115193;4511.300748384006;4532.388127602798;4544.863654090383;4560.156371071363;6065.5450841187085;6091.604045737102;6093.146959425684;6096.146539484475;6110;5738.053221218453;6154.5076393888385;6290.276618188876;6324.367563243639;6378.170837791057;5850.736716847667;5959.970200148971;5967.104934259895;6045.274567051894;6072.392760723892;5579.609427340129;5604.887902241932;5619.100943849046;5641.661500309912;5645.491905728504;6596.208454985433;6605.537612367184;6637.236717777324;6639.402453779183;6656.500762442739;5124.436312005751;6310.5898116622275;6353;6361.777337793155;6371.076193951943;6355.5551111421755;6443.838904027437;6488.253850807028;6525.282218956006;6548.705308261045;5781.364049954417;6031.728572214349;6281.905771413341;6335.841603959938;6337.65142917144;5688.431156884279;6242.219722534684;6270.12218289449;6296.118543403835;6322.399372059647;6132.630864714964;6258;6295.685215739103;6326;6327.905081423874;6191.133241346125;6200.3799620037635;6217.564770466205;6261.96869015652;6314.526410519321;6155.384461553988;6207.596506227262;6216.564840461305;6218.595791273553;6229.065640154013;6314.715837787218;6325.525585581192;6331.860265152317;6341.7780377688405;6360.586561873649;5984.910226346696;6022.36765139654;6061.848453788691;6084.39156084388;6124.846878827887 09:09:51 INFO - PROCESS | 1648 | |1;ext.html;507.4975773983755;510.25757522804315;528.2525226804072;542.3248056170069;546.1589152704837;30465.39069218614;32810.015699528994;32817.50773738396;40012.79993600028;41482.58517414825;42905;43385.915352116215;43388.78305608476;43435.565644343544;43469.7826510867;9486.857697134548;9629.3259471837;9655.903440965605;9667.081627245436;9670.178034867045;9427.434353938752;9492.905070949271;9499.335046546745;9514.238860891111;9538.904610953905;9474.952625236865;9529.142377186052;9542.570584323686;9553.665621703241;9556.187724043464;9447.527623618826;9508.334416590877;9512.809743805154;9513.476758778264;9522.523873806282;9466.526673666289;9534.427934323963;9551.808963820755;9555.61777528898;9559.952200238955;40606;40697.38953915694;40892.59107408918;41033.794831025654;41037.589624103675;3217.951730724041;3455.2398472336045;3752.4558938953974;3995.4805875236034;4001.8799436016966;29023.274418139503;29839.85080074586;30104.8494757527;31509.897153599515;31851.203719906956;3191.978566858606;3320.1865542942132;3398.490226466025;3421.555197824292;3431.3995050866247;506787;507406;507928;509374;511211;61129.38870611326;61618.69190654018;61734.69132654308;61744.382556174765;61860.74183694347;64754;64864.35135648583;64909.67545162244;65062;65089.34910650833;16928.915355423145;17136.314547418213;17139.57151071208;17156.914215429093;17213.7417938731;13203.537876174289;13267.601971940665;13275.867241327656;13300.068995170244;13325.400356983959;13619.26493719393;17454.476365709048;17455.563610909576;17480.47558573245;17673.939563626223;6091.908621370683;6344.68276586178;6631.635260060743;6670.433013193836;6726.730930762715;792.5561685456163;945.7257395355407;968.8546717992358;980.945483605113;1034.095166729112;29252;29601.85199073991;29680.851595741882;30248.395032099674;30610.84694576513;820.1757233979812;1055.482813421418;1059.9470026498643;1093.8632670916136;1094.8412480190327;15007.174605396589;15406.922965385325;15417.074975501506;15418.6145346365;15738.842611573738;636750;639859;640045;641814;642669;59048.11427828586;59328.70335648294;59414.70292648509;59461.702691486265;59468.405315946286;1217.3000524698334;1241.3544956622507;1323.4441534555701;1344.4084602774944;1375.0924389902616;30424.239394015327;30465.23836904095;31100.755969760958;31321.8433907829;31988.880389186266;50344.74827625838;55941.881162375714;56386.43613563976;56434.435655644564;60560.183194504236;604994;610370;610372;610679;611427;24028.39929001789;24361.87819060964;25995.61006584865;26327.605085923344;26421.471570568097;46847;46849.53150468451;46990.76504617455;47126.76436617795;47256.054878901545;37084.6291537092;37662;37832.43251351287;37888.81055594704;38871.6112838868;37746;37917.86246412612;38230.61769382271;38767.6123238764;39379.409308860966;37879.62120378871;38380.42429363506;38700.41949370706;38786.41820372753;38903;27255.727442725318;31741.365172695954;34429.82785086059;34580.789672361345;34751.304973900886;24675.876620616782;25214.62178067367;25613.615795762707;25662.871685641454;26226.213213603623 09:09:51 INFO - PROCESS | 1648 | |2;jquery.html;375.78580209280705;387.2962961178848;391.34645142611834;392.43881249812773;403.209708970418;14046.052474400705;19303.938283394407;20185.798142018575;20521.17915283387;20558.972051397428;16056.919715401407;19314;19409.12658930348;20510.589788204226;20643.380698579065;5378.381486129097;5431.538319242869;5444.128939369702;5873.85315367115;5884.499817515516;5237.292965449654;5872.354041055481;5879.441453061973;5943.019401798698;5964.761409543613;6059.545534084939;6064.3935606439445;6065.7573697052285;6084.148219249309;6098.81703548892;5809.912851307234;6058.303295121052;6479.6760161991715;6576.736930522773;6578.539502234846;5811.157382179603;5813.767449302065;5824.796132135355;5826.2134611827705;5835.299764028344;20112.698309525367;23453.882730586407;24154.275371738877;24498.387540311458;25308.861101250488;2281.783230593091;2310.27226423676;2550.966858422342;2840.1763488588285;2897.5219088850313;9937.552810123561;10390.896091039143;10425.635102771366;12285.201461905037;14252.572422827332;1810.1492298619628;1814.9183286752127;1843.6036252205706;1866.8973206473638;1905.8665893387467;73510.89017477387;77188.61405692992;79645.60177199135;118376.75420835007;123034.38482807619;11062.39156846365;11160.832587511193;11534.653960381202;11554.306741595363;11640.883591164149;14784.556463306119;14794.556163315117;14801.703965920622;14802.481913132988;14805.851941480663;7576.469647124759;7852.136265010844;7855.7250496232355;8425.536595487307;8495.872561911576;8279.764463594796;8475.364347673825;8493.702720404879;8654.524001179996;8681.479111253346;4446.68822697305;4523.570260825217;4527.162474942146;4601.907961840744;4613.331066995267;1584.5246426072133;1760.9911950440166;1804.4496428589143;1895.8578106642058;1911.2450582020024;779.0223269796483;783.6551917156432;819.713100414862;866.5234121233296;924.2236521321987;19627.411177664693;19746.30887918916;20482.89758551198;20770.376888693365;20802.27192048271;876.1632640827994;885.6324625280437;902.8374892519279;922.5894476957824;928.2063835420618;10716.624918127829;10916.836247456295;10966.945165274123;11014.559417623366;11048.116150708085;568331;569441.0695625633;576042.2395776073;580152;580376;127408.72591273968;132182;133632;134443;136819;957.2437774158476;968.2302569457298;979.4710856137748;992.0278127435154;993.011953106649;16883.577910552336;17869.910650447186;18209.908950455163;18239.179236934106;18400.11902400296;27687;51607.709807255116;52335;52555;54735.178972316244;48449.75775121102;77162.45675086355;79469.60265198637;80945;81183.59408202922;7797.610119494116;7893.644785984759;7964.2433968772875;8090.797730056795;8159.306458951056;10468.214883883587;11122.388268645302;11269.943650282024;11403.429828508708;12010.75978480443;10317.48412579353;10529.473526323807;10631.521581529005;11067.335959842436;11112.555497779998;10479.318844275098;10710.73223169427;10842.512086955949;10848.132149428184;10927;10835.916408359417;11059.778804423706;11091;11116.943365477413;11238.213325067167;6907.171139463297;7315.561066336037;7465.29079737424;7915.722949696963;8086.353091752763;10555.050045495942;10625.8937410628;10962.671119866416;11015.953484418967;11122.388268645302 09:09:51 INFO - PROCESS | 1648 | |3;mootools.html;1514.1596413990237;1546.4896584127239;1728.144568438623;1764.4794785538265;1889.5748456597275;7537.24627537246;7756.883646745289;8017.278444939954;8436.957815210922;8459.069502354743;7986.1614530474335;8230.670773169066;8260.380471464634;8357.95821020894;8364.916350836489;2368.1829768729804;2404.1825779235055;2405.458771776345;2407.723111842134;2408.421978725111;2398.832081754278;2421.2857207123852;2424.745401732819;2433.926982190528;2442.1086303499183;2354.0936739355384;2354.776296251853;2382.309130352196;2387.212219967407;2391.8325717199805;2334.704239147273;2343.3321503371544;2369.0642196332437;2370.371851459356;2373.6439534069855;2353.2469609724894;2367.147826782357;2391.0794344177616;2391.7847393734646;2395.4131237846664;8218.671253149867;8389.07720150783;8394.538300393477;8396.412251142423;8405;3993.4608827808456;4623.375844261015;5079.85703216777;5255.684658920477;5258.658187217857;3383.5263063171174;3458.2046129390383;3458.239187378773;3468.7051600613977;3476.9916724149966;1040.1159014837328;1075.5805235957982;1076.2358725305044;1095.4030053620795;1104.7735214281054;10841.620543281026;10933.507992140294;10949.616763413322;10957.616483423122;10963.342199468058;3951.3677811550015;4335.154644844288;4461.219286624892;4533.138703646297;4538.818447262139;8735.868961965576;8748.518831464204;8750.693725719697;8760.474371537728;8766.649334026695;5148.253503242009;5149.536541711264;5154.871128221749;5159.2003239497935;5173.3533308336455;4188.623023927861;4378.408914796525;4719.669623126349;4772.95227047732;4828.299896514985;3655.305491956573;3718.795466249328;3763.698904087721;3800.1639639279315;3813.1801662642665;1165.1319766773638;1166.381817636654;1170.53763763313;1181.3620644851856;1182.6274723462082;752.9209433009455;852.9530875801767;901.3195037746591;904.0778406025817;910.9817803644023;5621.7751289948765;5652.660840349592;5763.250777398911;5817.563682723812;6036.0644100164545;875.5009644502572;892.205936716323;914.92680585553;933.2114363362947;939.6758118449125;3358.7648864579733;3803.4294855771855;3941.7043721720984;3979.243943650697;4067;9955.900440995641;10181.847272290921;10304.021117993778;10304.536295866705;10358.015988481082;10259.230557708202;10263.12763415118;10271.691849244535;10275.383476991256;10278.691639250834;7926.841463170705;8085.110637829834;8092.312153467021;8093.676252949816;8094.554799486084;5062.316587260672;5354.9464505354445;5373.4357892422295;5856.267966504187;5985.281766188085;8069.273765361146;9309.022552631875;9439.386439881386;9463.810723785624;9473.431594104375;8926.955365223132;9294.72115836526;9451.810963780548;9477.526123693926;9640.951795240979;6961.686724097326;7134.536255143399;7167.247439019036;7213.891791623235;7309.232530584425;7968.721094761656;8035.4375193738215;8038.758837234892;8049.436539442183;8071.636776344961;7045.753398631228;7232.855342893218;7236.529625574321;7314.305141011595;7349.30181632744;6107.328193898578;7094.787156385317;7108.179445855243;7136.179339376038;7225.747098851515;6728.798136055926;6735.057092007025;6820.147481564804;6823.897641535282;6839.93160068393;4885.877853053702;4943.8516844494725;4947.158982972831;4967.428745694291;5039.395272567315;4231.682623803165;4331.371951067141;4963.379577552806;4989.401271847401;5123.615728820428 09:09:51 INFO - PROCESS | 1648 | |4;prototype.html;308.8903439279056;310.24919694339695;318.0553755346621;323.8170433704955;323.90930539448965;4657.51096134906;4911.519682560306;5326.547243484304;5336.199570064492;5366.409694933554;4037.8303032119793;4789.257665061921;5118.181091025437;5140.974295128529;5324.54741346985;3532.7037425673325;3792.184680293736;3993.9001524961964;4010.278149933011;4039.4950631171105;4005.6394924456795;4015.7873701039052;4031.979840100795;4032.6572241359518;4039.333509970866;3884.640375868452;3996.3406038003695;3999.7800120993334;4001.559828418872;4002.6597739192202;3478.4260597001467;3988.3818008208773;4003.6987978906973;4017.5379831319333;4032.5564187939303;2939.970600293991;3015.381846721417;3287.7862938908893;3439.6560343965652;3518.894433167009;4377.496587892401;4556.951901062774;5156.097682905514;5175.456577059392;5194.610404219661;3516.9648303517147;4556.476005259405;4591.977040114812;4619.630429565626;4619.9076018479445;5005.974970125126;5298.761555730001;5413.972930135364;5530.115181570929;5552.91670624941;3243.837808109609;3892.6885849132;3894.176721876645;3900.1614652849776;3910.765354078736;5475.7262136893;5507.642003269814;5736.856578585527;5739.426057394269;5815.88368232633;3654.3970244909824;3936.5866584008268;3948.763074215556;3954.5565868457807;3960.5049368828895;3677.9632203678157;3704.49989251453;3743.008102852746;4021.170367482788;4039.6162364575316;3600.7299452541165;4243;4267.786610669454;4652.976735116303;4673.859784206479;5400.514858413889;5515.132131291706;5563.777448902079;5572.263575960482;5606.55147588192;1106.1095817866533;1202.7113492761673;1264.3994102801096;1290.1291628150962;1291.7222797098668;827.185222555782;845.1843970568431;852.7953291210189;853.2891552437447;856.952867592276;4596.287575425815;4891.315215869781;4942.654014218971;5153.896922061538;5184.5593124584075;4853.684510506806;5063.5695965843315;5474.5894057945015;5751.482366587027;5764.654120752768;4604.907901842012;4872.878178045577;5158.63889527737;5296.708681022581;5345.492178243061;2540.0949288033976;2778.7082356352294;2845.160677600113;2860.32559556815;2865.7134286571177;4836.347093142381;4841.394825646794;4893.681910675795;5459.808906688247;5714.771409143587;4447.3989363829;4752.7385993769985;4892.315075889378;5240.292560504359;5434.347878254555;4754.738489383117;4958.553730164231;5245.973770131125;5357.223202635596;5479.890402192013;4364.678967821897;5194.454582268807;5399.29809124827;5417.620766546304;5418.376886657927;5313.546194973298;5355.30381050461;5372.811951581676;5390.892182156256;5414.88994756082;5201.661891977009;5260.9741100485035;5435.619506634498;5645.322561292671;5692.573057020657;3545.2554963457965;3652.251288485907;3670.870270945187;3673.2469843682516;3687.3362794697214;4508.752018639007;4555.453345598549;5245.396779370269;5470.890582188414;5534.557235421237;5261.73691315425;5267.604929630216;5281.128613778684;5290.73022474611;5303.337082864642;4886.315915771866;5233.188855727369;5244.606654501004;5265.368155821326;5302.840914772563;4418.504797947013;4689.835855745033;4728.810847566059;5074.340335756328;5129.53834154913;4780.95219047805;5303.310569626078;5461.371942226536;5522.1500797233375;5569.35952365467;5436.157395603688;5442.2108794225405;5461.9453805461435;5466.644668096561;5469.644473109235 09:09:51 INFO - PROCESS | 1648 | |5;yui.html;706.7420391557082;709.6380845768659;765.1812560560203;775.1163673412308;802.241881422056;14179.361928713206;15145.848541514582;15154.696906061872;15190.392384304629;15200.61998450038;13515.053946223768;13602.591922242324;13668.863311366908;13707.38316775745;13707.45170193191;687.6286805125227;708.5925592784143;845.7251393297172;858.5449711652834;870.5777697816554;861.7845538615346;861.9741407757746;863.1153068105211;873.3624454148476;875.1292463998299;940.9858852117189;946.280826571807;948.0993056596227;948.2461443152711;948.928830337724;930.7068273493828;938.5025936253796;938.7277689470045;942.4204114469586;946.6071580294204;690.1683471416931;691.6023286610219;703.0684343245169;707.0278367245038;710.3322876496129;14541.27293635314;14576.781348279785;14751.852481475154;14789.112653240732;15054.322555485029;14197.858021419757;14478.927605361905;14498.130112193303;14602.926985365111;14607.123572585679;11642.708932276677;11819.881801181964;11838;11841.348725820077;11909.702257443547;3716;3742.3450896093077;3797.411401232813;3973.8013099345208;4015.99600099975;91525;93099;93417;93421.13157736875;94718.5264073682;11061.281016734047;11074.390908499949;11259.774804503864;11428.200025998267;11437.828432573519;22438.43903902383;22736.886315568318;22744.31767046991;22810;22832.543349132924;7472.17806041335;7575.6969721211635;7665.8850117248285;7731.188225236382;8047.919520804717;4255.659547236213;4259.531451540328;4372.147431250875;4398.186335527937;4505.414296141481;3436.8281585921104;3511.999080262164;3536.3104194682305;3550.289942011608;3553.862763915522;626.946709529686;631.0754744299624;640.1230314469113;640.9903851442232;645.2869579115011;586.5131940489383;621.6075544650232;623.4077626255075;624.1979056911937;649.9187601549806;8457.661693532313;8837.513936733541;8899.644014239359;8968.506732129796;9143.177114059767;453.90974562140866;464.3638215644521;569.6923661222976;641.2561428742729;654.0842820051965;3580.7314451416246;3877.6316249956208;4357.934630980538;4416.889577760582;4461.470252713688;74203.62898185475;74528.62735686287;90043;93513.53243233876;115927;94351;98381.50809246051;98486;99625.5056174158;103200.45199322017;81723;85335;85778.14221857826;86377.56811215903;88101.11898881057;8538.103499132501;8555.82888342242;8597.742067737978;8666.35002374837;8769.342299327449;54852.45147548473;55118;55573;56381;58016.70991645015;76398.61800690962;76592.61703691445;76889;79371.80942285986;82401.58799206205;9473.715788526355;10688.519016644113;11048.558057677603;11559.133065019989;12001.819972700241;11548.711282218012;11945.761084778429;12090.274583525017;12216.328101954477;12242.204256723284;11194.44027798623;11403.657890263305;11688.88311116912;11885.762284754084;11965.282083075042;11177.552897883994;11225.550977961117;11983.221090629082;12002.1598488105;12224.816627750768;10565.26043177001;11393.829092563452;11525.366104864313;11595.5361785531;11733.35466549348;9229.49237791928;9756.51217439111;10027.849582256418;10160.44117573511;10220.693379198636;8605.612747426507;9637.9036209637;10007.199424046205;10009.799804004026;10018.048285412875 09:09:51 INFO - PROCESS | 1648 | __end_tp_report 09:09:51 INFO - PROCESS | 1648 | __start_cc_report 09:09:51 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1554 09:09:51 INFO - PROCESS | 1648 | __end_cc_report 09:09:51 INFO - PROCESS | 1648 | __startTimestamp1488215391246__endTimestamp 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:09:51 INFO - PROCESS | 1648 | Number of tests: 6 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5899.13 Median:6096.15 stddev:642.04 (10.5%) stddev-sans-first:616.35 09:09:51 INFO - PROCESS | 1648 | Values: 3522.7 3552.6 3565.6 3583.8 3599.8 5921.5 5978.8 6027.2 6027.3 6028.5 5969.5 6039.5 6041.5 6043.2 6046.5 4406.0 5314.3 5317.0 5335.2 5423.5 5289.5 5307.8 5312.0 5432.3 5438.8 5347.3 5371.9 5415.5 5419.1 5422.4 5358.8 5374.5 5383.0 5385.6 5424.5 5292.0 5354.3 5369.1 5386.6 5395.1 5748.8 5784.7 5789.4 5987.4 6007.2 6288.7 6306.0 6316.2 6326.8 6339.0 6343.0 6347.1 6350.5 6365.7 6368.0 5874.1 5955.6 6049.2 6049.6 6051.5 6375.7 6399.1 6411.1 6496.8 6523.4 6324.8 6328.1 6341.0 6341.9 6351.5 6283.4 6298.0 6299.6 6360.6 6379.6 6283.6 6309.7 6327.7 6340.6 6382.1 6354.3 6354.5 6364.1 6364.6 6368.1 5042.7 5091.2 5099.3 5105.9 5133.7 4460.8 4511.3 4532.4 4544.9 4560.2 6065.5 6091.6 6093.1 6096.1 6110.0 5738.1 6154.5 6290.3 6324.4 6378.2 5850.7 5960.0 5967.1 6045.3 6072.4 5579.6 5604.9 5619.1 5641.7 5645.5 6596.2 6605.5 6637.2 6639.4 6656.5 5124.4 6310.6 6353.0 6361.8 6371.1 6355.6 6443.8 6488.3 6525.3 6548.7 5781.4 6031.7 6281.9 6335.8 6337.7 5688.4 6242.2 6270.1 6296.1 6322.4 6132.6 6258.0 6295.7 6326.0 6327.9 6191.1 6200.4 6217.6 6262.0 6314.5 6155.4 6207.6 6216.6 6218.6 6229.1 6314.7 6325.5 6331.9 6341.8 6360.6 5984.9 6022.4 6061.8 6084.4 6124.8 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:71779.78 Median:40794.99 stddev:157439.28 (385.9%) stddev-sans-first:157790.00 09:09:51 INFO - PROCESS | 1648 | Values: 507.5 510.3 528.3 542.3 546.2 30465.4 32810.0 32817.5 40012.8 41482.6 42905.0 43385.9 43388.8 43435.6 43469.8 9486.9 9629.3 9655.9 9667.1 9670.2 9427.4 9492.9 9499.3 9514.2 9538.9 9475.0 9529.1 9542.6 9553.7 9556.2 9447.5 9508.3 9512.8 9513.5 9522.5 9466.5 9534.4 9551.8 9555.6 9560.0 40606.0 40697.4 40892.6 41033.8 41037.6 3218.0 3455.2 3752.5 3995.5 4001.9 29023.3 29839.9 30104.8 31509.9 31851.2 3192.0 3320.2 3398.5 3421.6 3431.4 506787.0 507406.0 507928.0 509374.0 511211.0 61129.4 61618.7 61734.7 61744.4 61860.7 64754.0 64864.4 64909.7 65062.0 65089.3 16928.9 17136.3 17139.6 17156.9 17213.7 13203.5 13267.6 13275.9 13300.1 13325.4 13619.3 17454.5 17455.6 17480.5 17673.9 6091.9 6344.7 6631.6 6670.4 6726.7 792.6 945.7 968.9 980.9 1034.1 29252.0 29601.9 29680.9 30248.4 30610.8 820.2 1055.5 1059.9 1093.9 1094.8 15007.2 15406.9 15417.1 15418.6 15738.8 636750.0 639859.0 640045.0 641814.0 642669.0 59048.1 59328.7 59414.7 59461.7 59468.4 1217.3 1241.4 1323.4 1344.4 1375.1 30424.2 30465.2 31100.8 31321.8 31988.9 50344.7 55941.9 56386.4 56434.4 60560.2 604994.0 610370.0 610372.0 610679.0 611427.0 24028.4 24361.9 25995.6 26327.6 26421.5 46847.0 46849.5 46990.8 47126.8 47256.1 37084.6 37662.0 37832.4 37888.8 38871.6 37746.0 37917.9 38230.6 38767.6 39379.4 37879.6 38380.4 38700.4 38786.4 38903.0 27255.7 31741.4 34429.8 34580.8 34751.3 24675.9 25214.6 25613.6 25662.9 26226.2 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:33387.16 Median:2868.85 stddev:95870.84 (3341.8%) stddev-sans-first:96107.74 09:09:51 INFO - PROCESS | 1648 | Values: 375.8 387.3 391.3 392.4 403.2 14046.1 19303.9 20185.8 20521.2 20559.0 16056.9 19314.0 19409.1 20510.6 20643.4 5378.4 5431.5 5444.1 5873.9 5884.5 5237.3 5872.4 5879.4 5943.0 5964.8 6059.5 6064.4 6065.8 6084.1 6098.8 5809.9 6058.3 6479.7 6576.7 6578.5 5811.2 5813.8 5824.8 5826.2 5835.3 20112.7 23453.9 24154.3 24498.4 25308.9 2281.8 2310.3 2551.0 2840.2 2897.5 9937.6 10390.9 10425.6 12285.2 14252.6 1810.1 1814.9 1843.6 1866.9 1905.9 73510.9 77188.6 79645.6 118376.8 123034.4 11062.4 11160.8 11534.7 11554.3 11640.9 14784.6 14794.6 14801.7 14802.5 14805.9 7576.5 7852.1 7855.7 8425.5 8495.9 8279.8 8475.4 8493.7 8654.5 8681.5 4446.7 4523.6 4527.2 4601.9 4613.3 1584.5 1761.0 1804.4 1895.9 1911.2 779.0 783.7 819.7 866.5 924.2 19627.4 19746.3 20482.9 20770.4 20802.3 876.2 885.6 902.8 922.6 928.2 10716.6 10916.8 10966.9 11014.6 11048.1 568331.0 569441.1 576042.2 580152.0 580376.0 127408.7 132182.0 133632.0 134443.0 136819.0 957.2 968.2 979.5 992.0 993.0 16883.6 17869.9 18209.9 18239.2 18400.1 27687.0 51607.7 52335.0 52555.0 54735.2 48449.8 77162.5 79469.6 80945.0 81183.6 7797.6 7893.6 7964.2 8090.8 8159.3 10468.2 11122.4 11269.9 11403.4 12010.8 10317.5 10529.5 10631.5 11067.3 11112.6 10479.3 10710.7 10842.5 10848.1 10927.0 10835.9 11059.8 11091.0 11116.9 11238.2 6907.2 7315.6 7465.3 7915.7 8086.4 10555.1 10625.9 10962.7 11016.0 11122.4 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5448.40 Median:5071.09 stddev:2974.65 (58.7%) stddev-sans-first:2968.30 09:09:51 INFO - PROCESS | 1648 | Values: 1514.2 1546.5 1728.1 1764.5 1889.6 7537.2 7756.9 8017.3 8437.0 8459.1 7986.2 8230.7 8260.4 8358.0 8364.9 2368.2 2404.2 2405.5 2407.7 2408.4 2398.8 2421.3 2424.7 2433.9 2442.1 2354.1 2354.8 2382.3 2387.2 2391.8 2334.7 2343.3 2369.1 2370.4 2373.6 2353.2 2367.1 2391.1 2391.8 2395.4 8218.7 8389.1 8394.5 8396.4 8405.0 3993.5 4623.4 5079.9 5255.7 5258.7 3383.5 3458.2 3458.2 3468.7 3477.0 1040.1 1075.6 1076.2 1095.4 1104.8 10841.6 10933.5 10949.6 10957.6 10963.3 3951.4 4335.2 4461.2 4533.1 4538.8 8735.9 8748.5 8750.7 8760.5 8766.6 5148.3 5149.5 5154.9 5159.2 5173.4 4188.6 4378.4 4719.7 4773.0 4828.3 3655.3 3718.8 3763.7 3800.2 3813.2 1165.1 1166.4 1170.5 1181.4 1182.6 752.9 853.0 901.3 904.1 911.0 5621.8 5652.7 5763.3 5817.6 6036.1 875.5 892.2 914.9 933.2 939.7 3358.8 3803.4 3941.7 3979.2 4067.0 9955.9 10181.8 10304.0 10304.5 10358.0 10259.2 10263.1 10271.7 10275.4 10278.7 7926.8 8085.1 8092.3 8093.7 8094.6 5062.3 5354.9 5373.4 5856.3 5985.3 8069.3 9309.0 9439.4 9463.8 9473.4 8927.0 9294.7 9451.8 9477.5 9641.0 6961.7 7134.5 7167.2 7213.9 7309.2 7968.7 8035.4 8038.8 8049.4 8071.6 7045.8 7232.9 7236.5 7314.3 7349.3 6107.3 7094.8 7108.2 7136.2 7225.7 6728.8 6735.1 6820.1 6823.9 6839.9 4885.9 4943.9 4947.2 4967.4 5039.4 4231.7 4331.4 4963.4 4989.4 5123.6 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4366.53 Median:4879.60 stddev:1320.44 (27.1%) stddev-sans-first:1288.54 09:09:51 INFO - PROCESS | 1648 | Values: 308.9 310.2 318.1 323.8 323.9 4657.5 4911.5 5326.5 5336.2 5366.4 4037.8 4789.3 5118.2 5141.0 5324.5 3532.7 3792.2 3993.9 4010.3 4039.5 4005.6 4015.8 4032.0 4032.7 4039.3 3884.6 3996.3 3999.8 4001.6 4002.7 3478.4 3988.4 4003.7 4017.5 4032.6 2940.0 3015.4 3287.8 3439.7 3518.9 4377.5 4557.0 5156.1 5175.5 5194.6 3517.0 4556.5 4592.0 4619.6 4619.9 5006.0 5298.8 5414.0 5530.1 5552.9 3243.8 3892.7 3894.2 3900.2 3910.8 5475.7 5507.6 5736.9 5739.4 5815.9 3654.4 3936.6 3948.8 3954.6 3960.5 3678.0 3704.5 3743.0 4021.2 4039.6 3600.7 4243.0 4267.8 4653.0 4673.9 5400.5 5515.1 5563.8 5572.3 5606.6 1106.1 1202.7 1264.4 1290.1 1291.7 827.2 845.2 852.8 853.3 857.0 4596.3 4891.3 4942.7 5153.9 5184.6 4853.7 5063.6 5474.6 5751.5 5764.7 4604.9 4872.9 5158.6 5296.7 5345.5 2540.1 2778.7 2845.2 2860.3 2865.7 4836.3 4841.4 4893.7 5459.8 5714.8 4447.4 4752.7 4892.3 5240.3 5434.3 4754.7 4958.6 5246.0 5357.2 5479.9 4364.7 5194.5 5399.3 5417.6 5418.4 5313.5 5355.3 5372.8 5390.9 5414.9 5201.7 5261.0 5435.6 5645.3 5692.6 3545.3 3652.3 3670.9 3673.2 3687.3 4508.8 4555.5 5245.4 5470.9 5534.6 5261.7 5267.6 5281.1 5290.7 5303.3 4886.3 5233.2 5244.6 5265.4 5302.8 4418.5 4689.8 4728.8 5074.3 5129.5 4781.0 5303.3 5461.4 5522.2 5569.4 5436.2 5442.2 5461.9 5466.6 5469.6 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20282.04 Median:55345.50 stddev:29554.86 (53.4%) stddev-sans-first:29601.22 09:09:51 INFO - PROCESS | 1648 | Values: 706.7 709.6 765.2 775.1 802.2 14179.4 15145.8 15154.7 15190.4 15200.6 13515.1 13602.6 13668.9 13707.4 13707.5 687.6 708.6 845.7 858.5 870.6 861.8 862.0 863.1 873.4 875.1 941.0 946.3 948.1 948.2 948.9 930.7 938.5 938.7 942.4 946.6 690.2 691.6 703.1 707.0 710.3 14541.3 14576.8 14751.9 14789.1 15054.3 14197.9 14478.9 14498.1 14602.9 14607.1 11642.7 11819.9 11838.0 11841.3 11909.7 3716.0 3742.3 3797.4 3973.8 4016.0 91525.0 93099.0 93417.0 93421.1 94718.5 11061.3 11074.4 11259.8 11428.2 11437.8 22438.4 22736.9 22744.3 22810.0 22832.5 7472.2 7575.7 7665.9 7731.2 8047.9 4255.7 4259.5 4372.1 4398.2 4505.4 3436.8 3512.0 3536.3 3550.3 3553.9 626.9 631.1 640.1 641.0 645.3 586.5 621.6 623.4 624.2 649.9 8457.7 8837.5 8899.6 8968.5 9143.2 453.9 464.4 569.7 641.3 654.1 3580.7 3877.6 4357.9 4416.9 4461.5 74203.6 74528.6 90043.0 93513.5 115927.0 94351.0 98381.5 98486.0 99625.5 103200.5 81723.0 85335.0 85778.1 86377.6 88101.1 8538.1 8555.8 8597.7 8666.4 8769.3 54852.5 55118.0 55573.0 56381.0 58016.7 76398.6 76592.6 76889.0 79371.8 82401.6 9473.7 10688.5 11048.6 11559.1 12001.8 11548.7 11945.8 12090.3 12216.3 12242.2 11194.4 11403.7 11688.9 11885.8 11965.3 11177.6 11225.6 11983.2 12002.2 12224.8 10565.3 11393.8 11525.4 11595.5 11733.4 9229.5 9756.5 10027.8 10160.4 10220.7 8605.6 9637.9 10007.2 10009.8 10018.0 09:09:51 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:09:51 INFO - PROCESS | 1648 | 09:09:51 INFO - TEST-INFO | 1648: exit 0 09:09:51 INFO - TEST-OK | dromaeo_css | took 1118678ms 09:09:51 INFO - TEST-START | kraken 09:09:51 INFO - operating with platform_type : mac_ 09:09:51 INFO - Initialising browser for kraken test... 09:09:51 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpgAiXwd/profile http://localhost:49236/getInfo.html) 09:09:54 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:09:54 INFO - PROCESS | 1660 | colorDepth:24 09:09:54 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:09:54 INFO - PROCESS | 1660 | __metrics 09:09:54 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:09:54 INFO - PROCESS | 1660 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:55 INFO - TEST-INFO | 1660: exit 0 09:09:55 INFO - Browser initialized. 09:09:55 INFO - Running cycle 1/1 for kraken test... 09:09:55 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpgAiXwd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:07 INFO - PROCESS | 1662 | RSS: Main: 171921408 09:10:07 INFO - PROCESS | 1662 | 09:10:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:11 INFO - PROCESS | 1662 | RSS: Main: 221868032 09:10:11 INFO - PROCESS | 1662 | 09:10:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 09:10:14 INFO - PROCESS | 1662 | RSS: Main: 233803776 09:10:14 INFO - PROCESS | 1662 | 09:10:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 09:10:18 INFO - PROCESS | 1662 | RSS: Main: 330285056 09:10:18 INFO - PROCESS | 1662 | 09:10:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 09:10:20 INFO - PROCESS | 1662 | RSS: Main: 233058304 09:10:20 INFO - PROCESS | 1662 | 09:10:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:23 INFO - PROCESS | 1662 | RSS: Main: 235388928 09:10:23 INFO - PROCESS | 1662 | 09:10:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:26 INFO - PROCESS | 1662 | RSS: Main: 274763776 09:10:26 INFO - PROCESS | 1662 | 09:10:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:30 INFO - PROCESS | 1662 | RSS: Main: 275755008 09:10:30 INFO - PROCESS | 1662 | 09:10:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 09:10:33 INFO - PROCESS | 1662 | RSS: Main: 273575936 09:10:33 INFO - PROCESS | 1662 | 09:10:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:35 INFO - PROCESS | 1662 | RSS: Main: 248872960 09:10:35 INFO - PROCESS | 1662 | 09:10:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:38 INFO - PROCESS | 1662 | RSS: Main: 251236352 09:10:38 INFO - PROCESS | 1662 | 09:10:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:40 INFO - PROCESS | 1662 | RSS: Main: 254070784 09:10:40 INFO - PROCESS | 1662 | 09:10:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:44 INFO - PROCESS | 1662 | RSS: Main: 272306176 09:10:44 INFO - PROCESS | 1662 | 09:10:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:47 INFO - PROCESS | 1662 | RSS: Main: 265953280 09:10:47 INFO - PROCESS | 1662 | 09:10:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 09:10:50 INFO - PROCESS | 1662 | RSS: Main: 310501376 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | __start_tp_report 09:10:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:10:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:10:50 INFO - PROCESS | 1662 | |i|pagename|runs| 09:10:50 INFO - PROCESS | 1662 | |0;ai-astar;114;113;113;113;113;114;112;111;114;113 09:10:50 INFO - PROCESS | 1662 | |1;audio-beat-detection;141;108;110;142;109;113;108;107;136;109 09:10:50 INFO - PROCESS | 1662 | |2;audio-dft;194;255;206;184;184;184;187;182;183;183 09:10:50 INFO - PROCESS | 1662 | |3;audio-fft;83;97;77;89;59;58;58;57;82;57 09:10:50 INFO - PROCESS | 1662 | |4;audio-oscillator;86;70;93;68;67;69;88;67;68;91 09:10:50 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;84;89;86;89;77;137;133;89;85 09:10:50 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;95;97;98;94;94;95;95;94;95 09:10:50 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;80;89;129;82;83;83;84;81;82 09:10:50 INFO - PROCESS | 1662 | |8;json-parse-financial;52;52;52;53;54;56;57;56;55;55 09:10:50 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;68;67;76;72;67;67;68;68;68 09:10:50 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;82;83;82;81;82;77;94;101;83 09:10:50 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;141;135;136;136;135;153;142;139;184;136 09:10:50 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;167;169;169;168;167;169;167;168;168;172 09:10:50 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;65;69;78;85;86;86;75;66;64 09:10:50 INFO - PROCESS | 1662 | __end_tp_report 09:10:50 INFO - PROCESS | 1662 | __start_cc_report 09:10:50 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1927 09:10:50 INFO - PROCESS | 1662 | __end_cc_report 09:10:50 INFO - PROCESS | 1662 | __startTimestamp1488215450018__endTimestamp 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:10:50 INFO - PROCESS | 1662 | Number of tests: 14 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 09:10:50 INFO - PROCESS | 1662 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 112.0 111.0 114.0 113.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:111.50 stddev:14.91 (13.4%) stddev-sans-first:13.36 09:10:50 INFO - PROCESS | 1662 | Values: 141.0 108.0 110.0 142.0 109.0 113.0 108.0 107.0 136.0 109.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:194.20 Median:185.50 stddev:22.61 (12.2%) stddev-sans-first:23.98 09:10:50 INFO - PROCESS | 1662 | Values: 194.0 255.0 206.0 184.0 184.0 184.0 187.0 182.0 183.0 183.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:71.70 Median:79.50 stddev:15.53 (19.5%) stddev-sans-first:15.92 09:10:50 INFO - PROCESS | 1662 | Values: 83.0 97.0 77.0 89.0 59.0 58.0 58.0 57.0 82.0 57.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:11.20 (14.4%) stddev-sans-first:11.36 09:10:50 INFO - PROCESS | 1662 | Values: 86.0 70.0 93.0 68.0 67.0 69.0 88.0 67.0 68.0 91.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:87.00 stddev:21.05 (24.2%) stddev-sans-first:22.14 09:10:50 INFO - PROCESS | 1662 | Values: 88.0 84.0 89.0 86.0 89.0 77.0 137.0 133.0 89.0 85.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.39 09:10:50 INFO - PROCESS | 1662 | Values: 93.0 95.0 97.0 98.0 94.0 94.0 95.0 95.0 94.0 95.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:87.80 Median:83.00 stddev:14.69 (17.7%) stddev-sans-first:15.54 09:10:50 INFO - PROCESS | 1662 | Values: 85.0 80.0 89.0 129.0 82.0 83.0 83.0 84.0 81.0 82.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.87 (3.4%) stddev-sans-first:1.81 09:10:50 INFO - PROCESS | 1662 | Values: 52.0 52.0 52.0 53.0 54.0 56.0 57.0 56.0 55.0 55.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:3.13 (4.6%) stddev-sans-first:3.04 09:10:50 INFO - PROCESS | 1662 | Values: 65.0 68.0 67.0 76.0 72.0 67.0 67.0 68.0 68.0 68.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:82.50 stddev:7.09 (8.6%) stddev-sans-first:7.52 09:10:50 INFO - PROCESS | 1662 | Values: 85.0 82.0 83.0 82.0 81.0 82.0 77.0 94.0 101.0 83.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:140.00 stddev:15.17 (10.8%) stddev-sans-first:16.06 09:10:50 INFO - PROCESS | 1662 | Values: 141.0 135.0 136.0 136.0 135.0 153.0 142.0 139.0 184.0 136.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 09:10:50 INFO - PROCESS | 1662 | Values: 167.0 169.0 169.0 168.0 167.0 169.0 167.0 168.0 168.0 172.0 09:10:50 INFO - PROCESS | 1662 | 09:10:50 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:76.50 stddev:9.19 (12.0%) stddev-sans-first:9.28 09:10:50 INFO - PROCESS | 1662 | Values: 66.0 65.0 69.0 78.0 85.0 86.0 86.0 75.0 66.0 64.0 09:10:50 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:10:50 INFO - PROCESS | 1662 | 09:10:51 INFO - TEST-INFO | 1662: exit 0 09:10:51 INFO - TEST-OK | kraken | took 59270ms 09:10:51 INFO - SUITE-END | took 1177s 09:10:51 INFO - Completed test suite (00:19:38) 09:10:51 INFO - javascript benchmark 09:10:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3522.6829585337314, 3552.609212986573, 3565.6434356564337, 3583.8208089595514, 3599.7840129592228, 5921.467067963882, 5978.760849566023, 6027.216461859963, 6027.336992930774, 6028.45743883051, 5969.522438204944, 6039.456448919596, 6041.546883983708, 6043.244594425697, 6046.455818976291, 4405.964598319409, 5314.3091398118195, 5316.9734151329185, 5335.1997200420055, 5423.457654234585, 5289.471052894718, 5307.814226502073, 5312.0, 5432.320959880015, 5438.782448702047, 5347.331583552056, 5371.919421208685, 5415.458454154593, 5419.105847535152, 5422.37642671092, 5358.812441564526, 5374.4625537445945, 5383.0041442333295, 5385.596080293974, 5424.511793938565, 5292.020976119392, 5354.303940487751, 5369.114096174127, 5386.569074474032, 5395.082835917903, 5748.798792042258, 5784.68184249866, 5789.363170051291, 5987.37132601075, 6007.15899774032, 6288.654124023177, 6306.0225665022, 6316.210473690789, 6326.778562750282, 6338.968305158444, 6343.0, 6347.111404403341, 6350.460210882081, 6365.713542890581, 6368.044793280998, 5874.0601503760045, 5955.553333499918, 6049.183360246355, 6049.606775559574, 6051.485623722033, 6375.681215939185, 6399.104125422445, 6411.102445657519, 6496.837579060561, 6523.445507131947, 6324.810255692337, 6328.050792381087, 6340.953742632414, 6341.904871426932, 6351.523635727339, 6283.371662833772, 6297.96851015742, 6299.559030867796, 6360.554761166766, 6379.55343125986, 6283.622982621057, 6309.716062777186, 6327.683615819191, 6340.556161068773, 6382.138411314506, 6354.26925903527, 6354.523410744213, 6364.077208804697, 6364.554481186365, 6368.076628888785, 5042.747862606855, 5091.1854103343285, 5099.337086178847, 5105.9489405106215, 5133.666311689728, 4460.77696115193, 4511.300748384006, 4532.388127602798, 4544.863654090383, 4560.156371071363, 6065.5450841187085, 6091.604045737102, 6093.146959425684, 6096.146539484475, 6110.0, 5738.053221218453, 6154.5076393888385, 6290.276618188876, 6324.367563243639, 6378.170837791057, 5850.736716847667, 5959.970200148971, 5967.104934259895, 6045.274567051894, 6072.392760723892, 5579.609427340129, 5604.887902241932, 5619.100943849046, 5641.661500309912, 5645.491905728504, 6596.208454985433, 6605.537612367184, 6637.236717777324, 6639.402453779183, 6656.500762442739, 5124.436312005751, 6310.5898116622275, 6353.0, 6361.777337793155, 6371.076193951943, 6355.5551111421755, 6443.838904027437, 6488.253850807028, 6525.282218956006, 6548.705308261045, 5781.364049954417, 6031.728572214349, 6281.905771413341, 6335.841603959938, 6337.65142917144, 5688.431156884279, 6242.219722534684, 6270.12218289449, 6296.118543403835, 6322.399372059647, 6132.630864714964, 6258.0, 6295.685215739103, 6326.0, 6327.905081423874, 6191.133241346125, 6200.3799620037635, 6217.564770466205, 6261.96869015652, 6314.526410519321, 6155.384461553988, 6207.596506227262, 6216.564840461305, 6218.595791273553, 6229.065640154013, 6314.715837787218, 6325.525585581192, 6331.860265152317, 6341.7780377688405, 6360.586561873649, 5984.910226346696, 6022.36765139654, 6061.848453788691, 6084.39156084388, 6124.846878827887], "value": 5859.789001857001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.4975773983755, 510.25757522804315, 528.2525226804072, 542.3248056170069, 546.1589152704837, 30465.39069218614, 32810.015699528994, 32817.50773738396, 40012.79993600028, 41482.58517414825, 42905.0, 43385.915352116215, 43388.78305608476, 43435.565644343544, 43469.7826510867, 9486.857697134548, 9629.3259471837, 9655.903440965605, 9667.081627245436, 9670.178034867045, 9427.434353938752, 9492.905070949271, 9499.335046546745, 9514.238860891111, 9538.904610953905, 9474.952625236865, 9529.142377186052, 9542.570584323686, 9553.665621703241, 9556.187724043464, 9447.527623618826, 9508.334416590877, 9512.809743805154, 9513.476758778264, 9522.523873806282, 9466.526673666289, 9534.427934323963, 9551.808963820755, 9555.61777528898, 9559.952200238955, 40606.0, 40697.38953915694, 40892.59107408918, 41033.794831025654, 41037.589624103675, 3217.951730724041, 3455.2398472336045, 3752.4558938953974, 3995.4805875236034, 4001.8799436016966, 29023.274418139503, 29839.85080074586, 30104.8494757527, 31509.897153599515, 31851.203719906956, 3191.978566858606, 3320.1865542942132, 3398.490226466025, 3421.555197824292, 3431.3995050866247, 506787.0, 507406.0, 507928.0, 509374.0, 511211.0, 61129.38870611326, 61618.69190654018, 61734.69132654308, 61744.382556174765, 61860.74183694347, 64754.0, 64864.35135648583, 64909.67545162244, 65062.0, 65089.34910650833, 16928.915355423145, 17136.314547418213, 17139.57151071208, 17156.914215429093, 17213.7417938731, 13203.537876174289, 13267.601971940665, 13275.867241327656, 13300.068995170244, 13325.400356983959, 13619.26493719393, 17454.476365709048, 17455.563610909576, 17480.47558573245, 17673.939563626223, 6091.908621370683, 6344.68276586178, 6631.635260060743, 6670.433013193836, 6726.730930762715, 792.5561685456163, 945.7257395355407, 968.8546717992358, 980.945483605113, 1034.095166729112, 29252.0, 29601.85199073991, 29680.851595741882, 30248.395032099674, 30610.84694576513, 820.1757233979812, 1055.482813421418, 1059.9470026498643, 1093.8632670916136, 1094.8412480190327, 15007.174605396589, 15406.922965385325, 15417.074975501506, 15418.6145346365, 15738.842611573738, 636750.0, 639859.0, 640045.0, 641814.0, 642669.0, 59048.11427828586, 59328.70335648294, 59414.70292648509, 59461.702691486265, 59468.405315946286, 1217.3000524698334, 1241.3544956622507, 1323.4441534555701, 1344.4084602774944, 1375.0924389902616, 30424.239394015327, 30465.23836904095, 31100.755969760958, 31321.8433907829, 31988.880389186266, 50344.74827625838, 55941.881162375714, 56386.43613563976, 56434.435655644564, 60560.183194504236, 604994.0, 610370.0, 610372.0, 610679.0, 611427.0, 24028.39929001789, 24361.87819060964, 25995.61006584865, 26327.605085923344, 26421.471570568097, 46847.0, 46849.53150468451, 46990.76504617455, 47126.76436617795, 47256.054878901545, 37084.6291537092, 37662.0, 37832.43251351287, 37888.81055594704, 38871.6112838868, 37746.0, 37917.86246412612, 38230.61769382271, 38767.6123238764, 39379.409308860966, 37879.62120378871, 38380.42429363506, 38700.41949370706, 38786.41820372753, 38903.0, 27255.727442725318, 31741.365172695954, 34429.82785086059, 34580.789672361345, 34751.304973900886, 24675.876620616782, 25214.62178067367, 25613.615795762707, 25662.871685641454, 26226.213213603623], "value": 19962.58536101403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.78580209280705, 387.2962961178848, 391.34645142611834, 392.43881249812773, 403.209708970418, 14046.052474400705, 19303.938283394407, 20185.798142018575, 20521.17915283387, 20558.972051397428, 16056.919715401407, 19314.0, 19409.12658930348, 20510.589788204226, 20643.380698579065, 5378.381486129097, 5431.538319242869, 5444.128939369702, 5873.85315367115, 5884.499817515516, 5237.292965449654, 5872.354041055481, 5879.441453061973, 5943.019401798698, 5964.761409543613, 6059.545534084939, 6064.3935606439445, 6065.7573697052285, 6084.148219249309, 6098.81703548892, 5809.912851307234, 6058.303295121052, 6479.6760161991715, 6576.736930522773, 6578.539502234846, 5811.157382179603, 5813.767449302065, 5824.796132135355, 5826.2134611827705, 5835.299764028344, 20112.698309525367, 23453.882730586407, 24154.275371738877, 24498.387540311458, 25308.861101250488, 2281.783230593091, 2310.27226423676, 2550.966858422342, 2840.1763488588285, 2897.5219088850313, 9937.552810123561, 10390.896091039143, 10425.635102771366, 12285.201461905037, 14252.572422827332, 1810.1492298619628, 1814.9183286752127, 1843.6036252205706, 1866.8973206473638, 1905.8665893387467, 73510.89017477387, 77188.61405692992, 79645.60177199135, 118376.75420835007, 123034.38482807619, 11062.39156846365, 11160.832587511193, 11534.653960381202, 11554.306741595363, 11640.883591164149, 14784.556463306119, 14794.556163315117, 14801.703965920622, 14802.481913132988, 14805.851941480663, 7576.469647124759, 7852.136265010844, 7855.7250496232355, 8425.536595487307, 8495.872561911576, 8279.764463594796, 8475.364347673825, 8493.702720404879, 8654.524001179996, 8681.479111253346, 4446.68822697305, 4523.570260825217, 4527.162474942146, 4601.907961840744, 4613.331066995267, 1584.5246426072133, 1760.9911950440166, 1804.4496428589143, 1895.8578106642058, 1911.2450582020024, 779.0223269796483, 783.6551917156432, 819.713100414862, 866.5234121233296, 924.2236521321987, 19627.411177664693, 19746.30887918916, 20482.89758551198, 20770.376888693365, 20802.27192048271, 876.1632640827994, 885.6324625280437, 902.8374892519279, 922.5894476957824, 928.2063835420618, 10716.624918127829, 10916.836247456295, 10966.945165274123, 11014.559417623366, 11048.116150708085, 568331.0, 569441.0695625633, 576042.2395776073, 580152.0, 580376.0, 127408.72591273968, 132182.0, 133632.0, 134443.0, 136819.0, 957.2437774158476, 968.2302569457298, 979.4710856137748, 992.0278127435154, 993.011953106649, 16883.577910552336, 17869.910650447186, 18209.908950455163, 18239.179236934106, 18400.11902400296, 27687.0, 51607.709807255116, 52335.0, 52555.0, 54735.178972316244, 48449.75775121102, 77162.45675086355, 79469.60265198637, 80945.0, 81183.59408202922, 7797.610119494116, 7893.644785984759, 7964.2433968772875, 8090.797730056795, 8159.306458951056, 10468.214883883587, 11122.388268645302, 11269.943650282024, 11403.429828508708, 12010.75978480443, 10317.48412579353, 10529.473526323807, 10631.521581529005, 11067.335959842436, 11112.555497779998, 10479.318844275098, 10710.73223169427, 10842.512086955949, 10848.132149428184, 10927.0, 10835.916408359417, 11059.778804423706, 11091.0, 11116.943365477413, 11238.213325067167, 6907.171139463297, 7315.561066336037, 7465.29079737424, 7915.722949696963, 8086.353091752763, 10555.050045495942, 10625.8937410628, 10962.671119866416, 11015.953484418967, 11122.388268645302], "value": 9341.950251792709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.1596413990237, 1546.4896584127239, 1728.144568438623, 1764.4794785538265, 1889.5748456597275, 7537.24627537246, 7756.883646745289, 8017.278444939954, 8436.957815210922, 8459.069502354743, 7986.1614530474335, 8230.670773169066, 8260.380471464634, 8357.95821020894, 8364.916350836489, 2368.1829768729804, 2404.1825779235055, 2405.458771776345, 2407.723111842134, 2408.421978725111, 2398.832081754278, 2421.2857207123852, 2424.745401732819, 2433.926982190528, 2442.1086303499183, 2354.0936739355384, 2354.776296251853, 2382.309130352196, 2387.212219967407, 2391.8325717199805, 2334.704239147273, 2343.3321503371544, 2369.0642196332437, 2370.371851459356, 2373.6439534069855, 2353.2469609724894, 2367.147826782357, 2391.0794344177616, 2391.7847393734646, 2395.4131237846664, 8218.671253149867, 8389.07720150783, 8394.538300393477, 8396.412251142423, 8405.0, 3993.4608827808456, 4623.375844261015, 5079.85703216777, 5255.684658920477, 5258.658187217857, 3383.5263063171174, 3458.2046129390383, 3458.239187378773, 3468.7051600613977, 3476.9916724149966, 1040.1159014837328, 1075.5805235957982, 1076.2358725305044, 1095.4030053620795, 1104.7735214281054, 10841.620543281026, 10933.507992140294, 10949.616763413322, 10957.616483423122, 10963.342199468058, 3951.3677811550015, 4335.154644844288, 4461.219286624892, 4533.138703646297, 4538.818447262139, 8735.868961965576, 8748.518831464204, 8750.693725719697, 8760.474371537728, 8766.649334026695, 5148.253503242009, 5149.536541711264, 5154.871128221749, 5159.2003239497935, 5173.3533308336455, 4188.623023927861, 4378.408914796525, 4719.669623126349, 4772.95227047732, 4828.299896514985, 3655.305491956573, 3718.795466249328, 3763.698904087721, 3800.1639639279315, 3813.1801662642665, 1165.1319766773638, 1166.381817636654, 1170.53763763313, 1181.3620644851856, 1182.6274723462082, 752.9209433009455, 852.9530875801767, 901.3195037746591, 904.0778406025817, 910.9817803644023, 5621.7751289948765, 5652.660840349592, 5763.250777398911, 5817.563682723812, 6036.0644100164545, 875.5009644502572, 892.205936716323, 914.92680585553, 933.2114363362947, 939.6758118449125, 3358.7648864579733, 3803.4294855771855, 3941.7043721720984, 3979.243943650697, 4067.0, 9955.900440995641, 10181.847272290921, 10304.021117993778, 10304.536295866705, 10358.015988481082, 10259.230557708202, 10263.12763415118, 10271.691849244535, 10275.383476991256, 10278.691639250834, 7926.841463170705, 8085.110637829834, 8092.312153467021, 8093.676252949816, 8094.554799486084, 5062.316587260672, 5354.9464505354445, 5373.4357892422295, 5856.267966504187, 5985.281766188085, 8069.273765361146, 9309.022552631875, 9439.386439881386, 9463.810723785624, 9473.431594104375, 8926.955365223132, 9294.72115836526, 9451.810963780548, 9477.526123693926, 9640.951795240979, 6961.686724097326, 7134.536255143399, 7167.247439019036, 7213.891791623235, 7309.232530584425, 7968.721094761656, 8035.4375193738215, 8038.758837234892, 8049.436539442183, 8071.636776344961, 7045.753398631228, 7232.855342893218, 7236.529625574321, 7314.305141011595, 7349.30181632744, 6107.328193898578, 7094.787156385317, 7108.179445855243, 7136.179339376038, 7225.747098851515, 6728.798136055926, 6735.057092007025, 6820.147481564804, 6823.897641535282, 6839.93160068393, 4885.877853053702, 4943.8516844494725, 4947.158982972831, 4967.428745694291, 5039.395272567315, 4231.682623803165, 4331.371951067141, 4963.379577552806, 4989.401271847401, 5123.615728820428], "value": 4426.8907767081755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8903439279056, 310.24919694339695, 318.0553755346621, 323.8170433704955, 323.90930539448965, 4657.51096134906, 4911.519682560306, 5326.547243484304, 5336.199570064492, 5366.409694933554, 4037.8303032119793, 4789.257665061921, 5118.181091025437, 5140.974295128529, 5324.54741346985, 3532.7037425673325, 3792.184680293736, 3993.9001524961964, 4010.278149933011, 4039.4950631171105, 4005.6394924456795, 4015.7873701039052, 4031.979840100795, 4032.6572241359518, 4039.333509970866, 3884.640375868452, 3996.3406038003695, 3999.7800120993334, 4001.559828418872, 4002.6597739192202, 3478.4260597001467, 3988.3818008208773, 4003.6987978906973, 4017.5379831319333, 4032.5564187939303, 2939.970600293991, 3015.381846721417, 3287.7862938908893, 3439.6560343965652, 3518.894433167009, 4377.496587892401, 4556.951901062774, 5156.097682905514, 5175.456577059392, 5194.610404219661, 3516.9648303517147, 4556.476005259405, 4591.977040114812, 4619.630429565626, 4619.9076018479445, 5005.974970125126, 5298.761555730001, 5413.972930135364, 5530.115181570929, 5552.91670624941, 3243.837808109609, 3892.6885849132, 3894.176721876645, 3900.1614652849776, 3910.765354078736, 5475.7262136893, 5507.642003269814, 5736.856578585527, 5739.426057394269, 5815.88368232633, 3654.3970244909824, 3936.5866584008268, 3948.763074215556, 3954.5565868457807, 3960.5049368828895, 3677.9632203678157, 3704.49989251453, 3743.008102852746, 4021.170367482788, 4039.6162364575316, 3600.7299452541165, 4243.0, 4267.786610669454, 4652.976735116303, 4673.859784206479, 5400.514858413889, 5515.132131291706, 5563.777448902079, 5572.263575960482, 5606.55147588192, 1106.1095817866533, 1202.7113492761673, 1264.3994102801096, 1290.1291628150962, 1291.7222797098668, 827.185222555782, 845.1843970568431, 852.7953291210189, 853.2891552437447, 856.952867592276, 4596.287575425815, 4891.315215869781, 4942.654014218971, 5153.896922061538, 5184.5593124584075, 4853.684510506806, 5063.5695965843315, 5474.5894057945015, 5751.482366587027, 5764.654120752768, 4604.907901842012, 4872.878178045577, 5158.63889527737, 5296.708681022581, 5345.492178243061, 2540.0949288033976, 2778.7082356352294, 2845.160677600113, 2860.32559556815, 2865.7134286571177, 4836.347093142381, 4841.394825646794, 4893.681910675795, 5459.808906688247, 5714.771409143587, 4447.3989363829, 4752.7385993769985, 4892.315075889378, 5240.292560504359, 5434.347878254555, 4754.738489383117, 4958.553730164231, 5245.973770131125, 5357.223202635596, 5479.890402192013, 4364.678967821897, 5194.454582268807, 5399.29809124827, 5417.620766546304, 5418.376886657927, 5313.546194973298, 5355.30381050461, 5372.811951581676, 5390.892182156256, 5414.88994756082, 5201.661891977009, 5260.9741100485035, 5435.619506634498, 5645.322561292671, 5692.573057020657, 3545.2554963457965, 3652.251288485907, 3670.870270945187, 3673.2469843682516, 3687.3362794697214, 4508.752018639007, 4555.453345598549, 5245.396779370269, 5470.890582188414, 5534.557235421237, 5261.73691315425, 5267.604929630216, 5281.128613778684, 5290.73022474611, 5303.337082864642, 4886.315915771866, 5233.188855727369, 5244.606654501004, 5265.368155821326, 5302.840914772563, 4418.504797947013, 4689.835855745033, 4728.810847566059, 5074.340335756328, 5129.53834154913, 4780.95219047805, 5303.310569626078, 5461.371942226536, 5522.1500797233375, 5569.35952365467, 5436.157395603688, 5442.2108794225405, 5461.9453805461435, 5466.644668096561, 5469.644473109235], "value": 3948.4689039500445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.7420391557082, 709.6380845768659, 765.1812560560203, 775.1163673412308, 802.241881422056, 14179.361928713206, 15145.848541514582, 15154.696906061872, 15190.392384304629, 15200.61998450038, 13515.053946223768, 13602.591922242324, 13668.863311366908, 13707.38316775745, 13707.45170193191, 687.6286805125227, 708.5925592784143, 845.7251393297172, 858.5449711652834, 870.5777697816554, 861.7845538615346, 861.9741407757746, 863.1153068105211, 873.3624454148476, 875.1292463998299, 940.9858852117189, 946.280826571807, 948.0993056596227, 948.2461443152711, 948.928830337724, 930.7068273493828, 938.5025936253796, 938.7277689470045, 942.4204114469586, 946.6071580294204, 690.1683471416931, 691.6023286610219, 703.0684343245169, 707.0278367245038, 710.3322876496129, 14541.27293635314, 14576.781348279785, 14751.852481475154, 14789.112653240732, 15054.322555485029, 14197.858021419757, 14478.927605361905, 14498.130112193303, 14602.926985365111, 14607.123572585679, 11642.708932276677, 11819.881801181964, 11838.0, 11841.348725820077, 11909.702257443547, 3716.0, 3742.3450896093077, 3797.411401232813, 3973.8013099345208, 4015.99600099975, 91525.0, 93099.0, 93417.0, 93421.13157736875, 94718.5264073682, 11061.281016734047, 11074.390908499949, 11259.774804503864, 11428.200025998267, 11437.828432573519, 22438.43903902383, 22736.886315568318, 22744.31767046991, 22810.0, 22832.543349132924, 7472.17806041335, 7575.6969721211635, 7665.8850117248285, 7731.188225236382, 8047.919520804717, 4255.659547236213, 4259.531451540328, 4372.147431250875, 4398.186335527937, 4505.414296141481, 3436.8281585921104, 3511.999080262164, 3536.3104194682305, 3550.289942011608, 3553.862763915522, 626.946709529686, 631.0754744299624, 640.1230314469113, 640.9903851442232, 645.2869579115011, 586.5131940489383, 621.6075544650232, 623.4077626255075, 624.1979056911937, 649.9187601549806, 8457.661693532313, 8837.513936733541, 8899.644014239359, 8968.506732129796, 9143.177114059767, 453.90974562140866, 464.3638215644521, 569.6923661222976, 641.2561428742729, 654.0842820051965, 3580.7314451416246, 3877.6316249956208, 4357.934630980538, 4416.889577760582, 4461.470252713688, 74203.62898185475, 74528.62735686287, 90043.0, 93513.53243233876, 115927.0, 94351.0, 98381.50809246051, 98486.0, 99625.5056174158, 103200.45199322017, 81723.0, 85335.0, 85778.14221857826, 86377.56811215903, 88101.11898881057, 8538.103499132501, 8555.82888342242, 8597.742067737978, 8666.35002374837, 8769.342299327449, 54852.45147548473, 55118.0, 55573.0, 56381.0, 58016.70991645015, 76398.61800690962, 76592.61703691445, 76889.0, 79371.80942285986, 82401.58799206205, 9473.715788526355, 10688.519016644113, 11048.558057677603, 11559.133065019989, 12001.819972700241, 11548.711282218012, 11945.761084778429, 12090.274583525017, 12216.328101954477, 12242.204256723284, 11194.44027798623, 11403.657890263305, 11688.88311116912, 11885.762284754084, 11965.282083075042, 11177.552897883994, 11225.550977961117, 11983.221090629082, 12002.1598488105, 12224.816627750768, 10565.26043177001, 11393.829092563452, 11525.366104864313, 11595.5361785531, 11733.35466549348, 9229.49237791928, 9756.51217439111, 10027.849582256418, 10160.44117573511, 10220.693379198636, 8605.612747426507, 9637.9036209637, 10007.199424046205, 10009.799804004026, 10018.048285412875], "value": 7221.936941945185, "unit": "score"}], "name": "dromaeo_css", "value": 7188.3233034795785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 111.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 110.0, 142.0, 109.0, 113.0, 108.0, 107.0, 136.0, 109.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 255.0, 206.0, 184.0, 184.0, 184.0, 187.0, 182.0, 183.0, 183.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 97.0, 77.0, 89.0, 59.0, 58.0, 58.0, 57.0, 82.0, 57.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 68.0, 67.0, 69.0, 88.0, 67.0, 68.0, 91.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 86.0, 89.0, 77.0, 137.0, 133.0, 89.0, 85.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 97.0, 98.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 89.0, 129.0, 82.0, 83.0, 83.0, 84.0, 81.0, 82.0], "value": 87.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 54.0, 56.0, 57.0, 56.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 76.0, 72.0, 67.0, 67.0, 68.0, 68.0, 68.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 83.0, 82.0, 81.0, 82.0, 77.0, 94.0, 101.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 135.0, 136.0, 136.0, 135.0, 153.0, 142.0, 139.0, 184.0, 136.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 169.0, 168.0, 167.0, 169.0, 167.0, 168.0, 168.0, 172.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 69.0, 78.0, 85.0, 86.0, 86.0, 75.0, 66.0, 64.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1446.3000000000002, "alertThreshold": 2.0}]} 09:10:51 INFO - Return code: 0 09:10:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:51 INFO - # TBPL SUCCESS # 09:10:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:51 INFO - 2017-02-27 09:10:51.327 screenresolution[1666:9818] starting screenresolution argv=screenresolution get 09:10:51 INFO - 2017-02-27 09:10:51.329 screenresolution[1666:9818] Display 0: 1600x1200x32@60 09:10:51 INFO - 2017-02-27 09:10:51.336 screenresolution[1667:9821] starting screenresolution argv=screenresolution list 09:10:51 INFO - Available Modes on Display 0 09:10:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:51 INFO - Intel Iris: 09:10:51 INFO - Chipset Model: Intel Iris 09:10:51 INFO - Type: GPU 09:10:51 INFO - Bus: Built-In 09:10:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:51 INFO - Vendor: Intel (0x8086) 09:10:51 INFO - Device ID: 0x0a2e 09:10:51 INFO - Revision ID: 0x0009 09:10:51 INFO - Displays: 09:10:51 INFO - Display: 09:10:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:51 INFO - Display Serial Number: 1600x1200 60 09:10:51 INFO - Main Display: Yes 09:10:51 INFO - Mirror: Off 09:10:51 INFO - Online: Yes 09:10:51 INFO - Rotation: Supported 09:10:51 INFO - Return code: 0 09:10:51 INFO - Running post-action listener: _resource_record_post_action 09:10:51 INFO - [mozharness: 2017-02-27 17:10:51.587762Z] Finished run-tests step (success) 09:10:51 INFO - Running post-run listener: _resource_record_post_run 09:10:51 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 38106112; Write bytes: 499972608; Read time: 247; Write time: 1617 09:10:51 INFO - TinderboxPrint: CPU usage
53.4% 09:10:51 INFO - TinderboxPrint: I/O read bytes / time
38,106,112 / 247 09:10:51 INFO - TinderboxPrint: I/O write bytes / time
499,972,608 / 1,617 09:10:51 INFO - TinderboxPrint: CPU idle
2,235.2 (46.6%) 09:10:51 INFO - TinderboxPrint: CPU system
958.6 (20.0%) 09:10:51 INFO - TinderboxPrint: CPU user
1,607.9 (33.5%) 09:10:51 INFO - TinderboxPrint: Swap in / out
230,014,976 / 0 09:10:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191062528; Write bytes: 190347264; Read time: 17969; Write time: 439 09:10:51 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 34518016; Write bytes: 302240256; Read time: 223; Write time: 1148 09:10:52 INFO - Running post-run listener: _upload_blobber_files 09:10:52 INFO - Blob upload gear active. 09:10:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:52 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 09:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:10:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:53 INFO - (blobuploader) - INFO - Done attempting. 09:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:54 INFO - (blobuploader) - INFO - Done attempting. 09:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:56 INFO - (blobuploader) - INFO - Done attempting. 09:10:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:56 INFO - Return code: 0 09:10:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecc5af464f9d75d6f632a7625158c50354c8a7fc447b9633cf1d3b89b27be4b6c88937698cb05a4cb4bb3793976af94dc4f8e36b0ffee2daae91bba7987a498b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ce2c77f1d36fef00891a311cffa746cdcdd0d49cec2b952000671960648ae37c636952448551f469c64fa535905b82b237cbaa38f93cbfc371bb6c6ec8f2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a64ebe8f482df8d40efb4be9aeeed527233d0fd9ae73ac53fcb6c2e4c15bd7d20abe9afcfeaeac0985846b3676f8bd35c694606ac31aa2937c026a47b987bf3"} 09:10:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:56 INFO - Contents: 09:10:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecc5af464f9d75d6f632a7625158c50354c8a7fc447b9633cf1d3b89b27be4b6c88937698cb05a4cb4bb3793976af94dc4f8e36b0ffee2daae91bba7987a498b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ce2c77f1d36fef00891a311cffa746cdcdd0d49cec2b952000671960648ae37c636952448551f469c64fa535905b82b237cbaa38f93cbfc371bb6c6ec8f2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a64ebe8f482df8d40efb4be9aeeed527233d0fd9ae73ac53fcb6c2e4c15bd7d20abe9afcfeaeac0985846b3676f8bd35c694606ac31aa2937c026a47b987bf3"} 09:10:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:56 INFO - Copying logs to upload dir... 09:10:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.056509 ========= master_lag: 1.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-27 09:10:57.925173) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:10:57.928897) ========= 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.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecc5af464f9d75d6f632a7625158c50354c8a7fc447b9633cf1d3b89b27be4b6c88937698cb05a4cb4bb3793976af94dc4f8e36b0ffee2daae91bba7987a498b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ce2c77f1d36fef00891a311cffa746cdcdd0d49cec2b952000671960648ae37c636952448551f469c64fa535905b82b237cbaa38f93cbfc371bb6c6ec8f2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a64ebe8f482df8d40efb4be9aeeed527233d0fd9ae73ac53fcb6c2e4c15bd7d20abe9afcfeaeac0985846b3676f8bd35c694606ac31aa2937c026a47b987bf3"} build_url:https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010979 build_url: 'https://queue.taskcluster.net/v1/task/ES2ob6p7S3KV2-Swcdj4TA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ecc5af464f9d75d6f632a7625158c50354c8a7fc447b9633cf1d3b89b27be4b6c88937698cb05a4cb4bb3793976af94dc4f8e36b0ffee2daae91bba7987a498b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ce2c77f1d36fef00891a311cffa746cdcdd0d49cec2b952000671960648ae37c636952448551f469c64fa535905b82b237cbaa38f93cbfc371bb6c6ec8f2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a64ebe8f482df8d40efb4be9aeeed527233d0fd9ae73ac53fcb6c2e4c15bd7d20abe9afcfeaeac0985846b3676f8bd35c694606ac31aa2937c026a47b987bf3"}' ========= master_lag: 0.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:10:58.309940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:10:58.310270) ========= 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.mNJw4GbNpo/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.H3r5IukGER/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.004806 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:10:58.338616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:10:58.338931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:10:58.339249) ========= ========= Total master_lag: 1.69 =========