builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1485276020.53 results: success (0) buildid: 20170124061149 builduid: 5ae163d1ca454843b68f9332f9323325 revision: 49ee6ecf35c2b576755453eebd648035d882779b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.532252) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.532771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.533046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.558615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.559011) ========= 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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 08:40:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-01-24 08:40:20 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.701032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.701434) ========= 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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.020415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:20.750281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 08:40:20.750650) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49ee6ecf35c2b576755453eebd648035d882779b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49ee6ecf35c2b576755453eebd648035d882779b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 08:40:20,839 truncating revision to first 12 chars 2017-01-24 08:40:20,839 Setting DEBUG logging. 2017-01-24 08:40:20,839 attempt 1/10 2017-01-24 08:40:20,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/49ee6ecf35c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 08:40:22,496 unpacking tar archive at: mozilla-beta-49ee6ecf35c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.915040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 08:40:22.689211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:22.689553) ========= script_repo_revision: 49ee6ecf35c2b576755453eebd648035d882779b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:22.690040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:22.690309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:22.710120) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 08:40:22.710490) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:40:22 INFO - MultiFileLogger online at 20170124 08:40:22 in /builds/slave/test 08:40:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:40:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:22 INFO - {'append_to_log': False, 08:40:22 INFO - 'base_work_dir': '/builds/slave/test', 08:40:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:22 INFO - 'branch': 'Mozilla-Beta', 08:40:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:22 INFO - 'config_files': ('talos/mac_config.py',), 08:40:22 INFO - 'default_actions': ('clobber', 08:40:22 INFO - 'read-buildbot-config', 08:40:22 INFO - 'download-and-extract', 08:40:22 INFO - 'populate-webroot', 08:40:22 INFO - 'create-virtualenv', 08:40:22 INFO - 'install', 08:40:22 INFO - 'run-tests'), 08:40:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:22 INFO - 'download_minidump_stackwalk': True, 08:40:22 INFO - 'download_symbols': 'ondemand', 08:40:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:22 INFO - 'installer_path': 'installer.exe', 08:40:22 INFO - 'log_level': 'info', 08:40:22 INFO - 'log_name': 'talos', 08:40:22 INFO - 'log_to_console': True, 08:40:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:22 INFO - 'opt_config_files': (), 08:40:22 INFO - 'pip_index': False, 08:40:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:22 INFO - 'cmd': ('bash', 08:40:22 INFO - '-c', 08:40:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:22 INFO - 'enabled': True, 08:40:22 INFO - 'halt_on_failure': False, 08:40:22 INFO - 'name': 'check_screen_resolution'},), 08:40:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:22 INFO - 'cmd': ('bash', 08:40:22 INFO - '-c', 08:40:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:22 INFO - 'enabled': True, 08:40:22 INFO - 'halt_on_failure': False, 08:40:22 INFO - 'name': 'check_screen_resolution'},), 08:40:22 INFO - 'run_cmd_checks_enabled': True, 08:40:22 INFO - 'sps_profile': False, 08:40:22 INFO - 'sps_profile_interval': 0, 08:40:22 INFO - 'suite': 'dromaeojs', 08:40:22 INFO - 'system_bits': '32', 08:40:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:22 INFO - 'title': 't-yosemite-r7-0036', 08:40:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:22 INFO - 'use_talos_json': True, 08:40:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:22 INFO - 'work_dir': 'build'} 08:40:22 INFO - [mozharness: 2017-01-24 16:40:22.927615Z] Running clobber step. 08:40:22 INFO - Running pre-action listener: _resource_record_pre_action 08:40:22 INFO - Running main action method: clobber 08:40:22 INFO - rmtree: /builds/slave/test/build 08:40:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - [mozharness: 2017-01-24 16:40:24.646164Z] Finished clobber step (success) 08:40:24 INFO - [mozharness: 2017-01-24 16:40:24.646327Z] Running read-buildbot-config step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: read_buildbot_config 08:40:24 INFO - Using buildbot properties: 08:40:24 INFO - { 08:40:24 INFO - "project": "", 08:40:24 INFO - "product": "firefox", 08:40:24 INFO - "script_repo_revision": "production", 08:40:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:40:24 INFO - "repository": "", 08:40:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:40:24 INFO - "buildid": "20170124061149", 08:40:24 INFO - "pgo_build": "False", 08:40:24 INFO - "basedir": "/builds/slave/test", 08:40:24 INFO - "buildnumber": 13, 08:40:24 INFO - "slavename": "t-yosemite-r7-0036", 08:40:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:40:24 INFO - "platform": "yosemite_r7", 08:40:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:40:24 INFO - "branch": "mozilla-beta", 08:40:24 INFO - "repo_path": "releases/mozilla-beta", 08:40:24 INFO - "revision": "49ee6ecf35c2b576755453eebd648035d882779b", 08:40:24 INFO - "stage_platform": "macosx64", 08:40:24 INFO - "builduid": "5ae163d1ca454843b68f9332f9323325", 08:40:24 INFO - "slavebuilddir": "test" 08:40:24 INFO - } 08:40:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - [mozharness: 2017-01-24 16:40:24.649571Z] Finished read-buildbot-config step (success) 08:40:24 INFO - [mozharness: 2017-01-24 16:40:24.649678Z] Running download-and-extract step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: download_and_extract 08:40:24 INFO - mkdir: /builds/slave/test/build/tests 08:40: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')]} 08:40:24 INFO - trying https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:40:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:40:26 INFO - Downloaded 1165 bytes. 08:40:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:40:26 INFO - Using the following test package requirements: 08:40:26 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:40:26 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:40:26 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:40:26 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:40:26 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:40:26 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:40:26 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:40:26 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:40:26 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:40:26 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:26 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:40:26 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:40:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:40:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:40:26 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:40:26 INFO - Http code: 200 08:40:26 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:40:26 INFO - x-amz-cf-id: T-hBb2bn1BBALZcOUJz5ajo7QzexhLuF48wti94BPFMErYwxBFDZcQ== 08:40:26 INFO - x-amz-version-id: jDpPpMSdVcDS5YTaMwnQFS6RhQeSj523 08:40:27 INFO - Expected file size: 16086062 08:40:27 INFO - Obtained file size: 16086062 08:40:33 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:40:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:40:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:40:33 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:40:34 INFO - Http code: 200 08:40:34 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:40:34 INFO - x-amz-cf-id: 3mj8CRyhPJcfGzv42LgVBWgH6uXUJ_MJ3DhCYI4RwHc1gZjrZcrsig== 08:40:34 INFO - x-amz-version-id: jDpPpMSdVcDS5YTaMwnQFS6RhQeSj523 08:40:34 INFO - Expected file size: 16086062 08:40:34 INFO - Obtained file size: 16086062 08:40:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:40:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:40:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:40:41 INFO - Http code: 200 08:40:41 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:40:41 INFO - x-amz-cf-id: AjW1CWVFmdVEX44FwsNyhPdmEK9czHD-FA1i07LXuKzlmdOwbj1kpg== 08:40:41 INFO - x-amz-version-id: a2nHYwbTG_cZ.emPLagtAeWGxAd3KyTB 08:40:42 INFO - Expected file size: 14402992 08:40:42 INFO - Obtained file size: 14402992 08:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:42 INFO - trying https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:42 INFO - Downloading https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:40:44 INFO - Downloaded 82123758 bytes. 08:40:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:44 INFO - mkdir: /builds/slave/test/properties 08:40:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:44 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:44 INFO - Contents: 08:40:44 INFO - build_url:https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:45 INFO - Running post-action listener: _resource_record_post_action 08:40:45 INFO - Running post-action listener: set_extra_try_arguments 08:40:45 INFO - [mozharness: 2017-01-24 16:40:45.464206Z] Finished download-and-extract step (success) 08:40:45 INFO - [mozharness: 2017-01-24 16:40:45.464317Z] Running populate-webroot step. 08:40:45 INFO - Running pre-action listener: _resource_record_pre_action 08:40:45 INFO - Running main action method: populate_webroot 08:40:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:45 INFO - '--tppagecycles', 08:40:45 INFO - '7'], 08:40:45 INFO - 'tests': ['tsvgm']}}, 08:40:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['damp', 'tps']}, 08:40:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'tests': ['damp', 'tps']}, 08:40:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['dromaeo_dom']}, 08:40:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['basic_compositor_video']}, 08:40:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['a11yr', 08:40:45 INFO - 'ts_paint', 08:40:45 INFO - 'tpaint', 08:40:45 INFO - 'sessionrestore', 08:40:45 INFO - 'sessionrestore_no_auto_restore', 08:40:45 INFO - 'tabpaint']}, 08:40:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['tsvgx', 08:40:45 INFO - 'tsvgr_opacity', 08:40:45 INFO - 'tart', 08:40:45 INFO - 'tscrollx', 08:40:45 INFO - 'cart']}, 08:40:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:45 INFO - 'tsvgr_opacity', 08:40:45 INFO - 'tart', 08:40:45 INFO - 'tscrollx', 08:40:45 INFO - 'cart']}, 08:40:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'talos_options': ['--disable-e10s'], 08:40:45 INFO - 'tests': ['tp5o']}, 08:40:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'tests': ['tp5o']}, 08:40:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'talos_options': ['--disable-e10s', 08:40:45 INFO - '--xperf_path', 08:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:45 INFO - 'tests': ['tp5n']}, 08:40:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:45 INFO - 'talos_options': ['--xperf_path', 08:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:45 INFO - 'tests': ['tp5n']}}, 08:40:45 INFO - 'talos.zip': {'path': '', 08:40:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:45 INFO - Running post-action listener: _resource_record_post_action 08:40:45 INFO - [mozharness: 2017-01-24 16:40:45.483202Z] Finished populate-webroot step (success) 08:40:45 INFO - [mozharness: 2017-01-24 16:40:45.483336Z] Running create-virtualenv step. 08:40:45 INFO - Running pre-action listener: _resource_record_pre_action 08:40:45 INFO - Running main action method: create_virtualenv 08:40:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:45 INFO - Using real prefix '/tools/python27' 08:40:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:49 INFO - Installing pip.................done. 08:40:49 INFO - Return code: 0 08:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:49 INFO - Reading from file tmpfile_stdout 08:40:49 INFO - Output received: 08:40:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:49 INFO - 'HOME': '/Users/cltbld', 08:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PAGER': '/bin/cat', 08:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:40:49 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - 'XPC_FLAGS': '0x0', 08:40:49 INFO - 'XPC_SERVICE_NAME': '0', 08:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:49 INFO - 'HOME': '/Users/cltbld', 08:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PAGER': '/bin/cat', 08:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:40:49 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - 'XPC_FLAGS': '0x0', 08:40:49 INFO - 'XPC_SERVICE_NAME': '0', 08:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Downloading/unpacking psutil>=3.1.1 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:53 INFO - Installing collected packages: psutil 08:40:53 INFO - Running setup.py install for psutil 08:40:53 INFO - building 'psutil._psutil_osx' extension 08:40:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:40:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:40:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:40:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:40:54 INFO - building 'psutil._psutil_posix' extension 08:40:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:40:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:40:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:40:54 INFO - ^ 08:40:54 INFO - 1 warning generated. 08:40:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:54 INFO - Successfully installed psutil 08:40:54 INFO - Cleaning up... 08:40:54 INFO - Return code: 0 08:40:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:54 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:54 INFO - 'HOME': '/Users/cltbld', 08:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:54 INFO - 'LOGNAME': 'cltbld', 08:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:54 INFO - 'MOZ_NO_REMOTE': '1', 08:40:54 INFO - 'NO_EM_RESTART': '1', 08:40:54 INFO - 'PAGER': '/bin/cat', 08:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:54 INFO - 'PWD': '/builds/slave/test', 08:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:54 INFO - 'SHELL': '/bin/bash', 08:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:40:54 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:54 INFO - 'USER': 'cltbld', 08:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:54 INFO - 'XPC_FLAGS': '0x0', 08:40:54 INFO - 'XPC_SERVICE_NAME': '0', 08:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:57 INFO - Installing collected packages: mozsystemmonitor 08:40:57 INFO - Running setup.py install for mozsystemmonitor 08:40:57 INFO - Successfully installed mozsystemmonitor 08:40:57 INFO - Cleaning up... 08:40:57 INFO - Return code: 0 08:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:57 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:57 INFO - 'HOME': '/Users/cltbld', 08:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:57 INFO - 'LOGNAME': 'cltbld', 08:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:57 INFO - 'MOZ_NO_REMOTE': '1', 08:40:57 INFO - 'NO_EM_RESTART': '1', 08:40:57 INFO - 'PAGER': '/bin/cat', 08:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:57 INFO - 'PWD': '/builds/slave/test', 08:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:57 INFO - 'SHELL': '/bin/bash', 08:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:40:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:57 INFO - 'USER': 'cltbld', 08:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:57 INFO - 'XPC_FLAGS': '0x0', 08:40:57 INFO - 'XPC_SERVICE_NAME': '0', 08:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:00 INFO - warning: no files found matching '*.txt' 08:41:00 INFO - no previously-included directories found matching 'build' 08:41:00 INFO - no previously-included directories found matching 'dist' 08:41:00 INFO - no previously-included directories found matching '.git*' 08:41:00 INFO - Installing collected packages: jsonschema, functools32 08:41:00 INFO - Running setup.py install for functools32 08:41:01 INFO - warning: no files found matching '*.txt' 08:41:01 INFO - no previously-included directories found matching 'build' 08:41:01 INFO - no previously-included directories found matching 'dist' 08:41:01 INFO - no previously-included directories found matching '.git*' 08:41:01 INFO - Successfully installed jsonschema functools32 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:01 INFO - 'HOME': '/Users/cltbld', 08:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PAGER': '/bin/cat', 08:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:01 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - 'XPC_FLAGS': '0x0', 08:41:01 INFO - 'XPC_SERVICE_NAME': '0', 08:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:01 INFO - 'HOME': '/Users/cltbld', 08:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PAGER': '/bin/cat', 08:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:01 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - 'XPC_FLAGS': '0x0', 08:41:01 INFO - 'XPC_SERVICE_NAME': '0', 08:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - Downloading docopt-0.6.1.tar.gz 08:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:05 INFO - Running setup.py install for blobuploader 08:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:05 INFO - Running setup.py install for requests 08:41:06 INFO - Running setup.py install for docopt 08:41:06 INFO - Successfully installed blobuploader requests docopt 08:41:06 INFO - Cleaning up... 08:41:06 INFO - Return code: 0 08:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:06 INFO - 'HOME': '/Users/cltbld', 08:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:06 INFO - 'LOGNAME': 'cltbld', 08:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:06 INFO - 'MOZ_NO_REMOTE': '1', 08:41:06 INFO - 'NO_EM_RESTART': '1', 08:41:06 INFO - 'PAGER': '/bin/cat', 08:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:06 INFO - 'PWD': '/builds/slave/test', 08:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:06 INFO - 'SHELL': '/bin/bash', 08:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:06 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:06 INFO - 'USER': 'cltbld', 08:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:06 INFO - 'XPC_FLAGS': '0x0', 08:41:06 INFO - 'XPC_SERVICE_NAME': '0', 08:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:06 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-jri9_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:06 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-BU4NK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-onXSZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-cKMHcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RbEsMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-iimJaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-4Ms64U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-EE4jVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-H_vofU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vqZdsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-a_uiXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-4aOEff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-E2pyXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-LoNXvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PA52Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-O0KICG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-a5FngH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:08 INFO - Running setup.py install for manifestparser 08:41:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:08 INFO - Running setup.py install for mozcrash 08:41:08 INFO - Running setup.py install for mozdebug 08:41:09 INFO - Running setup.py install for mozdevice 08:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozfile 08:41:09 INFO - Running setup.py install for mozhttpd 08:41:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozinfo 08:41:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozInstall 08:41:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:09 INFO - Running setup.py install for mozleak 08:41:09 INFO - Running setup.py install for mozlog 08:41:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for moznetwork 08:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozprocess 08:41:10 INFO - Running setup.py install for mozprofile 08:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozrunner 08:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:10 INFO - Running setup.py install for mozscreenshot 08:41:10 INFO - Running setup.py install for moztest 08:41:11 INFO - Running setup.py install for mozversion 08:41:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:11 INFO - 'HOME': '/Users/cltbld', 08:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:11 INFO - 'LOGNAME': 'cltbld', 08:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:11 INFO - 'MOZ_NO_REMOTE': '1', 08:41:11 INFO - 'NO_EM_RESTART': '1', 08:41:11 INFO - 'PAGER': '/bin/cat', 08:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:11 INFO - 'PWD': '/builds/slave/test', 08:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:11 INFO - 'SHELL': '/bin/bash', 08:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:11 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:11 INFO - 'USER': 'cltbld', 08:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:11 INFO - 'XPC_FLAGS': '0x0', 08:41:11 INFO - 'XPC_SERVICE_NAME': '0', 08:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-46rL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-u9txo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-zu8S3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NzF8ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qMp80p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KkIwY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Akcjlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-J7pceb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-xQZqnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dGJR4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-0meR_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-hYy1AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-26HH2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PxZCa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dHZxjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1laKwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-sFeUnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - Downloading blessings-1.6.tar.gz 08:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:16 INFO - Installing collected packages: blessings 08:41:16 INFO - Running setup.py install for blessings 08:41:16 INFO - Successfully installed blessings 08:41:16 INFO - Cleaning up... 08:41:16 INFO - Return code: 0 08:41:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:16 INFO - Reading from file tmpfile_stdout 08:41:16 INFO - Current package versions: 08:41:16 INFO - blessings == 1.6 08:41:16 INFO - blobuploader == 1.2.4 08:41:16 INFO - docopt == 0.6.1 08:41:16 INFO - functools32 == 3.2.3-2 08:41:16 INFO - jsonschema == 2.5.1 08:41:16 INFO - manifestparser == 1.1 08:41:16 INFO - mozInstall == 1.12 08:41:16 INFO - mozcrash == 1.0 08:41:16 INFO - mozdebug == 0.1 08:41:16 INFO - mozdevice == 0.48 08:41:16 INFO - mozfile == 1.2 08:41:16 INFO - mozhttpd == 0.7 08:41:16 INFO - mozinfo == 0.9 08:41:16 INFO - mozleak == 0.1 08:41:16 INFO - mozlog == 3.4 08:41:16 INFO - moznetwork == 0.27 08:41:16 INFO - mozprocess == 0.23 08:41:16 INFO - mozprofile == 0.28 08:41:16 INFO - mozrunner == 6.13 08:41:16 INFO - mozscreenshot == 0.1 08:41:16 INFO - mozsystemmonitor == 0.3 08:41:16 INFO - moztest == 0.8 08:41:16 INFO - mozversion == 1.4 08:41:16 INFO - psutil == 3.1.1 08:41:16 INFO - requests == 1.2.3 08:41:16 INFO - wsgiref == 0.1.2 08:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 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 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:17 INFO - 'HOME': '/Users/cltbld', 08:41:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PAGER': '/bin/cat', 08:41:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - 'XPC_FLAGS': '0x0', 08:41:17 INFO - 'XPC_SERVICE_NAME': '0', 08:41:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:18 INFO - Cleaning up... 08:41:18 INFO - Return code: 0 08:41:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89b9d76000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, '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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:18 INFO - 'HOME': '/Users/cltbld', 08:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:18 INFO - 'LOGNAME': 'cltbld', 08:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:18 INFO - 'MOZ_NO_REMOTE': '1', 08:41:18 INFO - 'NO_EM_RESTART': '1', 08:41:18 INFO - 'PAGER': '/bin/cat', 08:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:18 INFO - 'PWD': '/builds/slave/test', 08:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:18 INFO - 'SHELL': '/bin/bash', 08:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:18 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:18 INFO - 'USER': 'cltbld', 08:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:18 INFO - 'XPC_FLAGS': '0x0', 08:41:18 INFO - 'XPC_SERVICE_NAME': '0', 08:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:18 INFO - Cleaning up... 08:41:18 INFO - Return code: 0 08:41:18 INFO - Running post-action listener: _resource_record_post_action 08:41:18 INFO - Running post-action listener: _start_resource_monitoring 08:41:18 INFO - Starting resource monitoring. 08:41:18 INFO - [mozharness: 2017-01-24 16:41:18.682522Z] Finished create-virtualenv step (success) 08:41:18 INFO - [mozharness: 2017-01-24 16:41:18.683539Z] Running install step. 08:41:18 INFO - Running pre-action listener: _resource_record_pre_action 08:41:18 INFO - Running main action method: install 08:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:18 INFO - Reading from file tmpfile_stdout 08:41:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:19 INFO - Reading from file tmpfile_stdout 08:41:19 INFO - Output received: 08:41:19 INFO - Usage: mozinstall [options] installer 08:41:19 INFO - Options: 08:41:19 INFO - -h, --help show this help message and exit 08:41:19 INFO - -d DEST, --destination=DEST 08:41:19 INFO - Directory to install application into. [default: 08:41:19 INFO - "/builds/slave/test"] 08:41:19 INFO - --app=APP Application being installed. [default: firefox] 08:41:19 INFO - mkdir: /builds/slave/test/build/application 08:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:41:40 INFO - Reading from file tmpfile_stdout 08:41:40 INFO - Output received: 08:41:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:41:40 INFO - Running post-action listener: _resource_record_post_action 08:41:40 INFO - [mozharness: 2017-01-24 16:41:40.163398Z] Finished install step (success) 08:41:40 INFO - [mozharness: 2017-01-24 16:41:40.163535Z] Running run-tests step. 08:41:40 INFO - Running pre-action listener: _resource_record_pre_action 08:41:40 INFO - Running main action method: run_tests 08:41:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:40 INFO - 2017-01-24 08:41:40.178 screenresolution[2157:19013] starting screenresolution argv=screenresolution get 08:41:40 INFO - 2017-01-24 08:41:40.180 screenresolution[2157:19013] Display 0: 1600x1200x32@60 08:41:40 INFO - 2017-01-24 08:41:40.186 screenresolution[2158:19016] starting screenresolution argv=screenresolution list 08:41:40 INFO - Available Modes on Display 0 08:41:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:40 INFO - Intel Iris: 08:41:40 INFO - Chipset Model: Intel Iris 08:41:40 INFO - Type: GPU 08:41:40 INFO - Bus: Built-In 08:41:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:40 INFO - Vendor: Intel (0x8086) 08:41:40 INFO - Device ID: 0x0a2e 08:41:40 INFO - Revision ID: 0x0009 08:41:40 INFO - Displays: 08:41:40 INFO - Display: 08:41:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:40 INFO - Display Serial Number: 1600x1200 60 08:41:40 INFO - Main Display: Yes 08:41:40 INFO - Mirror: Off 08:41:40 INFO - Online: Yes 08:41:40 INFO - Rotation: Supported 08:41:40 INFO - Return code: 0 08:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:40 INFO - Python 2.7.3 08:41:40 INFO - Return code: 0 08:41:40 INFO - grabbing minidump binary from tooltool 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:40 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 0x10eb6ed30>, '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 0x10e9d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb66b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:41:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:40 INFO - Return code: 0 08:41:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ap1AERwZPJ/Render', 08:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:40 INFO - 'HOME': '/Users/cltbld', 08:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:40 INFO - 'LOGNAME': 'cltbld', 08:41:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:40 INFO - 'MOZ_NO_REMOTE': '1', 08:41:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:40 INFO - 'NO_EM_RESTART': '1', 08:41:40 INFO - 'PAGER': '/bin/cat', 08:41:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:40 INFO - 'PWD': '/builds/slave/test', 08:41:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:40 INFO - 'SHELL': '/bin/bash', 08:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VIQpUT3ags/Listeners', 08:41:40 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 08:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:40 INFO - 'USER': 'cltbld', 08:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:40 INFO - 'XPC_FLAGS': '0x0', 08:41:40 INFO - 'XPC_SERVICE_NAME': '0', 08:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:40 INFO - mozversion application_buildid: 20170124061149 08:41:40 INFO - mozversion application_changeset: 49ee6ecf35c2b576755453eebd648035d882779b 08:41:40 INFO - mozversion application_display_name: Firefox 08:41:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:40 INFO - mozversion application_name: Firefox 08:41:40 INFO - mozversion application_remotingname: firefox 08:41:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:40 INFO - mozversion application_vendor: Mozilla 08:41:40 INFO - mozversion application_version: 52.0 08:41:40 INFO - mozversion platform_buildid: 20170124061149 08:41:40 INFO - mozversion platform_changeset: 49ee6ecf35c2b576755453eebd648035d882779b 08:41:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:40 INFO - mozversion platform_version: 52.0 08:41:40 INFO - using testdate: 1485276100 08:41:40 INFO - actual date: 1485276100 08:41:40 INFO - starting webserver on 'localhost:53589' 08:41:40 INFO - SUITE-START | Running 2 tests 08:41:40 INFO - TEST-START | dromaeo_css 08:41:40 INFO - operating with platform_type : mac_ 08:41:40 INFO - Initialising browser for dromaeo_css test... 08:41:40 INFO - TEST-INFO | started process 2168 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpAfl9o1/profile http://localhost:53589/getInfo.html) 08:41:43 INFO - PROCESS | 2168 | __metrics Screen width/height:1600/1200 08:41:43 INFO - PROCESS | 2168 | colorDepth:24 08:41:43 INFO - PROCESS | 2168 | Browser inner width/height: 1024/689 08:41:43 INFO - PROCESS | 2168 | __metrics 08:41:43 INFO - PROCESS | 2168 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:41:43 INFO - PROCESS | 2168 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:44 INFO - TEST-INFO | 2168: exit 0 08:41:44 INFO - Browser initialized. 08:41:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:44 INFO - TEST-INFO | started process 2171 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpAfl9o1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:56 INFO - PROCESS | 2171 | RSS: Main: 167702528 08:41:56 INFO - PROCESS | 2171 | 08:44:59 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53589/tests/dromaeo/cssquery-ext.html) 08:45:01 INFO - PROCESS | 2171 | RSS: Main: 267452416 08:45:01 INFO - PROCESS | 2171 | 08:48:04 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-ext.html (next: http://localhost:53589/tests/dromaeo/cssquery-jquery.html) 08:48:04 INFO - PROCESS | 2171 | RSS: Main: 298008576 08:48:04 INFO - PROCESS | 2171 | 08:51:07 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53589/tests/dromaeo/cssquery-mootools.html) 08:51:07 INFO - PROCESS | 2171 | RSS: Main: 275148800 08:51:07 INFO - PROCESS | 2171 | 08:54:10 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53589/tests/dromaeo/cssquery-prototype.html) 08:54:10 INFO - PROCESS | 2171 | RSS: Main: 263901184 08:54:10 INFO - PROCESS | 2171 | 08:57:14 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53589/tests/dromaeo/cssquery-yui.html) 08:57:14 INFO - PROCESS | 2171 | RSS: Main: 258088960 08:57:14 INFO - PROCESS | 2171 | 09:00:17 INFO - PROCESS | 2171 | Cycle 1(1): loaded http://localhost:53589/tests/dromaeo/cssquery-yui.html (next: http://localhost:53589/tests/dromaeo/cssquery-dojo.html) 09:00:18 INFO - PROCESS | 2171 | RSS: Main: 337960960 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | __start_tp_report 09:00:18 INFO - PROCESS | 2171 | _x_x_mozilla_page_load 09:00:18 INFO - PROCESS | 2171 | _x_x_mozilla_page_load_details 09:00:18 INFO - PROCESS | 2171 | |i|pagename|runs| 09:00:18 INFO - PROCESS | 2171 | |0;dojo.html;3407.3526030054286;3455;3471.9652803471968;3483.355579217843;3528.1356067763386;5793.217915581396;5833.59164858459;5848.649081055134;5852.707364631762;5895.351511333755;5752.942470575293;5804.767809287623;5808.941910580893;5809.2738407699035;5814.040683287263;5160.2517634942815;5193.246979188016;5235.685858848481;5258.0535503609335;5271.130263506517;5180.715060671661;5209.739513024352;5214.087534681435;5281.762320695578;5289.920651190235;5209.32278803755;5238.345206849144;5311.097113490716;5317.12267475866;5325.041492531343;5256.763445644936;5319.335083114611;5328.147496400596;5329.413764485904;5341.545968592674;5160.251763494272;5262.526372626444;5286.920696189561;5301.178317360776;5335.839924802262;5715.914261286084;5735.1970724098655;5743.081107022898;5767.740451679684;5771.249737534135;6139.1064578004725;6202;6215.906761398583;6237.750489980395;6240.7503699852405;6244.281907580641;6258.718357673915;6276.152719382916;6277.372262773732;6309.589876658002;5842.065269556851;5896.086106653475;5923.378045305267;6000.399960003964;6045.425684559959;6305.306416294204;6331.651759153198;6336.239651241788;6342.175517182736;6352.205974253218;6185.381461853869;6204.503639708812;6214.347493513206;6218.968905155445;6222.875542489125;6122.12371750169;6152.907706384408;6190.50475961922;6206.968965155145;6239.500839932794;6191.19514463117;6196.318404975449;6208.913440147956;6210.689465526705;6213.409726076015;6150.477209437158;6182.876342473125;6196.783112591038;6198.442140207403;6224.470919971763;4983.626228032912;5032.270320803463;5050.242463630411;5069.036882992294;5120.92318615221;4542.909141817211;4556.043230921544;4574.268117101248;4615.23848564983;4637.304404339308;6009.038553831366;6011.398860113954;6018.428249316308;6033.3664965178905;6040.456358927718;6119.41115851624;6228.844278892973;6236.968815155895;6239.344868788712;6369.20384951881;5855.882882342329;5983.551233657493;6007.909881351783;6071.574989750763;6091.208142941389;5544.722763861791;5596.524295434933;5597.608167428241;5604.775808967595;5637.013522633522;5414.512693857571;6454.870902582016;6462.612243265419;6484.254310754135;6489.994050922114;6081.27024757032;6128.50971922254;6135.447809697149;6151.815445536641;6152.477039451518;5121.334226550524;6340.682965851781;6435.32429094957;6445.387688169616;6462.741490340334;6220.875582488235;6222.471089957223;6230.345813689497;6249.562530622813;6259.186305780219;5749.597528172988;6143.450468055707;6185.567010309235;6210.5652604317265;6211.65835879031;6114.540688159484;6123.191113103653;6163.568550201443;6226.813195604139;6236.282827474898;6175.5677102602385;6206.968965155145;6212.254529456494;6213.689315534296;6224;5970;6079.179310792986;6114.969425152845;6128.509719222362;6145.692715364304;6120.782376608402;6139.877202456015;6176.413240742122;6202.751889924352;6274.905876411949;6134.386561344008;6136.2943261523715;6141.570090093829;6147.631142131487;6152.830962117184 09:00:18 INFO - PROCESS | 2171 | |1;ext.html;449.3192812888474;497.50995269659404;517.0512110277642;529.3912001198621;540.5675459632293;31337.216569585744;33018.83490582547;40920.77237682867;41918.16163676725;42037.15925681485;43380.915477113085;43662.345064824054;43703;43952.56047439525;43964.560354396446;9613.855792163124;9811.313208075402;9812.46031468269;9812.656557020506;9822.754431139243;9730.756731081708;9821.558029888673;9830.508474576278;9830.754231144207;9831.016898310183;9748.220142388593;9834.852477212848;9849.90150098497;9849.901500985006;9850.40897546146;9777.657781977632;9798.412095274307;9817.607295708163;9835.31152819303;9844.3601165924;8182.386321025947;9628.855567166498;9640.373375730625;9647;9669.661561845302;41523.5466758662;41816.1636767263;41816.95457613584;41847.7907610463;41936.741897743115;3156.8895088672016;3246.2695893424025;3347.6150242722156;3478.513008178857;3723.5345581802276;29167.270818229503;30925;31168;31923.361532769213;31985.360292794245;3149.5118256670253;3271.018694391673;3283.1792051987004;3298.208429976812;3313.685199906005;526588;529493;530025;530087;530624.346878267;34521.30957380839;54004.72997635065;64164;64829;64849;35672.64327356693;36327;36626.81686591604;36670.083247919014;36722.265554688754;14558.344874480674;14711.264436778332;14716.926415368069;14717;14734.705305893822;10820.891791082146;11752.529898804123;12217.877821221851;12329.568465103679;12344.691382715324;8063.959680201561;8066.31436327907;8090.474119182234;8146.185381461925;8191.467554608931;3344.180675734412;3367.020187134404;3373;3385.322935412927;3411.181316484026;884.1114679746942;964.8325526113481;996.0537489385113;1026.7587117027492;1030.835066389374;29938.700612994027;30039.69960300369;30573.235669108006;30705.078847634606;30790.92231771922;945.7068308824287;1068.6793961811425;1124.454639499842;1146.97345875441;1250.2498500899387;15075.623109422133;15233;15962.92018539923;16087.758683619755;16369.754453682966;693353;697815;697891;698631;699326;60352;60950.695246523486;61275;61308;61342.38657613456;1263.3556885988028;1315.7434300311538;1316.9539066132638;1395.1071314359021;1419.5102689572082;28859.567106493;31519.054428367184;31636.892708755084;31782.06019668186;32113;50721.49278507168;51442;51488.712782180744;51490.74254628853;51530.96938061143;556437;559283;560971;561064;563552;24279.271621851374;24741;27331.590026149224;27807.30481737973;27882.88468461239;45197.77401112973;50148;50232.246516303014;50748.238776417646;51155.48844511507;38929.41605875971;39518.01204969899;39843.60156398515;40175.79912100421;40983;39134.804325978184;40769.388459172544;40834.889223918166;41328.38007429831;41445.378319324635;38216.80891595524;38647.2270554593;38761;39279.2144157121;39361.80319098386;29931.95238166654;32602.36037450125;35670.25316769104;35955.46066808948;36620.81689591642;26533.07134250292;26534.938602455684;26572.874170066734;26710.59934100951;27335 09:00:18 INFO - PROCESS | 2171 | |2;jquery.html;340.31596491052983;386.59407621996894;390.38124572552505;406.5345179769163;418.9099343641117;18824.435266941997;19858.304959326426;21186.364409067734;21428.892855535738;21492.462688432795;12147.635570932864;12280;14649.8280137589;20756.68864967027;21307.041183146757;5306.097963346221;5492.780288788444;5537.556995440355;5537.916931246014;5539.778408863641;5890.970545147268;6060.030395136779;6069.028955367142;6072.483838873701;6075.483583895374;5418.160185171305;5527.585431092664;6019.518438524908;6022.126791615213;6029.60807547508;5460.453954604528;5513.145462453326;5513.173024046385;5513.8345849624375;5516.503514683678;5101.6173786965755;5354.544863686591;5355.437679043684;5376.301080859464;5380.569554435636;13971.860281397157;14035.228062456561;14055.578332650037;14303.642408939755;24919;1789.579448829524;2198.318521258399;2244.7194100737406;2436.1838784007377;2938.38293958269;10529.947350263275;10671.19966002553;10727.13072633474;10748.462576871125;14028.579142625738;1830.9176087076114;1865.4310435317223;1868.813118688134;1882.9340973065878;1960.9705854412196;58575.41424585742;106603;121143.99999999911;124786;124872.37563812123;9478.715638530855;10080.74798130038;10165.034321739422;10410.843837342445;11570;12645.43095560702;12737.29944853042;12764.106512544033;12779.552715654907;12782.61652150437;7915.287624113742;8003.639836207385;8026.9966254218225;8099.311558517474;8156.388270879707;8194.836103277901;8205.58972051395;8219.95890020546;8265.752027439186;8361.289290410383;3919.235749028912;4018.7588744675413;4040.8989775255855;4076.3274059779806;4103.630673239423;1942.300771722179;1992.551675872917;1994.5711671990591;1995.7704863940542;1998.6702194138095;848.4357901995104;937.3391758810022;950.5627411390838;958.8513780364054;962.4802606592501;20594;21741.565168696536;21921.23275685375;21941.341759747233;22035;936.7470782888582;942.5475771629656;946.5645802930729;966.3573723473952;972.7033254857337;9714.708558743248;11026.558937642565;11402.372869492257;11441.485133169028;11630.592929247436;540948.2952585212;584779;590043;590056.0497197487;613744;79038.60480697559;84442.2605378896;106049.46975265074;114987;121251;800.2957397490288;907.9863802042975;921.4517362169498;937.044214900811;941.1905761045496;19127.426177214707;19898.60202795965;20167.79832201659;20192.697109543074;20193.788372697098;54463.18305225504;55178.72410637921;55660.443395565526;56309.08754580874;56503;75803;79244.60377698074;80673;80914;83700;10801.405922674328;11811.110222364381;11819.940900295443;11934.820977685167;12031.4585843639;13096.345182741015;13240.86759132435;13582.864171358555;13664.043516953718;13704.972127090308;11198.608048718255;11394.94302528482;11553.653390398302;11817.881821182022;11868.465919033837;11264.774704506028;11348;11766.764664706829;11783.52865885355;11931;11581.710457238636;11583.362915039754;11704.882951170379;12088;12101.636950891487;11861.644150675493;12006.459709312927;12121.636350909486;12207.38963051826;12221.38893055326;11670.580308929946;11688.824667630162;11905.523779049088;12055.939720301343;12066 09:00:18 INFO - PROCESS | 2171 | |3;mootools.html;1510.5996910818635;1533.11845688729;1682.3438858845052;1836.192075486785;1836.9357072502464;8045.477043992144;8357.498550086984;8369.83260334793;8371.665133394657;8375.204355586216;7400.481966262364;7670.386369090474;7701.807454813633;8023.598820058988;8242.711505097323;1988.8607797454183;2308.284431826131;2335.1593426366494;2335.43949452132;2336.871472069044;2325.988370058147;2352.3766201956496;2377.619580867062;2378.8810559472045;2379.988100059506;1870.7661542307212;2199.3401979406194;2321.8955147018423;2351.576716191085;2356.929292121239;2254.4025833154064;2306.4810417655976;2325.453518423169;2326.627739561679;2327.998960447007;2327.4065113396146;2350.82368822339;2356.2342238772467;2356.882155892216;2357.622780355135;8166.591670416456;8334;8336.333093352518;8354.248117669378;8357.164283571656;4482.618977386894;5050.090983622947;5202.869928251786;5208.374995000624;5225.320708307896;3192.74458043356;3228.063861480168;3542.0436482149935;3551.8756843510355;3563.394222982099;1044.0759927464173;1045.7647029418397;1074.462768615692;1087.8150714378496;1089.6730980705756;10545.209109316755;10671.786564268672;10680.572777088908;10695.09091727204;10718.410487423189;4470.284754439274;4572.588467037983;4659.207934651117;4674.252119660838;4731.52684731531;8164.387670924704;9355.766105847271;9441.858372124423;9442.716718498456;9509.857352139723;5235.8481134150425;5239.214117882349;5242.580593552507;5246.134387825966;5251.291075704808;4362.847300344472;4493.168763778712;4689.20283551797;4794.976025119852;4824.855254342376;3813.313603551332;3856.9614303857165;3913.72603917723;3952.782596957195;3955;1261.9369031548385;1266.6516707905216;1267.5120078769555;1272.7836267834305;1285.389440015985;914.5198770645464;914.6798620482778;915.9633614655472;928.2388441478058;948.6537413843897;5610.607257491936;5816.185733997244;5920;6005.6396616203165;6114.11345354921;900.0579245198969;921.1755478846395;960;988.980220395588;1012.6759436980095;3776.4524143999515;3925.7840818755244;3936.704747143918;4034.8587799426878;4052.230076285496;9509;9952.353097048668;9953.651622193189;9953.850692239623;9963.402195868272;8892.64429422816;9615.855762163574;9900.455474948947;9949.204063674888;9959.253056020827;7532.54804711719;7619.161892191854;7834.921650783419;7839.764807055797;7889.447738658354;5641;5827.125931110368;5841.620294680833;5878;5951.523878089829;9030.864537031819;9172.633094676139;9191.632334706537;9241.260699143917;9299.209567186865;7769.844603108019;9072.867876048991;9343.159115679622;9465.952670236606;9478.52607369615;6663.500237482305;6853.074834897225;6865.073215115895;7078.681459334445;7239.927600723925;7758.3017528422715;8004.799880003046;8013;8063.596820158851;8069.838603227785;7223.638818059181;7282.599457029914;7427.2201418850245;7429.4799364044;7454.962725186556;7182.030425892646;7211.062561866924;7237.457190710613;7318.707251709872;7469.066366704162;6047.667378294236;6263.906041409474;6550.737970481127;6714.194296684429;6730.966345168243;4523.411956445641;4788.186008378514;4828.444728856227;4833.637477189154;4851.320815085962;3918.471006414212;4628.629709623289;4651.534846515321;4817.445993710628;4870.172070747911 09:00:18 INFO - PROCESS | 2171 | |4;prototype.html;268.71918844807175;308.8656434451014;316.1889752784108;321.23225491076334;323.3629749393697;5050.64645474816;5185.662931909424;5224.033553792551;5259.973700131499;5266.947330526698;4284.335927931175;5003.774830132644;5101.897962040757;5146.511081447256;5151.896962060757;3949.526056873179;3953.9209215815667;3963.7027222958395;3985.5815139410233;4003.899902502432;3290.605127384717;3790.5830358660523;3960.980195099035;3983.1237127831973;4009.4386785850006;3122.6721194274614;3238.352329534091;3522.7710198836994;3989.640932316091;4026.617471340218;3991.44119823225;3997.620226078518;4002.699797515198;4020.8994775130564;4027.939580906289;3184.9044528664176;3220.246689080849;3543.6102028776813;3552.9518791956434;3567.3935430976535;4668;5055.912978709558;5101.744912754348;5103.515166059218;5114.979583064705;3637.2179981303884;3847.288251673421;4193.90958350831;4593.6095431888;4640.69835460694;4775.283707443877;5144.511271429208;5416.8104116355735;5422.861199148184;5475.780968761284;3946.782926939017;3953.4860468139245;3960.3663413853646;3961.6632586230203;3964.5638979712207;4536.092781443725;5186.5850731941355;5755.568332375088;5766.625169363978;5840.766369345263;3434.587849458081;3772.0569857535615;3995.141044675409;4029.6977726670616;4036.233115708006;4024.557298697141;4026.315526360526;4032.395140728914;4058.9797051014557;4076.1236334188293;4593.724376537419;4601.194790911577;4604.263317869192;4604.493505714368;4614.953850461519;5189.4032186299055;5228.424873263938;5468.7539060742365;5541.861453463695;5574.275344205227;1079.8434227037192;1217.4217246807873;1219.9812614034258;1272.338384040294;1309.6987692830703;837.7068026190906;871.2724874729672;905.8867641544807;912.0378001208655;916.7524768312518;4391.604755572014;4699.530046995274;4843.733594652328;4878.731529802277;4889.728670545684;4866.7566621668775;5012.874678133076;5282;5317.973410132925;5328.760205790749;4465.620422264079;4517.548245175456;4873.417088942866;4880.536349046906;4891.559759621651;2338.5439839231526;2737.6988531261545;2738.3838636306673;2757.5863620457094;2762.7651649610007;4837.588804951619;5462.863428414322;5467.753951072212;5521.420250873681;5522.39850443375;4604.608608268268;4854.927176092361;5197.66215196011;5385.407605163429;5390.8921821563345;4644.907101858012;4937.222599864046;4996.650234483552;5436.238926550286;5481.862953426196;5037.2695959084995;5068.467810879804;5216.608754343363;5245.583692403106;5321.866953326198;4880.6583539153335;5176.741162941763;5208.5051920069045;5215.522626752262;5264.763085661231;4577.93133102997;4850.296706977539;5170.871622668232;5439;5466.3986961435;3212.698856962934;3540.203239440813;3678;3859.2088621831895;3895.844166233319;4382.671299652475;4962.875928101682;5382.9275728843895;5518.862028449321;5519.43346343952;5514.944850551443;5514.972425137848;5532.91700624499;5553.611247212818;5575.386707462095;4629.93055104167;5152.819651312186;5249.6062795289745;5255.37083504115;5323.334583177103;4178.603032711888;4899;5362.892742145214;5363.865903352447;5390.568754499709;4791.448983366958;4853.223484242645;5474.890502190014;5492.752826122914;5494.752736126964;4664.580187783115;4692.624590032721;5051.747412629427;5114.488551144856;5366.946330536801 09:00:18 INFO - PROCESS | 2171 | |5;yui.html;701.2146396036437;744.8733715268407;767.0756738130553;784.9489783164094;820.5486982159811;14883.330250138742;15728.292226849791;15852.445164419247;15853.048817070983;15881.602959926007;14001.439942402318;14166.433342666307;14180.361883715232;14219.217943013131;14261.144331340127;694.6769752065288;717.852840167767;721.1850608812061;859.7377799771067;867.7310033889498;881.6517475597135;885.1723638398119;893.8391089603869;895.3016647015338;897.4704924094783;942.575840871607;957.1290125985355;957.8706874571948;959.6928982725531;959.8512230604233;953.4136506048765;953.823542644613;954.4368822394752;955.7180631713661;955.9330846840724;706.4101475268158;708.4332533972802;708.8440543080566;708.88303429934;709.6948312225741;12614.747705045847;12800.743985120338;12832.294223817686;12848.293343866084;15029.173395463245;14217.36021879018;14490.492832750908;14647.487337943227;14669.03939425657;14700.970932034761;10472.895271047268;10562.282401342789;10790.244682872202;11746.471408786625;11817;4333.588309110661;4637.930431043537;4783.784729687172;4802.68782529138;4817.084753896748;86907.61213122756;90284.19431611331;91322;91482;93601.99999999932;10613.522391492246;10636.202284828669;10888.836667449994;10900.563977440972;10904.61833835812;16301.266443010092;19914.203431862854;20065.29771458021;20456;20469.89765051165;7606.923930760621;7621.580813055224;7713.807154821062;7805.37556995439;7934.047914250212;4287.849925252601;4356.716813407118;4384.495782984934;4478.888027799266;4538.478075021415;3294.769366144395;3405.5402520659395;3409.215880347534;3415.5389022482145;3747.7563958343167;622.953278504114;713.0480808121113;720.8070643085701;724.2467833453255;726.9164046134656;552.3454706173197;613.420317799675;628.1864984844638;642.8457170279099;667.8363800868818;8932.598033088527;9321.114494123047;9370.765730856783;9613.031775439622;9923.255755818342;677.2448719677524;680.709600182046;698.8462538241579;701.1446035836271;716.9211386747454;4455.376247325377;4558.1795276849825;4622.0218739294705;4629.606483448944;4641.396618439581;116468.41765791287;118401;119155.40422297834;119977;126350.36824815816;71616;88280;102456;103037;105635;85310.5734471336;87703.12296877077;89247.55376223077;89949;92821.53589232011;8828.42615230008;8888.155625215593;8896.466212027299;8927.776805579913;8966.641334346554;54578;54789.63025924224;55272.85017719391;55364;57613;64456;73944;76874.62940909775;79362.603186986;80480.19519804727;11489.482973266056;11804.291742495478;11871.703207419883;12245.265284082983;12455.439505222468;14233.430662773788;14442.271027806144;14537.636559086108;14655.193964332064;15640.765388518954;13587.320633968064;13602.86397136016;13870.445182193003;13927.373268203159;14051.437942482185;8331.757046004352;11427.54307823822;12507.437165327765;12871.549495767604;13060.934695326463;13615.591532254048;13643.658908527366;13922.651933701738;13985.090969086978;14389.496367627084;10952.835707464235;11035.834462482908;11234.507485343815;11523.13576481784;11700.94149529281;10750;11418.657440276806;11526.481308341312;11685.182037257651;11695.356755378536 09:00:18 INFO - PROCESS | 2171 | __end_tp_report 09:00:18 INFO - PROCESS | 2171 | __start_cc_report 09:00:18 INFO - PROCESS | 2171 | _x_x_mozilla_cycle_collect,1657 09:00:18 INFO - PROCESS | 2171 | __end_cc_report 09:00:18 INFO - PROCESS | 2171 | __startTimestamp1485277218167__endTimestamp 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | ------- Summary: start ------- 09:00:18 INFO - PROCESS | 2171 | Number of tests: 6 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#0] dojo.html Cycles:165 Average:5815.18 Median:6114.97 stddev:616.62 (10.1%) stddev-sans-first:588.87 09:00:18 INFO - PROCESS | 2171 | Values: 3407.4 3455.0 3472.0 3483.4 3528.1 5793.2 5833.6 5848.6 5852.7 5895.4 5752.9 5804.8 5808.9 5809.3 5814.0 5160.3 5193.2 5235.7 5258.1 5271.1 5180.7 5209.7 5214.1 5281.8 5289.9 5209.3 5238.3 5311.1 5317.1 5325.0 5256.8 5319.3 5328.1 5329.4 5341.5 5160.3 5262.5 5286.9 5301.2 5335.8 5715.9 5735.2 5743.1 5767.7 5771.2 6139.1 6202.0 6215.9 6237.8 6240.8 6244.3 6258.7 6276.2 6277.4 6309.6 5842.1 5896.1 5923.4 6000.4 6045.4 6305.3 6331.7 6336.2 6342.2 6352.2 6185.4 6204.5 6214.3 6219.0 6222.9 6122.1 6152.9 6190.5 6207.0 6239.5 6191.2 6196.3 6208.9 6210.7 6213.4 6150.5 6182.9 6196.8 6198.4 6224.5 4983.6 5032.3 5050.2 5069.0 5120.9 4542.9 4556.0 4574.3 4615.2 4637.3 6009.0 6011.4 6018.4 6033.4 6040.5 6119.4 6228.8 6237.0 6239.3 6369.2 5855.9 5983.6 6007.9 6071.6 6091.2 5544.7 5596.5 5597.6 5604.8 5637.0 5414.5 6454.9 6462.6 6484.3 6490.0 6081.3 6128.5 6135.4 6151.8 6152.5 5121.3 6340.7 6435.3 6445.4 6462.7 6220.9 6222.5 6230.3 6249.6 6259.2 5749.6 6143.5 6185.6 6210.6 6211.7 6114.5 6123.2 6163.6 6226.8 6236.3 6175.6 6207.0 6212.3 6213.7 6224.0 5970.0 6079.2 6115.0 6128.5 6145.7 6120.8 6139.9 6176.4 6202.8 6274.9 6134.4 6136.3 6141.6 6147.6 6152.8 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#1] ext.html Cycles:180 Average:71597.38 Median:40877.83 stddev:160822.96 (393.4%) stddev-sans-first:161185.40 09:00:18 INFO - PROCESS | 2171 | Values: 449.3 497.5 517.1 529.4 540.6 31337.2 33018.8 40920.8 41918.2 42037.2 43380.9 43662.3 43703.0 43952.6 43964.6 9613.9 9811.3 9812.5 9812.7 9822.8 9730.8 9821.6 9830.5 9830.8 9831.0 9748.2 9834.9 9849.9 9849.9 9850.4 9777.7 9798.4 9817.6 9835.3 9844.4 8182.4 9628.9 9640.4 9647.0 9669.7 41523.5 41816.2 41817.0 41847.8 41936.7 3156.9 3246.3 3347.6 3478.5 3723.5 29167.3 30925.0 31168.0 31923.4 31985.4 3149.5 3271.0 3283.2 3298.2 3313.7 526588.0 529493.0 530025.0 530087.0 530624.3 34521.3 54004.7 64164.0 64829.0 64849.0 35672.6 36327.0 36626.8 36670.1 36722.3 14558.3 14711.3 14716.9 14717.0 14734.7 10820.9 11752.5 12217.9 12329.6 12344.7 8064.0 8066.3 8090.5 8146.2 8191.5 3344.2 3367.0 3373.0 3385.3 3411.2 884.1 964.8 996.1 1026.8 1030.8 29938.7 30039.7 30573.2 30705.1 30790.9 945.7 1068.7 1124.5 1147.0 1250.2 15075.6 15233.0 15962.9 16087.8 16369.8 693353.0 697815.0 697891.0 698631.0 699326.0 60352.0 60950.7 61275.0 61308.0 61342.4 1263.4 1315.7 1317.0 1395.1 1419.5 28859.6 31519.1 31636.9 31782.1 32113.0 50721.5 51442.0 51488.7 51490.7 51531.0 556437.0 559283.0 560971.0 561064.0 563552.0 24279.3 24741.0 27331.6 27807.3 27882.9 45197.8 50148.0 50232.2 50748.2 51155.5 38929.4 39518.0 39843.6 40175.8 40983.0 39134.8 40769.4 40834.9 41328.4 41445.4 38216.8 38647.2 38761.0 39279.2 39361.8 29932.0 32602.4 35670.3 35955.5 36620.8 26533.1 26534.9 26572.9 26710.6 27335.0 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#2] jquery.html Cycles:180 Average:33609.56 Median:21617.01 stddev:96981.32 (448.6%) stddev-sans-first:97221.20 09:00:18 INFO - PROCESS | 2171 | Values: 340.3 386.6 390.4 406.5 418.9 18824.4 19858.3 21186.4 21428.9 21492.5 12147.6 12280.0 14649.8 20756.7 21307.0 5306.1 5492.8 5537.6 5537.9 5539.8 5891.0 6060.0 6069.0 6072.5 6075.5 5418.2 5527.6 6019.5 6022.1 6029.6 5460.5 5513.1 5513.2 5513.8 5516.5 5101.6 5354.5 5355.4 5376.3 5380.6 13971.9 14035.2 14055.6 14303.6 24919.0 1789.6 2198.3 2244.7 2436.2 2938.4 10529.9 10671.2 10727.1 10748.5 14028.6 1830.9 1865.4 1868.8 1882.9 1961.0 58575.4 106603.0 121144.0 124786.0 124872.4 9478.7 10080.7 10165.0 10410.8 11570.0 12645.4 12737.3 12764.1 12779.6 12782.6 7915.3 8003.6 8027.0 8099.3 8156.4 8194.8 8205.6 8220.0 8265.8 8361.3 3919.2 4018.8 4040.9 4076.3 4103.6 1942.3 1992.6 1994.6 1995.8 1998.7 848.4 937.3 950.6 958.9 962.5 20594.0 21741.6 21921.2 21941.3 22035.0 936.7 942.5 946.6 966.4 972.7 9714.7 11026.6 11402.4 11441.5 11630.6 540948.3 584779.0 590043.0 590056.0 613744.0 79038.6 84442.3 106049.5 114987.0 121251.0 800.3 908.0 921.5 937.0 941.2 19127.4 19898.6 20167.8 20192.7 20193.8 54463.2 55178.7 55660.4 56309.1 56503.0 75803.0 79244.6 80673.0 80914.0 83700.0 10801.4 11811.1 11819.9 11934.8 12031.5 13096.3 13240.9 13582.9 13664.0 13705.0 11198.6 11394.9 11553.7 11817.9 11868.5 11264.8 11348.0 11766.8 11783.5 11931.0 11581.7 11583.4 11704.9 12088.0 12101.6 11861.6 12006.5 12121.6 12207.4 12221.4 11670.6 11688.8 11905.5 12055.9 12066.0 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#3] mootools.html Cycles:180 Average:5417.77 Median:5430.95 stddev:2912.01 (53.6%) stddev-sans-first:2905.37 09:00:18 INFO - PROCESS | 2171 | Values: 1510.6 1533.1 1682.3 1836.2 1836.9 8045.5 8357.5 8369.8 8371.7 8375.2 7400.5 7670.4 7701.8 8023.6 8242.7 1988.9 2308.3 2335.2 2335.4 2336.9 2326.0 2352.4 2377.6 2378.9 2380.0 1870.8 2199.3 2321.9 2351.6 2356.9 2254.4 2306.5 2325.5 2326.6 2328.0 2327.4 2350.8 2356.2 2356.9 2357.6 8166.6 8334.0 8336.3 8354.2 8357.2 4482.6 5050.1 5202.9 5208.4 5225.3 3192.7 3228.1 3542.0 3551.9 3563.4 1044.1 1045.8 1074.5 1087.8 1089.7 10545.2 10671.8 10680.6 10695.1 10718.4 4470.3 4572.6 4659.2 4674.3 4731.5 8164.4 9355.8 9441.9 9442.7 9509.9 5235.8 5239.2 5242.6 5246.1 5251.3 4362.8 4493.2 4689.2 4795.0 4824.9 3813.3 3857.0 3913.7 3952.8 3955.0 1261.9 1266.7 1267.5 1272.8 1285.4 914.5 914.7 916.0 928.2 948.7 5610.6 5816.2 5920.0 6005.6 6114.1 900.1 921.2 960.0 989.0 1012.7 3776.5 3925.8 3936.7 4034.9 4052.2 9509.0 9952.4 9953.7 9953.9 9963.4 8892.6 9615.9 9900.5 9949.2 9959.3 7532.5 7619.2 7834.9 7839.8 7889.4 5641.0 5827.1 5841.6 5878.0 5951.5 9030.9 9172.6 9191.6 9241.3 9299.2 7769.8 9072.9 9343.2 9466.0 9478.5 6663.5 6853.1 6865.1 7078.7 7239.9 7758.3 8004.8 8013.0 8063.6 8069.8 7223.6 7282.6 7427.2 7429.5 7455.0 7182.0 7211.1 7237.5 7318.7 7469.1 6047.7 6263.9 6550.7 6714.2 6731.0 4523.4 4788.2 4828.4 4833.6 4851.3 3918.5 4628.6 4651.5 4817.4 4870.2 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#4] prototype.html Cycles:180 Average:4333.54 Median:4854.08 stddev:1295.34 (26.7%) stddev-sans-first:1262.54 09:00:18 INFO - PROCESS | 2171 | Values: 268.7 308.9 316.2 321.2 323.4 5050.6 5185.7 5224.0 5260.0 5266.9 4284.3 5003.8 5101.9 5146.5 5151.9 3949.5 3953.9 3963.7 3985.6 4003.9 3290.6 3790.6 3961.0 3983.1 4009.4 3122.7 3238.4 3522.8 3989.6 4026.6 3991.4 3997.6 4002.7 4020.9 4027.9 3184.9 3220.2 3543.6 3553.0 3567.4 4668.0 5055.9 5101.7 5103.5 5115.0 3637.2 3847.3 4193.9 4593.6 4640.7 4775.3 5144.5 5416.8 5422.9 5475.8 3946.8 3953.5 3960.4 3961.7 3964.6 4536.1 5186.6 5755.6 5766.6 5840.8 3434.6 3772.1 3995.1 4029.7 4036.2 4024.6 4026.3 4032.4 4059.0 4076.1 4593.7 4601.2 4604.3 4604.5 4615.0 5189.4 5228.4 5468.8 5541.9 5574.3 1079.8 1217.4 1220.0 1272.3 1309.7 837.7 871.3 905.9 912.0 916.8 4391.6 4699.5 4843.7 4878.7 4889.7 4866.8 5012.9 5282.0 5318.0 5328.8 4465.6 4517.5 4873.4 4880.5 4891.6 2338.5 2737.7 2738.4 2757.6 2762.8 4837.6 5462.9 5467.8 5521.4 5522.4 4604.6 4854.9 5197.7 5385.4 5390.9 4644.9 4937.2 4996.7 5436.2 5481.9 5037.3 5068.5 5216.6 5245.6 5321.9 4880.7 5176.7 5208.5 5215.5 5264.8 4577.9 4850.3 5170.9 5439.0 5466.4 3212.7 3540.2 3678.0 3859.2 3895.8 4382.7 4962.9 5382.9 5518.9 5519.4 5514.9 5515.0 5532.9 5553.6 5575.4 4629.9 5152.8 5249.6 5255.4 5323.3 4178.6 4899.0 5362.9 5363.9 5390.6 4791.4 4853.2 5474.9 5492.8 5494.8 4664.6 4692.6 5051.7 5114.5 5366.9 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - PROCESS | 2171 | [#5] yui.html Cycles:180 Average:21178.42 Median:4625.81 stddev:31325.61 (677.2%) stddev-sans-first:31375.75 09:00:18 INFO - PROCESS | 2171 | Values: 701.2 744.9 767.1 784.9 820.5 14883.3 15728.3 15852.4 15853.0 15881.6 14001.4 14166.4 14180.4 14219.2 14261.1 694.7 717.9 721.2 859.7 867.7 881.7 885.2 893.8 895.3 897.5 942.6 957.1 957.9 959.7 959.9 953.4 953.8 954.4 955.7 955.9 706.4 708.4 708.8 708.9 709.7 12614.7 12800.7 12832.3 12848.3 15029.2 14217.4 14490.5 14647.5 14669.0 14701.0 10472.9 10562.3 10790.2 11746.5 11817.0 4333.6 4637.9 4783.8 4802.7 4817.1 86907.6 90284.2 91322.0 91482.0 93602.0 10613.5 10636.2 10888.8 10900.6 10904.6 16301.3 19914.2 20065.3 20456.0 20469.9 7606.9 7621.6 7713.8 7805.4 7934.0 4287.8 4356.7 4384.5 4478.9 4538.5 3294.8 3405.5 3409.2 3415.5 3747.8 623.0 713.0 720.8 724.2 726.9 552.3 613.4 628.2 642.8 667.8 8932.6 9321.1 9370.8 9613.0 9923.3 677.2 680.7 698.8 701.1 716.9 4455.4 4558.2 4622.0 4629.6 4641.4 116468.4 118401.0 119155.4 119977.0 126350.4 71616.0 88280.0 102456.0 103037.0 105635.0 85310.6 87703.1 89247.6 89949.0 92821.5 8828.4 8888.2 8896.5 8927.8 8966.6 54578.0 54789.6 55272.9 55364.0 57613.0 64456.0 73944.0 76874.6 79362.6 80480.2 11489.5 11804.3 11871.7 12245.3 12455.4 14233.4 14442.3 14537.6 14655.2 15640.8 13587.3 13602.9 13870.4 13927.4 14051.4 8331.8 11427.5 12507.4 12871.5 13060.9 13615.6 13643.7 13922.7 13985.1 14389.5 10952.8 11035.8 11234.5 11523.1 11700.9 10750.0 11418.7 11526.5 11685.2 11695.4 09:00:18 INFO - PROCESS | 2171 | -------- Summary: end -------- 09:00:18 INFO - PROCESS | 2171 | 09:00:18 INFO - TEST-INFO | 2171: exit 0 09:00:18 INFO - TEST-OK | dromaeo_css | took 1118028ms 09:00:18 INFO - TEST-START | kraken 09:00:18 INFO - operating with platform_type : mac_ 09:00:18 INFO - Initialising browser for kraken test... 09:00:18 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpXS0d0y/profile http://localhost:53589/getInfo.html) 09:00:21 INFO - PROCESS | 2176 | __metrics Screen width/height:1600/1200 09:00:21 INFO - PROCESS | 2176 | colorDepth:24 09:00:21 INFO - PROCESS | 2176 | Browser inner width/height: 1024/689 09:00:21 INFO - PROCESS | 2176 | __metrics 09:00:21 INFO - PROCESS | 2176 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:21 INFO - PROCESS | 2176 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:22 INFO - TEST-INFO | 2176: exit 0 09:00:22 INFO - Browser initialized. 09:00:22 INFO - Running cycle 1/1 for kraken test... 09:00:22 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpXS0d0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:34 INFO - PROCESS | 2178 | RSS: Main: 167518208 09:00:34 INFO - PROCESS | 2178 | 09:00:37 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53589/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:38 INFO - PROCESS | 2178 | RSS: Main: 217989120 09:00:38 INFO - PROCESS | 2178 | 09:00:40 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53589/tests/kraken/driver.html?testName=audio-dft) 09:00:41 INFO - PROCESS | 2178 | RSS: Main: 231362560 09:00:41 INFO - PROCESS | 2178 | 09:00:44 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53589/tests/kraken/driver.html?testName=audio-fft) 09:00:44 INFO - PROCESS | 2178 | RSS: Main: 327413760 09:00:44 INFO - PROCESS | 2178 | 09:00:46 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53589/tests/kraken/driver.html?testName=audio-oscillator) 09:00:47 INFO - PROCESS | 2178 | RSS: Main: 232394752 09:00:47 INFO - PROCESS | 2178 | 09:00:49 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53589/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:50 INFO - PROCESS | 2178 | RSS: Main: 233414656 09:00:50 INFO - PROCESS | 2178 | 09:00:53 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53589/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:53 INFO - PROCESS | 2178 | RSS: Main: 274694144 09:00:53 INFO - PROCESS | 2178 | 09:00:56 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53589/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:57 INFO - PROCESS | 2178 | RSS: Main: 272920576 09:00:57 INFO - PROCESS | 2178 | 09:00:59 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53589/tests/kraken/driver.html?testName=json-parse-financial) 09:01:00 INFO - PROCESS | 2178 | RSS: Main: 269697024 09:01:00 INFO - PROCESS | 2178 | 09:01:01 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53589/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:02 INFO - PROCESS | 2178 | RSS: Main: 249397248 09:01:02 INFO - PROCESS | 2178 | 09:01:04 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:05 INFO - PROCESS | 2178 | RSS: Main: 248381440 09:01:05 INFO - PROCESS | 2178 | 09:01:07 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:07 INFO - PROCESS | 2178 | RSS: Main: 251355136 09:01:07 INFO - PROCESS | 2178 | 09:01:10 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:11 INFO - PROCESS | 2178 | RSS: Main: 266469376 09:01:11 INFO - PROCESS | 2178 | 09:01:14 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:15 INFO - PROCESS | 2178 | RSS: Main: 266436608 09:01:15 INFO - PROCESS | 2178 | 09:01:16 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:53589/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53589/tests/kraken/driver.html?testName=ai-astar) 09:01:16 INFO - PROCESS | 2178 | RSS: Main: 310091776 09:01:16 INFO - PROCESS | 2178 | 09:01:16 INFO - PROCESS | 2178 | __start_tp_report 09:01:16 INFO - PROCESS | 2178 | _x_x_mozilla_page_load 09:01:16 INFO - PROCESS | 2178 | _x_x_mozilla_page_load_details 09:01:16 INFO - PROCESS | 2178 | |i|pagename|runs| 09:01:16 INFO - PROCESS | 2178 | |0;ai-astar;105;114;113;114;114;115;119;167;159;112 09:01:16 INFO - PROCESS | 2178 | |1;audio-beat-detection;143;107;106;142;110;112;112;111;138;107 09:01:16 INFO - PROCESS | 2178 | |2;audio-dft;182;185;183;184;184;185;181;184;182;184 09:01:16 INFO - PROCESS | 2178 | |3;audio-fft;82;60;58;90;61;58;61;79;109;71 09:01:16 INFO - PROCESS | 2178 | |4;audio-oscillator;85;67;93;69;69;69;89;68;68;92 09:01:16 INFO - PROCESS | 2178 | |5;imaging-gaussian-blur;91;128;122;84;88;129;94;84;89;84 09:01:16 INFO - PROCESS | 2178 | |6;imaging-darkroom;93;92;93;93;93;93;93;92;92;92 09:01:16 INFO - PROCESS | 2178 | |7;imaging-desaturate;84;81;81;82;84;81;85;86;86;83 09:01:16 INFO - PROCESS | 2178 | |8;json-parse-financial;53;54;52;55;56;56;57;55;55;56 09:01:16 INFO - PROCESS | 2178 | |9;json-stringify-tinderbox;62;71;79;72;72;69;67;68;68;68 09:01:16 INFO - PROCESS | 2178 | |10;stanford-crypto-aes;82;81;81;83;78;80;80;82;86;89 09:01:16 INFO - PROCESS | 2178 | |11;stanford-crypto-ccm;139;139;148;150;141;167;158;150;205;162 09:01:16 INFO - PROCESS | 2178 | |12;stanford-crypto-pbkdf2;162;162;162;162;162;163;161;161;156;162 09:01:16 INFO - PROCESS | 2178 | |13;stanford-crypto-sha256-iterative;66;66;66;66;67;65;66;66;65;65 09:01:16 INFO - PROCESS | 2178 | __end_tp_report 09:01:16 INFO - PROCESS | 2178 | __start_cc_report 09:01:16 INFO - PROCESS | 2178 | _x_x_mozilla_cycle_collect,1900 09:01:16 INFO - PROCESS | 2178 | __end_cc_report 09:01:16 INFO - PROCESS | 2178 | __startTimestamp1485277276992__endTimestamp 09:01:16 INFO - PROCESS | 2178 | 09:01:16 INFO - PROCESS | 2178 | ------- Summary: start ------- 09:01:16 INFO - PROCESS | 2178 | Number of tests: 14 09:01:16 INFO - PROCESS | 2178 | 09:01:16 INFO - PROCESS | 2178 | [#0] ai-astar Cycles:10 Average:123.20 Median:114.50 stddev:21.34 (18.6%) stddev-sans-first:21.60 09:01:16 INFO - PROCESS | 2178 | Values: 105.0 114.0 113.0 114.0 114.0 115.0 119.0 167.0 159.0 112.0 09:01:16 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:112.00 stddev:15.51 (13.9%) stddev-sans-first:13.76 09:01:17 INFO - PROCESS | 2178 | Values: 143.0 107.0 106.0 142.0 110.0 112.0 112.0 111.0 138.0 107.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.35 (0.7%) stddev-sans-first:1.33 09:01:17 INFO - PROCESS | 2178 | Values: 182.0 185.0 183.0 184.0 184.0 185.0 181.0 184.0 182.0 184.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#3] audio-fft Cycles:10 Average:72.90 Median:66.00 stddev:17.04 (25.8%) stddev-sans-first:17.75 09:01:17 INFO - PROCESS | 2178 | Values: 82.0 60.0 58.0 90.0 61.0 58.0 61.0 79.0 109.0 71.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:11.27 (14.6%) stddev-sans-first:11.57 09:01:17 INFO - PROCESS | 2178 | Values: 85.0 67.0 93.0 69.0 69.0 69.0 89.0 68.0 68.0 92.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:86.00 stddev:19.01 (22.1%) stddev-sans-first:19.93 09:01:17 INFO - PROCESS | 2178 | Values: 91.0 128.0 122.0 84.0 88.0 129.0 94.0 84.0 89.0 84.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:01:17 INFO - PROCESS | 2178 | Values: 93.0 92.0 93.0 93.0 93.0 93.0 93.0 92.0 92.0 92.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#7] imaging-desaturate Cycles:10 Average:83.30 Median:84.00 stddev:2.00 (2.4%) stddev-sans-first:2.11 09:01:17 INFO - PROCESS | 2178 | Values: 84.0 81.0 81.0 82.0 84.0 81.0 85.0 86.0 86.0 83.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.52 (2.7%) stddev-sans-first:1.45 09:01:17 INFO - PROCESS | 2178 | Values: 53.0 54.0 52.0 55.0 56.0 56.0 57.0 55.0 55.0 56.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:4.40 (6.3%) stddev-sans-first:3.71 09:01:17 INFO - PROCESS | 2178 | Values: 62.0 71.0 79.0 72.0 72.0 69.0 67.0 68.0 68.0 68.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:3.19 (3.9%) stddev-sans-first:3.38 09:01:17 INFO - PROCESS | 2178 | Values: 82.0 81.0 81.0 83.0 78.0 80.0 80.0 82.0 86.0 89.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:154.00 stddev:19.72 (12.8%) stddev-sans-first:19.95 09:01:17 INFO - PROCESS | 2178 | Values: 139.0 139.0 148.0 150.0 141.0 167.0 158.0 150.0 205.0 162.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:1.95 (1.2%) stddev-sans-first:2.05 09:01:17 INFO - PROCESS | 2178 | Values: 162.0 162.0 162.0 162.0 162.0 163.0 161.0 161.0 156.0 162.0 09:01:17 INFO - PROCESS | 2178 | 09:01:17 INFO - PROCESS | 2178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:01:17 INFO - PROCESS | 2178 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 66.0 66.0 65.0 65.0 09:01:17 INFO - PROCESS | 2178 | -------- Summary: end -------- 09:01:17 INFO - PROCESS | 2178 | 09:01:18 INFO - TEST-INFO | 2178: exit 0 09:01:18 INFO - TEST-OK | kraken | took 59439ms 09:01:18 INFO - SUITE-END | took 1177s 09:01:18 INFO - Completed test suite (00:19:37) 09:01:18 INFO - javascript benchmark 09:01:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3407.3526030054286, 3455.0, 3471.9652803471968, 3483.355579217843, 3528.1356067763386, 5793.217915581396, 5833.59164858459, 5848.649081055134, 5852.707364631762, 5895.351511333755, 5752.942470575293, 5804.767809287623, 5808.941910580893, 5809.2738407699035, 5814.040683287263, 5160.2517634942815, 5193.246979188016, 5235.685858848481, 5258.0535503609335, 5271.130263506517, 5180.715060671661, 5209.739513024352, 5214.087534681435, 5281.762320695578, 5289.920651190235, 5209.32278803755, 5238.345206849144, 5311.097113490716, 5317.12267475866, 5325.041492531343, 5256.763445644936, 5319.335083114611, 5328.147496400596, 5329.413764485904, 5341.545968592674, 5160.251763494272, 5262.526372626444, 5286.920696189561, 5301.178317360776, 5335.839924802262, 5715.914261286084, 5735.1970724098655, 5743.081107022898, 5767.740451679684, 5771.249737534135, 6139.1064578004725, 6202.0, 6215.906761398583, 6237.750489980395, 6240.7503699852405, 6244.281907580641, 6258.718357673915, 6276.152719382916, 6277.372262773732, 6309.589876658002, 5842.065269556851, 5896.086106653475, 5923.378045305267, 6000.399960003964, 6045.425684559959, 6305.306416294204, 6331.651759153198, 6336.239651241788, 6342.175517182736, 6352.205974253218, 6185.381461853869, 6204.503639708812, 6214.347493513206, 6218.968905155445, 6222.875542489125, 6122.12371750169, 6152.907706384408, 6190.50475961922, 6206.968965155145, 6239.500839932794, 6191.19514463117, 6196.318404975449, 6208.913440147956, 6210.689465526705, 6213.409726076015, 6150.477209437158, 6182.876342473125, 6196.783112591038, 6198.442140207403, 6224.470919971763, 4983.626228032912, 5032.270320803463, 5050.242463630411, 5069.036882992294, 5120.92318615221, 4542.909141817211, 4556.043230921544, 4574.268117101248, 4615.23848564983, 4637.304404339308, 6009.038553831366, 6011.398860113954, 6018.428249316308, 6033.3664965178905, 6040.456358927718, 6119.41115851624, 6228.844278892973, 6236.968815155895, 6239.344868788712, 6369.20384951881, 5855.882882342329, 5983.551233657493, 6007.909881351783, 6071.574989750763, 6091.208142941389, 5544.722763861791, 5596.524295434933, 5597.608167428241, 5604.775808967595, 5637.013522633522, 5414.512693857571, 6454.870902582016, 6462.612243265419, 6484.254310754135, 6489.994050922114, 6081.27024757032, 6128.50971922254, 6135.447809697149, 6151.815445536641, 6152.477039451518, 5121.334226550524, 6340.682965851781, 6435.32429094957, 6445.387688169616, 6462.741490340334, 6220.875582488235, 6222.471089957223, 6230.345813689497, 6249.562530622813, 6259.186305780219, 5749.597528172988, 6143.450468055707, 6185.567010309235, 6210.5652604317265, 6211.65835879031, 6114.540688159484, 6123.191113103653, 6163.568550201443, 6226.813195604139, 6236.282827474898, 6175.5677102602385, 6206.968965155145, 6212.254529456494, 6213.689315534296, 6224.0, 5970.0, 6079.179310792986, 6114.969425152845, 6128.509719222362, 6145.692715364304, 6120.782376608402, 6139.877202456015, 6176.413240742122, 6202.751889924352, 6274.905876411949, 6134.386561344008, 6136.2943261523715, 6141.570090093829, 6147.631142131487, 6152.830962117184], "value": 5777.833219473198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.3192812888474, 497.50995269659404, 517.0512110277642, 529.3912001198621, 540.5675459632293, 31337.216569585744, 33018.83490582547, 40920.77237682867, 41918.16163676725, 42037.15925681485, 43380.915477113085, 43662.345064824054, 43703.0, 43952.56047439525, 43964.560354396446, 9613.855792163124, 9811.313208075402, 9812.46031468269, 9812.656557020506, 9822.754431139243, 9730.756731081708, 9821.558029888673, 9830.508474576278, 9830.754231144207, 9831.016898310183, 9748.220142388593, 9834.852477212848, 9849.90150098497, 9849.901500985006, 9850.40897546146, 9777.657781977632, 9798.412095274307, 9817.607295708163, 9835.31152819303, 9844.3601165924, 8182.386321025947, 9628.855567166498, 9640.373375730625, 9647.0, 9669.661561845302, 41523.5466758662, 41816.1636767263, 41816.95457613584, 41847.7907610463, 41936.741897743115, 3156.8895088672016, 3246.2695893424025, 3347.6150242722156, 3478.513008178857, 3723.5345581802276, 29167.270818229503, 30925.0, 31168.0, 31923.361532769213, 31985.360292794245, 3149.5118256670253, 3271.018694391673, 3283.1792051987004, 3298.208429976812, 3313.685199906005, 526588.0, 529493.0, 530025.0, 530087.0, 530624.346878267, 34521.30957380839, 54004.72997635065, 64164.0, 64829.0, 64849.0, 35672.64327356693, 36327.0, 36626.81686591604, 36670.083247919014, 36722.265554688754, 14558.344874480674, 14711.264436778332, 14716.926415368069, 14717.0, 14734.705305893822, 10820.891791082146, 11752.529898804123, 12217.877821221851, 12329.568465103679, 12344.691382715324, 8063.959680201561, 8066.31436327907, 8090.474119182234, 8146.185381461925, 8191.467554608931, 3344.180675734412, 3367.020187134404, 3373.0, 3385.322935412927, 3411.181316484026, 884.1114679746942, 964.8325526113481, 996.0537489385113, 1026.7587117027492, 1030.835066389374, 29938.700612994027, 30039.69960300369, 30573.235669108006, 30705.078847634606, 30790.92231771922, 945.7068308824287, 1068.6793961811425, 1124.454639499842, 1146.97345875441, 1250.2498500899387, 15075.623109422133, 15233.0, 15962.92018539923, 16087.758683619755, 16369.754453682966, 693353.0, 697815.0, 697891.0, 698631.0, 699326.0, 60352.0, 60950.695246523486, 61275.0, 61308.0, 61342.38657613456, 1263.3556885988028, 1315.7434300311538, 1316.9539066132638, 1395.1071314359021, 1419.5102689572082, 28859.567106493, 31519.054428367184, 31636.892708755084, 31782.06019668186, 32113.0, 50721.49278507168, 51442.0, 51488.712782180744, 51490.74254628853, 51530.96938061143, 556437.0, 559283.0, 560971.0, 561064.0, 563552.0, 24279.271621851374, 24741.0, 27331.590026149224, 27807.30481737973, 27882.88468461239, 45197.77401112973, 50148.0, 50232.246516303014, 50748.238776417646, 51155.48844511507, 38929.41605875971, 39518.01204969899, 39843.60156398515, 40175.79912100421, 40983.0, 39134.804325978184, 40769.388459172544, 40834.889223918166, 41328.38007429831, 41445.378319324635, 38216.80891595524, 38647.2270554593, 38761.0, 39279.2144157121, 39361.80319098386, 29931.95238166654, 32602.36037450125, 35670.25316769104, 35955.46066808948, 36620.81689591642, 26533.07134250292, 26534.938602455684, 26572.874170066734, 26710.59934100951, 27335.0], "value": 19003.98845850169, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.31596491052983, 386.59407621996894, 390.38124572552505, 406.5345179769163, 418.9099343641117, 18824.435266941997, 19858.304959326426, 21186.364409067734, 21428.892855535738, 21492.462688432795, 12147.635570932864, 12280.0, 14649.8280137589, 20756.68864967027, 21307.041183146757, 5306.097963346221, 5492.780288788444, 5537.556995440355, 5537.916931246014, 5539.778408863641, 5890.970545147268, 6060.030395136779, 6069.028955367142, 6072.483838873701, 6075.483583895374, 5418.160185171305, 5527.585431092664, 6019.518438524908, 6022.126791615213, 6029.60807547508, 5460.453954604528, 5513.145462453326, 5513.173024046385, 5513.8345849624375, 5516.503514683678, 5101.6173786965755, 5354.544863686591, 5355.437679043684, 5376.301080859464, 5380.569554435636, 13971.860281397157, 14035.228062456561, 14055.578332650037, 14303.642408939755, 24919.0, 1789.579448829524, 2198.318521258399, 2244.7194100737406, 2436.1838784007377, 2938.38293958269, 10529.947350263275, 10671.19966002553, 10727.13072633474, 10748.462576871125, 14028.579142625738, 1830.9176087076114, 1865.4310435317223, 1868.813118688134, 1882.9340973065878, 1960.9705854412196, 58575.41424585742, 106603.0, 121143.99999999911, 124786.0, 124872.37563812123, 9478.715638530855, 10080.74798130038, 10165.034321739422, 10410.843837342445, 11570.0, 12645.43095560702, 12737.29944853042, 12764.106512544033, 12779.552715654907, 12782.61652150437, 7915.287624113742, 8003.639836207385, 8026.9966254218225, 8099.311558517474, 8156.388270879707, 8194.836103277901, 8205.58972051395, 8219.95890020546, 8265.752027439186, 8361.289290410383, 3919.235749028912, 4018.7588744675413, 4040.8989775255855, 4076.3274059779806, 4103.630673239423, 1942.300771722179, 1992.551675872917, 1994.5711671990591, 1995.7704863940542, 1998.6702194138095, 848.4357901995104, 937.3391758810022, 950.5627411390838, 958.8513780364054, 962.4802606592501, 20594.0, 21741.565168696536, 21921.23275685375, 21941.341759747233, 22035.0, 936.7470782888582, 942.5475771629656, 946.5645802930729, 966.3573723473952, 972.7033254857337, 9714.708558743248, 11026.558937642565, 11402.372869492257, 11441.485133169028, 11630.592929247436, 540948.2952585212, 584779.0, 590043.0, 590056.0497197487, 613744.0, 79038.60480697559, 84442.2605378896, 106049.46975265074, 114987.0, 121251.0, 800.2957397490288, 907.9863802042975, 921.4517362169498, 937.044214900811, 941.1905761045496, 19127.426177214707, 19898.60202795965, 20167.79832201659, 20192.697109543074, 20193.788372697098, 54463.18305225504, 55178.72410637921, 55660.443395565526, 56309.08754580874, 56503.0, 75803.0, 79244.60377698074, 80673.0, 80914.0, 83700.0, 10801.405922674328, 11811.110222364381, 11819.940900295443, 11934.820977685167, 12031.4585843639, 13096.345182741015, 13240.86759132435, 13582.864171358555, 13664.043516953718, 13704.972127090308, 11198.608048718255, 11394.94302528482, 11553.653390398302, 11817.881821182022, 11868.465919033837, 11264.774704506028, 11348.0, 11766.764664706829, 11783.52865885355, 11931.0, 11581.710457238636, 11583.362915039754, 11704.882951170379, 12088.0, 12101.636950891487, 11861.644150675493, 12006.459709312927, 12121.636350909486, 12207.38963051826, 12221.38893055326, 11670.580308929946, 11688.824667630162, 11905.523779049088, 12055.939720301343, 12066.0], "value": 9501.54935303178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.5996910818635, 1533.11845688729, 1682.3438858845052, 1836.192075486785, 1836.9357072502464, 8045.477043992144, 8357.498550086984, 8369.83260334793, 8371.665133394657, 8375.204355586216, 7400.481966262364, 7670.386369090474, 7701.807454813633, 8023.598820058988, 8242.711505097323, 1988.8607797454183, 2308.284431826131, 2335.1593426366494, 2335.43949452132, 2336.871472069044, 2325.988370058147, 2352.3766201956496, 2377.619580867062, 2378.8810559472045, 2379.988100059506, 1870.7661542307212, 2199.3401979406194, 2321.8955147018423, 2351.576716191085, 2356.929292121239, 2254.4025833154064, 2306.4810417655976, 2325.453518423169, 2326.627739561679, 2327.998960447007, 2327.4065113396146, 2350.82368822339, 2356.2342238772467, 2356.882155892216, 2357.622780355135, 8166.591670416456, 8334.0, 8336.333093352518, 8354.248117669378, 8357.164283571656, 4482.618977386894, 5050.090983622947, 5202.869928251786, 5208.374995000624, 5225.320708307896, 3192.74458043356, 3228.063861480168, 3542.0436482149935, 3551.8756843510355, 3563.394222982099, 1044.0759927464173, 1045.7647029418397, 1074.462768615692, 1087.8150714378496, 1089.6730980705756, 10545.209109316755, 10671.786564268672, 10680.572777088908, 10695.09091727204, 10718.410487423189, 4470.284754439274, 4572.588467037983, 4659.207934651117, 4674.252119660838, 4731.52684731531, 8164.387670924704, 9355.766105847271, 9441.858372124423, 9442.716718498456, 9509.857352139723, 5235.8481134150425, 5239.214117882349, 5242.580593552507, 5246.134387825966, 5251.291075704808, 4362.847300344472, 4493.168763778712, 4689.20283551797, 4794.976025119852, 4824.855254342376, 3813.313603551332, 3856.9614303857165, 3913.72603917723, 3952.782596957195, 3955.0, 1261.9369031548385, 1266.6516707905216, 1267.5120078769555, 1272.7836267834305, 1285.389440015985, 914.5198770645464, 914.6798620482778, 915.9633614655472, 928.2388441478058, 948.6537413843897, 5610.607257491936, 5816.185733997244, 5920.0, 6005.6396616203165, 6114.11345354921, 900.0579245198969, 921.1755478846395, 960.0, 988.980220395588, 1012.6759436980095, 3776.4524143999515, 3925.7840818755244, 3936.704747143918, 4034.8587799426878, 4052.230076285496, 9509.0, 9952.353097048668, 9953.651622193189, 9953.850692239623, 9963.402195868272, 8892.64429422816, 9615.855762163574, 9900.455474948947, 9949.204063674888, 9959.253056020827, 7532.54804711719, 7619.161892191854, 7834.921650783419, 7839.764807055797, 7889.447738658354, 5641.0, 5827.125931110368, 5841.620294680833, 5878.0, 5951.523878089829, 9030.864537031819, 9172.633094676139, 9191.632334706537, 9241.260699143917, 9299.209567186865, 7769.844603108019, 9072.867876048991, 9343.159115679622, 9465.952670236606, 9478.52607369615, 6663.500237482305, 6853.074834897225, 6865.073215115895, 7078.681459334445, 7239.927600723925, 7758.3017528422715, 8004.799880003046, 8013.0, 8063.596820158851, 8069.838603227785, 7223.638818059181, 7282.599457029914, 7427.2201418850245, 7429.4799364044, 7454.962725186556, 7182.030425892646, 7211.062561866924, 7237.457190710613, 7318.707251709872, 7469.066366704162, 6047.667378294236, 6263.906041409474, 6550.737970481127, 6714.194296684429, 6730.966345168243, 4523.411956445641, 4788.186008378514, 4828.444728856227, 4833.637477189154, 4851.320815085962, 3918.471006414212, 4628.629709623289, 4651.534846515321, 4817.445993710628, 4870.172070747911], "value": 4425.234218319348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.71918844807175, 308.8656434451014, 316.1889752784108, 321.23225491076334, 323.3629749393697, 5050.64645474816, 5185.662931909424, 5224.033553792551, 5259.973700131499, 5266.947330526698, 4284.335927931175, 5003.774830132644, 5101.897962040757, 5146.511081447256, 5151.896962060757, 3949.526056873179, 3953.9209215815667, 3963.7027222958395, 3985.5815139410233, 4003.899902502432, 3290.605127384717, 3790.5830358660523, 3960.980195099035, 3983.1237127831973, 4009.4386785850006, 3122.6721194274614, 3238.352329534091, 3522.7710198836994, 3989.640932316091, 4026.617471340218, 3991.44119823225, 3997.620226078518, 4002.699797515198, 4020.8994775130564, 4027.939580906289, 3184.9044528664176, 3220.246689080849, 3543.6102028776813, 3552.9518791956434, 3567.3935430976535, 4668.0, 5055.912978709558, 5101.744912754348, 5103.515166059218, 5114.979583064705, 3637.2179981303884, 3847.288251673421, 4193.90958350831, 4593.6095431888, 4640.69835460694, 4775.283707443877, 5144.511271429208, 5416.8104116355735, 5422.861199148184, 5475.780968761284, 3946.782926939017, 3953.4860468139245, 3960.3663413853646, 3961.6632586230203, 3964.5638979712207, 4536.092781443725, 5186.5850731941355, 5755.568332375088, 5766.625169363978, 5840.766369345263, 3434.587849458081, 3772.0569857535615, 3995.141044675409, 4029.6977726670616, 4036.233115708006, 4024.557298697141, 4026.315526360526, 4032.395140728914, 4058.9797051014557, 4076.1236334188293, 4593.724376537419, 4601.194790911577, 4604.263317869192, 4604.493505714368, 4614.953850461519, 5189.4032186299055, 5228.424873263938, 5468.7539060742365, 5541.861453463695, 5574.275344205227, 1079.8434227037192, 1217.4217246807873, 1219.9812614034258, 1272.338384040294, 1309.6987692830703, 837.7068026190906, 871.2724874729672, 905.8867641544807, 912.0378001208655, 916.7524768312518, 4391.604755572014, 4699.530046995274, 4843.733594652328, 4878.731529802277, 4889.728670545684, 4866.7566621668775, 5012.874678133076, 5282.0, 5317.973410132925, 5328.760205790749, 4465.620422264079, 4517.548245175456, 4873.417088942866, 4880.536349046906, 4891.559759621651, 2338.5439839231526, 2737.6988531261545, 2738.3838636306673, 2757.5863620457094, 2762.7651649610007, 4837.588804951619, 5462.863428414322, 5467.753951072212, 5521.420250873681, 5522.39850443375, 4604.608608268268, 4854.927176092361, 5197.66215196011, 5385.407605163429, 5390.8921821563345, 4644.907101858012, 4937.222599864046, 4996.650234483552, 5436.238926550286, 5481.862953426196, 5037.2695959084995, 5068.467810879804, 5216.608754343363, 5245.583692403106, 5321.866953326198, 4880.6583539153335, 5176.741162941763, 5208.5051920069045, 5215.522626752262, 5264.763085661231, 4577.93133102997, 4850.296706977539, 5170.871622668232, 5439.0, 5466.3986961435, 3212.698856962934, 3540.203239440813, 3678.0, 3859.2088621831895, 3895.844166233319, 4382.671299652475, 4962.875928101682, 5382.9275728843895, 5518.862028449321, 5519.43346343952, 5514.944850551443, 5514.972425137848, 5532.91700624499, 5553.611247212818, 5575.386707462095, 4629.93055104167, 5152.819651312186, 5249.6062795289745, 5255.37083504115, 5323.334583177103, 4178.603032711888, 4899.0, 5362.892742145214, 5363.865903352447, 5390.568754499709, 4791.448983366958, 4853.223484242645, 5474.890502190014, 5492.752826122914, 5494.752736126964, 4664.580187783115, 4692.624590032721, 5051.747412629427, 5114.488551144856, 5366.946330536801], "value": 3923.643121434614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.2146396036437, 744.8733715268407, 767.0756738130553, 784.9489783164094, 820.5486982159811, 14883.330250138742, 15728.292226849791, 15852.445164419247, 15853.048817070983, 15881.602959926007, 14001.439942402318, 14166.433342666307, 14180.361883715232, 14219.217943013131, 14261.144331340127, 694.6769752065288, 717.852840167767, 721.1850608812061, 859.7377799771067, 867.7310033889498, 881.6517475597135, 885.1723638398119, 893.8391089603869, 895.3016647015338, 897.4704924094783, 942.575840871607, 957.1290125985355, 957.8706874571948, 959.6928982725531, 959.8512230604233, 953.4136506048765, 953.823542644613, 954.4368822394752, 955.7180631713661, 955.9330846840724, 706.4101475268158, 708.4332533972802, 708.8440543080566, 708.88303429934, 709.6948312225741, 12614.747705045847, 12800.743985120338, 12832.294223817686, 12848.293343866084, 15029.173395463245, 14217.36021879018, 14490.492832750908, 14647.487337943227, 14669.03939425657, 14700.970932034761, 10472.895271047268, 10562.282401342789, 10790.244682872202, 11746.471408786625, 11817.0, 4333.588309110661, 4637.930431043537, 4783.784729687172, 4802.68782529138, 4817.084753896748, 86907.61213122756, 90284.19431611331, 91322.0, 91482.0, 93601.99999999932, 10613.522391492246, 10636.202284828669, 10888.836667449994, 10900.563977440972, 10904.61833835812, 16301.266443010092, 19914.203431862854, 20065.29771458021, 20456.0, 20469.89765051165, 7606.923930760621, 7621.580813055224, 7713.807154821062, 7805.37556995439, 7934.047914250212, 4287.849925252601, 4356.716813407118, 4384.495782984934, 4478.888027799266, 4538.478075021415, 3294.769366144395, 3405.5402520659395, 3409.215880347534, 3415.5389022482145, 3747.7563958343167, 622.953278504114, 713.0480808121113, 720.8070643085701, 724.2467833453255, 726.9164046134656, 552.3454706173197, 613.420317799675, 628.1864984844638, 642.8457170279099, 667.8363800868818, 8932.598033088527, 9321.114494123047, 9370.765730856783, 9613.031775439622, 9923.255755818342, 677.2448719677524, 680.709600182046, 698.8462538241579, 701.1446035836271, 716.9211386747454, 4455.376247325377, 4558.1795276849825, 4622.0218739294705, 4629.606483448944, 4641.396618439581, 116468.41765791287, 118401.0, 119155.40422297834, 119977.0, 126350.36824815816, 71616.0, 88280.0, 102456.0, 103037.0, 105635.0, 85310.5734471336, 87703.12296877077, 89247.55376223077, 89949.0, 92821.53589232011, 8828.42615230008, 8888.155625215593, 8896.466212027299, 8927.776805579913, 8966.641334346554, 54578.0, 54789.63025924224, 55272.85017719391, 55364.0, 57613.0, 64456.0, 73944.0, 76874.62940909775, 79362.603186986, 80480.19519804727, 11489.482973266056, 11804.291742495478, 11871.703207419883, 12245.265284082983, 12455.439505222468, 14233.430662773788, 14442.271027806144, 14537.636559086108, 14655.193964332064, 15640.765388518954, 13587.320633968064, 13602.86397136016, 13870.445182193003, 13927.373268203159, 14051.437942482185, 8331.757046004352, 11427.54307823822, 12507.437165327765, 12871.549495767604, 13060.934695326463, 13615.591532254048, 13643.658908527366, 13922.651933701738, 13985.090969086978, 14389.496367627084, 10952.835707464235, 11035.834462482908, 11234.507485343815, 11523.13576481784, 11700.94149529281, 10750.0, 11418.657440276806, 11526.481308341312, 11685.182037257651, 11695.356755378536], "value": 7558.316417743703, "unit": "score"}], "name": "dromaeo_css", "value": 7179.326046741417, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 114.0, 114.0, 115.0, 119.0, 167.0, 159.0, 112.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 106.0, 142.0, 110.0, 112.0, 112.0, 111.0, 138.0, 107.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 183.0, 184.0, 184.0, 185.0, 181.0, 184.0, 182.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 58.0, 90.0, 61.0, 58.0, 61.0, 79.0, 109.0, 71.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 67.0, 93.0, 69.0, 69.0, 69.0, 89.0, 68.0, 68.0, 92.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 128.0, 122.0, 84.0, 88.0, 129.0, 94.0, 84.0, 89.0, 84.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 81.0, 82.0, 84.0, 81.0, 85.0, 86.0, 86.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 55.0, 56.0, 56.0, 57.0, 55.0, 55.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 79.0, 72.0, 72.0, 69.0, 67.0, 68.0, 68.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 83.0, 78.0, 80.0, 80.0, 82.0, 86.0, 89.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 148.0, 150.0, 141.0, 167.0, 158.0, 150.0, 205.0, 162.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 156.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1440.1, "alertThreshold": 2.0}]} 09:01:18 INFO - Return code: 0 09:01:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:18 INFO - # TBPL SUCCESS # 09:01:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:18 INFO - 2017-01-24 09:01:18.798 screenresolution[2182:21139] starting screenresolution argv=screenresolution get 09:01:18 INFO - 2017-01-24 09:01:18.801 screenresolution[2182:21139] Display 0: 1600x1200x32@60 09:01:18 INFO - 2017-01-24 09:01:18.807 screenresolution[2183:21142] starting screenresolution argv=screenresolution list 09:01:18 INFO - Available Modes on Display 0 09:01:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:19 INFO - Intel Iris: 09:01:19 INFO - Chipset Model: Intel Iris 09:01:19 INFO - Type: GPU 09:01:19 INFO - Bus: Built-In 09:01:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:19 INFO - Vendor: Intel (0x8086) 09:01:19 INFO - Device ID: 0x0a2e 09:01:19 INFO - Revision ID: 0x0009 09:01:19 INFO - Displays: 09:01:19 INFO - Display: 09:01:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:19 INFO - Display Serial Number: 1600x1200 60 09:01:19 INFO - Main Display: Yes 09:01:19 INFO - Mirror: Off 09:01:19 INFO - Online: Yes 09:01:19 INFO - Rotation: Supported 09:01:19 INFO - Return code: 0 09:01:19 INFO - Running post-action listener: _resource_record_post_action 09:01:19 INFO - [mozharness: 2017-01-24 17:01:19.043911Z] Finished run-tests step (success) 09:01:19 INFO - Running post-run listener: _resource_record_post_run 09:01:19 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 450560; Write bytes: 498803200; Read time: 7; Write time: 1928 09:01:19 INFO - TinderboxPrint: CPU usage
53.5% 09:01:19 INFO - TinderboxPrint: I/O read bytes / time
450,560 / 7 09:01:19 INFO - TinderboxPrint: I/O write bytes / time
498,803,200 / 1,928 09:01:19 INFO - TinderboxPrint: CPU idle
2,232.8 (46.5%) 09:01:19 INFO - TinderboxPrint: CPU system
960.1 (20.0%) 09:01:19 INFO - TinderboxPrint: CPU user
1,604.7 (33.4%) 09:01:19 INFO - TinderboxPrint: Swap in / out
191,283,200 / 0 09:01:19 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187257344; Write bytes: 187377152; Read time: 16844; Write time: 393 09:01:19 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 450560; Write bytes: 304425984; Read time: 7; Write time: 1506 09:01:19 INFO - Running post-run listener: _upload_blobber_files 09:01:19 INFO - Blob upload gear active. 09:01:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:20 INFO - (blobuploader) - INFO - Done attempting. 09:01:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:21 INFO - (blobuploader) - INFO - Done attempting. 09:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:23 INFO - (blobuploader) - INFO - Done attempting. 09:01:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:23 INFO - Return code: 0 09:01:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26abdd01f9ac8ccc24c031b776ab89b4b0a902cf6f75666771e2449b888c8666c655afd68347bf58740b747f6bf9740c7c872526f24aebb79014d1c8830e7ab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47b61a7313fe92bbbc3fec720b7f7a303836aba7722db8b8e19e718081cfbe4c51a8b570b7c904569650af3fd65907a1b2fa13b75414b0c42f839fe82ac7775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5551a41f9bb9408f271a165b8e100b92cb47e06b80ecf4a46b2030fa87d83d1737bb0eed649b82c00af6c57e0bea8a059365438cb8cc529086786a97f017a8"} 09:01:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:23 INFO - Contents: 09:01:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26abdd01f9ac8ccc24c031b776ab89b4b0a902cf6f75666771e2449b888c8666c655afd68347bf58740b747f6bf9740c7c872526f24aebb79014d1c8830e7ab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47b61a7313fe92bbbc3fec720b7f7a303836aba7722db8b8e19e718081cfbe4c51a8b570b7c904569650af3fd65907a1b2fa13b75414b0c42f839fe82ac7775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5551a41f9bb9408f271a165b8e100b92cb47e06b80ecf4a46b2030fa87d83d1737bb0eed649b82c00af6c57e0bea8a059365438cb8cc529086786a97f017a8"} 09:01:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:23 INFO - Copying logs to upload dir... 09:01:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.076700 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 09:01:23.826503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:23.829770) ========= 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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26abdd01f9ac8ccc24c031b776ab89b4b0a902cf6f75666771e2449b888c8666c655afd68347bf58740b747f6bf9740c7c872526f24aebb79014d1c8830e7ab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47b61a7313fe92bbbc3fec720b7f7a303836aba7722db8b8e19e718081cfbe4c51a8b570b7c904569650af3fd65907a1b2fa13b75414b0c42f839fe82ac7775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5551a41f9bb9408f271a165b8e100b92cb47e06b80ecf4a46b2030fa87d83d1737bb0eed649b82c00af6c57e0bea8a059365438cb8cc529086786a97f017a8"} build_url:https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010977 build_url: 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26abdd01f9ac8ccc24c031b776ab89b4b0a902cf6f75666771e2449b888c8666c655afd68347bf58740b747f6bf9740c7c872526f24aebb79014d1c8830e7ab7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47b61a7313fe92bbbc3fec720b7f7a303836aba7722db8b8e19e718081cfbe4c51a8b570b7c904569650af3fd65907a1b2fa13b75414b0c42f839fe82ac7775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5551a41f9bb9408f271a165b8e100b92cb47e06b80ecf4a46b2030fa87d83d1737bb0eed649b82c00af6c57e0bea8a059365438cb8cc529086786a97f017a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:23.863645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:23.863965) ========= 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.Ap1AERwZPJ/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.VIQpUT3ags/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005215 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:23.914202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:01:23.914521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:01:23.914843) ========= ========= Total master_lag: 0.18 =========