builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1479821510.48 results: success (0) buildid: 20161122030216 builduid: 7004ea875ed3469d84fb2a5cc65733d2 revision: 0534254e9a40b4bade2577c631fe4cfa0b5db41d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.483076) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.483561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.483857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.510749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.511153) ========= 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.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-22 05:31:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.19M=0.001s 2016-11-22 05:31:50 (9.19 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.636030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.636359) ========= 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.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.027962 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:50.686600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 05:31:50.687077) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0534254e9a40b4bade2577c631fe4cfa0b5db41d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0534254e9a40b4bade2577c631fe4cfa0b5db41d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-22 05:31:50,781 truncating revision to first 12 chars 2016-11-22 05:31:50,781 Setting DEBUG logging. 2016-11-22 05:31:50,781 attempt 1/10 2016-11-22 05:31:50,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0534254e9a40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 05:31:51,559 unpacking tar archive at: mozilla-central-0534254e9a40/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040260 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 05:31:51.752968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:51.753528) ========= script_repo_revision: 0534254e9a40b4bade2577c631fe4cfa0b5db41d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:51.754211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:51.754676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 05:31:51.775838) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-22 05:31:51.776509) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:31:51 INFO - MultiFileLogger online at 20161122 05:31:51 in /builds/slave/test 05:31:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:51 INFO - {'append_to_log': False, 05:31:51 INFO - 'base_work_dir': '/builds/slave/test', 05:31:51 INFO - 'blob_upload_branch': 'Firefox', 05:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:51 INFO - 'branch': 'Firefox', 05:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:51 INFO - 'config_files': ('talos/mac_config.py',), 05:31:51 INFO - 'default_actions': ('clobber', 05:31:51 INFO - 'read-buildbot-config', 05:31:51 INFO - 'download-and-extract', 05:31:51 INFO - 'populate-webroot', 05:31:51 INFO - 'create-virtualenv', 05:31:51 INFO - 'install', 05:31:51 INFO - 'run-tests'), 05:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:51 INFO - 'download_minidump_stackwalk': True, 05:31:51 INFO - 'download_symbols': 'ondemand', 05:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:51 INFO - 'installer_path': 'installer.exe', 05:31:51 INFO - 'log_level': 'info', 05:31:51 INFO - 'log_name': 'talos', 05:31:51 INFO - 'log_to_console': True, 05:31:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:51 INFO - 'opt_config_files': (), 05:31:51 INFO - 'pip_index': False, 05:31:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'run_cmd_checks_enabled': True, 05:31:51 INFO - 'sps_profile': False, 05:31:51 INFO - 'sps_profile_interval': 0, 05:31:51 INFO - 'suite': 'dromaeojs', 05:31:51 INFO - 'system_bits': '32', 05:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:51 INFO - 'title': 't-yosemite-r7-0116', 05:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:51 INFO - 'use_talos_json': True, 05:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:51 INFO - 'work_dir': 'build'} 05:31:51 INFO - [mozharness: 2016-11-22 13:31:51.986915Z] Running clobber step. 05:31:51 INFO - Running pre-action listener: _resource_record_pre_action 05:31:51 INFO - Running main action method: clobber 05:31:51 INFO - rmtree: /builds/slave/test/build 05:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:54 INFO - Running post-action listener: _resource_record_post_action 05:31:54 INFO - [mozharness: 2016-11-22 13:31:54.490736Z] Finished clobber step (success) 05:31:54 INFO - [mozharness: 2016-11-22 13:31:54.490900Z] Running read-buildbot-config step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: read_buildbot_config 05:31:54 INFO - Using buildbot properties: 05:31:54 INFO - { 05:31:54 INFO - "project": "", 05:31:54 INFO - "product": "firefox", 05:31:54 INFO - "script_repo_revision": "production", 05:31:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:31:54 INFO - "repository": "", 05:31:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:31:54 INFO - "buildid": "20161122030216", 05:31:54 INFO - "stage_platform": "macosx64", 05:31:54 INFO - "basedir": "/builds/slave/test", 05:31:54 INFO - "nightly_build": "True", 05:31:54 INFO - "buildnumber": 0, 05:31:54 INFO - "slavename": "t-yosemite-r7-0116", 05:31:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:31:54 INFO - "platform": "yosemite_r7", 05:31:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:54 INFO - "branch": "mozilla-central", 05:31:54 INFO - "repo_path": "mozilla-central", 05:31:54 INFO - "revision": "0534254e9a40b4bade2577c631fe4cfa0b5db41d", 05:31:54 INFO - "pgo_build": "False", 05:31:54 INFO - "builduid": "7004ea875ed3469d84fb2a5cc65733d2", 05:31:54 INFO - "slavebuilddir": "test" 05:31:54 INFO - } 05:31:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:31:54 INFO - Running post-action listener: _resource_record_post_action 05:31:54 INFO - [mozharness: 2016-11-22 13:31:54.494380Z] Finished read-buildbot-config step (success) 05:31:54 INFO - [mozharness: 2016-11-22 13:31:54.494509Z] Running download-and-extract step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: download_and_extract 05:31:54 INFO - mkdir: /builds/slave/test/build/tests 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:54 INFO - trying https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:31:54 INFO - Downloading https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:31:55 INFO - Downloaded 1199 bytes. 05:31:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:31:55 INFO - Using the following test package requirements: 05:31:55 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:31:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:31:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'jsshell-mac.zip'], 05:31:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:31:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:31:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:31:55 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:31:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:31:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:31:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:55 INFO - Fetch https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:31:56 INFO - Http code: 200 05:31:56 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 05:31:56 INFO - x-amz-cf-id: B8ngyy-TF1bsjXHJIymRGvBc_aJ85-6Hb13nCp1ClNx1JS1_dw1YYQ== 05:31:56 INFO - x-amz-version-id: NUallmRGdQASbFeuJliG.FUUfNoHjYX1 05:31:57 INFO - Expected file size: 16282237 05:31:57 INFO - Obtained file size: 16282237 05:32:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:32:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:32:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:04 INFO - Fetch https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:32:04 INFO - Http code: 200 05:32:04 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:32:04 INFO - x-amz-cf-id: LM43Qm76yjDLaS0-7KdnEXpiZ4BowJRLACa9s6JU6IHqm9_2ukOYiw== 05:32:04 INFO - x-amz-version-id: NUallmRGdQASbFeuJliG.FUUfNoHjYX1 05:32:05 INFO - Expected file size: 16282237 05:32:05 INFO - Obtained file size: 16282237 05:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:32:12 INFO - Http code: 200 05:32:12 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 05:32:12 INFO - x-amz-cf-id: vFO3qHmbE57HCqa_yRODf0sUnZXJ-fhSJKWlNKB6Jj5GjhmACoJykw== 05:32:12 INFO - x-amz-version-id: cZXsRVUsEB19vmQr1CeA2xJDe1tVKgqD 05:32:13 INFO - Expected file size: 14409392 05:32:13 INFO - Obtained file size: 14409392 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:13 INFO - trying https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:13 INFO - Downloading https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:32:16 INFO - Downloaded 107601983 bytes. 05:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:16 INFO - mkdir: /builds/slave/test/properties 05:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:16 INFO - Contents: 05:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:32:18 INFO - Running post-action listener: _resource_record_post_action 05:32:18 INFO - Running post-action listener: set_extra_try_arguments 05:32:18 INFO - [mozharness: 2016-11-22 13:32:18.073688Z] Finished download-and-extract step (success) 05:32:18 INFO - [mozharness: 2016-11-22 13:32:18.073802Z] Running populate-webroot step. 05:32:18 INFO - Running pre-action listener: _resource_record_pre_action 05:32:18 INFO - Running main action method: populate_webroot 05:32:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:18 INFO - '--tppagecycles', 05:32:18 INFO - '7'], 05:32:18 INFO - 'tests': ['tsvgm']}}, 05:32:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['damp', 'tps']}, 05:32:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'tests': ['damp', 'tps']}, 05:32:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['dromaeo_dom']}, 05:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['basic_compositor_video']}, 05:32:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['a11yr', 05:32:18 INFO - 'ts_paint', 05:32:18 INFO - 'tpaint', 05:32:18 INFO - 'sessionrestore', 05:32:18 INFO - 'sessionrestore_no_auto_restore', 05:32:18 INFO - 'tabpaint']}, 05:32:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['tsvgx', 05:32:18 INFO - 'tsvgr_opacity', 05:32:18 INFO - 'tart', 05:32:18 INFO - 'tscrollx', 05:32:18 INFO - 'cart']}, 05:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:18 INFO - 'tsvgr_opacity', 05:32:18 INFO - 'tart', 05:32:18 INFO - 'tscrollx', 05:32:18 INFO - 'cart']}, 05:32:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'talos_options': ['--disable-e10s'], 05:32:18 INFO - 'tests': ['tp5o']}, 05:32:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:32:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'talos_options': ['--disable-e10s', 05:32:18 INFO - '--xperf_path', 05:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:18 INFO - 'tests': ['tp5n']}, 05:32:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:32:18 INFO - 'talos_options': ['--xperf_path', 05:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:18 INFO - 'tests': ['tp5n']}}, 05:32:18 INFO - 'talos.zip': {'path': '', 05:32:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:18 INFO - Running post-action listener: _resource_record_post_action 05:32:18 INFO - [mozharness: 2016-11-22 13:32:18.091938Z] Finished populate-webroot step (success) 05:32:18 INFO - [mozharness: 2016-11-22 13:32:18.092047Z] Running create-virtualenv step. 05:32:18 INFO - Running pre-action listener: _resource_record_pre_action 05:32:18 INFO - Running main action method: create_virtualenv 05:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:18 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 05:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:18 INFO - Using real prefix '/tools/python27' 05:32:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:21 INFO - Installing pip.................done. 05:32:21 INFO - Return code: 0 05:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:22 INFO - Reading from file tmpfile_stdout 05:32:22 INFO - Output received: 05:32:22 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) 05:32:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:22 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')]} 05:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 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')]} 05:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:22 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 05:32:22 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 05:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:22 INFO - 'HOME': '/Users/cltbld', 05:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:22 INFO - 'LOGNAME': 'cltbld', 05:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:22 INFO - 'MOZ_NO_REMOTE': '1', 05:32:22 INFO - 'NO_EM_RESTART': '1', 05:32:22 INFO - 'PAGER': '/bin/cat', 05:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:22 INFO - 'PWD': '/builds/slave/test', 05:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:22 INFO - 'SHELL': '/bin/bash', 05:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:22 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:22 INFO - 'USER': 'cltbld', 05:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:22 INFO - 'XPC_FLAGS': '0x0', 05:32:22 INFO - 'XPC_SERVICE_NAME': '0', 05:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:22 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 05:32:22 INFO - Cleaning up... 05:32:22 INFO - Return code: 0 05:32:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:22 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')]} 05:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 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')]} 05:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:22 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 05:32:22 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 05:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:22 INFO - 'HOME': '/Users/cltbld', 05:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:22 INFO - 'LOGNAME': 'cltbld', 05:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:22 INFO - 'MOZ_NO_REMOTE': '1', 05:32:22 INFO - 'NO_EM_RESTART': '1', 05:32:22 INFO - 'PAGER': '/bin/cat', 05:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:22 INFO - 'PWD': '/builds/slave/test', 05:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:22 INFO - 'SHELL': '/bin/bash', 05:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:22 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:22 INFO - 'USER': 'cltbld', 05:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:22 INFO - 'XPC_FLAGS': '0x0', 05:32:22 INFO - 'XPC_SERVICE_NAME': '0', 05:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:22 INFO - Downloading/unpacking psutil>=3.1.1 05:32:22 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 05:32:22 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 05:32:22 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 05:32:22 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 05:32:22 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 05:32:22 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 05:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:26 INFO - Installing collected packages: psutil 05:32:26 INFO - Running setup.py install for psutil 05:32:26 INFO - building 'psutil._psutil_osx' extension 05:32: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:32: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 05:32: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 05:32: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 05:32:27 INFO - building 'psutil._psutil_posix' extension 05:32:27 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 05:32:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:27 INFO - ^ 05:32:27 INFO - 1 warning generated. 05:32:27 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 05:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:27 INFO - Successfully installed psutil 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:30 INFO - Installing collected packages: mozsystemmonitor 05:32:30 INFO - Running setup.py install for mozsystemmonitor 05:32:30 INFO - Successfully installed mozsystemmonitor 05:32:30 INFO - Cleaning up... 05:32:30 INFO - Return code: 0 05:32:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:30 INFO - 'HOME': '/Users/cltbld', 05:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:30 INFO - 'LOGNAME': 'cltbld', 05:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:30 INFO - 'MOZ_NO_REMOTE': '1', 05:32:30 INFO - 'NO_EM_RESTART': '1', 05:32:30 INFO - 'PAGER': '/bin/cat', 05:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:30 INFO - 'PWD': '/builds/slave/test', 05:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:30 INFO - 'SHELL': '/bin/bash', 05:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:30 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:30 INFO - 'USER': 'cltbld', 05:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:30 INFO - 'XPC_FLAGS': '0x0', 05:32:30 INFO - 'XPC_SERVICE_NAME': '0', 05:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:30 INFO - Downloading/unpacking jsonschema==2.5.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:33 INFO - warning: no files found matching '*.txt' 05:32:33 INFO - no previously-included directories found matching 'build' 05:32:33 INFO - no previously-included directories found matching 'dist' 05:32:33 INFO - no previously-included directories found matching '.git*' 05:32:33 INFO - Installing collected packages: jsonschema, functools32 05:32:33 INFO - Running setup.py install for functools32 05:32:33 INFO - warning: no files found matching '*.txt' 05:32:33 INFO - no previously-included directories found matching 'build' 05:32:33 INFO - no previously-included directories found matching 'dist' 05:32:33 INFO - no previously-included directories found matching '.git*' 05:32:33 INFO - Successfully installed jsonschema functools32 05:32:33 INFO - Cleaning up... 05:32:33 INFO - Return code: 0 05:32:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32: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 05:32: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 05:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:33 INFO - 'HOME': '/Users/cltbld', 05:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:33 INFO - 'LOGNAME': 'cltbld', 05:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:33 INFO - 'MOZ_NO_REMOTE': '1', 05:32:33 INFO - 'NO_EM_RESTART': '1', 05:32:33 INFO - 'PAGER': '/bin/cat', 05:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:33 INFO - 'PWD': '/builds/slave/test', 05:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:33 INFO - 'SHELL': '/bin/bash', 05:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:33 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:33 INFO - 'USER': 'cltbld', 05:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:33 INFO - 'XPC_FLAGS': '0x0', 05:32:33 INFO - 'XPC_SERVICE_NAME': '0', 05:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:34 INFO - Cleaning up... 05:32:34 INFO - Return code: 0 05:32:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:34 INFO - 'HOME': '/Users/cltbld', 05:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:34 INFO - 'LOGNAME': 'cltbld', 05:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:34 INFO - 'MOZ_NO_REMOTE': '1', 05:32:34 INFO - 'NO_EM_RESTART': '1', 05:32:34 INFO - 'PAGER': '/bin/cat', 05:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:34 INFO - 'PWD': '/builds/slave/test', 05:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:34 INFO - 'SHELL': '/bin/bash', 05:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:34 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:34 INFO - 'USER': 'cltbld', 05:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:34 INFO - 'XPC_FLAGS': '0x0', 05:32:34 INFO - 'XPC_SERVICE_NAME': '0', 05:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:38 INFO - Downloading docopt-0.6.1.tar.gz 05:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:38 INFO - Running setup.py install for blobuploader 05:32:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:38 INFO - Running setup.py install for requests 05:32:38 INFO - Running setup.py install for docopt 05:32:39 INFO - Successfully installed blobuploader requests docopt 05:32:39 INFO - Cleaning up... 05:32:39 INFO - Return code: 0 05:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:39 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 05:32:39 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 05:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:39 INFO - 'HOME': '/Users/cltbld', 05:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:39 INFO - 'LOGNAME': 'cltbld', 05:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:39 INFO - 'MOZ_NO_REMOTE': '1', 05:32:39 INFO - 'NO_EM_RESTART': '1', 05:32:39 INFO - 'PAGER': '/bin/cat', 05:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:39 INFO - 'PWD': '/builds/slave/test', 05:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:39 INFO - 'SHELL': '/bin/bash', 05:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:39 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:39 INFO - 'USER': 'cltbld', 05:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:39 INFO - 'XPC_FLAGS': '0x0', 05:32:39 INFO - 'XPC_SERVICE_NAME': '0', 05:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bXtU0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-TXxL6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-gElZs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-gb_gob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-z4OyLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-3DqzMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-CwB4wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-k4xZii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-sCOHop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-FOKZ6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-xnoEbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-sAmJ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-pDDsCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-In0cTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-seczi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-8ou07P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:41 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-oE6RQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:41 INFO - Running setup.py install for manifestparser 05:32:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozcrash 05:32:42 INFO - Running setup.py install for mozdebug 05:32:42 INFO - Running setup.py install for mozdevice 05:32:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozfile 05:32:42 INFO - Running setup.py install for mozhttpd 05:32:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozinfo 05:32:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Running setup.py install for mozInstall 05:32:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Running setup.py install for mozleak 05:32:43 INFO - Running setup.py install for mozlog 05:32:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Running setup.py install for moznetwork 05:32:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Running setup.py install for mozprocess 05:32:43 INFO - Running setup.py install for mozprofile 05:32:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Running setup.py install for mozrunner 05:32:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:44 INFO - Running setup.py install for mozscreenshot 05:32:44 INFO - Running setup.py install for moztest 05:32:44 INFO - Running setup.py install for mozversion 05:32:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:44 INFO - Cleaning up... 05:32:44 INFO - Return code: 0 05:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:44 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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:44 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 05:32:44 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 05:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:44 INFO - 'HOME': '/Users/cltbld', 05:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:44 INFO - 'LOGNAME': 'cltbld', 05:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:44 INFO - 'MOZ_NO_REMOTE': '1', 05:32:44 INFO - 'NO_EM_RESTART': '1', 05:32:44 INFO - 'PAGER': '/bin/cat', 05:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:44 INFO - 'PWD': '/builds/slave/test', 05:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:44 INFO - 'SHELL': '/bin/bash', 05:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:44 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:44 INFO - 'USER': 'cltbld', 05:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:44 INFO - 'XPC_FLAGS': '0x0', 05:32:44 INFO - 'XPC_SERVICE_NAME': '0', 05:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-j_xjss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-m7kQwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-q2uvk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UwyEl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ApB7bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qSB8Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qNsuBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-O3yPse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-S83XXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-M4f_S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-y3IpW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-n3RqUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Ytl4oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6BLjdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-LgPtmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 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)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_HCGx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:46 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-C7THS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:47 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 05:32:47 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 05:32:47 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 05:32:47 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 05:32:47 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 05:32:47 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 05:32:49 INFO - Downloading blessings-1.6.tar.gz 05:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:49 INFO - Installing collected packages: blessings 05:32:49 INFO - Running setup.py install for blessings 05:32:49 INFO - Successfully installed blessings 05:32:49 INFO - Cleaning up... 05:32:50 INFO - Return code: 0 05:32:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:50 INFO - Reading from file tmpfile_stdout 05:32:50 INFO - Current package versions: 05:32:50 INFO - blessings == 1.6 05:32:50 INFO - blobuploader == 1.2.4 05:32:50 INFO - docopt == 0.6.1 05:32:50 INFO - functools32 == 3.2.3-2 05:32:50 INFO - jsonschema == 2.5.1 05:32:50 INFO - manifestparser == 1.1 05:32:50 INFO - mozInstall == 1.12 05:32:50 INFO - mozcrash == 1.0 05:32:50 INFO - mozdebug == 0.1 05:32:50 INFO - mozdevice == 0.49 05:32:50 INFO - mozfile == 1.2 05:32:50 INFO - mozhttpd == 0.7 05:32:50 INFO - mozinfo == 0.9 05:32:50 INFO - mozleak == 0.1 05:32:50 INFO - mozlog == 3.4 05:32:50 INFO - moznetwork == 0.27 05:32:50 INFO - mozprocess == 0.23 05:32:50 INFO - mozprofile == 0.28 05:32:50 INFO - mozrunner == 6.13 05:32:50 INFO - mozscreenshot == 0.1 05:32:50 INFO - mozsystemmonitor == 0.3 05:32:50 INFO - moztest == 0.7 05:32:50 INFO - mozversion == 1.4 05:32:50 INFO - psutil == 3.1.1 05:32:50 INFO - requests == 1.2.3 05:32:50 INFO - wsgiref == 0.1.2 05:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:50 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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32:50 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 05:32:50 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 05:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:50 INFO - 'HOME': '/Users/cltbld', 05:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:50 INFO - 'LOGNAME': 'cltbld', 05:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:50 INFO - 'MOZ_NO_REMOTE': '1', 05:32:50 INFO - 'NO_EM_RESTART': '1', 05:32:50 INFO - 'PAGER': '/bin/cat', 05:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:50 INFO - 'PWD': '/builds/slave/test', 05:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:50 INFO - 'SHELL': '/bin/bash', 05:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:50 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:50 INFO - 'USER': 'cltbld', 05:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:50 INFO - 'XPC_FLAGS': '0x0', 05:32:50 INFO - 'XPC_SERVICE_NAME': '0', 05:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 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)) 05:32:50 INFO - Cleaning up... 05:32:50 INFO - Return code: 0 05:32:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x105ea93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e1f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2785e78f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, '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.pNjU3IC8kq/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.MJctU64NPW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 05:32: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 05:32: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 05:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:50 INFO - 'HOME': '/Users/cltbld', 05:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:50 INFO - 'LOGNAME': 'cltbld', 05:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:50 INFO - 'MOZ_NO_REMOTE': '1', 05:32:50 INFO - 'NO_EM_RESTART': '1', 05:32:50 INFO - 'PAGER': '/bin/cat', 05:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:50 INFO - 'PWD': '/builds/slave/test', 05:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:50 INFO - 'SHELL': '/bin/bash', 05:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:32:50 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:50 INFO - 'USER': 'cltbld', 05:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:50 INFO - 'XPC_FLAGS': '0x0', 05:32:50 INFO - 'XPC_SERVICE_NAME': '0', 05:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:50 INFO - Cleaning up... 05:32:50 INFO - Return code: 0 05:32:50 INFO - Running post-action listener: _resource_record_post_action 05:32:50 INFO - Running post-action listener: _start_resource_monitoring 05:32:50 INFO - Starting resource monitoring. 05:32:50 INFO - [mozharness: 2016-11-22 13:32:50.840412Z] Finished create-virtualenv step (success) 05:32:50 INFO - [mozharness: 2016-11-22 13:32:50.841364Z] Running install step. 05:32:50 INFO - Running pre-action listener: _resource_record_pre_action 05:32:50 INFO - Running main action method: install 05:32:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:51 INFO - Reading from file tmpfile_stdout 05:32:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:51 INFO - Reading from file tmpfile_stdout 05:32:51 INFO - Output received: 05:32:51 INFO - Usage: mozinstall [options] installer 05:32:51 INFO - Options: 05:32:51 INFO - -h, --help show this help message and exit 05:32:51 INFO - -d DEST, --destination=DEST 05:32:51 INFO - Directory to install application into. [default: 05:32:51 INFO - "/builds/slave/test"] 05:32:51 INFO - --app=APP Application being installed. [default: firefox] 05:32:51 INFO - mkdir: /builds/slave/test/build/application 05:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:23 INFO - Reading from file tmpfile_stdout 05:33:23 INFO - Output received: 05:33:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:23 INFO - Running post-action listener: _resource_record_post_action 05:33:23 INFO - [mozharness: 2016-11-22 13:33:23.857562Z] Finished install step (success) 05:33:23 INFO - [mozharness: 2016-11-22 13:33:23.857770Z] Running run-tests step. 05:33:23 INFO - Running pre-action listener: _resource_record_pre_action 05:33:23 INFO - Running main action method: run_tests 05:33:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:23 INFO - 2016-11-22 05:33:23.872 screenresolution[1624:7487] starting screenresolution argv=screenresolution get 05:33:23 INFO - 2016-11-22 05:33:23.874 screenresolution[1624:7487] Display 0: 1600x1200x32@60 05:33:23 INFO - 2016-11-22 05:33:23.881 screenresolution[1625:7489] starting screenresolution argv=screenresolution list 05:33:23 INFO - Available Modes on Display 0 05:33:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:24 INFO - Intel Iris: 05:33:24 INFO - Chipset Model: Intel Iris 05:33:24 INFO - Type: GPU 05:33:24 INFO - Bus: Built-In 05:33:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:24 INFO - Vendor: Intel (0x8086) 05:33:24 INFO - Device ID: 0x0a2e 05:33:24 INFO - Revision ID: 0x0009 05:33:24 INFO - Displays: 05:33:24 INFO - Display: 05:33:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:24 INFO - Display Serial Number: 1600x1200 60 05:33:24 INFO - Main Display: Yes 05:33:24 INFO - Mirror: Off 05:33:24 INFO - Online: Yes 05:33:24 INFO - Rotation: Supported 05:33:24 INFO - Return code: 0 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:24 INFO - Python 2.7.3 05:33:24 INFO - Return code: 0 05:33:24 INFO - grabbing minidump binary from tooltool 05:33:24 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')]} 05:33:24 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 0x105cbfd30>, '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 0x105b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cb7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:24 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 05:33:24 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 05:33:24 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 05:33:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:24 INFO - Return code: 0 05:33:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 05:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNjU3IC8kq/Render', 05:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:24 INFO - 'HOME': '/Users/cltbld', 05:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PAGER': '/bin/cat', 05:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MJctU64NPW/Listeners', 05:33:24 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - 'XPC_FLAGS': '0x0', 05:33:24 INFO - 'XPC_SERVICE_NAME': '0', 05:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:33:24 INFO - mozversion application_buildid: 20161122030216 05:33:24 INFO - mozversion application_changeset: 0534254e9a40b4bade2577c631fe4cfa0b5db41d 05:33:24 INFO - mozversion application_display_name: Nightly 05:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:24 INFO - mozversion application_name: Firefox 05:33:24 INFO - mozversion application_remotingname: firefox 05:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:24 INFO - mozversion application_vendor: Mozilla 05:33:24 INFO - mozversion application_version: 53.0a1 05:33:24 INFO - mozversion platform_buildid: 20161122030216 05:33:24 INFO - mozversion platform_changeset: 0534254e9a40b4bade2577c631fe4cfa0b5db41d 05:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:24 INFO - mozversion platform_version: 53.0a1 05:33:24 INFO - using testdate: 1479821604 05:33:24 INFO - actual date: 1479821604 05:33:24 INFO - starting webserver on 'localhost:49241' 05:33:24 INFO - SUITE-START | Running 2 tests 05:33:24 INFO - TEST-START | dromaeo_css 05:33:24 INFO - operating with platform_type : mac_ 05:33:24 INFO - Initialising browser for dromaeo_css test... 05:33:24 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpwXVyNc/profile http://localhost:49241/getInfo.html) 05:33:27 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 05:33:27 INFO - PROCESS | 1635 | colorDepth:24 05:33:27 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 05:33:27 INFO - PROCESS | 1635 | __metrics 05:33:27 INFO - PROCESS | 1635 | 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" 05:33:27 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:28 INFO - TEST-INFO | 1635: exit 0 05:33:28 INFO - Browser initialized. 05:33:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:28 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpwXVyNc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:40 INFO - PROCESS | 1638 | RSS: Main: 236089344 05:33:40 INFO - PROCESS | 1638 | 05:34:32 INFO - PROCESS | 1638 | 1479821672276 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:36:47 INFO - PROCESS | 1638 | RSS: Main: 399306752 05:36:47 INFO - PROCESS | 1638 | 05:39:50 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:39:50 INFO - PROCESS | 1638 | RSS: Main: 371183616 05:39:50 INFO - PROCESS | 1638 | 05:42:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:42:53 INFO - PROCESS | 1638 | RSS: Main: 343474176 05:42:53 INFO - PROCESS | 1638 | 05:45:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:45:56 INFO - PROCESS | 1638 | RSS: Main: 341704704 05:45:56 INFO - PROCESS | 1638 | 05:49:00 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:49:01 INFO - PROCESS | 1638 | RSS: Main: 329228288 05:49:01 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:52:04 INFO - PROCESS | 1638 | RSS: Main: 569520128 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | __start_tp_report 05:52:04 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 05:52:04 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 05:52:04 INFO - PROCESS | 1638 | |i|pagename|runs| 05:52:04 INFO - PROCESS | 1638 | |0;dojo.html;3247.7888937219077;3299.45558982768;3301.1087006508237;3326.301476689895;3358.8320583970794;5392.703401312926;5483.341998960121;5495.175723641456;5598.580106492014;5604.355499117602;5485.9725701371535;5512.283403157594;5512.972435137829;5523.861903452415;5529.115341545354;4995.52542508462;5031.597472202233;5036.471170527097;5069.771860266278;5137.075326441239;5065.696058236499;5141.305923700309;5153.69077855328;5157.922631160535;5158.071547121516;5050.520200580939;5104.77028533715;5127.948720512784;5130.769115389798;5134.717590532519;5152.484751524855;5156;5161.225816127611;5187.118189907725;5192.350956130484;4994.076095922266;5006.123928312531;5045.899082018339;5111.361079865017;5120.359955005624;5431.103867861798;5460.754266058037;5486.149646804752;5516.613837031409;5523.199136125279;6067.453929146354;6071.635701857903;6073.878522429527;6077.209962704865;6085.3914608539235;5983.940160598382;6102.542309326774;6137.987232106697;6148.815535533941;6165.445109940127;5652.293463317085;5656.462636049651;5659.858503537444;5668.801591944303;5672.659640421588;6136.654150355513;6183.103449999815;6198.256209254918;6210.875782484325;6216.222972128484;5857.297124345106;5909.3204281507315;5922.911156332659;5932.377100404482;5941.0197317442135;6099.11562823397;6101.938980610137;6103.792276408673;6114.755409783559;6120.755169793248;6048.637081775108;6074.088886666947;6075.544334174866;6079.300880398722;6085;5973.761049557969;6042.456178943916;6058.454739073504;6074.817755467343;6094.786682466092;4840.394950631171;4847.80608775645;4860.246661767432;4885.364902562644;4930.038642464757;4366.454193225847;4374.343848422698;4381.605655491021;4395.934060989088;4419.756913369795;5479.0959491684225;5533.391326954032;5538.418466061086;5567.777288908479;5577.330720313507;6187.288461826947;6191.040388739752;6209.192804935329;6212.285587157445;6231;5646.265985421869;5662.292213473316;5667.574931880125;5668.631538949955;5679.091345384719;5200.349956255468;5236.685798852005;5242.397124330674;5305.1776974569;5314.7608357624;5350.197470379474;6163.476104531165;6190.3190649029475;6269.18500594938;6293.685315734287;6135.509159267337;6136.355682653257;6151.415615516519;6152.138700581832;6152.507799376129;5221.869453263699;6225.657588832658;6317.715702793477;6321.336259692666;6348.746050158126;4931.3096166536;5796.449337312949;5872.5301975842685;5949.929012777741;6039.335673076046;5929.0513517836935;6158.630482171084;6174.351693072343;6182.196314479269;6198.380161983766;5934.19888315072;5956.970215148896;5964.9105263420215;5971.462568368867;5975.731092100779;5706.657600543981;5801.274840644919;5810.912836307374;5848.298204215522;5898.351181370132;5613.073842815889;5656.37779844225;5657.886842263214;5661.943380566142;5662;5816.970915145566;5876.647401155944;5906.26171728534;5955.642661440327;5993.940060599512;5791.420857914175;5795.623284486495;5799.913001305068;5815.069588865761;5826.271716035496 05:52:04 INFO - PROCESS | 1638 | |1;ext.html;498.0164175752891;529.0768058108774;529.3066083430705;540.859376562094;548.0792268988098;25917.61123583148;32402.837985810067;38205.61794382055;39062.60937390632;40935.59064409355;40779.79610101953;41254.58745412545;41313.17373652525;41372.37941430881;41382.7930860346;9193.126652967974;9380.202682771973;9382.155605995458;9383.577739001761;9390.201832844183;9326.347155699104;9437.103475169848;9438;9438;9449.14957653811;9310.72067837966;9392.342536022481;9432.717018489457;9447.57485913132;9463.905360946406;9384.249260059212;9430.717078487656;9434.95282523583;9437.197838183763;9526.857097143513;9230.630774769;9284;9302.488363140024;9310.255179585616;9310.53447327631;38958.80520597379;39226.80386598049;39264;39281.80359098215;39364;3215.1962009497624;3261.1521004538754;3268.96731032689;3285.4414749492644;3386.0688310714504;29290.414191716045;29415.411691766043;29829.552556711667;29909.401811963857;30236.244093897607;3061.9693803062128;3093.8298393588343;3125.9062228132966;3128.0615815255333;3177.094528059515;354624;465685;465772;467177;470193;56944;57365.852682946104;57397;57414.138787918215;57547.13679294814;33646.831765841016;34407.65592344094;34460;35570.822145889106;60558.39441605616;15563.610909727347;15692;15834.366625335088;15851.841481585037;15867;12008.879911200951;12107.273563586214;12135.575254866037;12147.635570932885;12156.574519891761;15018.774718379233;18603.44189674312;18608.348707795434;18611.90694046521;18619.32426081632;7517.849643007109;7623.54258744466;7623.656935437919;7681.846363072819;7685.42359323053;870.2646263906988;930.7393929699695;966.5264020629841;1063.6436793674052;1118.1334465789078;29032.419351613273;29206.85396573046;29279.121626351243;29565.85217073944;30503.847480762455;872.4852337121002;999.1864765450683;1043.8486419469286;1069.2354966199205;1154.6247469572422;13952.232627205602;14511.201883896276;14566.29621863416;14703.632409189642;14767.92616036913;637440;637689;639101;639242;639448;53618.46381536135;54036;54055.18917216245;54151.45848541543;54190;1202.8857258560597;1225.301578100492;1317.6771690935782;1339.6784771654732;1361.7753070743217;24451.877740611184;28849.567256491588;28902.42195156127;29180;29438.705612943595;47809;48374;48397.758011211125;48452;48481.27278090902;517455;522158;522941;522977;525252;25618;26439.867800660875;26557.7344226563;27044.594331084656;27178.184654460398;44245.11509769722;44507.777461112484;45398;45480;45974.54025459703;36186.8190659045;36242.63757362498;36486;37513.2497350046;37604.81197593995;36781;36821;37840.62159378371;37934.53425527332;38312.80843595764;35245;35565.64434355623;35704.464433034045;35861.64138358583;36253.65561026757;31615;32775;32903.761172542;33032.50451243281;33160.336793263516;22191.007023419603;23795.524089518458;24036.63945040861;24584;24718.752812471645 05:52:04 INFO - PROCESS | 1638 | |2;jquery.html;350.77725644215917;365.76590981771653;374.3729253500387;379.84995926608997;398.2950178184613;14489.78265326021;14831.03598266112;15253.303144504194;19544.31594894179;20297.0866311016;18791.154398052087;19158.329458468957;19766.802331976676;20046.59906801863;20281.0873510692;5379.35447746271;5728.598998070137;5732.541396688276;5732.713364331767;5733.140028995643;5111.539961403473;5452.236686863842;5670.064439367499;5727.799527016556;5747.281589801275;5682.346530149044;5683.261176047129;5684.658920464785;5686.914696279559;5687.7156142192935;5213.852952350477;5570.470805273513;5689.687067211302;5879.294484661847;5942.138389933435;5533.944660553423;5736.139579063132;5776.537876969875;5788.160716696098;5792.768289268424;10217.029382208753;11908.702282443008;11976;12169.452374643162;12179.208351457215;2038.3171637501455;2139.8609090409072;2210.624193887043;2501.3621526510624;2512.5979843224995;9474.763130921714;9859.112679858847;9898.90101098987;10406.479676016244;10438.269321147523;1804.7022241330296;1815.9182836772377;1837.3201915291427;1859.8698091133626;1878.821511956362;115461;121028;122327.38836305762;122418.49116789676;123498.38250808779;11208.831867521994;11238.719032024264;11313.660590182308;11343;11570.595029174106;14315.713685726227;14324.283785810669;14325.64185895361;14336.283185840666;14354.784678229835;6824.897626535606;7942.6028698566;8224.588770561448;8350.08149103598;8384.622691978875;7079.00893874858;7799.337056350274;8112.107668156498;8124.953142571536;8297;4470.240059189946;4479.641628669699;4488.1248156609145;4496.213162696515;4549.772511374418;1723.9827601723823;1904.3144467991513;1907.818757218062;1911.1590900003953;1911.722800193964;795.316028215734;865.0881551770657;896.7264984179888;926.1340646495548;963.5278713430508;19979.900100499694;20550.58898822015;20625.16089427492;20672.483187920123;20820.687689684666;769.7960040589248;909.9181073703398;913.3104506097853;937.2361525356812;978.9804203916025;8568.357373197035;9920.751981200383;10432.895671043192;10912.290701104403;11099.72250693739;553929;557279;558307.2084639551;570418;571075.1446242742;118471;120574.39712801379;120980.18529722061;121926;124878;943.8206740719241;957.1242313283407;1003.3077176748167;1014.2241185493103;1019.4291196929743;16556.75164872504;18858.434246972614;19062.7140592894;19125.13936872872;19202.903985479985;39512.60487395089;52002;53921.730391347795;55040.44959550353;55095.449045510635;78711.60644196742;79025;80111;80382.45699343496;81541.59229203816;7763.4953728007495;7916.564588947663;7955;8029.638666260149;8039.1156972734125;10374.533146008296;12338.81491777642;12652.683682908;12671.366431678563;12862.935685321514;10673.57305707763;11055.61305354341;11158.44207789591;11179.161562882979;11289.04043156341;10452.947735261276;10695.465226738477;10865.022148006718;11012.339259644446;11034.117270618171;9631.181349585084;10965.671029869116;11272.718182045515;11316.321020738782;11344.829827552758;6605.339466053356;7853.37173026168;7926.088499822594;8031.799205019921;8224.671013159406;8924.910750892668;10617.93820617963;10645.680629581126;10926.890731092588;11050.557977681125 05:52:04 INFO - PROCESS | 1638 | |3;mootools.html;1318.1761399125546;1492.2315007770997;1497.760358342665;1678.3873886031595;1831.093608663711;7391.926080739191;7851.45039847211;8050.8792368114455;8272.462289951149;8302.086770455246;8222.301104406133;8294.460860044093;8297.294729947962;8300.958495207515;8306.70926517572;1926.9614607707838;2252.0991603358666;2281.577908087001;2291;2291.759365266648;2273.897674604647;2318.8956496957676;2339.543788961153;2343.6836027136374;2349.4713689419914;2279.5326957973575;2285.04028308111;2311.433698743802;2314.3635500237483;2316.339843144704;2227.120287486442;2250.8987095580737;2289.7366802817724;2291.0606651272897;2296.17337758406;2288.6795848581214;2303.67748515208;2309.6766452696634;2312.5028118954506;2321.117975169425;8046.557439340834;8169.428140030201;8234.958825205895;8279.751607451786;8356.415050946436;5050.696958182484;5167.870803229912;5188.610854185951;5194.039102766001;5197.29836472079;3365.7812242204423;3480.443129099357;3549.3256281306467;3556.946645800315;3568.3933731265747;1032.8244198486275;1046.984295235572;1052.8578641883325;1053.304818819583;1071.8660167479065;10785.83821242682;10849.78300433987;10915.235933484659;10931.453427328603;10937.125029997582;4126.133511962462;4321.2653848845775;4384.167008268419;4410.360497727876;4412.536683648171;8599.871001934976;8603.655853765904;8610.761202087502;8640.697575584825;8641.913580864237;4006.5392479864604;5016.874578135576;5017.422996355466;5024.196128619404;5036.5718913892;3933.6853051755793;4211.663066954637;4348.586884246055;4715.481297057321;4719.528047195253;3202.775805693626;3531.6756216418844;3547.8758243461357;3574.356615809127;3631.8184090795353;1118.0887576625025;1119.1550379463454;1127.932324060559;1133.7052366384798;1135.494704856331;806.9193080691883;864.6066039951806;881.6385282034336;923.5382308845577;943.7168849345169;5544.112941929272;5553.4724201200825;5753.424657534213;5807.186993820868;5947.613405128653;857.8884744983112;877.2674816528142;889.9065598112235;897.6050537763364;918.1919910478736;3647.6170002149925;3712.9628703712615;3820.8689634718885;3828.578856325802;3883.5339759229073;9648.565814538222;10133.797324053625;10147.832999205039;10161.339512931636;10198.847017294747;10066.647667331608;10082.395056296498;10094.141997930112;10099.495025248709;10104.989501049984;7676.654550545127;7847.097583777939;7857.05715314166;7859.84280314402;7861.331786798186;5247.7113758743635;5442.238086667949;5490.670559766427;5582.8325150245555;5598.32820061579;9192.816143676955;9220.400673956172;9376.062393760569;9396.342256042284;9467.857982130412;8797.868031979653;9422.104900034486;9510.524473776146;9536.761580960254;9627.807443851223;6360.554761166859;6512.544121911421;6542.934570654423;6732.932670673426;6737.696803643946;7863.960680196562;7932.960335198287;7962.163972782774;8020.877077209078;8048.5975701215875;7052.118485189351;7099.82250443743;7105.32499412555;7142.107236595426;7157.7136914522835;6024.307204671343;6922.342377474132;7007.8248043797275;7042.964785176247;7072.575645461289;6258.749650013949;6760.492963027694;6760.560563563353;6768.323167683192;6798.626075565693;4743.146233677971;4859.2954021667365;4872.561469467765;4903.681260718185;5013.147764880052;4761.880952976203;4885.022995400863;4923.803047878045;4973.9751301244705;5065.986802639561 05:52:04 INFO - PROCESS | 1638 | |4;prototype.html;296.11461729429004;300.98495075246245;307.1017274472169;314.294409051679;314.4308801070065;4122.814473348699;4425.8450954216605;4792.185328494155;4943.67866088704;4972.016789926047;4664.930026049612;4737.739424331669;4811.615070794337;4822.831200907969;4854.514548545152;3524.0837382280665;3780.319542482352;3810.409386545076;3816.5687867049855;3826.1582451860686;3436.536067630863;3772.1512659651635;3791.2227993261454;3800.6579407853287;3837.2901013312485;3039.95121683019;3788.3749181385037;3790.393537034075;3808.9809550952205;3816.866409675662;3770.170562476251;3775.5091838061153;3791.4123310886857;3804.9809750951345;3815.751976121543;2722.945541089187;3266.4283750343593;3272.30229840279;3276.57404537411;3279.754018448626;4812.687175333592;4817.181079216542;4830.589399901012;4830.686005409637;4836.661433699643;3529.982350088233;4099.241640296555;4195.91608167835;4244.257254980397;4344.152890186415;4265.658747300239;4869.464358920516;5030.446650868402;5137.357830271216;5227.372715274191;2982.895598654037;3053.0077724739326;3570.4822800694014;3581.7850928944345;3596.406592912166;5156.20078887773;5390.245365648773;5410.97294513525;5446.7276636168035;5487.5609951203805;3236.4336241157703;3478.3912815257227;3650.3611867923537;3652.9817350913077;3657.104009517685;3683.4106542953;3693.9076523087138;3706.054955986206;3710.627067984863;3734.6078661740125;3826.7895265760094;4314.928834159558;4318.52496225415;4320.675949303814;4338.8047537860875;4796.088743138793;4993.447892199283;5067.442581316126;5245.93440083938;5254.632175747661;1136.778328225988;1174.9647510574696;1181.704573856536;1187.8099504079305;1191.755690083531;693.7329128285646;700.3346820520526;758.9564349020097;763.3625922354785;772.3473664753275;4500.482444518922;4501.752403617833;4506.797194126272;4513.842015529506;4549.45406551216;4098.610631989956;4581.587657110809;4654.57961859831;4946.925796113062;4952.953933330976;4288.36115870427;4409.911801763947;4486.730796152176;4490.979059423273;4503.658097789197;2270.965935510969;2390.438247011951;2499.512595043985;2541.8053514847993;2585.7931365490717;4542.841000564964;4862.635302352267;5065.847015018602;5121.103806833789;5160.509751573594;4495.100979803987;4634.408333541465;5024.161348837895;5039.44566097729;5061.367329083864;5588.832335029955;5594;5595.468430499015;5600.243967064394;5632.464915832989;5074.5686616637995;5340.706261155518;5368.40947495783;5377;5431.375391829832;5058.07735356299;5316.777141257455;5369.57043436532;5369.946300537101;5370.543503802064;4725.480197178376;5560.304961879765;5561.888762224814;5562.22128901946;5588.972055139699;3629.4593784351587;3632.763870348419;3655.83548740302;3656.177360094064;3662.6520480554304;4516.954830451785;4713.62291016711;5166.844994650167;5337.119375303187;5408.405075441619;4178.937315940202;5201.505856943584;5242.68543887368;5252.002119597264;5278;5216.2436446714255;5224.346956630421;5231.581473482189;5243.872567397875;5303.761330740203;4704.270838020112;5052.989402119664;5069.822556210663;5105.33630628016;5117.02776472469;4266.914661706686;4446.843281008643;4801.671189473033;4961.231009193581;5173.430922598436;4426.225410553076;4979.576735977483;5115.718635475085;5119.974400128124;5122.667026643257 05:52:04 INFO - PROCESS | 1638 | |5;yui.html;623.987520249595;652.7747926965197;697.8464737757691;703.4969996452538;710.4103594016966;13976.790348144787;14972.700545989073;14976.850231497681;15000.249987500622;15005.92497037516;13302;13494.865051349483;13500.392482338293;13512.932435337834;13532.458701651922;653.3466533466534;675.0212192321154;819.983600327993;830.244477525452;847.576211894053;842.4608250719544;843.0852525010371;847.9067302596709;853.9487630742144;857.8455877941968;906.9546522673872;907.7049958763396;910.3263584947125;913.70761356366;915.4232833315035;700.1493185779302;903.8056817784142;904.8235594059161;905.6784841381314;908.1644886704182;538.7010209333819;638.8626445314234;651.280335229574;654.3521913305793;656.993430065698;11600.477978490904;13843.515476958359;13907.304634768221;13917.373718182605;13949.58151255464;11763;12031.819522707166;12048.397580121047;12084.697882552919;12255.632331030083;11390.373529455877;11638.709032274177;11668.708282292926;11713.472893719803;11748.177627566074;4058.472398588194;4154.813033413504;4158.688098392633;4169.4162817205615;4212.578742125794;83969.320613588;84146.15853841505;85575.57212213961;85605;87791.12208877894;9709.951450242845;9728.708138755848;9777.65778197774;10027.949860250652;10143.492825358702;18323.633527329377;19105.331313403964;19217.8078219216;19289.51776205606;19300.71048934267;7294.235088594959;7440.107187137578;7489.063867016623;7503.474756766974;7655.272749088827;3446.758726889144;3479.634638362986;3524.8590056397456;3605.3330133925306;3923.1172986078473;3417.9829100854336;3487.738419618539;3511.754177207571;3535.1869070114017;3544.8759293424605;648.303074195242;650.2587050762135;659.7229163751236;663.6747993483159;671.9899201511981;523.6151428699902;556.3685217278418;611.7338957553478;648.4844548583887;648.5913874259281;8184.754457366289;8583.48499090044;8712.47438460731;8741.388102832869;8884.866726998971;501.03593911865573;599.9310079340844;620.5625034350771;652.2173391929704;655.2595567009249;4105.34314509677;4257.850975215914;4259.680523960654;4317.179735850178;4424.048829501673;93701.5314923421;101068;117205;118041;122433;99028;101922.49038754907;102704.48647756713;105622;106336;89317.55341223383;90025;90460.09539904648;91729.90970993186;92116.53941730516;6737.393634572912;7981.48120372174;8131.593420329078;8328.500289982621;8506.447080939719;56909;57262;57618.7119064402;58686.4131358681;60158.69920650369;81516.59241703754;84042.57978710068;85062;86046.1395386038;88758.11241887498;10639.308444951053;10873.510692019036;11057.060149887027;11172.441377931233;11208.607698730506;11801.350925698825;12015.339156346485;12171;12176.330301833485;12634;10701.983311585387;11173.273737207055;11368.488418021043;11476.254043487146;11747.29516229029;11593.942030289794;11651;12117.454714537691;12193.26840389544;12204.267743935392;11119.72200694989;11220.326780393203;11355;11407.315561066363;11561;6927.7228910845015;9467.195288400288;9746;10032.297739158188;10064.696625284023;8444.40889137779;8655.523946182768;8865.379423440556;9757.560909758937;9773.657921972697 05:52:04 INFO - PROCESS | 1638 | __end_tp_report 05:52:04 INFO - PROCESS | 1638 | __start_cc_report 05:52:04 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,2228 05:52:04 INFO - PROCESS | 1638 | __end_cc_report 05:52:04 INFO - PROCESS | 1638 | __startTimestamp1479822724414__endTimestamp 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | ------- Summary: start ------- 05:52:04 INFO - PROCESS | 1638 | Number of tests: 6 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5597.60 Median:5679.09 stddev:617.38 (10.9%) stddev-sans-first:591.11 05:52:04 INFO - PROCESS | 1638 | Values: 3247.8 3299.5 3301.1 3326.3 3358.8 5392.7 5483.3 5495.2 5598.6 5604.4 5486.0 5512.3 5513.0 5523.9 5529.1 4995.5 5031.6 5036.5 5069.8 5137.1 5065.7 5141.3 5153.7 5157.9 5158.1 5050.5 5104.8 5127.9 5130.8 5134.7 5152.5 5156.0 5161.2 5187.1 5192.4 4994.1 5006.1 5045.9 5111.4 5120.4 5431.1 5460.8 5486.1 5516.6 5523.2 6067.5 6071.6 6073.9 6077.2 6085.4 5983.9 6102.5 6138.0 6148.8 6165.4 5652.3 5656.5 5659.9 5668.8 5672.7 6136.7 6183.1 6198.3 6210.9 6216.2 5857.3 5909.3 5922.9 5932.4 5941.0 6099.1 6101.9 6103.8 6114.8 6120.8 6048.6 6074.1 6075.5 6079.3 6085.0 5973.8 6042.5 6058.5 6074.8 6094.8 4840.4 4847.8 4860.2 4885.4 4930.0 4366.5 4374.3 4381.6 4395.9 4419.8 5479.1 5533.4 5538.4 5567.8 5577.3 6187.3 6191.0 6209.2 6212.3 6231.0 5646.3 5662.3 5667.6 5668.6 5679.1 5200.3 5236.7 5242.4 5305.2 5314.8 5350.2 6163.5 6190.3 6269.2 6293.7 6135.5 6136.4 6151.4 6152.1 6152.5 5221.9 6225.7 6317.7 6321.3 6348.7 4931.3 5796.4 5872.5 5949.9 6039.3 5929.1 6158.6 6174.4 6182.2 6198.4 5934.2 5957.0 5964.9 5971.5 5975.7 5706.7 5801.3 5810.9 5848.3 5898.4 5613.1 5656.4 5657.9 5661.9 5662.0 5817.0 5876.6 5906.3 5955.6 5993.9 5791.4 5795.6 5799.9 5815.1 5826.3 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:65870.10 Median:38070.08 stddev:144854.97 (380.5%) stddev-sans-first:145178.18 05:52:04 INFO - PROCESS | 1638 | Values: 498.0 529.1 529.3 540.9 548.1 25917.6 32402.8 38205.6 39062.6 40935.6 40779.8 41254.6 41313.2 41372.4 41382.8 9193.1 9380.2 9382.2 9383.6 9390.2 9326.3 9437.1 9438.0 9438.0 9449.1 9310.7 9392.3 9432.7 9447.6 9463.9 9384.2 9430.7 9435.0 9437.2 9526.9 9230.6 9284.0 9302.5 9310.3 9310.5 38958.8 39226.8 39264.0 39281.8 39364.0 3215.2 3261.2 3269.0 3285.4 3386.1 29290.4 29415.4 29829.6 29909.4 30236.2 3062.0 3093.8 3125.9 3128.1 3177.1 354624.0 465685.0 465772.0 467177.0 470193.0 56944.0 57365.9 57397.0 57414.1 57547.1 33646.8 34407.7 34460.0 35570.8 60558.4 15563.6 15692.0 15834.4 15851.8 15867.0 12008.9 12107.3 12135.6 12147.6 12156.6 15018.8 18603.4 18608.3 18611.9 18619.3 7517.8 7623.5 7623.7 7681.8 7685.4 870.3 930.7 966.5 1063.6 1118.1 29032.4 29206.9 29279.1 29565.9 30503.8 872.5 999.2 1043.8 1069.2 1154.6 13952.2 14511.2 14566.3 14703.6 14767.9 637440.0 637689.0 639101.0 639242.0 639448.0 53618.5 54036.0 54055.2 54151.5 54190.0 1202.9 1225.3 1317.7 1339.7 1361.8 24451.9 28849.6 28902.4 29180.0 29438.7 47809.0 48374.0 48397.8 48452.0 48481.3 517455.0 522158.0 522941.0 522977.0 525252.0 25618.0 26439.9 26557.7 27044.6 27178.2 44245.1 44507.8 45398.0 45480.0 45974.5 36186.8 36242.6 36486.0 37513.2 37604.8 36781.0 36821.0 37840.6 37934.5 38312.8 35245.0 35565.6 35704.5 35861.6 36253.7 31615.0 32775.0 32903.8 33032.5 33160.3 22191.0 23795.5 24036.6 24584.0 24718.8 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:33264.94 Median:1431.69 stddev:94229.91 (6581.7%) stddev-sans-first:94461.84 05:52:04 INFO - PROCESS | 1638 | Values: 350.8 365.8 374.4 379.8 398.3 14489.8 14831.0 15253.3 19544.3 20297.1 18791.2 19158.3 19766.8 20046.6 20281.1 5379.4 5728.6 5732.5 5732.7 5733.1 5111.5 5452.2 5670.1 5727.8 5747.3 5682.3 5683.3 5684.7 5686.9 5687.7 5213.9 5570.5 5689.7 5879.3 5942.1 5533.9 5736.1 5776.5 5788.2 5792.8 10217.0 11908.7 11976.0 12169.5 12179.2 2038.3 2139.9 2210.6 2501.4 2512.6 9474.8 9859.1 9898.9 10406.5 10438.3 1804.7 1815.9 1837.3 1859.9 1878.8 115461.0 121028.0 122327.4 122418.5 123498.4 11208.8 11238.7 11313.7 11343.0 11570.6 14315.7 14324.3 14325.6 14336.3 14354.8 6824.9 7942.6 8224.6 8350.1 8384.6 7079.0 7799.3 8112.1 8125.0 8297.0 4470.2 4479.6 4488.1 4496.2 4549.8 1724.0 1904.3 1907.8 1911.2 1911.7 795.3 865.1 896.7 926.1 963.5 19979.9 20550.6 20625.2 20672.5 20820.7 769.8 909.9 913.3 937.2 979.0 8568.4 9920.8 10432.9 10912.3 11099.7 553929.0 557279.0 558307.2 570418.0 571075.1 118471.0 120574.4 120980.2 121926.0 124878.0 943.8 957.1 1003.3 1014.2 1019.4 16556.8 18858.4 19062.7 19125.1 19202.9 39512.6 52002.0 53921.7 55040.4 55095.4 78711.6 79025.0 80111.0 80382.5 81541.6 7763.5 7916.6 7955.0 8029.6 8039.1 10374.5 12338.8 12652.7 12671.4 12862.9 10673.6 11055.6 11158.4 11179.2 11289.0 10452.9 10695.5 10865.0 11012.3 11034.1 9631.2 10965.7 11272.7 11316.3 11344.8 6605.3 7853.4 7926.1 8031.8 8224.7 8924.9 10617.9 10645.7 10926.9 11050.6 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5366.48 Median:5020.81 stddev:2960.59 (59.0%) stddev-sans-first:2953.26 05:52:04 INFO - PROCESS | 1638 | Values: 1318.2 1492.2 1497.8 1678.4 1831.1 7391.9 7851.5 8050.9 8272.5 8302.1 8222.3 8294.5 8297.3 8301.0 8306.7 1927.0 2252.1 2281.6 2291.0 2291.8 2273.9 2318.9 2339.5 2343.7 2349.5 2279.5 2285.0 2311.4 2314.4 2316.3 2227.1 2250.9 2289.7 2291.1 2296.2 2288.7 2303.7 2309.7 2312.5 2321.1 8046.6 8169.4 8235.0 8279.8 8356.4 5050.7 5167.9 5188.6 5194.0 5197.3 3365.8 3480.4 3549.3 3556.9 3568.4 1032.8 1047.0 1052.9 1053.3 1071.9 10785.8 10849.8 10915.2 10931.5 10937.1 4126.1 4321.3 4384.2 4410.4 4412.5 8599.9 8603.7 8610.8 8640.7 8641.9 4006.5 5016.9 5017.4 5024.2 5036.6 3933.7 4211.7 4348.6 4715.5 4719.5 3202.8 3531.7 3547.9 3574.4 3631.8 1118.1 1119.2 1127.9 1133.7 1135.5 806.9 864.6 881.6 923.5 943.7 5544.1 5553.5 5753.4 5807.2 5947.6 857.9 877.3 889.9 897.6 918.2 3647.6 3713.0 3820.9 3828.6 3883.5 9648.6 10133.8 10147.8 10161.3 10198.8 10066.6 10082.4 10094.1 10099.5 10105.0 7676.7 7847.1 7857.1 7859.8 7861.3 5247.7 5442.2 5490.7 5582.8 5598.3 9192.8 9220.4 9376.1 9396.3 9467.9 8797.9 9422.1 9510.5 9536.8 9627.8 6360.6 6512.5 6542.9 6732.9 6737.7 7864.0 7933.0 7962.2 8020.9 8048.6 7052.1 7099.8 7105.3 7142.1 7157.7 6024.3 6922.3 7007.8 7043.0 7072.6 6258.7 6760.5 6760.6 6768.3 6798.6 4743.1 4859.3 4872.6 4903.7 5013.1 4761.9 4885.0 4923.8 4974.0 5066.0 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4164.85 Median:4565.52 stddev:1286.84 (28.2%) stddev-sans-first:1257.26 05:52:04 INFO - PROCESS | 1638 | Values: 296.1 301.0 307.1 314.3 314.4 4122.8 4425.8 4792.2 4943.7 4972.0 4664.9 4737.7 4811.6 4822.8 4854.5 3524.1 3780.3 3810.4 3816.6 3826.2 3436.5 3772.2 3791.2 3800.7 3837.3 3040.0 3788.4 3790.4 3809.0 3816.9 3770.2 3775.5 3791.4 3805.0 3815.8 2722.9 3266.4 3272.3 3276.6 3279.8 4812.7 4817.2 4830.6 4830.7 4836.7 3530.0 4099.2 4195.9 4244.3 4344.2 4265.7 4869.5 5030.4 5137.4 5227.4 2982.9 3053.0 3570.5 3581.8 3596.4 5156.2 5390.2 5411.0 5446.7 5487.6 3236.4 3478.4 3650.4 3653.0 3657.1 3683.4 3693.9 3706.1 3710.6 3734.6 3826.8 4314.9 4318.5 4320.7 4338.8 4796.1 4993.4 5067.4 5245.9 5254.6 1136.8 1175.0 1181.7 1187.8 1191.8 693.7 700.3 759.0 763.4 772.3 4500.5 4501.8 4506.8 4513.8 4549.5 4098.6 4581.6 4654.6 4946.9 4953.0 4288.4 4409.9 4486.7 4491.0 4503.7 2271.0 2390.4 2499.5 2541.8 2585.8 4542.8 4862.6 5065.8 5121.1 5160.5 4495.1 4634.4 5024.2 5039.4 5061.4 5588.8 5594.0 5595.5 5600.2 5632.5 5074.6 5340.7 5368.4 5377.0 5431.4 5058.1 5316.8 5369.6 5369.9 5370.5 4725.5 5560.3 5561.9 5562.2 5589.0 3629.5 3632.8 3655.8 3656.2 3662.7 4517.0 4713.6 5166.8 5337.1 5408.4 4178.9 5201.5 5242.7 5252.0 5278.0 5216.2 5224.3 5231.6 5243.9 5303.8 4704.3 5053.0 5069.8 5105.3 5117.0 4266.9 4446.8 4801.7 4961.2 5173.4 4426.2 4979.6 5115.7 5120.0 5122.7 05:52:04 INFO - PROCESS | 1638 | 05:52:04 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20818.06 Median:28732.68 stddev:31687.26 (110.3%) stddev-sans-first:31739.88 05:52:04 INFO - PROCESS | 1638 | Values: 624.0 652.8 697.8 703.5 710.4 13976.8 14972.7 14976.9 15000.2 15005.9 13302.0 13494.9 13500.4 13512.9 13532.5 653.3 675.0 820.0 830.2 847.6 842.5 843.1 847.9 853.9 857.8 907.0 907.7 910.3 913.7 915.4 700.1 903.8 904.8 905.7 908.2 538.7 638.9 651.3 654.4 657.0 11600.5 13843.5 13907.3 13917.4 13949.6 11763.0 12031.8 12048.4 12084.7 12255.6 11390.4 11638.7 11668.7 11713.5 11748.2 4058.5 4154.8 4158.7 4169.4 4212.6 83969.3 84146.2 85575.6 85605.0 87791.1 9710.0 9728.7 9777.7 10027.9 10143.5 18323.6 19105.3 19217.8 19289.5 19300.7 7294.2 7440.1 7489.1 7503.5 7655.3 3446.8 3479.6 3524.9 3605.3 3923.1 3418.0 3487.7 3511.8 3535.2 3544.9 648.3 650.3 659.7 663.7 672.0 523.6 556.4 611.7 648.5 648.6 8184.8 8583.5 8712.5 8741.4 8884.9 501.0 599.9 620.6 652.2 655.3 4105.3 4257.9 4259.7 4317.2 4424.0 93701.5 101068.0 117205.0 118041.0 122433.0 99028.0 101922.5 102704.5 105622.0 106336.0 89317.6 90025.0 90460.1 91729.9 92116.5 6737.4 7981.5 8131.6 8328.5 8506.4 56909.0 57262.0 57618.7 58686.4 60158.7 81516.6 84042.6 85062.0 86046.1 88758.1 10639.3 10873.5 11057.1 11172.4 11208.6 11801.4 12015.3 12171.0 12176.3 12634.0 10702.0 11173.3 11368.5 11476.3 11747.3 11593.9 11651.0 12117.5 12193.3 12204.3 11119.7 11220.3 11355.0 11407.3 11561.0 6927.7 9467.2 9746.0 10032.3 10064.7 8444.4 8655.5 8865.4 9757.6 9773.7 05:52:04 INFO - PROCESS | 1638 | -------- Summary: end -------- 05:52:04 INFO - PROCESS | 1638 | 05:52:05 INFO - TEST-INFO | 1638: exit 0 05:52:05 INFO - TEST-OK | dromaeo_css | took 1120679ms 05:52:05 INFO - TEST-START | kraken 05:52:05 INFO - operating with platform_type : mac_ 05:52:05 INFO - Initialising browser for kraken test... 05:52:05 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpqK4fnz/profile http://localhost:49241/getInfo.html) 05:52:07 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:52:07 INFO - PROCESS | 1648 | colorDepth:24 05:52:07 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:52:07 INFO - PROCESS | 1648 | __metrics 05:52:07 INFO - PROCESS | 1648 | 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" 05:52:07 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:08 INFO - TEST-INFO | 1648: exit 0 05:52:08 INFO - Browser initialized. 05:52:08 INFO - Running cycle 1/1 for kraken test... 05:52:08 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpqK4fnz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:20 INFO - PROCESS | 1650 | RSS: Main: 243593216 05:52:20 INFO - PROCESS | 1650 | 05:52:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:24 INFO - PROCESS | 1650 | RSS: Main: 294264832 05:52:24 INFO - PROCESS | 1650 | 05:52:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:52:27 INFO - PROCESS | 1650 | RSS: Main: 295575552 05:52:27 INFO - PROCESS | 1650 | 05:52:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:52:32 INFO - PROCESS | 1650 | RSS: Main: 387940352 05:52:32 INFO - PROCESS | 1650 | 05:52:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:52:34 INFO - PROCESS | 1650 | RSS: Main: 291581952 05:52:34 INFO - PROCESS | 1650 | 05:52:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:37 INFO - PROCESS | 1650 | RSS: Main: 293789696 05:52:37 INFO - PROCESS | 1650 | 05:52:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:40 INFO - PROCESS | 1650 | RSS: Main: 336904192 05:52:40 INFO - PROCESS | 1650 | 05:52:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:44 INFO - PROCESS | 1650 | RSS: Main: 336355328 05:52:44 INFO - PROCESS | 1650 | 05:52:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:52:47 INFO - PROCESS | 1650 | RSS: Main: 334680064 05:52:47 INFO - PROCESS | 1650 | 05:52:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:50 INFO - PROCESS | 1650 | RSS: Main: 309805056 05:52:50 INFO - PROCESS | 1650 | 05:52:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:52 INFO - PROCESS | 1650 | RSS: Main: 312623104 05:52:52 INFO - PROCESS | 1650 | 05:52:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:55 INFO - PROCESS | 1650 | RSS: Main: 315330560 05:52:55 INFO - PROCESS | 1650 | 05:52:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:59 INFO - PROCESS | 1650 | RSS: Main: 332242944 05:52:59 INFO - PROCESS | 1650 | 05:53:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:02 INFO - PROCESS | 1650 | RSS: Main: 325885952 05:53:02 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:53:04 INFO - PROCESS | 1650 | RSS: Main: 369381376 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | __start_tp_report 05:53:04 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 05:53:04 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 05:53:04 INFO - PROCESS | 1650 | |i|pagename|runs| 05:53:04 INFO - PROCESS | 1650 | |0;ai-astar;115;114;114;114;114;118;166;163;115;112 05:53:04 INFO - PROCESS | 1650 | |1;audio-beat-detection;141;111;115;149;112;113;111;117;127;122 05:53:04 INFO - PROCESS | 1650 | |2;audio-dft;186;183;185;186;184;182;179;185;184;178 05:53:04 INFO - PROCESS | 1650 | |3;audio-fft;83;59;76;116;90;58;59;59;85;58 05:53:04 INFO - PROCESS | 1650 | |4;audio-oscillator;85;70;93;68;67;70;89;68;67;93 05:53:04 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;85;87;85;123;86;88;85;88;85 05:53:04 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;97;97;118;168;96;96;96;96;96 05:53:04 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;84;86;85;87;87;87;83;85;98 05:53:04 INFO - PROCESS | 1650 | |8;json-parse-financial;56;56;56;56;55;55;54;54;54;55 05:53:04 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;71;65;74;74;70;68;69;68;69 05:53:04 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;87;87;88;87;88;85;109;88;85 05:53:04 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;149;150;151;149;147;151;154;157;206;164 05:53:04 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;175;172;170;173;182;237;237;173;171;170 05:53:04 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;61;76;87;90;69;67;67;66;67;67 05:53:04 INFO - PROCESS | 1650 | __end_tp_report 05:53:04 INFO - PROCESS | 1650 | __start_cc_report 05:53:04 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2014 05:53:04 INFO - PROCESS | 1650 | __end_cc_report 05:53:04 INFO - PROCESS | 1650 | __startTimestamp1479822784956__endTimestamp 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | ------- Summary: start ------- 05:53:04 INFO - PROCESS | 1650 | Number of tests: 14 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:124.50 Median:115.00 stddev:21.15 (18.4%) stddev-sans-first:22.15 05:53:04 INFO - PROCESS | 1650 | Values: 115.0 114.0 114.0 114.0 114.0 118.0 166.0 163.0 115.0 112.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:119.50 stddev:13.38 (11.2%) stddev-sans-first:12.26 05:53:04 INFO - PROCESS | 1650 | Values: 141.0 111.0 115.0 149.0 112.0 113.0 111.0 117.0 127.0 122.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.50 stddev:2.78 (1.5%) stddev-sans-first:2.76 05:53:04 INFO - PROCESS | 1650 | Values: 186.0 183.0 185.0 186.0 184.0 182.0 179.0 185.0 184.0 178.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:74.30 Median:67.50 stddev:19.47 (28.8%) stddev-sans-first:20.40 05:53:04 INFO - PROCESS | 1650 | Values: 83.0 59.0 76.0 116.0 90.0 58.0 59.0 59.0 85.0 58.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:11.45 (14.8%) stddev-sans-first:11.77 05:53:04 INFO - PROCESS | 1650 | Values: 85.0 70.0 93.0 68.0 67.0 70.0 89.0 68.0 67.0 93.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:86.50 stddev:11.66 (13.5%) stddev-sans-first:12.36 05:53:04 INFO - PROCESS | 1650 | Values: 89.0 85.0 87.0 85.0 123.0 86.0 88.0 85.0 88.0 85.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:96.00 stddev:23.02 (24.0%) stddev-sans-first:24.10 05:53:04 INFO - PROCESS | 1650 | Values: 95.0 97.0 97.0 118.0 168.0 96.0 96.0 96.0 96.0 96.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:86.50 stddev:4.19 (4.8%) stddev-sans-first:4.40 05:53:04 INFO - PROCESS | 1650 | Values: 85.0 84.0 86.0 85.0 87.0 87.0 87.0 83.0 85.0 98.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 05:53:04 INFO - PROCESS | 1650 | Values: 56.0 56.0 56.0 56.0 55.0 55.0 54.0 54.0 54.0 55.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:3.13 (4.5%) stddev-sans-first:2.91 05:53:04 INFO - PROCESS | 1650 | Values: 65.0 71.0 65.0 74.0 74.0 70.0 68.0 69.0 68.0 69.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:87.00 stddev:7.08 (8.1%) stddev-sans-first:7.47 05:53:04 INFO - PROCESS | 1650 | Values: 87.0 87.0 87.0 88.0 87.0 88.0 85.0 109.0 88.0 85.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:157.80 Median:152.50 stddev:17.64 (11.6%) stddev-sans-first:18.42 05:53:04 INFO - PROCESS | 1650 | Values: 149.0 150.0 151.0 149.0 147.0 151.0 154.0 157.0 206.0 164.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.00 Median:174.00 stddev:27.10 (15.6%) stddev-sans-first:28.45 05:53:04 INFO - PROCESS | 1650 | Values: 175.0 172.0 170.0 173.0 182.0 237.0 237.0 173.0 171.0 170.0 05:53:04 INFO - PROCESS | 1650 | 05:53:04 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:68.00 stddev:9.60 (14.1%) stddev-sans-first:9.37 05:53:04 INFO - PROCESS | 1650 | Values: 61.0 76.0 87.0 90.0 69.0 67.0 67.0 66.0 67.0 67.0 05:53:04 INFO - PROCESS | 1650 | -------- Summary: end -------- 05:53:04 INFO - PROCESS | 1650 | 05:53:05 INFO - TEST-INFO | 1650: exit 0 05:53:06 INFO - TEST-OK | kraken | took 60910ms 05:53:06 INFO - SUITE-END | took 1181s 05:53:06 INFO - Completed test suite (00:19:41) 05:53:06 INFO - javascript benchmark 05:53:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.7888937219077, 3299.45558982768, 3301.1087006508237, 3326.301476689895, 3358.8320583970794, 5392.703401312926, 5483.341998960121, 5495.175723641456, 5598.580106492014, 5604.355499117602, 5485.9725701371535, 5512.283403157594, 5512.972435137829, 5523.861903452415, 5529.115341545354, 4995.52542508462, 5031.597472202233, 5036.471170527097, 5069.771860266278, 5137.075326441239, 5065.696058236499, 5141.305923700309, 5153.69077855328, 5157.922631160535, 5158.071547121516, 5050.520200580939, 5104.77028533715, 5127.948720512784, 5130.769115389798, 5134.717590532519, 5152.484751524855, 5156.0, 5161.225816127611, 5187.118189907725, 5192.350956130484, 4994.076095922266, 5006.123928312531, 5045.899082018339, 5111.361079865017, 5120.359955005624, 5431.103867861798, 5460.754266058037, 5486.149646804752, 5516.613837031409, 5523.199136125279, 6067.453929146354, 6071.635701857903, 6073.878522429527, 6077.209962704865, 6085.3914608539235, 5983.940160598382, 6102.542309326774, 6137.987232106697, 6148.815535533941, 6165.445109940127, 5652.293463317085, 5656.462636049651, 5659.858503537444, 5668.801591944303, 5672.659640421588, 6136.654150355513, 6183.103449999815, 6198.256209254918, 6210.875782484325, 6216.222972128484, 5857.297124345106, 5909.3204281507315, 5922.911156332659, 5932.377100404482, 5941.0197317442135, 6099.11562823397, 6101.938980610137, 6103.792276408673, 6114.755409783559, 6120.755169793248, 6048.637081775108, 6074.088886666947, 6075.544334174866, 6079.300880398722, 6085.0, 5973.761049557969, 6042.456178943916, 6058.454739073504, 6074.817755467343, 6094.786682466092, 4840.394950631171, 4847.80608775645, 4860.246661767432, 4885.364902562644, 4930.038642464757, 4366.454193225847, 4374.343848422698, 4381.605655491021, 4395.934060989088, 4419.756913369795, 5479.0959491684225, 5533.391326954032, 5538.418466061086, 5567.777288908479, 5577.330720313507, 6187.288461826947, 6191.040388739752, 6209.192804935329, 6212.285587157445, 6231.0, 5646.265985421869, 5662.292213473316, 5667.574931880125, 5668.631538949955, 5679.091345384719, 5200.349956255468, 5236.685798852005, 5242.397124330674, 5305.1776974569, 5314.7608357624, 5350.197470379474, 6163.476104531165, 6190.3190649029475, 6269.18500594938, 6293.685315734287, 6135.509159267337, 6136.355682653257, 6151.415615516519, 6152.138700581832, 6152.507799376129, 5221.869453263699, 6225.657588832658, 6317.715702793477, 6321.336259692666, 6348.746050158126, 4931.3096166536, 5796.449337312949, 5872.5301975842685, 5949.929012777741, 6039.335673076046, 5929.0513517836935, 6158.630482171084, 6174.351693072343, 6182.196314479269, 6198.380161983766, 5934.19888315072, 5956.970215148896, 5964.9105263420215, 5971.462568368867, 5975.731092100779, 5706.657600543981, 5801.274840644919, 5810.912836307374, 5848.298204215522, 5898.351181370132, 5613.073842815889, 5656.37779844225, 5657.886842263214, 5661.943380566142, 5662.0, 5816.970915145566, 5876.647401155944, 5906.26171728534, 5955.642661440327, 5993.940060599512, 5791.420857914175, 5795.623284486495, 5799.913001305068, 5815.069588865761, 5826.271716035496], "value": 5559.1169069109255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.0164175752891, 529.0768058108774, 529.3066083430705, 540.859376562094, 548.0792268988098, 25917.61123583148, 32402.837985810067, 38205.61794382055, 39062.60937390632, 40935.59064409355, 40779.79610101953, 41254.58745412545, 41313.17373652525, 41372.37941430881, 41382.7930860346, 9193.126652967974, 9380.202682771973, 9382.155605995458, 9383.577739001761, 9390.201832844183, 9326.347155699104, 9437.103475169848, 9438.0, 9438.0, 9449.14957653811, 9310.72067837966, 9392.342536022481, 9432.717018489457, 9447.57485913132, 9463.905360946406, 9384.249260059212, 9430.717078487656, 9434.95282523583, 9437.197838183763, 9526.857097143513, 9230.630774769, 9284.0, 9302.488363140024, 9310.255179585616, 9310.53447327631, 38958.80520597379, 39226.80386598049, 39264.0, 39281.80359098215, 39364.0, 3215.1962009497624, 3261.1521004538754, 3268.96731032689, 3285.4414749492644, 3386.0688310714504, 29290.414191716045, 29415.411691766043, 29829.552556711667, 29909.401811963857, 30236.244093897607, 3061.9693803062128, 3093.8298393588343, 3125.9062228132966, 3128.0615815255333, 3177.094528059515, 354624.0, 465685.0, 465772.0, 467177.0, 470193.0, 56944.0, 57365.852682946104, 57397.0, 57414.138787918215, 57547.13679294814, 33646.831765841016, 34407.65592344094, 34460.0, 35570.822145889106, 60558.39441605616, 15563.610909727347, 15692.0, 15834.366625335088, 15851.841481585037, 15867.0, 12008.879911200951, 12107.273563586214, 12135.575254866037, 12147.635570932885, 12156.574519891761, 15018.774718379233, 18603.44189674312, 18608.348707795434, 18611.90694046521, 18619.32426081632, 7517.849643007109, 7623.54258744466, 7623.656935437919, 7681.846363072819, 7685.42359323053, 870.2646263906988, 930.7393929699695, 966.5264020629841, 1063.6436793674052, 1118.1334465789078, 29032.419351613273, 29206.85396573046, 29279.121626351243, 29565.85217073944, 30503.847480762455, 872.4852337121002, 999.1864765450683, 1043.8486419469286, 1069.2354966199205, 1154.6247469572422, 13952.232627205602, 14511.201883896276, 14566.29621863416, 14703.632409189642, 14767.92616036913, 637440.0, 637689.0, 639101.0, 639242.0, 639448.0, 53618.46381536135, 54036.0, 54055.18917216245, 54151.45848541543, 54190.0, 1202.8857258560597, 1225.301578100492, 1317.6771690935782, 1339.6784771654732, 1361.7753070743217, 24451.877740611184, 28849.567256491588, 28902.42195156127, 29180.0, 29438.705612943595, 47809.0, 48374.0, 48397.758011211125, 48452.0, 48481.27278090902, 517455.0, 522158.0, 522941.0, 522977.0, 525252.0, 25618.0, 26439.867800660875, 26557.7344226563, 27044.594331084656, 27178.184654460398, 44245.11509769722, 44507.777461112484, 45398.0, 45480.0, 45974.54025459703, 36186.8190659045, 36242.63757362498, 36486.0, 37513.2497350046, 37604.81197593995, 36781.0, 36821.0, 37840.62159378371, 37934.53425527332, 38312.80843595764, 35245.0, 35565.64434355623, 35704.464433034045, 35861.64138358583, 36253.65561026757, 31615.0, 32775.0, 32903.761172542, 33032.50451243281, 33160.336793263516, 22191.007023419603, 23795.524089518458, 24036.63945040861, 24584.0, 24718.752812471645], "value": 19019.130427233147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.77725644215917, 365.76590981771653, 374.3729253500387, 379.84995926608997, 398.2950178184613, 14489.78265326021, 14831.03598266112, 15253.303144504194, 19544.31594894179, 20297.0866311016, 18791.154398052087, 19158.329458468957, 19766.802331976676, 20046.59906801863, 20281.0873510692, 5379.35447746271, 5728.598998070137, 5732.541396688276, 5732.713364331767, 5733.140028995643, 5111.539961403473, 5452.236686863842, 5670.064439367499, 5727.799527016556, 5747.281589801275, 5682.346530149044, 5683.261176047129, 5684.658920464785, 5686.914696279559, 5687.7156142192935, 5213.852952350477, 5570.470805273513, 5689.687067211302, 5879.294484661847, 5942.138389933435, 5533.944660553423, 5736.139579063132, 5776.537876969875, 5788.160716696098, 5792.768289268424, 10217.029382208753, 11908.702282443008, 11976.0, 12169.452374643162, 12179.208351457215, 2038.3171637501455, 2139.8609090409072, 2210.624193887043, 2501.3621526510624, 2512.5979843224995, 9474.763130921714, 9859.112679858847, 9898.90101098987, 10406.479676016244, 10438.269321147523, 1804.7022241330296, 1815.9182836772377, 1837.3201915291427, 1859.8698091133626, 1878.821511956362, 115461.0, 121028.0, 122327.38836305762, 122418.49116789676, 123498.38250808779, 11208.831867521994, 11238.719032024264, 11313.660590182308, 11343.0, 11570.595029174106, 14315.713685726227, 14324.283785810669, 14325.64185895361, 14336.283185840666, 14354.784678229835, 6824.897626535606, 7942.6028698566, 8224.588770561448, 8350.08149103598, 8384.622691978875, 7079.00893874858, 7799.337056350274, 8112.107668156498, 8124.953142571536, 8297.0, 4470.240059189946, 4479.641628669699, 4488.1248156609145, 4496.213162696515, 4549.772511374418, 1723.9827601723823, 1904.3144467991513, 1907.818757218062, 1911.1590900003953, 1911.722800193964, 795.316028215734, 865.0881551770657, 896.7264984179888, 926.1340646495548, 963.5278713430508, 19979.900100499694, 20550.58898822015, 20625.16089427492, 20672.483187920123, 20820.687689684666, 769.7960040589248, 909.9181073703398, 913.3104506097853, 937.2361525356812, 978.9804203916025, 8568.357373197035, 9920.751981200383, 10432.895671043192, 10912.290701104403, 11099.72250693739, 553929.0, 557279.0, 558307.2084639551, 570418.0, 571075.1446242742, 118471.0, 120574.39712801379, 120980.18529722061, 121926.0, 124878.0, 943.8206740719241, 957.1242313283407, 1003.3077176748167, 1014.2241185493103, 1019.4291196929743, 16556.75164872504, 18858.434246972614, 19062.7140592894, 19125.13936872872, 19202.903985479985, 39512.60487395089, 52002.0, 53921.730391347795, 55040.44959550353, 55095.449045510635, 78711.60644196742, 79025.0, 80111.0, 80382.45699343496, 81541.59229203816, 7763.4953728007495, 7916.564588947663, 7955.0, 8029.638666260149, 8039.1156972734125, 10374.533146008296, 12338.81491777642, 12652.683682908, 12671.366431678563, 12862.935685321514, 10673.57305707763, 11055.61305354341, 11158.44207789591, 11179.161562882979, 11289.04043156341, 10452.947735261276, 10695.465226738477, 10865.022148006718, 11012.339259644446, 11034.117270618171, 9631.181349585084, 10965.671029869116, 11272.718182045515, 11316.321020738782, 11344.829827552758, 6605.339466053356, 7853.37173026168, 7926.088499822594, 8031.799205019921, 8224.671013159406, 8924.910750892668, 10617.93820617963, 10645.680629581126, 10926.890731092588, 11050.557977681125], "value": 9087.800140906662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.1761399125546, 1492.2315007770997, 1497.760358342665, 1678.3873886031595, 1831.093608663711, 7391.926080739191, 7851.45039847211, 8050.8792368114455, 8272.462289951149, 8302.086770455246, 8222.301104406133, 8294.460860044093, 8297.294729947962, 8300.958495207515, 8306.70926517572, 1926.9614607707838, 2252.0991603358666, 2281.577908087001, 2291.0, 2291.759365266648, 2273.897674604647, 2318.8956496957676, 2339.543788961153, 2343.6836027136374, 2349.4713689419914, 2279.5326957973575, 2285.04028308111, 2311.433698743802, 2314.3635500237483, 2316.339843144704, 2227.120287486442, 2250.8987095580737, 2289.7366802817724, 2291.0606651272897, 2296.17337758406, 2288.6795848581214, 2303.67748515208, 2309.6766452696634, 2312.5028118954506, 2321.117975169425, 8046.557439340834, 8169.428140030201, 8234.958825205895, 8279.751607451786, 8356.415050946436, 5050.696958182484, 5167.870803229912, 5188.610854185951, 5194.039102766001, 5197.29836472079, 3365.7812242204423, 3480.443129099357, 3549.3256281306467, 3556.946645800315, 3568.3933731265747, 1032.8244198486275, 1046.984295235572, 1052.8578641883325, 1053.304818819583, 1071.8660167479065, 10785.83821242682, 10849.78300433987, 10915.235933484659, 10931.453427328603, 10937.125029997582, 4126.133511962462, 4321.2653848845775, 4384.167008268419, 4410.360497727876, 4412.536683648171, 8599.871001934976, 8603.655853765904, 8610.761202087502, 8640.697575584825, 8641.913580864237, 4006.5392479864604, 5016.874578135576, 5017.422996355466, 5024.196128619404, 5036.5718913892, 3933.6853051755793, 4211.663066954637, 4348.586884246055, 4715.481297057321, 4719.528047195253, 3202.775805693626, 3531.6756216418844, 3547.8758243461357, 3574.356615809127, 3631.8184090795353, 1118.0887576625025, 1119.1550379463454, 1127.932324060559, 1133.7052366384798, 1135.494704856331, 806.9193080691883, 864.6066039951806, 881.6385282034336, 923.5382308845577, 943.7168849345169, 5544.112941929272, 5553.4724201200825, 5753.424657534213, 5807.186993820868, 5947.613405128653, 857.8884744983112, 877.2674816528142, 889.9065598112235, 897.6050537763364, 918.1919910478736, 3647.6170002149925, 3712.9628703712615, 3820.8689634718885, 3828.578856325802, 3883.5339759229073, 9648.565814538222, 10133.797324053625, 10147.832999205039, 10161.339512931636, 10198.847017294747, 10066.647667331608, 10082.395056296498, 10094.141997930112, 10099.495025248709, 10104.989501049984, 7676.654550545127, 7847.097583777939, 7857.05715314166, 7859.84280314402, 7861.331786798186, 5247.7113758743635, 5442.238086667949, 5490.670559766427, 5582.8325150245555, 5598.32820061579, 9192.816143676955, 9220.400673956172, 9376.062393760569, 9396.342256042284, 9467.857982130412, 8797.868031979653, 9422.104900034486, 9510.524473776146, 9536.761580960254, 9627.807443851223, 6360.554761166859, 6512.544121911421, 6542.934570654423, 6732.932670673426, 6737.696803643946, 7863.960680196562, 7932.960335198287, 7962.163972782774, 8020.877077209078, 8048.5975701215875, 7052.118485189351, 7099.82250443743, 7105.32499412555, 7142.107236595426, 7157.7136914522835, 6024.307204671343, 6922.342377474132, 7007.8248043797275, 7042.964785176247, 7072.575645461289, 6258.749650013949, 6760.492963027694, 6760.560563563353, 6768.323167683192, 6798.626075565693, 4743.146233677971, 4859.2954021667365, 4872.561469467765, 4903.681260718185, 5013.147764880052, 4761.880952976203, 4885.022995400863, 4923.803047878045, 4973.9751301244705, 5065.986802639561], "value": 4339.926902247807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.11461729429004, 300.98495075246245, 307.1017274472169, 314.294409051679, 314.4308801070065, 4122.814473348699, 4425.8450954216605, 4792.185328494155, 4943.67866088704, 4972.016789926047, 4664.930026049612, 4737.739424331669, 4811.615070794337, 4822.831200907969, 4854.514548545152, 3524.0837382280665, 3780.319542482352, 3810.409386545076, 3816.5687867049855, 3826.1582451860686, 3436.536067630863, 3772.1512659651635, 3791.2227993261454, 3800.6579407853287, 3837.2901013312485, 3039.95121683019, 3788.3749181385037, 3790.393537034075, 3808.9809550952205, 3816.866409675662, 3770.170562476251, 3775.5091838061153, 3791.4123310886857, 3804.9809750951345, 3815.751976121543, 2722.945541089187, 3266.4283750343593, 3272.30229840279, 3276.57404537411, 3279.754018448626, 4812.687175333592, 4817.181079216542, 4830.589399901012, 4830.686005409637, 4836.661433699643, 3529.982350088233, 4099.241640296555, 4195.91608167835, 4244.257254980397, 4344.152890186415, 4265.658747300239, 4869.464358920516, 5030.446650868402, 5137.357830271216, 5227.372715274191, 2982.895598654037, 3053.0077724739326, 3570.4822800694014, 3581.7850928944345, 3596.406592912166, 5156.20078887773, 5390.245365648773, 5410.97294513525, 5446.7276636168035, 5487.5609951203805, 3236.4336241157703, 3478.3912815257227, 3650.3611867923537, 3652.9817350913077, 3657.104009517685, 3683.4106542953, 3693.9076523087138, 3706.054955986206, 3710.627067984863, 3734.6078661740125, 3826.7895265760094, 4314.928834159558, 4318.52496225415, 4320.675949303814, 4338.8047537860875, 4796.088743138793, 4993.447892199283, 5067.442581316126, 5245.93440083938, 5254.632175747661, 1136.778328225988, 1174.9647510574696, 1181.704573856536, 1187.8099504079305, 1191.755690083531, 693.7329128285646, 700.3346820520526, 758.9564349020097, 763.3625922354785, 772.3473664753275, 4500.482444518922, 4501.752403617833, 4506.797194126272, 4513.842015529506, 4549.45406551216, 4098.610631989956, 4581.587657110809, 4654.57961859831, 4946.925796113062, 4952.953933330976, 4288.36115870427, 4409.911801763947, 4486.730796152176, 4490.979059423273, 4503.658097789197, 2270.965935510969, 2390.438247011951, 2499.512595043985, 2541.8053514847993, 2585.7931365490717, 4542.841000564964, 4862.635302352267, 5065.847015018602, 5121.103806833789, 5160.509751573594, 4495.100979803987, 4634.408333541465, 5024.161348837895, 5039.44566097729, 5061.367329083864, 5588.832335029955, 5594.0, 5595.468430499015, 5600.243967064394, 5632.464915832989, 5074.5686616637995, 5340.706261155518, 5368.40947495783, 5377.0, 5431.375391829832, 5058.07735356299, 5316.777141257455, 5369.57043436532, 5369.946300537101, 5370.543503802064, 4725.480197178376, 5560.304961879765, 5561.888762224814, 5562.22128901946, 5588.972055139699, 3629.4593784351587, 3632.763870348419, 3655.83548740302, 3656.177360094064, 3662.6520480554304, 4516.954830451785, 4713.62291016711, 5166.844994650167, 5337.119375303187, 5408.405075441619, 4178.937315940202, 5201.505856943584, 5242.68543887368, 5252.002119597264, 5278.0, 5216.2436446714255, 5224.346956630421, 5231.581473482189, 5243.872567397875, 5303.761330740203, 4704.270838020112, 5052.989402119664, 5069.822556210663, 5105.33630628016, 5117.02776472469, 4266.914661706686, 4446.843281008643, 4801.671189473033, 4961.231009193581, 5173.430922598436, 4426.225410553076, 4979.576735977483, 5115.718635475085, 5119.974400128124, 5122.667026643257], "value": 3752.1343857638803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.987520249595, 652.7747926965197, 697.8464737757691, 703.4969996452538, 710.4103594016966, 13976.790348144787, 14972.700545989073, 14976.850231497681, 15000.249987500622, 15005.92497037516, 13302.0, 13494.865051349483, 13500.392482338293, 13512.932435337834, 13532.458701651922, 653.3466533466534, 675.0212192321154, 819.983600327993, 830.244477525452, 847.576211894053, 842.4608250719544, 843.0852525010371, 847.9067302596709, 853.9487630742144, 857.8455877941968, 906.9546522673872, 907.7049958763396, 910.3263584947125, 913.70761356366, 915.4232833315035, 700.1493185779302, 903.8056817784142, 904.8235594059161, 905.6784841381314, 908.1644886704182, 538.7010209333819, 638.8626445314234, 651.280335229574, 654.3521913305793, 656.993430065698, 11600.477978490904, 13843.515476958359, 13907.304634768221, 13917.373718182605, 13949.58151255464, 11763.0, 12031.819522707166, 12048.397580121047, 12084.697882552919, 12255.632331030083, 11390.373529455877, 11638.709032274177, 11668.708282292926, 11713.472893719803, 11748.177627566074, 4058.472398588194, 4154.813033413504, 4158.688098392633, 4169.4162817205615, 4212.578742125794, 83969.320613588, 84146.15853841505, 85575.57212213961, 85605.0, 87791.12208877894, 9709.951450242845, 9728.708138755848, 9777.65778197774, 10027.949860250652, 10143.492825358702, 18323.633527329377, 19105.331313403964, 19217.8078219216, 19289.51776205606, 19300.71048934267, 7294.235088594959, 7440.107187137578, 7489.063867016623, 7503.474756766974, 7655.272749088827, 3446.758726889144, 3479.634638362986, 3524.8590056397456, 3605.3330133925306, 3923.1172986078473, 3417.9829100854336, 3487.738419618539, 3511.754177207571, 3535.1869070114017, 3544.8759293424605, 648.303074195242, 650.2587050762135, 659.7229163751236, 663.6747993483159, 671.9899201511981, 523.6151428699902, 556.3685217278418, 611.7338957553478, 648.4844548583887, 648.5913874259281, 8184.754457366289, 8583.48499090044, 8712.47438460731, 8741.388102832869, 8884.866726998971, 501.03593911865573, 599.9310079340844, 620.5625034350771, 652.2173391929704, 655.2595567009249, 4105.34314509677, 4257.850975215914, 4259.680523960654, 4317.179735850178, 4424.048829501673, 93701.5314923421, 101068.0, 117205.0, 118041.0, 122433.0, 99028.0, 101922.49038754907, 102704.48647756713, 105622.0, 106336.0, 89317.55341223383, 90025.0, 90460.09539904648, 91729.90970993186, 92116.53941730516, 6737.393634572912, 7981.48120372174, 8131.593420329078, 8328.500289982621, 8506.447080939719, 56909.0, 57262.0, 57618.7119064402, 58686.4131358681, 60158.69920650369, 81516.59241703754, 84042.57978710068, 85062.0, 86046.1395386038, 88758.11241887498, 10639.308444951053, 10873.510692019036, 11057.060149887027, 11172.441377931233, 11208.607698730506, 11801.350925698825, 12015.339156346485, 12171.0, 12176.330301833485, 12634.0, 10701.983311585387, 11173.273737207055, 11368.488418021043, 11476.254043487146, 11747.29516229029, 11593.942030289794, 11651.0, 12117.454714537691, 12193.26840389544, 12204.267743935392, 11119.72200694989, 11220.326780393203, 11355.0, 11407.315561066363, 11561.0, 6927.7228910845015, 9467.195288400288, 9746.0, 10032.297739158188, 10064.696625284023, 8444.40889137779, 8655.523946182768, 8865.379423440556, 9757.560909758937, 9773.657921972697], "value": 7035.088295511761, "unit": "score"}], "name": "dromaeo_css", "value": 6922.918905492818, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 118.0, 166.0, 163.0, 115.0, 112.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 115.0, 149.0, 112.0, 113.0, 111.0, 117.0, 127.0, 122.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 185.0, 186.0, 184.0, 182.0, 179.0, 185.0, 184.0, 178.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 76.0, 116.0, 90.0, 58.0, 59.0, 59.0, 85.0, 58.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 93.0, 68.0, 67.0, 70.0, 89.0, 68.0, 67.0, 93.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 85.0, 123.0, 86.0, 88.0, 85.0, 88.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 118.0, 168.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 85.0, 87.0, 87.0, 87.0, 83.0, 85.0, 98.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 65.0, 74.0, 74.0, 70.0, 68.0, 69.0, 68.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 88.0, 87.0, 88.0, 85.0, 109.0, 88.0, 85.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 149.0, 147.0, 151.0, 154.0, 157.0, 206.0, 164.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 170.0, 173.0, 182.0, 237.0, 237.0, 173.0, 171.0, 170.0], "value": 186.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 76.0, 87.0, 90.0, 69.0, 67.0, 67.0, 66.0, 67.0, 67.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1492.1, "alertThreshold": 2.0}]} 05:53:06 INFO - Return code: 0 05:53:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:06 INFO - # TBPL SUCCESS # 05:53:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:06 INFO - 2016-11-22 05:53:06.287 screenresolution[1654:9880] starting screenresolution argv=screenresolution get 05:53:06 INFO - 2016-11-22 05:53:06.290 screenresolution[1654:9880] Display 0: 1600x1200x32@60 05:53:06 INFO - 2016-11-22 05:53:06.296 screenresolution[1655:9883] starting screenresolution argv=screenresolution list 05:53:06 INFO - Available Modes on Display 0 05:53:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:06 INFO - Intel Iris: 05:53:06 INFO - Chipset Model: Intel Iris 05:53:06 INFO - Type: GPU 05:53:06 INFO - Bus: Built-In 05:53:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:06 INFO - Vendor: Intel (0x8086) 05:53:06 INFO - Device ID: 0x0a2e 05:53:06 INFO - Revision ID: 0x0009 05:53:06 INFO - Displays: 05:53:06 INFO - Display: 05:53:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:06 INFO - Display Serial Number: 1600x1200 60 05:53:06 INFO - Main Display: Yes 05:53:06 INFO - Mirror: Off 05:53:06 INFO - Online: Yes 05:53:06 INFO - Rotation: Supported 05:53:06 INFO - Return code: 0 05:53:06 INFO - Running post-action listener: _resource_record_post_action 05:53:06 INFO - [mozharness: 2016-11-22 13:53:06.544412Z] Finished run-tests step (success) 05:53:06 INFO - Running post-run listener: _resource_record_post_run 05:53:06 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38859776; Write bytes: 694901760; Read time: 384; Write time: 2034 05:53:06 INFO - TinderboxPrint: CPU usage
53.7% 05:53:06 INFO - TinderboxPrint: I/O read bytes / time
38,859,776 / 384 05:53:06 INFO - TinderboxPrint: I/O write bytes / time
694,901,760 / 2,034 05:53:06 INFO - TinderboxPrint: CPU idle
2,252.5 (46.3%) 05:53:06 INFO - TinderboxPrint: CPU system
975.0 (20.1%) 05:53:06 INFO - TinderboxPrint: CPU user
1,634.2 (33.6%) 05:53:06 INFO - TinderboxPrint: Swap in / out
421,363,712 / 0 05:53:06 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 270336; Write bytes: 385857536; Read time: 6; Write time: 783 05:53:06 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 34509824; Write bytes: 307659776; Read time: 352; Write time: 1246 05:53:07 INFO - Running post-run listener: _upload_blobber_files 05:53:07 INFO - Blob upload gear active. 05:53:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:08 INFO - (blobuploader) - INFO - Done attempting. 05:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:09 INFO - (blobuploader) - INFO - Done attempting. 05:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:11 INFO - (blobuploader) - INFO - Done attempting. 05:53:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:11 INFO - Return code: 0 05:53:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ef20b1131766dc05052c0a6f41f2e2b08adc2199ea844fe83a60f62bc51a923e8a989d69d55175ff072fd19606dc8abce152b861be28dbdcdf165db3a44f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b97ef11fed84c98e97da26d7b99357d6711468009424c864740aacc43cabe2726e4dec2350ad53a8abe11f56545740e097498e25ea0bad9fc88af70caf4471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74db3443ba7a5b8a592ef61a24309f339fcf5c8afe187f339f2c0355b27f47a5a9e0a4a3925b5a1f83ebd0910b85e1083e6ab1b2b03aaeec98c2e7a83c04944d"} 05:53:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:11 INFO - Contents: 05:53:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ef20b1131766dc05052c0a6f41f2e2b08adc2199ea844fe83a60f62bc51a923e8a989d69d55175ff072fd19606dc8abce152b861be28dbdcdf165db3a44f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b97ef11fed84c98e97da26d7b99357d6711468009424c864740aacc43cabe2726e4dec2350ad53a8abe11f56545740e097498e25ea0bad9fc88af70caf4471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74db3443ba7a5b8a592ef61a24309f339fcf5c8afe187f339f2c0355b27f47a5a9e0a4a3925b5a1f83ebd0910b85e1083e6ab1b2b03aaeec98c2e7a83c04944d"} 05:53:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:11 INFO - Copying logs to upload dir... 05:53:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.784406 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-22 05:53:11.608230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 05:53:11.611839) ========= 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.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/Firefox/sha512/b7ef20b1131766dc05052c0a6f41f2e2b08adc2199ea844fe83a60f62bc51a923e8a989d69d55175ff072fd19606dc8abce152b861be28dbdcdf165db3a44f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b97ef11fed84c98e97da26d7b99357d6711468009424c864740aacc43cabe2726e4dec2350ad53a8abe11f56545740e097498e25ea0bad9fc88af70caf4471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74db3443ba7a5b8a592ef61a24309f339fcf5c8afe187f339f2c0355b27f47a5a9e0a4a3925b5a1f83ebd0910b85e1083e6ab1b2b03aaeec98c2e7a83c04944d"} build_url:https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/D1VaquXdRqyXO6zvp11ufw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ef20b1131766dc05052c0a6f41f2e2b08adc2199ea844fe83a60f62bc51a923e8a989d69d55175ff072fd19606dc8abce152b861be28dbdcdf165db3a44f38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00b97ef11fed84c98e97da26d7b99357d6711468009424c864740aacc43cabe2726e4dec2350ad53a8abe11f56545740e097498e25ea0bad9fc88af70caf4471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74db3443ba7a5b8a592ef61a24309f339fcf5c8afe187f339f2c0355b27f47a5a9e0a4a3925b5a1f83ebd0910b85e1083e6ab1b2b03aaeec98c2e7a83c04944d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 05:53:11.646817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:53:11.647149) ========= 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.pNjU3IC8kq/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.MJctU64NPW/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 05:53:11.696565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 05:53:11.696888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 05:53:11.697263) ========= ========= Total master_lag: 0.19 =========