builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0269 starttime: 1493552436.58 results: success (0) buildid: 20170430030208 builduid: f65b162368ab4a5aa132a607e7dff60d revision: 2fe636103d7167f3a5d57f61bd19fddcc878ca3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:36.583654) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:36.584124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:36.584464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:36.611840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:36.612332) ========= 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.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-04-30 04:40:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.26M=0.002s 2017-04-30 04:40:37 (6.26 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.382064 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:37.186409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:37.186809) ========= 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.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.020986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:37.238344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 04:40:37.238826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fe636103d7167f3a5d57f61bd19fddcc878ca3c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2fe636103d7167f3a5d57f61bd19fddcc878ca3c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-04-30 04:40:37,327 truncating revision to first 12 chars 2017-04-30 04:40:37,327 Setting DEBUG logging. 2017-04-30 04:40:37,327 attempt 1/10 2017-04-30 04:40:37,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fe636103d71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-30 04:40:38,195 unpacking tar archive at: mozilla-central-2fe636103d71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135007 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 04:40:38.401378) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:38.401742) ========= script_repo_revision: 2fe636103d7167f3a5d57f61bd19fddcc878ca3c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:38.402203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:38.402526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 04:40:38.422735) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2017-04-30 04:40:38.423041) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:40:38 INFO - MultiFileLogger online at 20170430 04:40:38 in /builds/slave/test 04:40:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:40:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:38 INFO - {'append_to_log': False, 04:40:38 INFO - 'base_work_dir': '/builds/slave/test', 04:40:38 INFO - 'blob_upload_branch': 'Firefox', 04:40:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:38 INFO - 'branch': 'Firefox', 04:40:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:38 INFO - 'config_files': ('talos/mac_config.py',), 04:40:38 INFO - 'default_actions': ('clobber', 04:40:38 INFO - 'read-buildbot-config', 04:40:38 INFO - 'download-and-extract', 04:40:38 INFO - 'populate-webroot', 04:40:38 INFO - 'create-virtualenv', 04:40:38 INFO - 'install', 04:40:38 INFO - 'run-tests'), 04:40:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:38 INFO - 'download_minidump_stackwalk': True, 04:40:38 INFO - 'download_symbols': 'ondemand', 04:40:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:38 INFO - 'gecko_profile': False, 04:40:38 INFO - 'gecko_profile_interval': 0, 04:40:38 INFO - 'installer_path': 'installer.exe', 04:40:38 INFO - 'log_level': 'info', 04:40:38 INFO - 'log_name': 'talos', 04:40:38 INFO - 'log_to_console': True, 04:40:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:40:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:40:38 INFO - 'opt_config_files': (), 04:40:38 INFO - 'pip_index': False, 04:40:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:38 INFO - 'cmd': ('bash', 04:40:38 INFO - '-c', 04:40:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:38 INFO - 'enabled': True, 04:40:38 INFO - 'halt_on_failure': False, 04:40:38 INFO - 'name': 'check_screen_resolution'},), 04:40:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:38 INFO - 'cmd': ('bash', 04:40:38 INFO - '-c', 04:40:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:38 INFO - 'enabled': True, 04:40:38 INFO - 'halt_on_failure': False, 04:40:38 INFO - 'name': 'check_screen_resolution'},), 04:40:38 INFO - 'run_cmd_checks_enabled': True, 04:40:38 INFO - 'suite': 'dromaeojs', 04:40:38 INFO - 'system_bits': '32', 04:40:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:38 INFO - 'title': 't-yosemite-r7-0269', 04:40:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:38 INFO - 'use_talos_json': True, 04:40:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:38 INFO - 'work_dir': 'build'} 04:40:38 INFO - [mozharness: 2017-04-30 11:40:38.627471Z] Running clobber step. 04:40:38 INFO - Running pre-action listener: _resource_record_pre_action 04:40:38 INFO - Running main action method: clobber 04:40:38 INFO - rmtree: /builds/slave/test/build 04:40:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:40 INFO - Running post-action listener: _resource_record_post_action 04:40:40 INFO - [mozharness: 2017-04-30 11:40:40.392049Z] Finished clobber step (success) 04:40:40 INFO - [mozharness: 2017-04-30 11:40:40.392246Z] Running read-buildbot-config step. 04:40:40 INFO - Running pre-action listener: _resource_record_pre_action 04:40:40 INFO - Running main action method: read_buildbot_config 04:40:40 INFO - Using buildbot properties: 04:40:40 INFO - { 04:40:40 INFO - "project": "", 04:40:40 INFO - "product": "firefox", 04:40:40 INFO - "script_repo_revision": "production", 04:40:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:40:40 INFO - "repository": "", 04:40:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:40:40 INFO - "buildid": "20170430030208", 04:40:40 INFO - "stage_platform": "macosx64", 04:40:40 INFO - "basedir": "/builds/slave/test", 04:40:40 INFO - "nightly_build": "True", 04:40:40 INFO - "buildnumber": 110, 04:40:40 INFO - "slavename": "t-yosemite-r7-0269", 04:40:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:40:40 INFO - "platform": "yosemite_r7", 04:40:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:40:40 INFO - "branch": "mozilla-central", 04:40:40 INFO - "repo_path": "mozilla-central", 04:40:40 INFO - "revision": "2fe636103d7167f3a5d57f61bd19fddcc878ca3c", 04:40:40 INFO - "pgo_build": "False", 04:40:40 INFO - "builduid": "f65b162368ab4a5aa132a607e7dff60d", 04:40:40 INFO - "slavebuilddir": "test" 04:40:40 INFO - } 04:40:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:40:40 INFO - Running post-action listener: _resource_record_post_action 04:40:40 INFO - [mozharness: 2017-04-30 11:40:40.395875Z] Finished read-buildbot-config step (success) 04:40:40 INFO - [mozharness: 2017-04-30 11:40:40.395997Z] Running download-and-extract step. 04:40:40 INFO - Running pre-action listener: _resource_record_pre_action 04:40:40 INFO - Running main action method: download_and_extract 04:40:40 INFO - mkdir: /builds/slave/test/build/tests 04:40: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')]} 04:40:40 INFO - trying https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:40 INFO - Downloading https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:40:41 INFO - Downloaded 1325 bytes. 04:40:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:41 INFO - Using the following test package requirements: 04:40:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:40:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:40:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:40:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'jsshell-mac.zip'], 04:40:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:40:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:40:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:40:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:40:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:40:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:40:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:40:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:40:41 INFO - Fetch https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:40:43 INFO - Content-Length response header: 52701315 04:40:43 INFO - Bytes received: 52701315 04:40:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:40:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:40:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:40:59 INFO - Fetch https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:41:01 INFO - Content-Length response header: 52701315 04:41:01 INFO - Bytes received: 52701315 04:41:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:41:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:41:17 INFO - Fetch https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:41:18 INFO - Content-Length response header: 14408811 04:41:18 INFO - Bytes received: 14408811 04: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')]} 04:41:18 INFO - trying https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:41:18 INFO - Downloading https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:41:50 WARNING - URL Error: https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:41:50 INFO - Running command: ['nslookup', 'queue.taskcluster.net'] 04:41:50 INFO - Copy/paste: nslookup queue.taskcluster.net 04:41:50 INFO - Server: 10.26.75.40 04:41:50 INFO - Address: 10.26.75.40#53 04:41:50 INFO - queue.taskcluster.net canonical name = toyama-73636.herokussl.com. 04:41:50 INFO - toyama-73636.herokussl.com canonical name = elb081832-1105536650.us-east-1.elb.amazonaws.com. 04:41:50 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 04:41:50 INFO - Address: 23.23.146.199 04:41:50 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 04:41:50 INFO - Address: 54.235.149.195 04:41:50 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 04:41:50 INFO - Address: 50.19.237.146 04:41:50 INFO - Return code: 0 04:41:50 INFO - retry: attempt #1 caught URLError exception: 04:41:50 INFO - retry: Failed, sleeping 30 seconds before retrying 04:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #2 04:42:22 INFO - Downloaded 71273067 bytes. 04:42:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:22 INFO - mkdir: /builds/slave/test/properties 04:42:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:22 INFO - Contents: 04:42:22 INFO - build_url:https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:23 INFO - Running post-action listener: _resource_record_post_action 04:42:23 INFO - Running post-action listener: set_extra_try_arguments 04:42:23 INFO - [mozharness: 2017-04-30 11:42:23.340756Z] Finished download-and-extract step (success) 04:42:23 INFO - [mozharness: 2017-04-30 11:42:23.340904Z] Running populate-webroot step. 04:42:23 INFO - Running pre-action listener: _resource_record_pre_action 04:42:23 INFO - Running main action method: populate_webroot 04:42:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:23 INFO - '--tppagecycles', 04:42:23 INFO - '7'], 04:42:23 INFO - 'tests': ['tsvgm']}}, 04:42:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['damp', 'tps']}, 04:42:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'tests': ['damp', 'tps']}, 04:42:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['dromaeo_dom']}, 04:42:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:42:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:42:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['a11yr', 04:42:23 INFO - 'ts_paint', 04:42:23 INFO - 'tpaint', 04:42:23 INFO - 'sessionrestore', 04:42:23 INFO - 'sessionrestore_no_auto_restore', 04:42:23 INFO - 'tabpaint']}, 04:42:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:42:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:42:23 INFO - 'bloom_basic_ref']}, 04:42:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['tsvgx', 04:42:23 INFO - 'tsvgr_opacity', 04:42:23 INFO - 'tart', 04:42:23 INFO - 'tscrollx', 04:42:23 INFO - 'cart', 04:42:23 INFO - 'tsvg_static']}, 04:42:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:23 INFO - 'tsvgr_opacity', 04:42:23 INFO - 'tart', 04:42:23 INFO - 'tscrollx', 04:42:23 INFO - 'cart', 04:42:23 INFO - 'tsvg_static']}, 04:42:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'talos_options': ['--disable-e10s'], 04:42:23 INFO - 'tests': ['tp5o']}, 04:42:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'talos_options': ['--disable-e10s', 04:42:23 INFO - '--xperf_path', 04:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:23 INFO - 'tests': ['tp5n']}, 04:42:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:23 INFO - 'talos_options': ['--xperf_path', 04:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:23 INFO - 'tests': ['tp5n']}}, 04:42:23 INFO - 'talos.zip': {'path': '', 04:42:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:23 INFO - Running post-action listener: _resource_record_post_action 04:42:23 INFO - [mozharness: 2017-04-30 11:42:23.359911Z] Finished populate-webroot step (success) 04:42:23 INFO - [mozharness: 2017-04-30 11:42:23.360015Z] Running create-virtualenv step. 04:42:23 INFO - Running pre-action listener: _resource_record_pre_action 04:42:23 INFO - Running main action method: create_virtualenv 04:42:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:23 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 04:42:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:23 INFO - Using real prefix '/tools/python27' 04:42:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:27 INFO - Installing pip.................done. 04:42:27 INFO - Return code: 0 04:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:27 INFO - Reading from file tmpfile_stdout 04:42:27 INFO - Output received: 04:42:27 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) 04:42:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:27 INFO - 'HOME': '/Users/cltbld', 04:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:27 INFO - 'LOGNAME': 'cltbld', 04:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:27 INFO - 'MOZ_NO_REMOTE': '1', 04:42:27 INFO - 'NO_EM_RESTART': '1', 04:42:27 INFO - 'PAGER': '/bin/cat', 04:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:27 INFO - 'PWD': '/builds/slave/test', 04:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:27 INFO - 'SHELL': '/bin/bash', 04:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:27 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:27 INFO - 'USER': 'cltbld', 04:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:27 INFO - 'XPC_FLAGS': '0x0', 04:42:27 INFO - 'XPC_SERVICE_NAME': '0', 04:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:27 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 04:42:27 INFO - Cleaning up... 04:42:27 INFO - Return code: 0 04:42:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:27 INFO - 'HOME': '/Users/cltbld', 04:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:27 INFO - 'LOGNAME': 'cltbld', 04:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:27 INFO - 'MOZ_NO_REMOTE': '1', 04:42:27 INFO - 'NO_EM_RESTART': '1', 04:42:27 INFO - 'PAGER': '/bin/cat', 04:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:27 INFO - 'PWD': '/builds/slave/test', 04:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:27 INFO - 'SHELL': '/bin/bash', 04:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:27 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:27 INFO - 'USER': 'cltbld', 04:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:27 INFO - 'XPC_FLAGS': '0x0', 04:42:27 INFO - 'XPC_SERVICE_NAME': '0', 04:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 INFO - Downloading/unpacking psutil>=3.1.1 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:32 INFO - Installing collected packages: psutil 04:42:32 INFO - Running setup.py install for psutil 04:42:32 INFO - building 'psutil._psutil_osx' extension 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 INFO - building 'psutil._psutil_posix' extension 04:42:32 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 04:42:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:32 INFO - ^ 04:42:32 INFO - 1 warning generated. 04:42:32 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 04:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:32 INFO - Successfully installed psutil 04:42:32 INFO - Cleaning up... 04:42:32 INFO - Return code: 0 04:42:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:32 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')]} 04:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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')]} 04:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:32 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 04:42:32 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 04:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:32 INFO - 'HOME': '/Users/cltbld', 04:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:32 INFO - 'LOGNAME': 'cltbld', 04:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:32 INFO - 'MOZ_NO_REMOTE': '1', 04:42:32 INFO - 'NO_EM_RESTART': '1', 04:42:32 INFO - 'PAGER': '/bin/cat', 04:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:32 INFO - 'PWD': '/builds/slave/test', 04:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:32 INFO - 'SHELL': '/bin/bash', 04:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:32 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:32 INFO - 'USER': 'cltbld', 04:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:32 INFO - 'XPC_FLAGS': '0x0', 04:42:32 INFO - 'XPC_SERVICE_NAME': '0', 04:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:35 INFO - Installing collected packages: mozsystemmonitor 04:42:35 INFO - Running setup.py install for mozsystemmonitor 04:42:35 INFO - Successfully installed mozsystemmonitor 04:42:35 INFO - Cleaning up... 04:42:36 INFO - Return code: 0 04:42:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:36 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')]} 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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')]} 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:36 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 04:42:36 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 04:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:36 INFO - 'HOME': '/Users/cltbld', 04:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:36 INFO - 'LOGNAME': 'cltbld', 04:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:36 INFO - 'MOZ_NO_REMOTE': '1', 04:42:36 INFO - 'NO_EM_RESTART': '1', 04:42:36 INFO - 'PAGER': '/bin/cat', 04:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:36 INFO - 'PWD': '/builds/slave/test', 04:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:36 INFO - 'SHELL': '/bin/bash', 04:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:36 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:36 INFO - 'USER': 'cltbld', 04:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:36 INFO - 'XPC_FLAGS': '0x0', 04:42:36 INFO - 'XPC_SERVICE_NAME': '0', 04:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:39 INFO - warning: no files found matching '*.txt' 04:42:39 INFO - no previously-included directories found matching 'build' 04:42:39 INFO - no previously-included directories found matching 'dist' 04:42:39 INFO - no previously-included directories found matching '.git*' 04:42:39 INFO - Installing collected packages: jsonschema, functools32 04:42:39 INFO - Running setup.py install for functools32 04:42:39 INFO - warning: no files found matching '*.txt' 04:42:39 INFO - no previously-included directories found matching 'build' 04:42:39 INFO - no previously-included directories found matching 'dist' 04:42:39 INFO - no previously-included directories found matching '.git*' 04:42:39 INFO - Successfully installed jsonschema functools32 04:42:39 INFO - Cleaning up... 04:42:39 INFO - Return code: 0 04:42:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:39 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:39 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 04:42:39 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 04:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:39 INFO - 'HOME': '/Users/cltbld', 04:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:39 INFO - 'LOGNAME': 'cltbld', 04:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:39 INFO - 'MOZ_NO_REMOTE': '1', 04:42:39 INFO - 'NO_EM_RESTART': '1', 04:42:39 INFO - 'PAGER': '/bin/cat', 04:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:39 INFO - 'PWD': '/builds/slave/test', 04:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:39 INFO - 'SHELL': '/bin/bash', 04:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:39 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:39 INFO - 'USER': 'cltbld', 04:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:39 INFO - 'XPC_FLAGS': '0x0', 04:42:39 INFO - 'XPC_SERVICE_NAME': '0', 04:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:39 INFO - Cleaning up... 04:42:40 INFO - Return code: 0 04:42:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:40 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 04:42:40 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 04:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:40 INFO - 'HOME': '/Users/cltbld', 04:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:40 INFO - 'LOGNAME': 'cltbld', 04:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:40 INFO - 'MOZ_NO_REMOTE': '1', 04:42:40 INFO - 'NO_EM_RESTART': '1', 04:42:40 INFO - 'PAGER': '/bin/cat', 04:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:40 INFO - 'PWD': '/builds/slave/test', 04:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:40 INFO - 'SHELL': '/bin/bash', 04:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:40 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:40 INFO - 'USER': 'cltbld', 04:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:40 INFO - 'XPC_FLAGS': '0x0', 04:42:40 INFO - 'XPC_SERVICE_NAME': '0', 04:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:42 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 04:42:42 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 04:42:42 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 04:42:42 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 04:42:42 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 04:42:42 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 04:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:44 INFO - Downloading docopt-0.6.1.tar.gz 04:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:44 INFO - Running setup.py install for blobuploader 04:42:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:44 INFO - Running setup.py install for requests 04:42:44 INFO - Running setup.py install for docopt 04:42:44 INFO - Successfully installed blobuploader requests docopt 04:42:44 INFO - Cleaning up... 04:42:45 INFO - Return code: 0 04:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:45 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 04:42:45 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 04:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:45 INFO - 'HOME': '/Users/cltbld', 04:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:45 INFO - 'LOGNAME': 'cltbld', 04:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:45 INFO - 'MOZ_NO_REMOTE': '1', 04:42:45 INFO - 'NO_EM_RESTART': '1', 04:42:45 INFO - 'PAGER': '/bin/cat', 04:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:45 INFO - 'PWD': '/builds/slave/test', 04:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:45 INFO - 'SHELL': '/bin/bash', 04:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:45 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:45 INFO - 'USER': 'cltbld', 04:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:45 INFO - 'XPC_FLAGS': '0x0', 04:42:45 INFO - 'XPC_SERVICE_NAME': '0', 04:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-8rsaEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-kRJtG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-hPqwcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-WjvXzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-BN99cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-moHsmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:45 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-3WG3_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wpY_0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-zrGz0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-c_itsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-KR4msR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-bphKfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-blU0mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Mz0V9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-1AesSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-8z8vSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-I4fio6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:47 INFO - Running setup.py install for manifestparser 04:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozcrash 04:42:47 INFO - Running setup.py install for mozdebug 04:42:47 INFO - Running setup.py install for mozdevice 04:42:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozfile 04:42:47 INFO - Running setup.py install for mozhttpd 04:42:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozinfo 04:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozInstall 04:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozleak 04:42:48 INFO - Running setup.py install for mozlog 04:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for moznetwork 04:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozprocess 04:42:48 INFO - Running setup.py install for mozprofile 04:42:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Running setup.py install for mozrunner 04:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Running setup.py install for mozscreenshot 04:42:49 INFO - Running setup.py install for moztest 04:42:49 INFO - Running setup.py install for mozversion 04:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:49 INFO - Cleaning up... 04:42:49 INFO - Return code: 0 04:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:49 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:49 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 04:42:49 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 04:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:49 INFO - 'HOME': '/Users/cltbld', 04:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:49 INFO - 'LOGNAME': 'cltbld', 04:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:49 INFO - 'MOZ_NO_REMOTE': '1', 04:42:49 INFO - 'NO_EM_RESTART': '1', 04:42:49 INFO - 'PAGER': '/bin/cat', 04:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:49 INFO - 'PWD': '/builds/slave/test', 04:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:49 INFO - 'SHELL': '/bin/bash', 04:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:49 INFO - 'USER': 'cltbld', 04:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:49 INFO - 'XPC_FLAGS': '0x0', 04:42:49 INFO - 'XPC_SERVICE_NAME': '0', 04:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CC7QEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-KX31Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-HP0CQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-bT7BGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-S7cpQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-6x9tBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Q8mrTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-2YsPGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-uFu6aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-39XU9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:50 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)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-d60Xdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:51 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-fy3xwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-5INE2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:51 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Na31Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:51 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Mq7uPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:51 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-g0ebcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:51 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)) 04:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-KDzT5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:51 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)) 04:42:51 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)) 04:42:51 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)) 04:42:51 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)) 04:42:51 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:51 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:51 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 04:42:51 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 04:42:51 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 04:42:51 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 04:42:51 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 04:42:51 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 04:42:54 INFO - Downloading blessings-1.6.tar.gz 04:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:54 INFO - Installing collected packages: blessings 04:42:54 INFO - Running setup.py install for blessings 04:42:54 INFO - Successfully installed blessings 04:42:54 INFO - Cleaning up... 04:42:54 INFO - Return code: 0 04:42:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:55 INFO - Reading from file tmpfile_stdout 04:42:55 INFO - Current package versions: 04:42:55 INFO - blessings == 1.6 04:42:55 INFO - blobuploader == 1.2.4 04:42:55 INFO - docopt == 0.6.1 04:42:55 INFO - functools32 == 3.2.3-2 04:42:55 INFO - jsonschema == 2.5.1 04:42:55 INFO - manifestparser == 1.1 04:42:55 INFO - mozInstall == 1.12 04:42:55 INFO - mozcrash == 1.0 04:42:55 INFO - mozdebug == 0.1 04:42:55 INFO - mozdevice == 0.50 04:42:55 INFO - mozfile == 1.2 04:42:55 INFO - mozhttpd == 0.7 04:42:55 INFO - mozinfo == 0.9 04:42:55 INFO - mozleak == 0.1 04:42:55 INFO - mozlog == 3.4 04:42:55 INFO - moznetwork == 0.27 04:42:55 INFO - mozprocess == 0.25 04:42:55 INFO - mozprofile == 0.28 04:42:55 INFO - mozrunner == 6.13 04:42:55 INFO - mozscreenshot == 0.1 04:42:55 INFO - mozsystemmonitor == 0.3 04:42:55 INFO - moztest == 0.8 04:42:55 INFO - mozversion == 1.4 04:42:55 INFO - psutil == 3.1.1 04:42:55 INFO - requests == 1.2.3 04:42:55 INFO - wsgiref == 0.1.2 04:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:55 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')]} 04:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 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')]} 04:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:55 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 04:42:55 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 04:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:55 INFO - 'HOME': '/Users/cltbld', 04:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:55 INFO - 'LOGNAME': 'cltbld', 04:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:55 INFO - 'MOZ_NO_REMOTE': '1', 04:42:55 INFO - 'NO_EM_RESTART': '1', 04:42:55 INFO - 'PAGER': '/bin/cat', 04:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:55 INFO - 'PWD': '/builds/slave/test', 04:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:55 INFO - 'SHELL': '/bin/bash', 04:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:55 INFO - 'USER': 'cltbld', 04:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:55 INFO - 'XPC_FLAGS': '0x0', 04:42:55 INFO - 'XPC_SERVICE_NAME': '0', 04:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 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)) 04:42:55 INFO - Cleaning up... 04:42:55 INFO - Return code: 0 04:42:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:55 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')]} 04:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 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')]} 04:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 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 0x10d026b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d029768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb62d953e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, '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.3LMhEl44BT/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.podvDKlKn6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 04:42:55 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 04:42:55 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 04:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:55 INFO - 'HOME': '/Users/cltbld', 04:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:55 INFO - 'LOGNAME': 'cltbld', 04:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:55 INFO - 'MOZ_NO_REMOTE': '1', 04:42:55 INFO - 'NO_EM_RESTART': '1', 04:42:55 INFO - 'PAGER': '/bin/cat', 04:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:55 INFO - 'PWD': '/builds/slave/test', 04:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:55 INFO - 'SHELL': '/bin/bash', 04:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:42:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:55 INFO - 'USER': 'cltbld', 04:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:55 INFO - 'XPC_FLAGS': '0x0', 04:42:55 INFO - 'XPC_SERVICE_NAME': '0', 04:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:55 INFO - Cleaning up... 04:42:55 INFO - Return code: 0 04:42:55 INFO - Running post-action listener: _resource_record_post_action 04:42:55 INFO - Running post-action listener: _start_resource_monitoring 04:42:55 INFO - Starting resource monitoring. 04:42:55 INFO - [mozharness: 2017-04-30 11:42:55.592161Z] Finished create-virtualenv step (success) 04:42:55 INFO - [mozharness: 2017-04-30 11:42:55.593119Z] Running install step. 04:42:55 INFO - Running pre-action listener: _resource_record_pre_action 04:42:55 INFO - Running main action method: install 04:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:55 INFO - Reading from file tmpfile_stdout 04:42:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:55 INFO - Reading from file tmpfile_stdout 04:42:55 INFO - Output received: 04:42:55 INFO - Usage: mozinstall [options] installer 04:42:55 INFO - Options: 04:42:55 INFO - -h, --help show this help message and exit 04:42:55 INFO - -d DEST, --destination=DEST 04:42:55 INFO - Directory to install application into. [default: 04:42:55 INFO - "/builds/slave/test"] 04:42:55 INFO - --app=APP Application being installed. [default: firefox] 04:42:55 INFO - mkdir: /builds/slave/test/build/application 04:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:15 INFO - Reading from file tmpfile_stdout 04:43:15 INFO - Output received: 04:43:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:15 INFO - Running post-action listener: _resource_record_post_action 04:43:15 INFO - [mozharness: 2017-04-30 11:43:15.739046Z] Finished install step (success) 04:43:15 INFO - [mozharness: 2017-04-30 11:43:15.739204Z] Running run-tests step. 04:43:15 INFO - Running pre-action listener: _resource_record_pre_action 04:43:15 INFO - Running main action method: run_tests 04:43:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:15 INFO - 2017-04-30 04:43:15.754 screenresolution[2778:44969] starting screenresolution argv=screenresolution get 04:43:15 INFO - 2017-04-30 04:43:15.757 screenresolution[2778:44969] Display 0: 1600x1200x32@60 04:43:15 INFO - 2017-04-30 04:43:15.763 screenresolution[2779:44972] starting screenresolution argv=screenresolution list 04:43:15 INFO - Available Modes on Display 0 04:43:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:15 INFO - Intel Iris: 04:43:15 INFO - Chipset Model: Intel Iris 04:43:15 INFO - Type: GPU 04:43:15 INFO - Bus: Built-In 04:43:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:15 INFO - Vendor: Intel (0x8086) 04:43:15 INFO - Device ID: 0x0a2e 04:43:15 INFO - Revision ID: 0x0009 04:43:15 INFO - Displays: 04:43:15 INFO - Display: 04:43:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:15 INFO - Display Serial Number: 1600x1200 60 04:43:15 INFO - Main Display: Yes 04:43:15 INFO - Mirror: Off 04:43:15 INFO - Online: Yes 04:43:15 INFO - Rotation: Supported 04:43:15 INFO - Return code: 0 04:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:16 INFO - Python 2.7.3 04:43:16 INFO - Return code: 0 04:43:16 INFO - grabbing minidump binary from tooltool 04:43: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')]} 04:43:16 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 0x10ce04d30>, '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 0x10cd2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:16 INFO - Return code: 0 04:43:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:16 INFO - ENV: RUST_BACKTRACE is now 1 04:43:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 04:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --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 04:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3LMhEl44BT/Render', 04:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:16 INFO - 'HOME': '/Users/cltbld', 04:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:16 INFO - 'LOGNAME': 'cltbld', 04:43:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:16 INFO - 'MOZ_NO_REMOTE': '1', 04:43:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:16 INFO - 'NO_EM_RESTART': '1', 04:43:16 INFO - 'PAGER': '/bin/cat', 04:43:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:16 INFO - 'PWD': '/builds/slave/test', 04:43:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:16 INFO - 'RUST_BACKTRACE': '1', 04:43:16 INFO - 'SHELL': '/bin/bash', 04:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.podvDKlKn6/Listeners', 04:43:16 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 04:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:16 INFO - 'USER': 'cltbld', 04:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:16 INFO - 'XPC_FLAGS': '0x0', 04:43:16 INFO - 'XPC_SERVICE_NAME': '0', 04:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 04:43:16 INFO - mozversion application_buildid: 20170430030208 04:43:16 INFO - mozversion application_changeset: 2fe636103d7167f3a5d57f61bd19fddcc878ca3c 04:43:16 INFO - mozversion application_display_name: Nightly 04:43:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:16 INFO - mozversion application_name: Firefox 04:43:16 INFO - mozversion application_remotingname: firefox 04:43:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:16 INFO - mozversion application_vendor: Mozilla 04:43:16 INFO - mozversion application_version: 55.0a1 04:43:16 INFO - mozversion platform_buildid: 20170430030208 04:43:16 INFO - mozversion platform_changeset: 2fe636103d7167f3a5d57f61bd19fddcc878ca3c 04:43:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:16 INFO - mozversion platform_version: 55.0a1 04:43:16 INFO - using testdate: 1493552596 04:43:16 INFO - actual date: 1493552596 04:43:16 INFO - starting webserver on 'localhost:61102' 04:43:16 INFO - SUITE-START | Running 2 tests 04:43:16 INFO - TEST-START | dromaeo_css 04:43:16 INFO - operating with platform_type : mac_ 04:43:16 INFO - Initialising browser for dromaeo_css test... 04:43:16 INFO - TEST-INFO | started process 2789 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpn8SIYn/profile http://localhost:61102/getInfo.html) 04:43:19 INFO - PID 2789 | __metrics Screen width/height:1600/1200 04:43:19 INFO - PID 2789 | colorDepth:24 04:43:19 INFO - PID 2789 | Browser inner width/height: 1024/689 04:43:19 INFO - PID 2789 | __metrics 04:43:19 INFO - PID 2789 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:43:19 INFO - PID 2789 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:20 INFO - TEST-INFO | 2789: exit 0 04:43:20 INFO - Browser initialized. 04:43:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:20 INFO - TEST-INFO | started process 2792 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpn8SIYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:32 INFO - PID 2792 | RSS: Main: 241852416 04:43:32 INFO - PID 2792 | 04:46:38 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61102/tests/dromaeo/cssquery-ext.html) 04:46:39 INFO - PID 2792 | RSS: Main: 419049472 04:46:39 INFO - PID 2792 | 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | A coding exception was thrown and uncaught in a Task. 04:48:22 INFO - PID 2792 | 04:48:22 ERROR - PID 2792 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:22 INFO - PID 2792 | Full stack: 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | A coding exception was thrown and uncaught in a Task. 04:48:22 INFO - PID 2792 | 04:48:22 ERROR - PID 2792 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:22 INFO - PID 2792 | Full stack: 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | A coding exception was thrown and uncaught in a Task. 04:48:22 INFO - PID 2792 | 04:48:22 ERROR - PID 2792 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:22 INFO - PID 2792 | Full stack: 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | ************************* 04:48:22 INFO - PID 2792 | A coding exception was thrown and uncaught in a Task. 04:48:22 INFO - PID 2792 | 04:48:22 ERROR - PID 2792 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:22 INFO - PID 2792 | Full stack: 04:48:22 INFO - PID 2792 | ************************* 04:49:42 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-ext.html (next: http://localhost:61102/tests/dromaeo/cssquery-jquery.html) 04:49:43 INFO - PID 2792 | RSS: Main: 369733632 04:49:43 INFO - PID 2792 | 04:52:45 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61102/tests/dromaeo/cssquery-mootools.html) 04:52:46 INFO - PID 2792 | RSS: Main: 325271552 04:52:46 INFO - PID 2792 | 04:55:48 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61102/tests/dromaeo/cssquery-prototype.html) 04:55:48 INFO - PID 2792 | RSS: Main: 358473728 04:55:48 INFO - PID 2792 | 04:58:52 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61102/tests/dromaeo/cssquery-yui.html) 04:58:53 INFO - PID 2792 | RSS: Main: 328421376 04:58:53 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | Cycle 1(1): loaded http://localhost:61102/tests/dromaeo/cssquery-yui.html (next: http://localhost:61102/tests/dromaeo/cssquery-dojo.html) 05:01:55 INFO - PID 2792 | RSS: Main: 375996416 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | __start_tp_report 05:01:55 INFO - PID 2792 | _x_x_mozilla_page_load 05:01:55 INFO - PID 2792 | _x_x_mozilla_page_load_details 05:01:55 INFO - PID 2792 | |i|pagename|runs| 05:01:55 INFO - PID 2792 | |0;dojo.html;3318.917027074323;3491.5810102787655;3511.3328467591173;3515.0860776198188;3561.7684850484716;5927.673977931212;6102.908456373147;6166.475849552788;6209.099680546324;6209.223847019122;6032.819015429544;6060.969695151529;6070.301915279744;6071;6097.085437184435;5199.194124910626;5239.52844244018;5252.527272545489;5261.552768014704;5364.5708343332635;5366.4633536646415;5367.543758780508;5380.569554435655;5381;5384.892302153974;5360.222767698681;5369.463053694639;5371.489708477708;5375;5417.26866872973;5398.46015398459;5423.186522021689;5447.782088716446;5463.48096930791;5496.780128794843;5315.042874480262;5368.489993450616;5372.892542149174;5386.8383948481605;5401.27082843815;5888.4700376966275;6151.169592105053;6171.413715697046;6238.781642642486;6264.561480696353;5855.531557475391;6297.905531416986;6333;6357.046443033536;6491.350864913518;6619.271880093186;6640.302768209317;6642.368974947421;6666.866662666768;6677.332266773284;6286.308506064329;6293.339199384044;6297.0554416837385;6297.6536290504;6315.210598675166;6485.416312531895;6563.442107420923;6634.734610615521;6731.562448440835;6737.52837301394;6274.749010039547;6398.712057957403;6399.840003999844;6432.839179020562;6433.453156481658;6562.212534495891;6568.113304703899;6568.737250510022;6574;6586.934130658728;5884.529237660977;6362.395572420613;6421.871562568723;6449.774257900951;6458.483321334282;6337.714802833883;6403.583767055126;6428.935710642833;6454.160959075384;6471.611703297817;5197.610179236573;5215.869603259949;5216.713080780518;5232;5240.9213861792105;4627.167109920247;4675.462321832964;4689.062187562433;4697.506761790031;4716.716996980193;6045.486133678686;6113.32753397126;6125.84685382869;6134.601250918676;6158.107074474176;6456.257530383972;6472.838179045561;6479.125318081999;6489.221293444817;6647.800565983028;6127.708789264043;6175.073738939195;6202.844928876814;6213.813585592439;6229.657368844757;5774.48029677331;5774.538036957033;5776.768929242783;5778.104393818965;5799.4780469757925;6497.220333560003;6593;6750.122484077038;6792.558483698544;6800.31996800316;6554.4756419487285;6594.967025164843;6612.437942774918;6670.433013193933;6672.266050734513;6714.462842972648;6721.630310332978;6794.04883316346;6795.218549866829;6802.591844489347;5382.407935127055;6284.3087260402235;6469.256035555972;6484.708188131451;6497.935020649733;6451.3226111257645;6451.387118223761;6527.445167160845;6527.869442611216;6578.342165783383;6253.249610046823;6337.96831015842;6352.301246862934;6365.395287447685;6422.325655806073;6286.402791734778;6293;6336.271328797247;6338.841528961812;6343.080253363144;6283.8114856554375;6311.27420346666;6313.179286692701;6315.084312774714;6340.302566717565;6260.342664020212;6336.778212762531;6341.55609107358;6365.267994180544;6414.486841052611;6265.091561723433;6276.435120839146;6280.466160376419;6293.622382657055;6293.779717709858 05:01:55 INFO - PID 2792 | |1;ext.html;747.2079595628634;788.7712563356625;804.4690504267184;1116.8715597706262;1128.542940109255;26687.199384018488;37163;37166.442503362436;37258.695945641906;37269;39019;39195.60804391962;39230;39258.411123833095;39312.606873931254;5966.224390829186;6054.061620448838;7150.284971502861;8307.999999999985;8445.662173513052;7572.204918483562;8525.488470691747;8529.658813647447;8561.700340488083;8569.785755356104;8409.663613455485;8489.066202717697;8491.40560160789;8520.8721869172;8544.145585441469;7167.24743901888;8401.495910245374;8433.19884610961;8434;8450.577471126418;8307.46001509906;8357.414980951336;8363.954505686788;8367.916320836775;8395.454295470836;36887.63112368869;36895.815520922224;37056.444153337725;37121;37156.44265336022;3517.1734642359024;3550;3551.1122219445137;3552.289542091592;3554.431290993429;30210.54684179739;30300.787968481454;30339.848300758356;30365.69634303673;30420.935267265762;3103.7672174586996;3161.3993341265086;3189.027346659268;3193.0101668482844;3205.0705295464522;276599;277101;278078.6096069527;279310;281918;48035.519644803804;48118.27822582664;48189.75905120522;48230.27654585184;48317;49656.0068798622;49764.502354976714;49849;49912.50087499079;50034.49965500371;13811.447542098203;13893.4442622296;13910.652233694238;13922.303884805922;13940.302984850718;9774.706758797247;9820.201242645811;11379.975802177843;11389.974902258837;11399.088072954144;10513.001264879977;12088.395580220953;12143;12159.027277817753;12374.938125309316;4466.798994045275;5460.863478413072;5462.9726851365485;5510.862228444241;5525.917111243334;758.5031804168168;887.933404994628;921.1709461484584;938.7606160429046;952.842780941137;19798.90100549517;21020.894895525424;23397.649035264483;23594.34839561214;23874.52250954971;1017.9898201018043;1029.330934892311;1041.5261056219401;1057.006413970865;1059.9364038157735;11739.706507337214;11750.177487575958;11790.292582445081;11820.94089529564;11842.88157118435;310266;312221;312286;312524;313085;53139.93720125576;53278;53310.46689533132;53341.1998820018;53387;1290.5999140266547;1337.1041402260703;1343.0531475309883;1346.3335648853881;1356.6269275949194;21794.673079904132;22702.772972270064;22746.43133921665;23247.953842076808;23520.882395587912;34983.65016349804;35043.64956350506;35075.47386789251;35085.47371789476;35116.64883351134;291876;292274;292670;292778;293620;29633.851830740707;32876.67123328736;33760.324793504486;33816.83091584526;33984.66015339815;37459.43810842894;37495.062623434635;37533.2493350126;37597.62402376051;37646.81176594209;25431.237062888144;29189.416211675223;30002.699973000865;30101;31108.533371998987;30832.075037748902;31451.056468305986;31487.52768708517;31507;31644.367112658078;30656.846715766278;35712.464313035845;36548.26903461863;37225.25549488941;37477.43783843299;29888.85055574708;30188.396232075676;30905;31045.223869403446;31480.05559833209;21679.163103358595;22003.22988695388;23082.307530774102;24345.26964191077;24498 05:01:55 INFO - PID 2792 | |2;jquery.html;358.397891542209;371.5225934673944;373.0656545809977;416.1988172767422;443.34163766806284;12945.870541294584;21112.89443552782;21880;21939.232126875562;22029.118835246572;18177.90911045446;22108.557828843455;22732.88633556834;23776.5244695106;23983.40041498959;5952.7321270542825;6217.222847144107;6219.813405597817;6221.844453888666;6223.035429508411;4734.763261836912;5988.6226167981395;6101.2983506896835;6139.508839292868;6223.533235007392;6188.721507532172;6193.566450348478;6194.256689197303;6194.535409844257;6201.81394558164;5945.702714864261;6083.209182806229;6084.330723620398;6114.877702445926;6134.846628834271;5245.659032162897;5427.6200665953;5457.781688732446;5458.863528411822;5459.808906688247;26661;27123.86438067797;27160.32099197516;27414.725852741416;27468.725312746818;2188.518525924294;2252.279270633398;2268.875211863347;2295.7130358705163;2295.8163346932206;17757.467275981613;17822.732659010126;18027.909860450745;18146;18199.818001819945;2150.236665983569;2252.8986195621073;2283.8515496492673;2343.0510643189536;2396.9520609587885;161093;161247.284983147;161965;163966.1801690984;164725;18396.908015459838;23791.286261412184;23792.26751305798;23835.404114897265;24216.03135874545;29879.253018674273;34593;40820;40837.591624083376;40869.591304087175;9364.531773411301;9954.651587194558;10594.31136976094;10649.733756656145;11016.283941543934;8620.827583448296;8651.870221946676;8676.392652514389;8816.691415800417;8849;9233.568796836502;11060.723481912855;11078.889211107948;11153.163512736577;11290.266132701348;3606.855725770992;4247.469066366704;4302.419173411549;4342.305231162999;4358.3244597087505;842.9789255268668;848.4485084694998;848.8854004709285;856.738694698123;894.874717539545;15815.683686326209;19365.4190374289;19907.800921990885;20118.798812011693;20216.29242976518;770.9267619576132;889.2974550105345;891.595736714677;925.9953700231456;927.3276874266238;9613.230941524662;9681.757956051015;9850.901490985141;10166.745831354276;10245.692629221136;535968;540559;542329;551057;552389;117241.4137929322;118785.40607296908;119028;119153;120115.39942300232;1148.2995372822572;1154.6189757380043;1182.976340473203;1195.653260554447;1198.6284251881943;13076.869231307564;16064.43774467888;17327.393541225996;17567.68233889376;17761.822381776015;39985.60014399935;55232.44767552434;56385.15422268587;56443.71778141083;58424.70787646034;75214.62392688001;76333.61833190799;76560;76979;77128.61435692785;8581.65673373058;8662;8872.911270887209;9167.991520932559;12103.455344509694;13546.932265339005;13728.794068089186;13802.930985345009;13969.790453143009;14044.438222471395;11703.707407314885;11774.470148843151;11925.880741192477;12071.456784444545;12179.208351457128;9709;10176.135028522362;11030.779384412428;11175.888241117485;11359.148063895076;11718.121140914294;11892.405379731152;12238.326892021025;12279;12313.26120432777;8081.4747041442115;8610.397272190887;8700.738977830675;8718;8909.420887642282;11449.255798373079;11718.355490447766;11972.700682483008;12052.638420847388;12153.331566763913 05:01:55 INFO - PID 2792 | |3;mootools.html;1285.2160182288796;1410.6261840612237;1421.9239909731791;1446.746819306621;1468.2658670664664;11046.889531104687;11554.768904621902;11576;11576.189666723332;11583.53665853366;10821.621243256488;11397.601083962063;11430.657080287605;11450.141239407058;11453.656390308282;2474.0474917156935;2510.698716154064;2514.7485251474795;2518.987405062972;2520.117958714454;2105.5578328551023;2359.127122964497;2505.912293069743;2511.7739403453684;2520.332111990315;2156.331537223458;2179.2699445685716;2453.251758213744;2524.116559204273;2529.127451029392;2463.7782599566126;2492.264781889338;2498.7376325485743;2500.9374765630823;2503.311589312935;2478.31846242283;2478.9380265493505;2482.677251957252;2485.701715794098;2489.191012920808;11257.380844053574;11494.885051149466;11519;11520.251183673034;11532.82700759481;6532.510061745388;6797.898031529531;6802.863942721118;6803.251642319341;6809.114815074058;3857.5756666766633;4085.7344272622186;4311.116221174651;4312.633426158749;4319.568043195687;1235.0860363331071;1237.55448038706;1267.3156495492424;1268.3404629592653;1286.6075846866702;16379.0172589645;16444.75332869996;16521.421750238685;16529;16540.75188872168;5220;5297.9404119176315;5429.701366424805;5508.669479831223;5529.198266251451;9689.467079310705;11686.649400517828;11694;11705.648830535098;11718.414079296172;6509.837254068686;6512.641804700692;6513.674316284167;6516;6517.120188774455;5991.281046274475;6128.969355153285;6220.098085777537;6220.346863579259;6261.373862613702;4194.140201258735;4331.263685173528;4335.696501244883;4371.956280437218;4396.340548917624;1256.3969294738577;1257.8176164456102;1263.564070395712;1272.9872701273055;1282.2753396681449;554.9028919938994;649.6849028221309;688.6625553478759;763.1452772894394;782.6595430987538;6561.622059367586;6780.559263647847;6867.965660171667;6955.617441040791;7077.292270772881;882.6204731965188;888.5512816027865;889.1242126505387;911.2118017914456;924.8705181274627;3493.283876805249;3970.404439334123;3999.3601023836045;4014.498187726534;4197.811098500575;12443;14007.649808754863;14639.707205856037;15178.089314641156;15236.771448428282;15067;15117.924410377878;15125.39498420051;15128.470503532544;15141.167235802137;7881.935938648324;8144.959275203586;8145.470544414594;8344.415890887702;8372.41393102477;6328.968355158379;6347.0479428086155;6421.678916054272;6470.838229044311;6523.934760652332;13099.345032748515;13439.059265851296;13517.188968661912;13520.18878867271;13640.908727301594;13328.666783330107;13652.726945460836;13809.171449713049;13845.930770346084;13863.79204311916;8957.328200385127;9052.004279529378;9177.816443671223;9263.675771347971;9283.860742088738;10196.286259961731;10366.222533309881;10397.740056498647;10405.375677459377;10405.531751071372;8735.99536053362;8839.558022098741;8878.911210887809;8888.111188881061;9102.226310763659;8331.583420829056;8641.913580864362;8647;8711.651533938824;8736.606852691772;7912.248336408032;7912.881306780518;7967.800804979922;7986.560739159402;8012.919870801451;5040.521150490697;5729.799457018984;5860.472557469678;5907.881842363215;5977.372375900468;5066.797328106834;5784.913226301693;5801.100829371454;5927.377625349449;6159.137720719193 05:01:55 INFO - PID 2792 | |4;prototype.html;356.835855506467;370.44063464169096;383.8176865988654;387.52528153012565;397.2551466001247;4498.50516443191;4622.815087396509;5505.504504594585;5699.800506982246;5779.422057794219;5507.511378226743;5535.837474130427;5572.247746554214;5644.350899646542;5662.37713851477;3811.028187812104;4329.458817647794;4382.189294980439;4388.692791504596;4418.690691651585;3618.2220822523154;3855.4409610606444;4037.798110094498;4376.759278239696;4415.82336706533;4344.522102568715;4358.150160718661;4361.60745532902;4380.780960951955;4386.9561304387025;4335.1329734053315;4335.5014173370155;4358.476982762073;4387.3857659927635;4398.472183337988;3363.9495407568907;3731.1418373774186;3834.2585051688175;3880.8835734927998;3927.9410808837893;5124.666896651705;5484.424135465799;5511.669299841982;5565.805196818133;5596.300462442195;5049.697018178921;5217.295665085241;5224.223763920248;5248.160294352923;5254.97683391893;5629.620742918011;5949.9107513387335;6010.230179028138;6077.696115194267;6078.45293923549;3560;4004.3192657248337;4023.994001499625;4043.3934909763475;4052.6150015748754;6290.370118743745;6347.746090156388;6370.095026829315;6402.6158430494315;6422.775202867877;3678.3378991781738;4055.9391609125887;4074.796260186979;4075.3275709507598;4101.26177288085;4157.97921010393;4160.313548264502;4171.958280417157;4175.68682348825;4177.770222637723;4825.721183886273;4827.758612069382;4865.878353041131;4876.780544875489;4889;5775.913361299584;5949.929012777741;6007.8197654070445;6042.305134909541;6080.604760690541;1264.5447638850007;1318.5319211679716;1364.311022933432;1368.5825823123844;1369.897257705676;741.4772585327331;839.3662784597711;873.24028095556;877.4209022045419;903.4850135422878;5153.974230128825;5248.711320877388;5642.4075472075665;5644.209810626516;5647.491725744702;5484.7531861066345;5645.040343141676;5986.43220301297;6214.502839772807;6219.8230619283795;4964.304997300309;5624.62196761796;5626.971865140648;5628.71856407178;5639.746211420496;2759.0548663192403;2992.506236470958;3189.2505261263586;3240.4329242382487;3252;6300.21247344082;6347;6358.872822543523;6359.523035772336;6380.585261957958;6279.874402511924;6298.811035668938;6303.338149494237;6315.179026726496;6328.430441260309;6070.939290607037;6255.6872156392;6320.273168585672;6348.1430006949395;6379.776707815204;6142.846428839315;6168.25980882297;6179.134921111138;6181.783637572664;6220.573976149396;5816.534677225727;5891.764329426775;6019.759209631741;6043.75824967014;6067.726952287246;6290.937090629035;6298.401651843067;6325.209348831396;6338.683065846597;6348.587341822767;3405.4721518164724;3760.3983362661843;3801.4340320283145;4040.9797951010055;4059.512858457004;5800.9419905800405;5892.440218179266;6229.106808244847;6259.561830671809;6303.810885673437;4905.558499735041;5558.888822223614;5841.883162336644;6005.19844046793;6061.909071363845;4558.2934645128735;5662.7734890603915;5775.624584402169;6086.239220097488;6127.111568822585;4422.71252368595;5090.363704536933;5622.634528755618;5639.379668236573;5929.822105336847;5201.297824793604;5255.78976840922;5739.966805974965;5898.380670029585;6116.633002019893;4893.951060489492;5126.871828204325;5975.671338076448;5986.371430999857;6013.368596297326 05:01:55 INFO - PID 2792 | |5;yui.html;699.5592776550773;841.6633346661334;844.3287586368837;849.7875531117216;861.117354711421;11790.64407593127;16086.919565402171;18676.53308667284;18685.4394368169;18702.90648546759;16647.417340393087;16806.495805125865;16806.57983550409;16809.747853782203;17141.228644710987;628.7547856336032;923.9907600923972;937.6624415210518;941.6186444489975;963.6193703487119;971.3297824501107;972.6401231544303;973.2068364283122;973.8880028796673;980.0248752491282;998.990010099897;1002.5187909803299;1002.997002997003;1005.4872015272227;1040.9746399796195;997.1125698128672;1000.0149852395384;1000.559753708366;1000.8348622477282;1038.9688309350731;736.0835759479429;737.72704099483;738.0737174845588;745.5303159009843;769.97690069298;14234.786478202835;14292.785608215885;14575.781363279559;16800.915995420066;17118.48644540666;13860;16716.41492547755;17006.659866802594;17096.57258568533;17128.314867405414;11235.719107022309;13741.106828056145;13923.651908702263;14072;14264.78602820948;3337.2491189482416;3347.3472672828807;3366.2425954160362;3367.175042114673;3373.983130084334;128193;128357;128577.99999999907;129522;131168.6883131166;10800.567977280822;11174.720631984266;11876;11891.16761826681;11927.701807454883;18983.62032759337;19041.904790476237;19363.32228372;19953.60092798165;24920.750792492207;6743.98840173968;7301.634918254066;7636.618169091635;7639.197884222188;7642.3504002159325;3330.633630300665;3403.7447191460737;3417.6411476795074;3422.281320922584;3741.962580374216;3642;3713.1274150574595;3724.8882533523497;3730.515033045741;3740.925181496355;841.7138173021202;877.2543338162511;878.1920633017639;878.5782824244399;882.7219425880827;575.3297408519029;648.2674577727232;652.9379708927644;656.8029591122644;692.1486571516962;10801.83797243042;10925.289856159483;11264.267822591506;11613.187076904704;11792.469338879771;639.1180171363488;639.7025383196835;644.3009334871623;645.4287955159717;676.6210921883761;4967.772833396478;5352.518273355417;5469.835904922858;5615.691136987423;5670.971645141748;105304.47347763213;106744.46627766966;106852;109096;109518;86179.56910215534;87481;87902;88135.55932220299;88797;79165.20834791694;79674.60162699265;80467.59766201132;80497.59751201207;83530.16469835346;10779.51492182838;12106.878931210575;12723.300218488072;12888.935555322163;12987.610371688865;40151.79544613666;40351.192976139726;40422.393664094474;40907;40945.38581921214;43568.782156089015;48940.510594893596;49163;49179.754101229264;49237;15657.217139143226;15994.920025399799;16124;16214.756778648565;16485.258163382437;17820.643587128445;17825.376111836023;18009.369672061413;18157.636847263246;18195.727064094313;16388.344466221217;16561.751573726164;16880.831191687925;16901.91549042247;17010.574735631708;15821.525354239391;15861.206939653202;16471.505854824376;16633.750493742846;16690;15834.92082539626;15849.920750396173;16051.839481605035;16225.756613650568;16231.918840405722;10138.732658417697;11709.414529273672;11768.411579421167;11956.222845515014;12138.939305303416;12896.548620798227;12959.676008099874;12992.610221693365;12997.740045199233;13184.077114601885 05:01:55 INFO - PID 2792 | __end_tp_report 05:01:55 INFO - PID 2792 | __start_cc_report 05:01:55 INFO - PID 2792 | _x_x_mozilla_cycle_collect,1829 05:01:55 INFO - PID 2792 | __end_cc_report 05:01:55 INFO - PID 2792 | __startTimestamp1493553715954__endTimestamp 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | ------- Summary: start ------- 05:01:55 INFO - PID 2792 | Number of tests: 6 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#0] dojo.html Cycles:165 Average:6033.01 Median:6286.40 stddev:686.38 (10.9%) stddev-sans-first:654.63 05:01:55 INFO - PID 2792 | Values: 3318.9 3491.6 3511.3 3515.1 3561.8 5927.7 6102.9 6166.5 6209.1 6209.2 6032.8 6061.0 6070.3 6071.0 6097.1 5199.2 5239.5 5252.5 5261.6 5364.6 5366.5 5367.5 5380.6 5381.0 5384.9 5360.2 5369.5 5371.5 5375.0 5417.3 5398.5 5423.2 5447.8 5463.5 5496.8 5315.0 5368.5 5372.9 5386.8 5401.3 5888.5 6151.2 6171.4 6238.8 6264.6 5855.5 6297.9 6333.0 6357.0 6491.4 6619.3 6640.3 6642.4 6666.9 6677.3 6286.3 6293.3 6297.1 6297.7 6315.2 6485.4 6563.4 6634.7 6731.6 6737.5 6274.7 6398.7 6399.8 6432.8 6433.5 6562.2 6568.1 6568.7 6574.0 6586.9 5884.5 6362.4 6421.9 6449.8 6458.5 6337.7 6403.6 6428.9 6454.2 6471.6 5197.6 5215.9 5216.7 5232.0 5240.9 4627.2 4675.5 4689.1 4697.5 4716.7 6045.5 6113.3 6125.8 6134.6 6158.1 6456.3 6472.8 6479.1 6489.2 6647.8 6127.7 6175.1 6202.8 6213.8 6229.7 5774.5 5774.5 5776.8 5778.1 5799.5 6497.2 6593.0 6750.1 6792.6 6800.3 6554.5 6595.0 6612.4 6670.4 6672.3 6714.5 6721.6 6794.0 6795.2 6802.6 5382.4 6284.3 6469.3 6484.7 6497.9 6451.3 6451.4 6527.4 6527.9 6578.3 6253.2 6338.0 6352.3 6365.4 6422.3 6286.4 6293.0 6336.3 6338.8 6343.1 6283.8 6311.3 6313.2 6315.1 6340.3 6260.3 6336.8 6341.6 6365.3 6414.5 6265.1 6276.4 6280.5 6293.6 6293.8 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#1] ext.html Cycles:180 Average:43938.86 Median:33900.75 stddev:77347.75 (228.2%) stddev-sans-first:77496.75 05:01:55 INFO - PID 2792 | Values: 747.2 788.8 804.5 1116.9 1128.5 26687.2 37163.0 37166.4 37258.7 37269.0 39019.0 39195.6 39230.0 39258.4 39312.6 5966.2 6054.1 7150.3 8308.0 8445.7 7572.2 8525.5 8529.7 8561.7 8569.8 8409.7 8489.1 8491.4 8520.9 8544.1 7167.2 8401.5 8433.2 8434.0 8450.6 8307.5 8357.4 8364.0 8367.9 8395.5 36887.6 36895.8 37056.4 37121.0 37156.4 3517.2 3550.0 3551.1 3552.3 3554.4 30210.5 30300.8 30339.8 30365.7 30420.9 3103.8 3161.4 3189.0 3193.0 3205.1 276599.0 277101.0 278078.6 279310.0 281918.0 48035.5 48118.3 48189.8 48230.3 48317.0 49656.0 49764.5 49849.0 49912.5 50034.5 13811.4 13893.4 13910.7 13922.3 13940.3 9774.7 9820.2 11380.0 11390.0 11399.1 10513.0 12088.4 12143.0 12159.0 12374.9 4466.8 5460.9 5463.0 5510.9 5525.9 758.5 887.9 921.2 938.8 952.8 19798.9 21020.9 23397.6 23594.3 23874.5 1018.0 1029.3 1041.5 1057.0 1059.9 11739.7 11750.2 11790.3 11820.9 11842.9 310266.0 312221.0 312286.0 312524.0 313085.0 53139.9 53278.0 53310.5 53341.2 53387.0 1290.6 1337.1 1343.1 1346.3 1356.6 21794.7 22702.8 22746.4 23248.0 23520.9 34983.7 35043.6 35075.5 35085.5 35116.6 291876.0 292274.0 292670.0 292778.0 293620.0 29633.9 32876.7 33760.3 33816.8 33984.7 37459.4 37495.1 37533.2 37597.6 37646.8 25431.2 29189.4 30002.7 30101.0 31108.5 30832.1 31451.1 31487.5 31507.0 31644.4 30656.8 35712.5 36548.3 37225.3 37477.4 29888.9 30188.4 30905.0 31045.2 31480.1 21679.2 22003.2 23082.3 24345.3 24498.0 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#2] jquery.html Cycles:180 Average:36069.60 Median:27142.09 stddev:92300.94 (340.1%) stddev-sans-first:92520.92 05:01:55 INFO - PID 2792 | Values: 358.4 371.5 373.1 416.2 443.3 12945.9 21112.9 21880.0 21939.2 22029.1 18177.9 22108.6 22732.9 23776.5 23983.4 5952.7 6217.2 6219.8 6221.8 6223.0 4734.8 5988.6 6101.3 6139.5 6223.5 6188.7 6193.6 6194.3 6194.5 6201.8 5945.7 6083.2 6084.3 6114.9 6134.8 5245.7 5427.6 5457.8 5458.9 5459.8 26661.0 27123.9 27160.3 27414.7 27468.7 2188.5 2252.3 2268.9 2295.7 2295.8 17757.5 17822.7 18027.9 18146.0 18199.8 2150.2 2252.9 2283.9 2343.1 2397.0 161093.0 161247.3 161965.0 163966.2 164725.0 18396.9 23791.3 23792.3 23835.4 24216.0 29879.3 34593.0 40820.0 40837.6 40869.6 9364.5 9954.7 10594.3 10649.7 11016.3 8620.8 8651.9 8676.4 8816.7 8849.0 9233.6 11060.7 11078.9 11153.2 11290.3 3606.9 4247.5 4302.4 4342.3 4358.3 843.0 848.4 848.9 856.7 894.9 15815.7 19365.4 19907.8 20118.8 20216.3 770.9 889.3 891.6 926.0 927.3 9613.2 9681.8 9850.9 10166.7 10245.7 535968.0 540559.0 542329.0 551057.0 552389.0 117241.4 118785.4 119028.0 119153.0 120115.4 1148.3 1154.6 1183.0 1195.7 1198.6 13076.9 16064.4 17327.4 17567.7 17761.8 39985.6 55232.4 56385.2 56443.7 58424.7 75214.6 76333.6 76560.0 76979.0 77128.6 8581.7 8662.0 8872.9 9168.0 12103.5 13546.9 13728.8 13802.9 13969.8 14044.4 11703.7 11774.5 11925.9 12071.5 12179.2 9709.0 10176.1 11030.8 11175.9 11359.1 11718.1 11892.4 12238.3 12279.0 12313.3 8081.5 8610.4 8700.7 8718.0 8909.4 11449.3 11718.4 11972.7 12052.6 12153.3 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#3] mootools.html Cycles:180 Average:6985.48 Median:3913.99 stddev:4449.13 (113.7%) stddev-sans-first:4440.99 05:01:55 INFO - PID 2792 | Values: 1285.2 1410.6 1421.9 1446.7 1468.3 11046.9 11554.8 11576.0 11576.2 11583.5 10821.6 11397.6 11430.7 11450.1 11453.7 2474.0 2510.7 2514.7 2519.0 2520.1 2105.6 2359.1 2505.9 2511.8 2520.3 2156.3 2179.3 2453.3 2524.1 2529.1 2463.8 2492.3 2498.7 2500.9 2503.3 2478.3 2478.9 2482.7 2485.7 2489.2 11257.4 11494.9 11519.0 11520.3 11532.8 6532.5 6797.9 6802.9 6803.3 6809.1 3857.6 4085.7 4311.1 4312.6 4319.6 1235.1 1237.6 1267.3 1268.3 1286.6 16379.0 16444.8 16521.4 16529.0 16540.8 5220.0 5297.9 5429.7 5508.7 5529.2 9689.5 11686.6 11694.0 11705.6 11718.4 6509.8 6512.6 6513.7 6516.0 6517.1 5991.3 6129.0 6220.1 6220.3 6261.4 4194.1 4331.3 4335.7 4372.0 4396.3 1256.4 1257.8 1263.6 1273.0 1282.3 554.9 649.7 688.7 763.1 782.7 6561.6 6780.6 6868.0 6955.6 7077.3 882.6 888.6 889.1 911.2 924.9 3493.3 3970.4 3999.4 4014.5 4197.8 12443.0 14007.6 14639.7 15178.1 15236.8 15067.0 15117.9 15125.4 15128.5 15141.2 7881.9 8145.0 8145.5 8344.4 8372.4 6329.0 6347.0 6421.7 6470.8 6523.9 13099.3 13439.1 13517.2 13520.2 13640.9 13328.7 13652.7 13809.2 13845.9 13863.8 8957.3 9052.0 9177.8 9263.7 9283.9 10196.3 10366.2 10397.7 10405.4 10405.5 8736.0 8839.6 8878.9 8888.1 9102.2 8331.6 8641.9 8647.0 8711.7 8736.6 7912.2 7912.9 7967.8 7986.6 8012.9 5040.5 5729.8 5860.5 5907.9 5977.4 5066.8 5784.9 5801.1 5927.4 6159.1 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#4] prototype.html Cycles:180 Average:4867.85 Median:5562.35 stddev:1523.34 (27.4%) stddev-sans-first:1489.51 05:01:55 INFO - PID 2792 | Values: 356.8 370.4 383.8 387.5 397.3 4498.5 4622.8 5505.5 5699.8 5779.4 5507.5 5535.8 5572.2 5644.4 5662.4 3811.0 4329.5 4382.2 4388.7 4418.7 3618.2 3855.4 4037.8 4376.8 4415.8 4344.5 4358.2 4361.6 4380.8 4387.0 4335.1 4335.5 4358.5 4387.4 4398.5 3363.9 3731.1 3834.3 3880.9 3927.9 5124.7 5484.4 5511.7 5565.8 5596.3 5049.7 5217.3 5224.2 5248.2 5255.0 5629.6 5949.9 6010.2 6077.7 6078.5 3560.0 4004.3 4024.0 4043.4 4052.6 6290.4 6347.7 6370.1 6402.6 6422.8 3678.3 4055.9 4074.8 4075.3 4101.3 4158.0 4160.3 4172.0 4175.7 4177.8 4825.7 4827.8 4865.9 4876.8 4889.0 5775.9 5949.9 6007.8 6042.3 6080.6 1264.5 1318.5 1364.3 1368.6 1369.9 741.5 839.4 873.2 877.4 903.5 5154.0 5248.7 5642.4 5644.2 5647.5 5484.8 5645.0 5986.4 6214.5 6219.8 4964.3 5624.6 5627.0 5628.7 5639.7 2759.1 2992.5 3189.3 3240.4 3252.0 6300.2 6347.0 6358.9 6359.5 6380.6 6279.9 6298.8 6303.3 6315.2 6328.4 6070.9 6255.7 6320.3 6348.1 6379.8 6142.8 6168.3 6179.1 6181.8 6220.6 5816.5 5891.8 6019.8 6043.8 6067.7 6290.9 6298.4 6325.2 6338.7 6348.6 3405.5 3760.4 3801.4 4041.0 4059.5 5800.9 5892.4 6229.1 6259.6 6303.8 4905.6 5558.9 5841.9 6005.2 6061.9 4558.3 5662.8 5775.6 6086.2 6127.1 4422.7 5090.4 5622.6 5639.4 5929.8 5201.3 5255.8 5740.0 5898.4 6116.6 4894.0 5126.9 5975.7 5986.4 6013.4 05:01:55 INFO - PID 2792 | 05:01:55 INFO - PID 2792 | [#5] yui.html Cycles:180 Average:21296.78 Median:18680.99 stddev:30812.72 (164.9%) stddev-sans-first:30860.34 05:01:55 INFO - PID 2792 | Values: 699.6 841.7 844.3 849.8 861.1 11790.6 16086.9 18676.5 18685.4 18702.9 16647.4 16806.5 16806.6 16809.7 17141.2 628.8 924.0 937.7 941.6 963.6 971.3 972.6 973.2 973.9 980.0 999.0 1002.5 1003.0 1005.5 1041.0 997.1 1000.0 1000.6 1000.8 1039.0 736.1 737.7 738.1 745.5 770.0 14234.8 14292.8 14575.8 16800.9 17118.5 13860.0 16716.4 17006.7 17096.6 17128.3 11235.7 13741.1 13923.7 14072.0 14264.8 3337.2 3347.3 3366.2 3367.2 3374.0 128193.0 128357.0 128578.0 129522.0 131168.7 10800.6 11174.7 11876.0 11891.2 11927.7 18983.6 19041.9 19363.3 19953.6 24920.8 6744.0 7301.6 7636.6 7639.2 7642.4 3330.6 3403.7 3417.6 3422.3 3742.0 3642.0 3713.1 3724.9 3730.5 3740.9 841.7 877.3 878.2 878.6 882.7 575.3 648.3 652.9 656.8 692.1 10801.8 10925.3 11264.3 11613.2 11792.5 639.1 639.7 644.3 645.4 676.6 4967.8 5352.5 5469.8 5615.7 5671.0 105304.5 106744.5 106852.0 109096.0 109518.0 86179.6 87481.0 87902.0 88135.6 88797.0 79165.2 79674.6 80467.6 80497.6 83530.2 10779.5 12106.9 12723.3 12888.9 12987.6 40151.8 40351.2 40422.4 40907.0 40945.4 43568.8 48940.5 49163.0 49179.8 49237.0 15657.2 15994.9 16124.0 16214.8 16485.3 17820.6 17825.4 18009.4 18157.6 18195.7 16388.3 16561.8 16880.8 16901.9 17010.6 15821.5 15861.2 16471.5 16633.8 16690.0 15834.9 15849.9 16051.8 16225.8 16231.9 10138.7 11709.4 11768.4 11956.2 12138.9 12896.5 12959.7 12992.6 12997.7 13184.1 05:01:55 INFO - PID 2792 | -------- Summary: end -------- 05:01:55 INFO - PID 2792 | 05:01:56 INFO - TEST-INFO | 2792: exit 0 05:01:56 INFO - TEST-OK | dromaeo_css | took 1120350ms 05:01:56 INFO - TEST-START | kraken 05:01:56 INFO - operating with platform_type : mac_ 05:01:56 INFO - Initialising browser for kraken test... 05:01:56 INFO - TEST-INFO | started process 2797 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpzQjTLv/profile http://localhost:61102/getInfo.html) 05:01:59 INFO - PID 2797 | __metrics Screen width/height:1600/1200 05:01:59 INFO - PID 2797 | colorDepth:24 05:01:59 INFO - PID 2797 | Browser inner width/height: 1024/689 05:01:59 INFO - PID 2797 | __metrics 05:01:59 INFO - PID 2797 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:01:59 INFO - PID 2797 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:00 INFO - TEST-INFO | 2797: exit 0 05:02:00 INFO - Browser initialized. 05:02:00 INFO - Running cycle 1/1 for kraken test... 05:02:00 INFO - TEST-INFO | started process 2799 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpzQjTLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:12 INFO - PID 2799 | RSS: Main: 241610752 05:02:12 INFO - PID 2799 | 05:02:15 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61102/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:16 INFO - PID 2799 | RSS: Main: 310501376 05:02:16 INFO - PID 2799 | 05:02:18 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61102/tests/kraken/driver.html?testName=audio-dft) 05:02:19 INFO - PID 2799 | RSS: Main: 293855232 05:02:19 INFO - PID 2799 | 05:02:22 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61102/tests/kraken/driver.html?testName=audio-fft) 05:02:23 INFO - PID 2799 | RSS: Main: 385622016 05:02:23 INFO - PID 2799 | 05:02:25 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61102/tests/kraken/driver.html?testName=audio-oscillator) 05:02:26 INFO - PID 2799 | RSS: Main: 288964608 05:02:26 INFO - PID 2799 | 05:02:28 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:28 INFO - PID 2799 | RSS: Main: 291028992 05:02:28 INFO - PID 2799 | 05:02:31 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61102/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:32 INFO - PID 2799 | RSS: Main: 354607104 05:02:32 INFO - PID 2799 | 05:02:35 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61102/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:35 INFO - PID 2799 | RSS: Main: 368558080 05:02:35 INFO - PID 2799 | 05:02:38 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61102/tests/kraken/driver.html?testName=json-parse-financial) 05:02:39 INFO - PID 2799 | RSS: Main: 372113408 05:02:39 INFO - PID 2799 | 05:02:40 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:41 INFO - PID 2799 | RSS: Main: 330981376 05:02:41 INFO - PID 2799 | 05:02:43 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:43 INFO - PID 2799 | RSS: Main: 333447168 05:02:43 INFO - PID 2799 | 05:02:45 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:46 INFO - PID 2799 | RSS: Main: 335323136 05:02:46 INFO - PID 2799 | 05:02:49 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:50 INFO - PID 2799 | RSS: Main: 349704192 05:02:50 INFO - PID 2799 | 05:02:53 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:53 INFO - PID 2799 | RSS: Main: 340860928 05:02:53 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | Cycle 1(1): loaded http://localhost:61102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61102/tests/kraken/driver.html?testName=ai-astar) 05:02:55 INFO - PID 2799 | RSS: Main: 384180224 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | __start_tp_report 05:02:55 INFO - PID 2799 | _x_x_mozilla_page_load 05:02:55 INFO - PID 2799 | _x_x_mozilla_page_load_details 05:02:55 INFO - PID 2799 | |i|pagename|runs| 05:02:55 INFO - PID 2799 | |0;ai-astar;111;112;112;111;111;110;110;111;110;110 05:02:55 INFO - PID 2799 | |1;audio-beat-detection;140;109;133;181;106;107;107;109;139;105 05:02:55 INFO - PID 2799 | |2;audio-dft;185;181;184;187;187;187;181;186;179;184 05:02:55 INFO - PID 2799 | |3;audio-fft;78;48;58;101;51;59;84;83;101;60 05:02:55 INFO - PID 2799 | |4;audio-oscillator;94;73;86;70;69;69;87;68;68;88 05:02:55 INFO - PID 2799 | |5;imaging-gaussian-blur;89;89;88;88;89;88;89;88;88;89 05:02:55 INFO - PID 2799 | |6;imaging-darkroom;95;94;96;94;95;96;96;95;94;95 05:02:55 INFO - PID 2799 | |7;imaging-desaturate;86;84;84;85;82;84;86;85;85;86 05:02:55 INFO - PID 2799 | |8;json-parse-financial;49;48;46;47;50;48;48;48;48;47 05:02:55 INFO - PID 2799 | |9;json-stringify-tinderbox;53;64;54;70;61;59;58;55;58;58 05:02:55 INFO - PID 2799 | |10;stanford-crypto-aes;82;82;82;82;82;81;82;82;82;82 05:02:55 INFO - PID 2799 | |11;stanford-crypto-ccm;136;136;137;134;133;133;151;144;184;137 05:02:55 INFO - PID 2799 | |12;stanford-crypto-pbkdf2;201;199;184;182;187;185;157;215;229;180 05:02:55 INFO - PID 2799 | |13;stanford-crypto-sha256-iterative;67;68;68;67;67;68;68;69;68;69 05:02:55 INFO - PID 2799 | __end_tp_report 05:02:55 INFO - PID 2799 | __start_cc_report 05:02:55 INFO - PID 2799 | _x_x_mozilla_cycle_collect,2219 05:02:55 INFO - PID 2799 | __end_cc_report 05:02:55 INFO - PID 2799 | __startTimestamp1493553775913__endTimestamp 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | ------- Summary: start ------- 05:02:55 INFO - PID 2799 | Number of tests: 14 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 05:02:55 INFO - PID 2799 | Values: 111.0 112.0 112.0 111.0 111.0 110.0 110.0 111.0 110.0 110.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:121.00 stddev:24.77 (20.5%) stddev-sans-first:25.55 05:02:55 INFO - PID 2799 | Values: 140.0 109.0 133.0 181.0 106.0 107.0 107.0 109.0 139.0 105.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.50 stddev:2.88 (1.6%) stddev-sans-first:3.04 05:02:55 INFO - PID 2799 | Values: 185.0 181.0 184.0 187.0 187.0 187.0 181.0 186.0 179.0 184.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#3] audio-fft Cycles:10 Average:72.30 Median:59.50 stddev:19.74 (33.2%) stddev-sans-first:20.83 05:02:55 INFO - PID 2799 | Values: 78.0 48.0 58.0 101.0 51.0 59.0 84.0 83.0 101.0 60.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:10.25 (12.9%) stddev-sans-first:8.89 05:02:55 INFO - PID 2799 | Values: 94.0 73.0 86.0 70.0 69.0 69.0 87.0 68.0 68.0 88.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:02:55 INFO - PID 2799 | Values: 89.0 89.0 88.0 88.0 89.0 88.0 89.0 88.0 88.0 89.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 05:02:55 INFO - PID 2799 | Values: 95.0 94.0 96.0 94.0 95.0 96.0 96.0 95.0 94.0 95.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.24 05:02:55 INFO - PID 2799 | Values: 86.0 84.0 84.0 85.0 82.0 84.0 86.0 85.0 85.0 86.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:48.00 stddev:1.10 (2.3%) stddev-sans-first:1.09 05:02:55 INFO - PID 2799 | Values: 49.0 48.0 46.0 47.0 50.0 48.0 48.0 48.0 48.0 47.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.50 stddev:5.06 (8.6%) stddev-sans-first:4.87 05:02:55 INFO - PID 2799 | Values: 53.0 64.0 54.0 70.0 61.0 59.0 58.0 55.0 58.0 58.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 05:02:55 INFO - PID 2799 | Values: 82.0 82.0 82.0 82.0 82.0 81.0 82.0 82.0 82.0 82.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:137.00 stddev:15.62 (11.4%) stddev-sans-first:16.38 05:02:55 INFO - PID 2799 | Values: 136.0 136.0 137.0 134.0 133.0 133.0 151.0 144.0 184.0 137.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.90 Median:193.00 stddev:20.10 (10.4%) stddev-sans-first:21.04 05:02:55 INFO - PID 2799 | Values: 201.0 199.0 184.0 182.0 187.0 185.0 157.0 215.0 229.0 180.0 05:02:55 INFO - PID 2799 | 05:02:55 INFO - PID 2799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 05:02:55 INFO - PID 2799 | Values: 67.0 68.0 68.0 67.0 67.0 68.0 68.0 69.0 68.0 69.0 05:02:55 INFO - PID 2799 | -------- Summary: end -------- 05:02:55 INFO - PID 2799 | 05:02:57 INFO - TEST-INFO | 2799: exit 0 05:02:57 INFO - TEST-OK | kraken | took 60385ms 05:02:57 INFO - SUITE-END | took 1180s 05:02:57 INFO - Completed test suite (00:19:41) 05:02:57 INFO - javascript benchmark 05:02:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7676.205725912712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.917027074323, 3491.5810102787655, 3511.3328467591173, 3515.0860776198188, 3561.7684850484716, 5927.673977931212, 6102.908456373147, 6166.475849552788, 6209.099680546324, 6209.223847019122, 6032.819015429544, 6060.969695151529, 6070.301915279744, 6071.0, 6097.085437184435, 5199.194124910626, 5239.52844244018, 5252.527272545489, 5261.552768014704, 5364.5708343332635, 5366.4633536646415, 5367.543758780508, 5380.569554435655, 5381.0, 5384.892302153974, 5360.222767698681, 5369.463053694639, 5371.489708477708, 5375.0, 5417.26866872973, 5398.46015398459, 5423.186522021689, 5447.782088716446, 5463.48096930791, 5496.780128794843, 5315.042874480262, 5368.489993450616, 5372.892542149174, 5386.8383948481605, 5401.27082843815, 5888.4700376966275, 6151.169592105053, 6171.413715697046, 6238.781642642486, 6264.561480696353, 5855.531557475391, 6297.905531416986, 6333.0, 6357.046443033536, 6491.350864913518, 6619.271880093186, 6640.302768209317, 6642.368974947421, 6666.866662666768, 6677.332266773284, 6286.308506064329, 6293.339199384044, 6297.0554416837385, 6297.6536290504, 6315.210598675166, 6485.416312531895, 6563.442107420923, 6634.734610615521, 6731.562448440835, 6737.52837301394, 6274.749010039547, 6398.712057957403, 6399.840003999844, 6432.839179020562, 6433.453156481658, 6562.212534495891, 6568.113304703899, 6568.737250510022, 6574.0, 6586.934130658728, 5884.529237660977, 6362.395572420613, 6421.871562568723, 6449.774257900951, 6458.483321334282, 6337.714802833883, 6403.583767055126, 6428.935710642833, 6454.160959075384, 6471.611703297817, 5197.610179236573, 5215.869603259949, 5216.713080780518, 5232.0, 5240.9213861792105, 4627.167109920247, 4675.462321832964, 4689.062187562433, 4697.506761790031, 4716.716996980193, 6045.486133678686, 6113.32753397126, 6125.84685382869, 6134.601250918676, 6158.107074474176, 6456.257530383972, 6472.838179045561, 6479.125318081999, 6489.221293444817, 6647.800565983028, 6127.708789264043, 6175.073738939195, 6202.844928876814, 6213.813585592439, 6229.657368844757, 5774.48029677331, 5774.538036957033, 5776.768929242783, 5778.104393818965, 5799.4780469757925, 6497.220333560003, 6593.0, 6750.122484077038, 6792.558483698544, 6800.31996800316, 6554.4756419487285, 6594.967025164843, 6612.437942774918, 6670.433013193933, 6672.266050734513, 6714.462842972648, 6721.630310332978, 6794.04883316346, 6795.218549866829, 6802.591844489347, 5382.407935127055, 6284.3087260402235, 6469.256035555972, 6484.708188131451, 6497.935020649733, 6451.3226111257645, 6451.387118223761, 6527.445167160845, 6527.869442611216, 6578.342165783383, 6253.249610046823, 6337.96831015842, 6352.301246862934, 6365.395287447685, 6422.325655806073, 6286.402791734778, 6293.0, 6336.271328797247, 6338.841528961812, 6343.080253363144, 6283.8114856554375, 6311.27420346666, 6313.179286692701, 6315.084312774714, 6340.302566717565, 6260.342664020212, 6336.778212762531, 6341.55609107358, 6365.267994180544, 6414.486841052611, 6265.091561723433, 6276.435120839146, 6280.466160376419, 6293.622382657055, 6293.779717709858], "value": 5987.517784049755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.2079595628634, 788.7712563356625, 804.4690504267184, 1116.8715597706262, 1128.542940109255, 26687.199384018488, 37163.0, 37166.442503362436, 37258.695945641906, 37269.0, 39019.0, 39195.60804391962, 39230.0, 39258.411123833095, 39312.606873931254, 5966.224390829186, 6054.061620448838, 7150.284971502861, 8307.999999999985, 8445.662173513052, 7572.204918483562, 8525.488470691747, 8529.658813647447, 8561.700340488083, 8569.785755356104, 8409.663613455485, 8489.066202717697, 8491.40560160789, 8520.8721869172, 8544.145585441469, 7167.24743901888, 8401.495910245374, 8433.19884610961, 8434.0, 8450.577471126418, 8307.46001509906, 8357.414980951336, 8363.954505686788, 8367.916320836775, 8395.454295470836, 36887.63112368869, 36895.815520922224, 37056.444153337725, 37121.0, 37156.44265336022, 3517.1734642359024, 3550.0, 3551.1122219445137, 3552.289542091592, 3554.431290993429, 30210.54684179739, 30300.787968481454, 30339.848300758356, 30365.69634303673, 30420.935267265762, 3103.7672174586996, 3161.3993341265086, 3189.027346659268, 3193.0101668482844, 3205.0705295464522, 276599.0, 277101.0, 278078.6096069527, 279310.0, 281918.0, 48035.519644803804, 48118.27822582664, 48189.75905120522, 48230.27654585184, 48317.0, 49656.0068798622, 49764.502354976714, 49849.0, 49912.50087499079, 50034.49965500371, 13811.447542098203, 13893.4442622296, 13910.652233694238, 13922.303884805922, 13940.302984850718, 9774.706758797247, 9820.201242645811, 11379.975802177843, 11389.974902258837, 11399.088072954144, 10513.001264879977, 12088.395580220953, 12143.0, 12159.027277817753, 12374.938125309316, 4466.798994045275, 5460.863478413072, 5462.9726851365485, 5510.862228444241, 5525.917111243334, 758.5031804168168, 887.933404994628, 921.1709461484584, 938.7606160429046, 952.842780941137, 19798.90100549517, 21020.894895525424, 23397.649035264483, 23594.34839561214, 23874.52250954971, 1017.9898201018043, 1029.330934892311, 1041.5261056219401, 1057.006413970865, 1059.9364038157735, 11739.706507337214, 11750.177487575958, 11790.292582445081, 11820.94089529564, 11842.88157118435, 310266.0, 312221.0, 312286.0, 312524.0, 313085.0, 53139.93720125576, 53278.0, 53310.46689533132, 53341.1998820018, 53387.0, 1290.5999140266547, 1337.1041402260703, 1343.0531475309883, 1346.3335648853881, 1356.6269275949194, 21794.673079904132, 22702.772972270064, 22746.43133921665, 23247.953842076808, 23520.882395587912, 34983.65016349804, 35043.64956350506, 35075.47386789251, 35085.47371789476, 35116.64883351134, 291876.0, 292274.0, 292670.0, 292778.0, 293620.0, 29633.851830740707, 32876.67123328736, 33760.324793504486, 33816.83091584526, 33984.66015339815, 37459.43810842894, 37495.062623434635, 37533.2493350126, 37597.62402376051, 37646.81176594209, 25431.237062888144, 29189.416211675223, 30002.699973000865, 30101.0, 31108.533371998987, 30832.075037748902, 31451.056468305986, 31487.52768708517, 31507.0, 31644.367112658078, 30656.846715766278, 35712.464313035845, 36548.26903461863, 37225.25549488941, 37477.43783843299, 29888.85055574708, 30188.396232075676, 30905.0, 31045.223869403446, 31480.05559833209, 21679.163103358595, 22003.22988695388, 23082.307530774102, 24345.26964191077, 24498.0], "value": 16788.51065590754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.397891542209, 371.5225934673944, 373.0656545809977, 416.1988172767422, 443.34163766806284, 12945.870541294584, 21112.89443552782, 21880.0, 21939.232126875562, 22029.118835246572, 18177.90911045446, 22108.557828843455, 22732.88633556834, 23776.5244695106, 23983.40041498959, 5952.7321270542825, 6217.222847144107, 6219.813405597817, 6221.844453888666, 6223.035429508411, 4734.763261836912, 5988.6226167981395, 6101.2983506896835, 6139.508839292868, 6223.533235007392, 6188.721507532172, 6193.566450348478, 6194.256689197303, 6194.535409844257, 6201.81394558164, 5945.702714864261, 6083.209182806229, 6084.330723620398, 6114.877702445926, 6134.846628834271, 5245.659032162897, 5427.6200665953, 5457.781688732446, 5458.863528411822, 5459.808906688247, 26661.0, 27123.86438067797, 27160.32099197516, 27414.725852741416, 27468.725312746818, 2188.518525924294, 2252.279270633398, 2268.875211863347, 2295.7130358705163, 2295.8163346932206, 17757.467275981613, 17822.732659010126, 18027.909860450745, 18146.0, 18199.818001819945, 2150.236665983569, 2252.8986195621073, 2283.8515496492673, 2343.0510643189536, 2396.9520609587885, 161093.0, 161247.284983147, 161965.0, 163966.1801690984, 164725.0, 18396.908015459838, 23791.286261412184, 23792.26751305798, 23835.404114897265, 24216.03135874545, 29879.253018674273, 34593.0, 40820.0, 40837.591624083376, 40869.591304087175, 9364.531773411301, 9954.651587194558, 10594.31136976094, 10649.733756656145, 11016.283941543934, 8620.827583448296, 8651.870221946676, 8676.392652514389, 8816.691415800417, 8849.0, 9233.568796836502, 11060.723481912855, 11078.889211107948, 11153.163512736577, 11290.266132701348, 3606.855725770992, 4247.469066366704, 4302.419173411549, 4342.305231162999, 4358.3244597087505, 842.9789255268668, 848.4485084694998, 848.8854004709285, 856.738694698123, 894.874717539545, 15815.683686326209, 19365.4190374289, 19907.800921990885, 20118.798812011693, 20216.29242976518, 770.9267619576132, 889.2974550105345, 891.595736714677, 925.9953700231456, 927.3276874266238, 9613.230941524662, 9681.757956051015, 9850.901490985141, 10166.745831354276, 10245.692629221136, 535968.0, 540559.0, 542329.0, 551057.0, 552389.0, 117241.4137929322, 118785.40607296908, 119028.0, 119153.0, 120115.39942300232, 1148.2995372822572, 1154.6189757380043, 1182.976340473203, 1195.653260554447, 1198.6284251881943, 13076.869231307564, 16064.43774467888, 17327.393541225996, 17567.68233889376, 17761.822381776015, 39985.60014399935, 55232.44767552434, 56385.15422268587, 56443.71778141083, 58424.70787646034, 75214.62392688001, 76333.61833190799, 76560.0, 76979.0, 77128.61435692785, 8581.65673373058, 8662.0, 8872.911270887209, 9167.991520932559, 12103.455344509694, 13546.932265339005, 13728.794068089186, 13802.930985345009, 13969.790453143009, 14044.438222471395, 11703.707407314885, 11774.470148843151, 11925.880741192477, 12071.456784444545, 12179.208351457128, 9709.0, 10176.135028522362, 11030.779384412428, 11175.888241117485, 11359.148063895076, 11718.121140914294, 11892.405379731152, 12238.326892021025, 12279.0, 12313.26120432777, 8081.4747041442115, 8610.397272190887, 8700.738977830675, 8718.0, 8909.420887642282, 11449.255798373079, 11718.355490447766, 11972.700682483008, 12052.638420847388, 12153.331566763913], "value": 10959.916977644672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.2160182288796, 1410.6261840612237, 1421.9239909731791, 1446.746819306621, 1468.2658670664664, 11046.889531104687, 11554.768904621902, 11576.0, 11576.189666723332, 11583.53665853366, 10821.621243256488, 11397.601083962063, 11430.657080287605, 11450.141239407058, 11453.656390308282, 2474.0474917156935, 2510.698716154064, 2514.7485251474795, 2518.987405062972, 2520.117958714454, 2105.5578328551023, 2359.127122964497, 2505.912293069743, 2511.7739403453684, 2520.332111990315, 2156.331537223458, 2179.2699445685716, 2453.251758213744, 2524.116559204273, 2529.127451029392, 2463.7782599566126, 2492.264781889338, 2498.7376325485743, 2500.9374765630823, 2503.311589312935, 2478.31846242283, 2478.9380265493505, 2482.677251957252, 2485.701715794098, 2489.191012920808, 11257.380844053574, 11494.885051149466, 11519.0, 11520.251183673034, 11532.82700759481, 6532.510061745388, 6797.898031529531, 6802.863942721118, 6803.251642319341, 6809.114815074058, 3857.5756666766633, 4085.7344272622186, 4311.116221174651, 4312.633426158749, 4319.568043195687, 1235.0860363331071, 1237.55448038706, 1267.3156495492424, 1268.3404629592653, 1286.6075846866702, 16379.0172589645, 16444.75332869996, 16521.421750238685, 16529.0, 16540.75188872168, 5220.0, 5297.9404119176315, 5429.701366424805, 5508.669479831223, 5529.198266251451, 9689.467079310705, 11686.649400517828, 11694.0, 11705.648830535098, 11718.414079296172, 6509.837254068686, 6512.641804700692, 6513.674316284167, 6516.0, 6517.120188774455, 5991.281046274475, 6128.969355153285, 6220.098085777537, 6220.346863579259, 6261.373862613702, 4194.140201258735, 4331.263685173528, 4335.696501244883, 4371.956280437218, 4396.340548917624, 1256.3969294738577, 1257.8176164456102, 1263.564070395712, 1272.9872701273055, 1282.2753396681449, 554.9028919938994, 649.6849028221309, 688.6625553478759, 763.1452772894394, 782.6595430987538, 6561.622059367586, 6780.559263647847, 6867.965660171667, 6955.617441040791, 7077.292270772881, 882.6204731965188, 888.5512816027865, 889.1242126505387, 911.2118017914456, 924.8705181274627, 3493.283876805249, 3970.404439334123, 3999.3601023836045, 4014.498187726534, 4197.811098500575, 12443.0, 14007.649808754863, 14639.707205856037, 15178.089314641156, 15236.771448428282, 15067.0, 15117.924410377878, 15125.39498420051, 15128.470503532544, 15141.167235802137, 7881.935938648324, 8144.959275203586, 8145.470544414594, 8344.415890887702, 8372.41393102477, 6328.968355158379, 6347.0479428086155, 6421.678916054272, 6470.838229044311, 6523.934760652332, 13099.345032748515, 13439.059265851296, 13517.188968661912, 13520.18878867271, 13640.908727301594, 13328.666783330107, 13652.726945460836, 13809.171449713049, 13845.930770346084, 13863.79204311916, 8957.328200385127, 9052.004279529378, 9177.816443671223, 9263.675771347971, 9283.860742088738, 10196.286259961731, 10366.222533309881, 10397.740056498647, 10405.375677459377, 10405.531751071372, 8735.99536053362, 8839.558022098741, 8878.911210887809, 8888.111188881061, 9102.226310763659, 8331.583420829056, 8641.913580864362, 8647.0, 8711.651533938824, 8736.606852691772, 7912.248336408032, 7912.881306780518, 7967.800804979922, 7986.560739159402, 8012.919870801451, 5040.521150490697, 5729.799457018984, 5860.472557469678, 5907.881842363215, 5977.372375900468, 5066.797328106834, 5784.913226301693, 5801.100829371454, 5927.377625349449, 6159.137720719193], "value": 5268.685163550508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.835855506467, 370.44063464169096, 383.8176865988654, 387.52528153012565, 397.2551466001247, 4498.50516443191, 4622.815087396509, 5505.504504594585, 5699.800506982246, 5779.422057794219, 5507.511378226743, 5535.837474130427, 5572.247746554214, 5644.350899646542, 5662.37713851477, 3811.028187812104, 4329.458817647794, 4382.189294980439, 4388.692791504596, 4418.690691651585, 3618.2220822523154, 3855.4409610606444, 4037.798110094498, 4376.759278239696, 4415.82336706533, 4344.522102568715, 4358.150160718661, 4361.60745532902, 4380.780960951955, 4386.9561304387025, 4335.1329734053315, 4335.5014173370155, 4358.476982762073, 4387.3857659927635, 4398.472183337988, 3363.9495407568907, 3731.1418373774186, 3834.2585051688175, 3880.8835734927998, 3927.9410808837893, 5124.666896651705, 5484.424135465799, 5511.669299841982, 5565.805196818133, 5596.300462442195, 5049.697018178921, 5217.295665085241, 5224.223763920248, 5248.160294352923, 5254.97683391893, 5629.620742918011, 5949.9107513387335, 6010.230179028138, 6077.696115194267, 6078.45293923549, 3560.0, 4004.3192657248337, 4023.994001499625, 4043.3934909763475, 4052.6150015748754, 6290.370118743745, 6347.746090156388, 6370.095026829315, 6402.6158430494315, 6422.775202867877, 3678.3378991781738, 4055.9391609125887, 4074.796260186979, 4075.3275709507598, 4101.26177288085, 4157.97921010393, 4160.313548264502, 4171.958280417157, 4175.68682348825, 4177.770222637723, 4825.721183886273, 4827.758612069382, 4865.878353041131, 4876.780544875489, 4889.0, 5775.913361299584, 5949.929012777741, 6007.8197654070445, 6042.305134909541, 6080.604760690541, 1264.5447638850007, 1318.5319211679716, 1364.311022933432, 1368.5825823123844, 1369.897257705676, 741.4772585327331, 839.3662784597711, 873.24028095556, 877.4209022045419, 903.4850135422878, 5153.974230128825, 5248.711320877388, 5642.4075472075665, 5644.209810626516, 5647.491725744702, 5484.7531861066345, 5645.040343141676, 5986.43220301297, 6214.502839772807, 6219.8230619283795, 4964.304997300309, 5624.62196761796, 5626.971865140648, 5628.71856407178, 5639.746211420496, 2759.0548663192403, 2992.506236470958, 3189.2505261263586, 3240.4329242382487, 3252.0, 6300.21247344082, 6347.0, 6358.872822543523, 6359.523035772336, 6380.585261957958, 6279.874402511924, 6298.811035668938, 6303.338149494237, 6315.179026726496, 6328.430441260309, 6070.939290607037, 6255.6872156392, 6320.273168585672, 6348.1430006949395, 6379.776707815204, 6142.846428839315, 6168.25980882297, 6179.134921111138, 6181.783637572664, 6220.573976149396, 5816.534677225727, 5891.764329426775, 6019.759209631741, 6043.75824967014, 6067.726952287246, 6290.937090629035, 6298.401651843067, 6325.209348831396, 6338.683065846597, 6348.587341822767, 3405.4721518164724, 3760.3983362661843, 3801.4340320283145, 4040.9797951010055, 4059.512858457004, 5800.9419905800405, 5892.440218179266, 6229.106808244847, 6259.561830671809, 6303.810885673437, 4905.558499735041, 5558.888822223614, 5841.883162336644, 6005.19844046793, 6061.909071363845, 4558.2934645128735, 5662.7734890603915, 5775.624584402169, 6086.239220097488, 6127.111568822585, 4422.71252368595, 5090.363704536933, 5622.634528755618, 5639.379668236573, 5929.822105336847, 5201.297824793604, 5255.78976840922, 5739.966805974965, 5898.380670029585, 6116.633002019893, 4893.951060489492, 5126.871828204325, 5975.671338076448, 5986.371430999857, 6013.368596297326], "value": 4383.979207847911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.5592776550773, 841.6633346661334, 844.3287586368837, 849.7875531117216, 861.117354711421, 11790.64407593127, 16086.919565402171, 18676.53308667284, 18685.4394368169, 18702.90648546759, 16647.417340393087, 16806.495805125865, 16806.57983550409, 16809.747853782203, 17141.228644710987, 628.7547856336032, 923.9907600923972, 937.6624415210518, 941.6186444489975, 963.6193703487119, 971.3297824501107, 972.6401231544303, 973.2068364283122, 973.8880028796673, 980.0248752491282, 998.990010099897, 1002.5187909803299, 1002.997002997003, 1005.4872015272227, 1040.9746399796195, 997.1125698128672, 1000.0149852395384, 1000.559753708366, 1000.8348622477282, 1038.9688309350731, 736.0835759479429, 737.72704099483, 738.0737174845588, 745.5303159009843, 769.97690069298, 14234.786478202835, 14292.785608215885, 14575.781363279559, 16800.915995420066, 17118.48644540666, 13860.0, 16716.41492547755, 17006.659866802594, 17096.57258568533, 17128.314867405414, 11235.719107022309, 13741.106828056145, 13923.651908702263, 14072.0, 14264.78602820948, 3337.2491189482416, 3347.3472672828807, 3366.2425954160362, 3367.175042114673, 3373.983130084334, 128193.0, 128357.0, 128577.99999999907, 129522.0, 131168.6883131166, 10800.567977280822, 11174.720631984266, 11876.0, 11891.16761826681, 11927.701807454883, 18983.62032759337, 19041.904790476237, 19363.32228372, 19953.60092798165, 24920.750792492207, 6743.98840173968, 7301.634918254066, 7636.618169091635, 7639.197884222188, 7642.3504002159325, 3330.633630300665, 3403.7447191460737, 3417.6411476795074, 3422.281320922584, 3741.962580374216, 3642.0, 3713.1274150574595, 3724.8882533523497, 3730.515033045741, 3740.925181496355, 841.7138173021202, 877.2543338162511, 878.1920633017639, 878.5782824244399, 882.7219425880827, 575.3297408519029, 648.2674577727232, 652.9379708927644, 656.8029591122644, 692.1486571516962, 10801.83797243042, 10925.289856159483, 11264.267822591506, 11613.187076904704, 11792.469338879771, 639.1180171363488, 639.7025383196835, 644.3009334871623, 645.4287955159717, 676.6210921883761, 4967.772833396478, 5352.518273355417, 5469.835904922858, 5615.691136987423, 5670.971645141748, 105304.47347763213, 106744.46627766966, 106852.0, 109096.0, 109518.0, 86179.56910215534, 87481.0, 87902.0, 88135.55932220299, 88797.0, 79165.20834791694, 79674.60162699265, 80467.59766201132, 80497.59751201207, 83530.16469835346, 10779.51492182838, 12106.878931210575, 12723.300218488072, 12888.935555322163, 12987.610371688865, 40151.79544613666, 40351.192976139726, 40422.393664094474, 40907.0, 40945.38581921214, 43568.782156089015, 48940.510594893596, 49163.0, 49179.754101229264, 49237.0, 15657.217139143226, 15994.920025399799, 16124.0, 16214.756778648565, 16485.258163382437, 17820.643587128445, 17825.376111836023, 18009.369672061413, 18157.636847263246, 18195.727064094313, 16388.344466221217, 16561.751573726164, 16880.831191687925, 16901.91549042247, 17010.574735631708, 15821.525354239391, 15861.206939653202, 16471.505854824376, 16633.750493742846, 16690.0, 15834.92082539626, 15849.920750396173, 16051.839481605035, 16225.756613650568, 16231.918840405722, 10138.732658417697, 11709.414529273672, 11768.411579421167, 11956.222845515014, 12138.939305303416, 12896.548620798227, 12959.676008099874, 12992.610221693365, 12997.740045199233, 13184.077114601885], "value": 8039.121160360375, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 133.0, 181.0, 106.0, 107.0, 107.0, 109.0, 139.0, 105.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 184.0, 187.0, 187.0, 187.0, 181.0, 186.0, 179.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 48.0, 58.0, 101.0, 51.0, 59.0, 84.0, 83.0, 101.0, 60.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 73.0, 86.0, 70.0, 69.0, 69.0, 87.0, 68.0, 68.0, 88.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 89.0, 88.0, 89.0, 88.0, 88.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 82.0, 84.0, 86.0, 85.0, 85.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 46.0, 47.0, 50.0, 48.0, 48.0, 48.0, 48.0, 47.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 64.0, 54.0, 70.0, 61.0, 59.0, 58.0, 55.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0, 82.0, 82.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 137.0, 134.0, 133.0, 133.0, 151.0, 144.0, 184.0, 137.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 184.0, 182.0, 187.0, 185.0, 157.0, 215.0, 229.0, 180.0], "value": 191.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 67.9, "unit": "score"}]}]} 05:02:57 INFO - Return code: 0 05:02:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:57 ERROR - # TBPL SUCCESS # 05:02:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:57 INFO - 2017-04-30 05:02:57.721 screenresolution[2804:47119] starting screenresolution argv=screenresolution get 05:02:57 INFO - 2017-04-30 05:02:57.724 screenresolution[2804:47119] Display 0: 1600x1200x32@60 05:02:57 INFO - 2017-04-30 05:02:57.730 screenresolution[2805:47121] starting screenresolution argv=screenresolution list 05:02:57 INFO - Available Modes on Display 0 05:02:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:57 INFO - Intel Iris: 05:02:57 INFO - Chipset Model: Intel Iris 05:02:57 INFO - Type: GPU 05:02:57 INFO - Bus: Built-In 05:02:57 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:57 INFO - Vendor: Intel (0x8086) 05:02:57 INFO - Device ID: 0x0a2e 05:02:57 INFO - Revision ID: 0x0009 05:02:57 INFO - Displays: 05:02:57 INFO - Display: 05:02:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:57 INFO - Display Serial Number: 1600x1200 60 05:02:57 INFO - Main Display: Yes 05:02:57 INFO - Mirror: Off 05:02:57 INFO - Online: Yes 05:02:57 INFO - Rotation: Supported 05:02:57 INFO - Return code: 0 05:02:57 INFO - Running post-action listener: _resource_record_post_action 05:02:57 INFO - [mozharness: 2017-04-30 12:02:57.964061Z] Finished run-tests step (success) 05:02:57 INFO - Running post-run listener: _resource_record_post_run 05:02:58 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 1430016; Write bytes: 511503360; Read time: 8; Write time: 1566 05:02:58 INFO - TinderboxPrint: CPU usage
53.3% 05:02:58 INFO - TinderboxPrint: I/O read bytes / time
1,430,016 / 8 05:02:58 INFO - TinderboxPrint: I/O write bytes / time
511,503,360 / 1,566 05:02:58 INFO - TinderboxPrint: CPU idle
2,244.1 (46.7%) 05:02:58 INFO - TinderboxPrint: CPU system
953.8 (19.8%) 05:02:58 INFO - TinderboxPrint: CPU user
1,607.7 (33.5%) 05:02:58 INFO - TinderboxPrint: Swap in / out
209,764,352 / 0 05:02:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209437184; Write bytes: 209338368; Read time: 16112; Write time: 439 05:02:58 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 471552; Write bytes: 300829696; Read time: 4; Write time: 1119 05:02:58 INFO - Running post-run listener: _upload_blobber_files 05:02:58 INFO - Blob upload gear active. 05:02:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:02:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:59 INFO - (blobuploader) - INFO - Done attempting. 05:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:00 INFO - (blobuploader) - INFO - Done attempting. 05:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:01 INFO - (blobuploader) - INFO - Done attempting. 05:03:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:03 INFO - (blobuploader) - INFO - Done attempting. 05:03:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:03 INFO - Return code: 0 05:03:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7160e96b4a7f7cbd33f7958e236325e46fea94cc5756f5b034c19cbe8f6d2fe3e1c5958e31d8bcfdab01ac4e0b0d2007458158b5862ea77b92af13bf4425e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88d53c24ab8acca6f370ccf7b6e8d8af9c735ac928c4ac73e9eb8cf93e057917a47217266eb9f6d14e2c6ffb57031bdd51e3e4f9e2418a1d11c19f40f6d234c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1874f1d9cc211c0429ea95367019d783b380afd38ce505f0f264434049829071a4eefd019ee52b7e9e97c45e8c115e5a98b906d1dd1da024875f95505596f3d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88b6ea4cae4494e005150ccd9f710050887b2ed19dd979b34a715c88857249a378089cfcfb1d11bca5025892103ea0a80829644c5cb83ba8d10af155d09cbd88"} 05:03:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:03 INFO - Contents: 05:03:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7160e96b4a7f7cbd33f7958e236325e46fea94cc5756f5b034c19cbe8f6d2fe3e1c5958e31d8bcfdab01ac4e0b0d2007458158b5862ea77b92af13bf4425e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88d53c24ab8acca6f370ccf7b6e8d8af9c735ac928c4ac73e9eb8cf93e057917a47217266eb9f6d14e2c6ffb57031bdd51e3e4f9e2418a1d11c19f40f6d234c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1874f1d9cc211c0429ea95367019d783b380afd38ce505f0f264434049829071a4eefd019ee52b7e9e97c45e8c115e5a98b906d1dd1da024875f95505596f3d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88b6ea4cae4494e005150ccd9f710050887b2ed19dd979b34a715c88857249a378089cfcfb1d11bca5025892103ea0a80829644c5cb83ba8d10af155d09cbd88"} 05:03:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:03 INFO - Copying logs to upload dir... 05:03:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1345.236987 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2017-04-30 05:03:03.714662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 05:03:03.720721) ========= 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.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7160e96b4a7f7cbd33f7958e236325e46fea94cc5756f5b034c19cbe8f6d2fe3e1c5958e31d8bcfdab01ac4e0b0d2007458158b5862ea77b92af13bf4425e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88d53c24ab8acca6f370ccf7b6e8d8af9c735ac928c4ac73e9eb8cf93e057917a47217266eb9f6d14e2c6ffb57031bdd51e3e4f9e2418a1d11c19f40f6d234c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1874f1d9cc211c0429ea95367019d783b380afd38ce505f0f264434049829071a4eefd019ee52b7e9e97c45e8c115e5a98b906d1dd1da024875f95505596f3d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88b6ea4cae4494e005150ccd9f710050887b2ed19dd979b34a715c88857249a378089cfcfb1d11bca5025892103ea0a80829644c5cb83ba8d10af155d09cbd88"} build_url:https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/AMGXos4kTsChaunv2LSvgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7160e96b4a7f7cbd33f7958e236325e46fea94cc5756f5b034c19cbe8f6d2fe3e1c5958e31d8bcfdab01ac4e0b0d2007458158b5862ea77b92af13bf4425e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88d53c24ab8acca6f370ccf7b6e8d8af9c735ac928c4ac73e9eb8cf93e057917a47217266eb9f6d14e2c6ffb57031bdd51e3e4f9e2418a1d11c19f40f6d234c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1874f1d9cc211c0429ea95367019d783b380afd38ce505f0f264434049829071a4eefd019ee52b7e9e97c45e8c115e5a98b906d1dd1da024875f95505596f3d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88b6ea4cae4494e005150ccd9f710050887b2ed19dd979b34a715c88857249a378089cfcfb1d11bca5025892103ea0a80829644c5cb83ba8d10af155d09cbd88"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 05:03:03.760688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 05:03:03.761392) ========= 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.3LMhEl44BT/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.podvDKlKn6/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005039 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 05:03:03.811507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 05:03:03.811876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 05:03:03.812221) ========= ========= Total master_lag: 0.38 =========