builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0363 starttime: 1490988661.44 results: success (0) buildid: 20170331111022 builduid: f9b63e8f0b4b4d2ba699c45bbf05dfbf revision: 31810a9548fcede48be099fc9823fd2710616d64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.438890) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.439363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.439637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.464096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.464441) ========= 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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-03-31 12:31:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.07M=0.001s 2017-03-31 12:31:01 (8.07 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.612066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.612388) ========= 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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.022399 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:01.660953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 12:31:01.661321) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31810a9548fcede48be099fc9823fd2710616d64 --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 31810a9548fcede48be099fc9823fd2710616d64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-03-31 12:31:01,752 truncating revision to first 12 chars 2017-03-31 12:31:01,753 Setting DEBUG logging. 2017-03-31 12:31:01,753 attempt 1/10 2017-03-31 12:31:01,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31810a9548fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 12:31:02,957 unpacking tar archive at: mozilla-central-31810a9548fc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 12:31:03.153831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:03.154133) ========= script_repo_revision: 31810a9548fcede48be099fc9823fd2710616d64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:03.154543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:03.154807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 12:31:03.174741) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 12:31:03.175129) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:31:03 INFO - MultiFileLogger online at 20170331 12:31:03 in /builds/slave/test 12:31:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:31:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:31:03 INFO - {'append_to_log': False, 12:31:03 INFO - 'base_work_dir': '/builds/slave/test', 12:31:03 INFO - 'blob_upload_branch': 'Firefox', 12:31:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:31:03 INFO - 'branch': 'Firefox', 12:31:03 INFO - 'buildbot_json_path': 'buildprops.json', 12:31:03 INFO - 'config_files': ('talos/mac_config.py',), 12:31:03 INFO - 'default_actions': ('clobber', 12:31:03 INFO - 'read-buildbot-config', 12:31:03 INFO - 'download-and-extract', 12:31:03 INFO - 'populate-webroot', 12:31:03 INFO - 'create-virtualenv', 12:31:03 INFO - 'install', 12:31:03 INFO - 'run-tests'), 12:31:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:31:03 INFO - 'download_minidump_stackwalk': True, 12:31:03 INFO - 'download_symbols': 'ondemand', 12:31:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:31:03 INFO - 'tooltool.py': '/tools/tooltool.py', 12:31:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:31:03 INFO - '/tools/misc-python/virtualenv.py')}, 12:31:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:31:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:31:03 INFO - 'gecko_profile': False, 12:31:03 INFO - 'gecko_profile_interval': 0, 12:31:03 INFO - 'installer_path': 'installer.exe', 12:31:03 INFO - 'log_level': 'info', 12:31:03 INFO - 'log_name': 'talos', 12:31:03 INFO - 'log_to_console': True, 12:31:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:31:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:31:03 INFO - 'opt_config_files': (), 12:31:03 INFO - 'pip_index': False, 12:31:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:31:03 INFO - 'cmd': ('bash', 12:31:03 INFO - '-c', 12:31:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:31:03 INFO - 'enabled': True, 12:31:03 INFO - 'halt_on_failure': False, 12:31:03 INFO - 'name': 'check_screen_resolution'},), 12:31:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:31:03 INFO - 'cmd': ('bash', 12:31:03 INFO - '-c', 12:31:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:31:03 INFO - 'enabled': True, 12:31:03 INFO - 'halt_on_failure': False, 12:31:03 INFO - 'name': 'check_screen_resolution'},), 12:31:03 INFO - 'run_cmd_checks_enabled': True, 12:31:03 INFO - 'suite': 'dromaeojs-e10s', 12:31:03 INFO - 'system_bits': '32', 12:31:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:31:03 INFO - 'title': 't-yosemite-r7-0363', 12:31:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:31:03 INFO - 'use_talos_json': True, 12:31:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:31:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:31:03 INFO - 'work_dir': 'build'} 12:31:03 INFO - [mozharness: 2017-03-31 19:31:03.383055Z] Running clobber step. 12:31:03 INFO - Running pre-action listener: _resource_record_pre_action 12:31:03 INFO - Running main action method: clobber 12:31:03 INFO - rmtree: /builds/slave/test/build 12:31:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:31:05 INFO - Running post-action listener: _resource_record_post_action 12:31:05 INFO - [mozharness: 2017-03-31 19:31:05.358824Z] Finished clobber step (success) 12:31:05 INFO - [mozharness: 2017-03-31 19:31:05.359007Z] Running read-buildbot-config step. 12:31:05 INFO - Running pre-action listener: _resource_record_pre_action 12:31:05 INFO - Running main action method: read_buildbot_config 12:31:05 INFO - Using buildbot properties: 12:31:05 INFO - { 12:31:05 INFO - "project": "", 12:31:05 INFO - "product": "firefox", 12:31:05 INFO - "script_repo_revision": "production", 12:31:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:31:05 INFO - "repository": "", 12:31:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:31:05 INFO - "buildid": "20170331111022", 12:31:05 INFO - "pgo_build": "False", 12:31:05 INFO - "basedir": "/builds/slave/test", 12:31:05 INFO - "buildnumber": 8, 12:31:05 INFO - "slavename": "t-yosemite-r7-0363", 12:31:05 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:31:05 INFO - "platform": "yosemite_r7", 12:31:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:31:05 INFO - "branch": "mozilla-central", 12:31:05 INFO - "repo_path": "mozilla-central", 12:31:05 INFO - "revision": "31810a9548fcede48be099fc9823fd2710616d64", 12:31:05 INFO - "stage_platform": "macosx64", 12:31:05 INFO - "builduid": "f9b63e8f0b4b4d2ba699c45bbf05dfbf", 12:31:05 INFO - "slavebuilddir": "test" 12:31:05 INFO - } 12:31:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:31:05 INFO - Running post-action listener: _resource_record_post_action 12:31:05 INFO - [mozharness: 2017-03-31 19:31:05.362388Z] Finished read-buildbot-config step (success) 12:31:05 INFO - [mozharness: 2017-03-31 19:31:05.362529Z] Running download-and-extract step. 12:31:05 INFO - Running pre-action listener: _resource_record_pre_action 12:31:05 INFO - Running main action method: download_and_extract 12:31:05 INFO - mkdir: /builds/slave/test/build/tests 12:31:05 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')]} 12:31:05 INFO - trying https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:31:05 INFO - Downloading https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:06 INFO - Downloaded 1325 bytes. 12:31:06 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:31:06 INFO - Using the following test package requirements: 12:31:06 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:31:06 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:31:06 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:31:06 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:31:06 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'jsshell-mac.zip'], 12:31:06 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:31:06 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:31:06 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:31:06 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:31:06 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:31:06 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:31:06 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:31:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:31:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:31:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:31:06 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:31:07 INFO - Expected file size: 52508085 12:31:07 INFO - Obtained file size: 52508085 12:31:23 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 12:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:31:26 INFO - Expected file size: 52508085 12:31:26 INFO - Obtained file size: 52508085 12:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:31:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:31:43 INFO - Expected file size: 14404152 12:31:43 INFO - Obtained file size: 14404152 12:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:43 INFO - trying https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/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 12:31:45 INFO - Downloaded 75600229 bytes. 12:31:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:45 INFO - mkdir: /builds/slave/test/properties 12:31:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:31:45 INFO - Writing to file /builds/slave/test/properties/build_url 12:31:45 INFO - Contents: 12:31:45 INFO - build_url:https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:31:46 INFO - Running post-action listener: _resource_record_post_action 12:31:46 INFO - Running post-action listener: set_extra_try_arguments 12:31:46 INFO - [mozharness: 2017-03-31 19:31:46.253917Z] Finished download-and-extract step (success) 12:31:46 INFO - [mozharness: 2017-03-31 19:31:46.254041Z] Running populate-webroot step. 12:31:46 INFO - Running pre-action listener: _resource_record_pre_action 12:31:46 INFO - Running main action method: populate_webroot 12:31:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:46 INFO - '--tppagecycles', 12:31:46 INFO - '7'], 12:31:46 INFO - 'tests': ['tsvgm']}}, 12:31:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:31:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:31:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:31:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['damp', 'tps']}, 12:31:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'tests': ['damp', 'tps']}, 12:31:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['dromaeo_dom']}, 12:31:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['basic_compositor_video']}, 12:31:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:31:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'other-e10s': {'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['a11yr', 12:31:46 INFO - 'ts_paint', 12:31:46 INFO - 'tpaint', 12:31:46 INFO - 'sessionrestore', 12:31:46 INFO - 'sessionrestore_no_auto_restore', 12:31:46 INFO - 'tabpaint']}, 12:31:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['tsvgx', 12:31:46 INFO - 'tsvgr_opacity', 12:31:46 INFO - 'tart', 12:31:46 INFO - 'tscrollx', 12:31:46 INFO - 'cart', 12:31:46 INFO - 'tsvg_static']}, 12:31:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:31:46 INFO - 'tsvgr_opacity', 12:31:46 INFO - 'tart', 12:31:46 INFO - 'tscrollx', 12:31:46 INFO - 'cart', 12:31:46 INFO - 'tsvg_static']}, 12:31:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'talos_options': ['--disable-e10s'], 12:31:46 INFO - 'tests': ['tp5o']}, 12:31:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:31:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'talos_options': ['--disable-e10s', 12:31:46 INFO - '--xperf_path', 12:31:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:46 INFO - 'tests': ['tp5n']}, 12:31:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:31:46 INFO - 'talos_options': ['--xperf_path', 12:31:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:46 INFO - 'tests': ['tp5n']}}, 12:31:46 INFO - 'talos.zip': {'path': '', 12:31:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:46 INFO - Running post-action listener: _resource_record_post_action 12:31:46 INFO - [mozharness: 2017-03-31 19:31:46.272458Z] Finished populate-webroot step (success) 12:31:46 INFO - [mozharness: 2017-03-31 19:31:46.272587Z] Running create-virtualenv step. 12:31:46 INFO - Running pre-action listener: _resource_record_pre_action 12:31:46 INFO - Running main action method: create_virtualenv 12:31:46 INFO - Creating virtualenv /builds/slave/test/build/venv 12:31:46 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 12:31:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:31:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:46 INFO - Using real prefix '/tools/python27' 12:31:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:31:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:49 INFO - Installing pip.................done. 12:31:49 INFO - Return code: 0 12:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:31:50 INFO - Reading from file tmpfile_stdout 12:31:50 INFO - Output received: 12:31:50 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) 12:31:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:50 INFO - 'HOME': '/Users/cltbld', 12:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:50 INFO - 'LOGNAME': 'cltbld', 12:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:50 INFO - 'MOZ_NO_REMOTE': '1', 12:31:50 INFO - 'NO_EM_RESTART': '1', 12:31:50 INFO - 'PAGER': '/bin/cat', 12:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:50 INFO - 'PWD': '/builds/slave/test', 12:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:50 INFO - 'SHELL': '/bin/bash', 12:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:31:50 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:50 INFO - 'USER': 'cltbld', 12:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:50 INFO - 'XPC_FLAGS': '0x0', 12:31:50 INFO - 'XPC_SERVICE_NAME': '0', 12:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:50 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 12:31:50 INFO - Cleaning up... 12:31:50 INFO - Return code: 0 12:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:50 INFO - 'HOME': '/Users/cltbld', 12:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:50 INFO - 'LOGNAME': 'cltbld', 12:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:50 INFO - 'MOZ_NO_REMOTE': '1', 12:31:50 INFO - 'NO_EM_RESTART': '1', 12:31:50 INFO - 'PAGER': '/bin/cat', 12:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:50 INFO - 'PWD': '/builds/slave/test', 12:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:50 INFO - 'SHELL': '/bin/bash', 12:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:31:50 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:50 INFO - 'USER': 'cltbld', 12:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:50 INFO - 'XPC_FLAGS': '0x0', 12:31:50 INFO - 'XPC_SERVICE_NAME': '0', 12:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:50 INFO - Downloading/unpacking psutil>=3.1.1 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:54 INFO - Installing collected packages: psutil 12:31:54 INFO - Running setup.py install for psutil 12:31:54 INFO - building 'psutil._psutil_osx' extension 12:31:54 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 12:31:54 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 12:31:54 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 12:31:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:31:54 INFO - building 'psutil._psutil_posix' extension 12:31:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:31:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:31:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:31:54 INFO - ^ 12:31:54 INFO - 1 warning generated. 12:31:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:55 INFO - Successfully installed psutil 12:31:55 INFO - Cleaning up... 12:31:55 INFO - Return code: 0 12:31:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:31: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 mozsystemmonitor==0.3 12:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:55 INFO - 'HOME': '/Users/cltbld', 12:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:55 INFO - 'LOGNAME': 'cltbld', 12:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:55 INFO - 'MOZ_NO_REMOTE': '1', 12:31:55 INFO - 'NO_EM_RESTART': '1', 12:31:55 INFO - 'PAGER': '/bin/cat', 12:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:55 INFO - 'PWD': '/builds/slave/test', 12:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:55 INFO - 'SHELL': '/bin/bash', 12:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:31:55 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:55 INFO - 'USER': 'cltbld', 12:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:55 INFO - 'XPC_FLAGS': '0x0', 12:31:55 INFO - 'XPC_SERVICE_NAME': '0', 12:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:31:55 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 12:31:55 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 12:31:55 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 12:31:55 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 12:31:55 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 12:31:55 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 12:31:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:31:58 INFO - Installing collected packages: mozsystemmonitor 12:31:58 INFO - Running setup.py install for mozsystemmonitor 12:31:58 INFO - Successfully installed mozsystemmonitor 12:31:58 INFO - Cleaning up... 12:31:58 INFO - Return code: 0 12:31:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:31:58 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')]} 12:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:58 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')]} 12:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:59 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:31:59 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 12:31:59 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 12:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:59 INFO - 'HOME': '/Users/cltbld', 12:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:59 INFO - 'LOGNAME': 'cltbld', 12:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:59 INFO - 'MOZ_NO_REMOTE': '1', 12:31:59 INFO - 'NO_EM_RESTART': '1', 12:31:59 INFO - 'PAGER': '/bin/cat', 12:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:59 INFO - 'PWD': '/builds/slave/test', 12:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:59 INFO - 'SHELL': '/bin/bash', 12:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:31:59 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:59 INFO - 'USER': 'cltbld', 12:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:59 INFO - 'XPC_FLAGS': '0x0', 12:31:59 INFO - 'XPC_SERVICE_NAME': '0', 12:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:59 INFO - Downloading/unpacking jsonschema==2.5.1 12:31:59 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 12:31:59 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 12:31:59 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 12:31:59 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 12:31:59 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 12:31:59 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 12:32:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:32:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:32:02 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 12:32:02 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 12:32:02 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 12:32:02 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 12:32:02 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 12:32:02 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 12:32:02 INFO - Downloading functools32-3.2.3-2.tar.gz 12:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:32:02 INFO - warning: no files found matching '*.txt' 12:32:03 INFO - no previously-included directories found matching 'build' 12:32:03 INFO - no previously-included directories found matching 'dist' 12:32:03 INFO - no previously-included directories found matching '.git*' 12:32:03 INFO - Installing collected packages: jsonschema, functools32 12:32:03 INFO - Running setup.py install for functools32 12:32:03 INFO - warning: no files found matching '*.txt' 12:32:03 INFO - no previously-included directories found matching 'build' 12:32:03 INFO - no previously-included directories found matching 'dist' 12:32:03 INFO - no previously-included directories found matching '.git*' 12:32:03 INFO - Successfully installed jsonschema functools32 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:32:03 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')]} 12:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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')]} 12:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:03 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 12:32:03 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 12:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:03 INFO - 'HOME': '/Users/cltbld', 12:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:03 INFO - 'LOGNAME': 'cltbld', 12:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:03 INFO - 'MOZ_NO_REMOTE': '1', 12:32:03 INFO - 'NO_EM_RESTART': '1', 12:32:03 INFO - 'PAGER': '/bin/cat', 12:32:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:03 INFO - 'PWD': '/builds/slave/test', 12:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:03 INFO - 'SHELL': '/bin/bash', 12:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:03 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:03 INFO - 'USER': 'cltbld', 12:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:03 INFO - 'XPC_FLAGS': '0x0', 12:32:03 INFO - 'XPC_SERVICE_NAME': '0', 12:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:32:03 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')]} 12:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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')]} 12:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:03 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 12:32:03 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 12:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:03 INFO - 'HOME': '/Users/cltbld', 12:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:03 INFO - 'LOGNAME': 'cltbld', 12:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:03 INFO - 'MOZ_NO_REMOTE': '1', 12:32:03 INFO - 'NO_EM_RESTART': '1', 12:32:03 INFO - 'PAGER': '/bin/cat', 12:32:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:03 INFO - 'PWD': '/builds/slave/test', 12:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:03 INFO - 'SHELL': '/bin/bash', 12:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:03 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:03 INFO - 'USER': 'cltbld', 12:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:03 INFO - 'XPC_FLAGS': '0x0', 12:32:03 INFO - 'XPC_SERVICE_NAME': '0', 12:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:03 INFO - Downloading/unpacking blobuploader==1.2.4 12:32:03 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 12:32:03 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 12:32:03 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 12:32:03 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 12:32:03 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 12:32:03 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 12:32:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:32:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:32:06 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 12:32:06 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 12:32:06 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 12:32:06 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 12:32:06 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 12:32:06 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 12:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:32:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:32:07 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 12:32:07 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 12:32:07 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 12:32:07 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 12:32:07 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 12:32:07 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 12:32:07 INFO - Downloading docopt-0.6.1.tar.gz 12:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:32:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:32:07 INFO - Running setup.py install for blobuploader 12:32:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:32:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:32:07 INFO - Running setup.py install for requests 12:32:08 INFO - Running setup.py install for docopt 12:32:08 INFO - Successfully installed blobuploader requests docopt 12:32:08 INFO - Cleaning up... 12:32:08 INFO - Return code: 0 12:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:08 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')]} 12:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:08 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')]} 12:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:08 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:08 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 12:32:08 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 12:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:08 INFO - 'HOME': '/Users/cltbld', 12:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:08 INFO - 'LOGNAME': 'cltbld', 12:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:08 INFO - 'MOZ_NO_REMOTE': '1', 12:32:08 INFO - 'NO_EM_RESTART': '1', 12:32:08 INFO - 'PAGER': '/bin/cat', 12:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:08 INFO - 'PWD': '/builds/slave/test', 12:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:08 INFO - 'SHELL': '/bin/bash', 12:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:08 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:08 INFO - 'USER': 'cltbld', 12:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:08 INFO - 'XPC_FLAGS': '0x0', 12:32:08 INFO - 'XPC_SERVICE_NAME': '0', 12:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:08 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-YUtAHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-0lieci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-xX4Oqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-3FGyip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-EH2Lih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ruNAQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-BUKrUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-YzYHN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-XDSw6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-2iCOZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:09 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-5iN9gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-pZ755I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-QZOxx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-3MOBi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-TO7Kbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-JFRick-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:10 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-zFtHbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:32:10 INFO - Running setup.py install for manifestparser 12:32:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:32:10 INFO - Running setup.py install for mozcrash 12:32:10 INFO - Running setup.py install for mozdebug 12:32:11 INFO - Running setup.py install for mozdevice 12:32:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Running setup.py install for mozfile 12:32:11 INFO - Running setup.py install for mozhttpd 12:32:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Running setup.py install for mozinfo 12:32:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Running setup.py install for mozInstall 12:32:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:32:11 INFO - Running setup.py install for mozleak 12:32:11 INFO - Running setup.py install for mozlog 12:32:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Running setup.py install for moznetwork 12:32:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Running setup.py install for mozprocess 12:32:12 INFO - Running setup.py install for mozprofile 12:32:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Running setup.py install for mozrunner 12:32:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:32:12 INFO - Running setup.py install for mozscreenshot 12:32:12 INFO - Running setup.py install for moztest 12:32:13 INFO - Running setup.py install for mozversion 12:32:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:32:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:32:13 INFO - Cleaning up... 12:32:13 INFO - Return code: 0 12:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:13 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:13 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 12:32:13 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 12:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:13 INFO - 'HOME': '/Users/cltbld', 12:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:13 INFO - 'LOGNAME': 'cltbld', 12:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:13 INFO - 'MOZ_NO_REMOTE': '1', 12:32:13 INFO - 'NO_EM_RESTART': '1', 12:32:13 INFO - 'PAGER': '/bin/cat', 12:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:13 INFO - 'PWD': '/builds/slave/test', 12:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:13 INFO - 'SHELL': '/bin/bash', 12:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:13 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:13 INFO - 'USER': 'cltbld', 12:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:13 INFO - 'XPC_FLAGS': '0x0', 12:32:13 INFO - 'XPC_SERVICE_NAME': '0', 12:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-93O9Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:13 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)) 12:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-hEA1nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:13 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)) 12:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-2xvK35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:13 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)) 12:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-9kBZVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-YXLXDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-2fJ6Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-xFbA_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-6sSTHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Y4Yabw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-7l8xtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-TNmW9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-umK0cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-_6TJ7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:14 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)) 12:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:14 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-doYzEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:15 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)) 12:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:15 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-4WgIvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:15 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)) 12:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:15 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-bpSPWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:15 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)) 12:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:15 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-tYyudD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:15 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)) 12:32:15 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)) 12:32:15 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)) 12:32:15 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)) 12:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:15 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 12:32:17 INFO - Downloading blessings-1.6.tar.gz 12:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:32:18 INFO - Installing collected packages: blessings 12:32:18 INFO - Running setup.py install for blessings 12:32:18 INFO - Successfully installed blessings 12:32:18 INFO - Cleaning up... 12:32:18 INFO - Return code: 0 12:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:18 INFO - Reading from file tmpfile_stdout 12:32:18 INFO - Current package versions: 12:32:18 INFO - blessings == 1.6 12:32:18 INFO - blobuploader == 1.2.4 12:32:18 INFO - docopt == 0.6.1 12:32:18 INFO - functools32 == 3.2.3-2 12:32:18 INFO - jsonschema == 2.5.1 12:32:18 INFO - manifestparser == 1.1 12:32:18 INFO - mozInstall == 1.12 12:32:18 INFO - mozcrash == 1.0 12:32:18 INFO - mozdebug == 0.1 12:32:18 INFO - mozdevice == 0.49 12:32:18 INFO - mozfile == 1.2 12:32:18 INFO - mozhttpd == 0.7 12:32:18 INFO - mozinfo == 0.9 12:32:18 INFO - mozleak == 0.1 12:32:18 INFO - mozlog == 3.4 12:32:18 INFO - moznetwork == 0.27 12:32:18 INFO - mozprocess == 0.25 12:32:18 INFO - mozprofile == 0.28 12:32:18 INFO - mozrunner == 6.13 12:32:18 INFO - mozscreenshot == 0.1 12:32:18 INFO - mozsystemmonitor == 0.3 12:32:18 INFO - moztest == 0.8 12:32:18 INFO - mozversion == 1.4 12:32:18 INFO - psutil == 3.1.1 12:32:18 INFO - requests == 1.2.3 12:32:18 INFO - wsgiref == 0.1.2 12:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32: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')]} 12:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32: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')]} 12:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:18 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 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:18 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 12:32:18 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 12:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:18 INFO - 'HOME': '/Users/cltbld', 12:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:18 INFO - 'LOGNAME': 'cltbld', 12:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:18 INFO - 'MOZ_NO_REMOTE': '1', 12:32:18 INFO - 'NO_EM_RESTART': '1', 12:32:18 INFO - 'PAGER': '/bin/cat', 12:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:18 INFO - 'PWD': '/builds/slave/test', 12:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:18 INFO - 'SHELL': '/bin/bash', 12:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:18 INFO - 'USER': 'cltbld', 12:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:18 INFO - 'XPC_FLAGS': '0x0', 12:32:18 INFO - 'XPC_SERVICE_NAME': '0', 12:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:18 INFO - Cleaning up... 12:32:18 INFO - Return code: 0 12:32:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:32: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')]} 12:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32: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')]} 12:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10847bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe925b0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, '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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 12:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:18 INFO - 'HOME': '/Users/cltbld', 12:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:18 INFO - 'LOGNAME': 'cltbld', 12:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:18 INFO - 'MOZ_NO_REMOTE': '1', 12:32:18 INFO - 'NO_EM_RESTART': '1', 12:32:18 INFO - 'PAGER': '/bin/cat', 12:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:18 INFO - 'PWD': '/builds/slave/test', 12:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:18 INFO - 'SHELL': '/bin/bash', 12:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:18 INFO - 'USER': 'cltbld', 12:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:18 INFO - 'XPC_FLAGS': '0x0', 12:32:18 INFO - 'XPC_SERVICE_NAME': '0', 12:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:32:19 INFO - Cleaning up... 12:32:19 INFO - Return code: 0 12:32:19 INFO - Running post-action listener: _resource_record_post_action 12:32:19 INFO - Running post-action listener: _start_resource_monitoring 12:32:19 INFO - Starting resource monitoring. 12:32:19 INFO - [mozharness: 2017-03-31 19:32:19.145278Z] Finished create-virtualenv step (success) 12:32:19 INFO - [mozharness: 2017-03-31 19:32:19.146238Z] Running install step. 12:32:19 INFO - Running pre-action listener: _resource_record_pre_action 12:32:19 INFO - Running main action method: install 12:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:19 INFO - Reading from file tmpfile_stdout 12:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:32:19 INFO - Reading from file tmpfile_stdout 12:32:19 INFO - Output received: 12:32:19 INFO - Usage: mozinstall [options] installer 12:32:19 INFO - Options: 12:32:19 INFO - -h, --help show this help message and exit 12:32:19 INFO - -d DEST, --destination=DEST 12:32:19 INFO - Directory to install application into. [default: 12:32:19 INFO - "/builds/slave/test"] 12:32:19 INFO - --app=APP Application being installed. [default: firefox] 12:32:19 INFO - mkdir: /builds/slave/test/build/application 12:32:19 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'] 12:32:19 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 12:32:40 INFO - Reading from file tmpfile_stdout 12:32:40 INFO - Output received: 12:32:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:32:40 INFO - Running post-action listener: _resource_record_post_action 12:32:40 INFO - [mozharness: 2017-03-31 19:32:40.310313Z] Finished install step (success) 12:32:40 INFO - [mozharness: 2017-03-31 19:32:40.310461Z] Running run-tests step. 12:32:40 INFO - Running pre-action listener: _resource_record_pre_action 12:32:40 INFO - Running main action method: run_tests 12:32:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:32:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:32:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:32:40 INFO - 2017-03-31 12:32:40.325 screenresolution[1916:15320] starting screenresolution argv=screenresolution get 12:32:40 INFO - 2017-03-31 12:32:40.327 screenresolution[1916:15320] Display 0: 1600x1200x32@60 12:32:40 INFO - 2017-03-31 12:32:40.333 screenresolution[1917:15322] starting screenresolution argv=screenresolution list 12:32:40 INFO - Available Modes on Display 0 12:32:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:32:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:32:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:32:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:32:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:32:40 INFO - Intel Iris: 12:32:40 INFO - Chipset Model: Intel Iris 12:32:40 INFO - Type: GPU 12:32:40 INFO - Bus: Built-In 12:32:40 INFO - VRAM (Dynamic, Max): 1536 MB 12:32:40 INFO - Vendor: Intel (0x8086) 12:32:40 INFO - Device ID: 0x0a2e 12:32:40 INFO - Revision ID: 0x0009 12:32:40 INFO - Displays: 12:32:40 INFO - Display: 12:32:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:32:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:32:40 INFO - Display Serial Number: 1600x1200 60 12:32:40 INFO - Main Display: Yes 12:32:40 INFO - Mirror: Off 12:32:40 INFO - Online: Yes 12:32:40 INFO - Rotation: Supported 12:32:40 INFO - Return code: 0 12:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:32:40 INFO - Python 2.7.3 12:32:40 INFO - Return code: 0 12:32:40 INFO - grabbing minidump binary from tooltool 12:32: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')]} 12:32:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108259d30>, '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 0x108180db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:32:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:32:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:32:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:32:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:32:40 INFO - Return code: 0 12:32:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:32:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:32:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:32:40 INFO - ENV: RUST_BACKTRACE is now 1 12:32:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:32:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0363 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0PYe3G2f2/Render', 12:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:32:40 INFO - 'HOME': '/Users/cltbld', 12:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:32:40 INFO - 'LOGNAME': 'cltbld', 12:32:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:32:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:40 INFO - 'MOZ_NO_REMOTE': '1', 12:32:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:32:40 INFO - 'NO_EM_RESTART': '1', 12:32:40 INFO - 'PAGER': '/bin/cat', 12:32:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:40 INFO - 'PWD': '/builds/slave/test', 12:32:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:32:40 INFO - 'RUST_BACKTRACE': '1', 12:32:40 INFO - 'SHELL': '/bin/bash', 12:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXXGHFF5Tj/Listeners', 12:32:40 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 12:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:32:40 INFO - 'USER': 'cltbld', 12:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:40 INFO - 'XPC_FLAGS': '0x0', 12:32:40 INFO - 'XPC_SERVICE_NAME': '0', 12:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:32:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:32:40 INFO - mozversion application_buildid: 20170331111022 12:32:40 INFO - mozversion application_changeset: 31810a9548fcede48be099fc9823fd2710616d64 12:32:40 INFO - mozversion application_display_name: Nightly 12:32:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:32:40 INFO - mozversion application_name: Firefox 12:32:40 INFO - mozversion application_remotingname: firefox 12:32:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:32:40 INFO - mozversion application_vendor: Mozilla 12:32:40 INFO - mozversion application_version: 55.0a1 12:32:40 INFO - mozversion platform_buildid: 20170331111022 12:32:40 INFO - mozversion platform_changeset: 31810a9548fcede48be099fc9823fd2710616d64 12:32:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:32:40 INFO - mozversion platform_version: 55.0a1 12:32:40 INFO - using testdate: 1490988760 12:32:40 INFO - actual date: 1490988760 12:32:40 INFO - starting webserver on 'localhost:49368' 12:32:40 INFO - SUITE-START | Running 2 tests 12:32:40 INFO - TEST-START | dromaeo_css 12:32:40 INFO - operating with platform_type : mac_ 12:32:40 INFO - Initialising browser for dromaeo_css test... 12:32:40 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpmSjSUh/profile http://localhost:49368/getInfo.html) 12:32:43 INFO - PID 1927 | 2017-03-31 12:32:43.791 plugin-container[1929:15495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c43, name = 'com.apple.tsm.portname' 12:32:43 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:32:43 INFO - PID 1927 | 2017-03-31 12:32:43.797 plugin-container[1929:15495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 12:32:43 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:32:43 INFO - PID 1927 | 2017-03-31 12:32:43.797 plugin-container[1929:15495] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:32:43 INFO - PID 1927 | __metrics Screen width/height:1600/1200 12:32:43 INFO - PID 1927 | colorDepth:24 12:32:43 INFO - PID 1927 | Browser inner width/height: 1024/689 12:32:43 INFO - PID 1927 | __metrics 12:32:43 ERROR - PID 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 12:32:44 INFO - TEST-INFO | 1927: exit 0 12:32:44 INFO - Browser initialized. 12:32:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:32:44 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpmSjSUh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:47 INFO - PID 1930 | 2017-03-31 12:32:47.319 plugin-container[1931:15614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 12:32:47 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:32:47 INFO - PID 1930 | 2017-03-31 12:32:47.319 plugin-container[1931:15614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 12:32:47 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:32:47 INFO - PID 1930 | 2017-03-31 12:32:47.319 plugin-container[1931:15614] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:32:57 INFO - PID 1930 | RSS: Main: 228941824 12:32:57 INFO - PID 1930 | 12:36:00 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49368/tests/dromaeo/cssquery-ext.html) 12:36:02 INFO - PID 1930 | RSS: Main: 256290816 12:36:02 INFO - PID 1930 | 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 12:37:45 INFO - PID 1930 | 12:37:45 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:45 INFO - PID 1930 | Full stack: 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 12:37:45 INFO - PID 1930 | 12:37:45 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:45 INFO - PID 1930 | Full stack: 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 12:37:45 INFO - PID 1930 | 12:37:45 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:45 INFO - PID 1930 | Full stack: 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | ************************* 12:37:45 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 12:37:45 INFO - PID 1930 | 12:37:45 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:37:45 INFO - PID 1930 | Full stack: 12:37:45 INFO - PID 1930 | ************************* 12:39:04 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-ext.html (next: http://localhost:49368/tests/dromaeo/cssquery-jquery.html) 12:39:05 INFO - PID 1930 | RSS: Main: 261079040 12:39:05 INFO - PID 1930 | 12:42:07 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49368/tests/dromaeo/cssquery-mootools.html) 12:42:07 INFO - PID 1930 | RSS: Main: 272187392 12:42:07 INFO - PID 1930 | 12:45:09 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49368/tests/dromaeo/cssquery-prototype.html) 12:45:10 INFO - PID 1930 | RSS: Main: 264585216 12:45:10 INFO - PID 1930 | 12:48:13 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49368/tests/dromaeo/cssquery-yui.html) 12:48:14 INFO - PID 1930 | RSS: Main: 277889024 12:48:14 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-yui.html (next: http://localhost:49368/tests/dromaeo/cssquery-dojo.html) 12:51:17 INFO - PID 1930 | RSS: Main: 271654912 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | __start_tp_report 12:51:17 INFO - PID 1930 | _x_x_mozilla_page_load 12:51:17 INFO - PID 1930 | _x_x_mozilla_page_load_details 12:51:17 INFO - PID 1930 | |i|pagename|runs| 12:51:17 INFO - PID 1930 | |0;dojo.html;3527.629598892116;3530.240998185388;3544.556930383702;3556.2531868307656;3570.1788588624618;5359.7856085756575;6058.454739073482;6154.046122850959;6177.598456100356;6197.070439434087;6102.603330783496;6147.631142131475;6153.230846144232;6245.968770156154;6270.937290627093;5355.973220133894;5404.864878378053;5434.076207044812;5464.781408743665;5507.586930980173;5334.253204551366;5444.7822087116465;5457.617966742329;5473.233747275384;5489.1217405215175;4717.976410117927;5179.04187725272;5387.892242155135;5404.4325345838515;5468.863278418032;5391.78432862685;5394.973025134888;5438.972805135989;5439.347278326587;5485.6982865942355;5376.892462150774;5391.919121213185;5406.729663516848;5407.702576358299;5467.097928841737;5259.8422047338645;6029.8191054268445;6053.51571874249;6141.486007784275;6218.409251121137;6555.311692272338;6631.635260060695;6644.069830223772;6649.202095748493;6652.50106242029;6708.731650733965;6723.966380168117;6727.461803055744;6728.158980127484;6742.359475849787;6147.815565533041;6166.599171053867;6341.143945567382;6373.267074286424;6377.394147555929;6856.588604683735;6892.689828957608;6928.757493487704;6948.513604047769;6973.686184121727;5294.444083371268;6254.74981000764;6379.393957574023;6466.515011374166;6539.247986481616;6479.222493300834;6608.636524991171;6663.100481434944;6745.730170793211;6746.055552222692;6548.1814773153355;6553.41019308255;6568.211814582281;6572.737090516326;6589.17635295588;6311.747530098744;6405.647689377129;6422.775202867971;6566.179227596551;6573.769918052845;5310.415854256029;5310.548603368757;5334.386545547234;5337.893242135136;5368.7047212403695;4699.436067671902;4708.340832283483;4717.009428020086;4719.882002949954;4774.737389443544;6207.224096987877;6304.085907543381;6372.872542549123;6413.583117097373;6419.679016049179;6646.96676516624;6689.665516724242;6721.1262535871;6737.797866064026;6739.629320387327;5156.4070131935305;6371.267304259976;6376.776812811529;6381.23425188971;6382.680865956683;5719.971400143056;5862.325832529228;5880.323762767251;5881.470667639933;5897.67562784051;5738.942610573841;6715.966420167868;6840.3501667341525;6932.202796678446;6943.236244013054;6019.307779605401;6202.782902598387;6679.9332006679315;6687.264400915798;6721.529492935643;6127.785527506516;6812.863742725217;6832.555883867532;6858.074159988537;6892.517523773287;6343.809685709436;6436.13112229843;6513.3161018094315;6517;6575.243846957661;6736.5958042517605;6748.932510675027;6755.594664320157;6756;6776.254611992776;5449.509544141047;6091.573589848668;6269.404406581368;6310.6213627182515;6514.1531600891585;5486.286782718221;6362.586431881913;6419.325970773189;6489.707963141575;6507.707153178213;6292.811215663537;6342.270638876404;6359.586626869239;6373.171487706569;6402.903956440564;6389.680515974275;6394.968025159845;6420.6468644225015;6479.384458476626;6482.546221764431;6358.77744278948;6359.491240700825;6368.554201205871;6368.5860419072615;6381 12:51:17 INFO - PID 1930 | |1;ext.html;801.6713147609481;830.88367628532;1099.444780385905;1139.071656599871;1255.2092181925386;37844.43233351498;38778.509934106;38832.80583597085;38936.61063389365;39757.99999999996;38079;38478.807605961934;38498.230035399276;38504;38509.614903850954;6112.297085835142;6240.656763877985;7940.047194336687;8090.1909809018925;8126.75619731409;8422.28410585101;8611.913880861173;8635.43869648474;8650.65397384104;8653.870191947095;8660.65357385707;8664.826703465927;8727.996280427737;8730;8738.126187381275;8627.95686021569;8656.220940115389;8696.347773916981;8698.608562614634;8710.21608055278;7250.4562157837845;8415.368847336475;8423.241908228289;8498.957505212496;8506.404551681384;38353.42469862954;38494.037649058715;38497;38536.61463385386;38569.80715096435;2988.970110298891;2997.4005198960294;3013.1976862946362;3032.5906002689794;3044.5128779395413;27436.325699190824;27467.188602199625;27787;27894.16317510478;28493.287667808265;2758.586212068206;2793.399419124898;2795.077624383948;2812.479691257124;2832.277769168849;312305.43847280846;315091;315511;315516;316014;39908.20183596312;40822.775316740546;48502.75748621305;49533.50466495361;50102;51473;51599.74200128976;51655;51713.70715732137;51789.7410512945;14198.929005354907;14283;14308.427662893368;14310.212938288287;14354.354054067591;11405.201635885409;11443.542258309575;11549.595764148215;11610.88389116115;11621.360825154528;12305.953993910618;12323.383830808423;12332.136750427384;12393.380330983415;12447.93776031132;4776.976115119472;5687.630304030307;5737.799177028784;5739.598228123991;5752.108423194411;960.8846938367441;983.9754006149903;987.6543209876486;991.0733464210986;1019.4240254256322;20651.4837129073;23925;24088.397790055387;24128.63807042896;24184.153554625504;1051.2431049644244;1084.6095405653957;1091.8416829559828;1124.4939777100337;1127.515168477546;9630.518474076269;10962.903709629132;11183;12312.630621081382;12366.567170149001;425706;426874;427573;428239;428653;54449;54522;54537.45462545403;54603.18095228575;54666.63333416617;1474.4102359056462;1497.9325930333162;1536.5543992242349;1542.4909779772872;1543.6989786991653;21102.47243818917;23412.063517459792;23545.882270588536;23582.528349433258;23618.881905590362;37891.62108378991;37944;38024.239515210094;38109.23781524299;38256.426153607164;310530;426033;426826;427943.44113118184;429685.07047041843;32934.01197963969;32936;33060;33121.33757324888;33200.66799331976;32185.356292873545;41953.95115122147;42334.7883260594;42403;43067;29421.85289073541;29676.70323296826;30142.246443839078;30239;30567.694323056483;29099.05316096311;30120.84939575288;30235.395292094476;30256.09231723052;30501.54247686242;29572.704272956995;35344.469832953044;36059;36165.27669446649;36254;29548.55677164801;30025.249368765955;30219.848900756235;30407.78368865309;30542.694573053985;22376.77623223812;22847.657285141067;23852.642210367205;24401.145959891317;24460.388490287885 12:51:17 INFO - PID 1930 | |2;jquery.html;399.85605182134447;404.9028233224027;413.83860294485174;425.8764958162132;446.3906767262686;19169.6570972887;20685.68971465429;21338.46653833655;21475.57048859022;21579.784202157975;21309.893450532763;21338.57322853542;21672.916354182307;21987.560248795013;22074.11703531861;6072.939270607292;6265.216847894013;6325.715342809562;6326.2092238470195;6327.525435592326;6054.939450605481;6123.387661233885;6153.7538498460235;6161.661108639023;6240.750369985218;6159.661218632973;6168.599041062339;6171.352008039158;6171.629702217859;6188;5425.403205647375;5914.172015917775;6117.4188452097205;6187.535934804908;6397.912354899655;5245.763940622643;5454.972725136388;5502.972485137589;5513.117901135799;5541.085720856054;27186.864065679543;27277.590836137475;27675.72324276772;27709.81337146234;28017.57973630397;2037.7758446570865;2071.0576687607104;2073.7718850926385;2097.318371529259;2147.441665167052;15425.614359641098;16485.83514164855;16600;16733.330666773316;16778.6644267114;1833.2025568877582;1845.4648152035893;1868.2900497810745;1879.3234435603172;1926.3546711851548;109089;122857;131619.34190329083;132204.3389783045;134159;11860.822087668692;12287.508499660093;12322.876771232352;12372.381380930918;12422.937885310515;15840.841591584167;16056.518304450885;16067.11630860314;16113.677726445405;16114;8543.914560854311;8749.825003499895;8772.473651580925;8781.034086250507;8834.29325653959;7188.568685878864;7933.484323518953;8246.958765206136;8413.579321034047;8437.704680336159;7143.571385716874;7418.629068546551;7757.301842834172;7777.733708800984;7939.166387529226;1919.4145785535545;1963.9116239769244;2126.3833488288533;2129.968050479244;2167.425632207466;920.447731361178;928.9303302252358;960.846264597661;963.3064193780467;971.6647756523988;19294.71057934132;20539.281125160847;20653.27713530019;20661.58676826485;20764.896175519025;873.5632183908046;977.8288799460066;1001.8948010458943;1007.1338648762058;1011.6256984915481;10083.747906302402;10572.15422766177;10572.894271057345;10588.523516441779;10755.462226888625;627392;690022;703441;723394;725657.7434225696;140034.59965400214;141224;143053.28473357775;143421;146044.26977865043;1119.7032786311634;1142.7942970265265;1161.3264306702092;1163.1450883600546;1164.9184557081091;17051.14744262757;17750;17777.288908444036;17811.02039387846;18009.639807204043;47815.521844782495;59085.409145907994;59883;59980.10029849468;61543.69228153831;79812;80103.59948200222;81457;82024;83977.74033389382;8183.79540511492;8356.958215208884;8479.491230526188;8822.95588522079;8886.555672216493;11311.434428278717;13428.39572219272;13684.110532815335;14056.578302650936;14079.718405631626;11740.119491038036;11872.46573904159;11904.880951190376;11906.107041971714;12103.455344509342;10593.52329145175;10681.626143084955;10785.838212426977;10898;11088.279261847954;10257.640982565574;11504.022158116653;11829.408529573659;12017.519299227934;12348.629541113782;8295.921530201034;8310.87533686983;8684.869726953975;8845.911540884767;8968.910310896808;11573.305601663928;11617.361045142261;11727.296362218294;11892.524299028288;11996.700082497659 12:51:17 INFO - PID 1930 | |3;mootools.html;1259.2759163480998;1423.629856237378;1434.2971943747566;1441.473862040355;1466.1056755379216;8581.613827377767;10804.72988175294;11130.666080017612;11145.944270278636;11153.72115697108;10739.892601073987;10963;10964;10967.341959482417;10987.780244395108;2381.833271670984;2415.722191947922;2421.5883299838983;2425.1754403502805;2427.5509030829353;2361.5749165150264;2436.3909022744315;2446.3394883381475;2457.8771061446946;2462.532118897404;2328.7089113860766;2354.281944007077;2362.055177928825;2444.4622183119686;2451.6077427611585;2362.8582285062953;2414.5895197816412;2421.3946513371657;2426.9757302427015;2439.512097580491;2330.545543618995;2408.759124087595;2415.6376543518613;2426.0902161689364;2435.2085572189108;10974.286671366415;11017.44912754359;11021.063209627191;11022.228444008922;11074.390908500029;6158.199434073542;6291.245050593912;6359.20509936258;6361.745530178788;6365.077063825719;3935;3975.840966361371;4022.1151346703678;4060.614241647039;4083.4895638045246;1022.3405903192473;1142.9657110286705;1171.4084387384316;1174.7562156281547;1217.190568272098;13699.657508562366;14181.00732948694;14917.552473425814;14959.92520037393;15055.774163387558;4822.68652537584;5109.671485413819;5223.869403264873;5403.675779453245;5428.891422171534;11266.605668801552;11351.659450216506;11400.201985860911;11402;11405.942970285261;6099.329073801879;6205.6586887721605;6267;6285.057241413733;6295.779647712399;5290.074237008585;5370.516653501204;5743.195952566644;5757.625754325955;5810.854728631818;4051.4530538376944;4215;4220.261454245495;4257.169851878916;4272.081502476983;1241.1994263699862;1252.1485389934749;1256.133268045046;1256.604169686546;1275.489804078376;664.9468042556584;754.7320701151123;779.8869163971192;783.9608019598998;812.622130709223;5308.681479111266;5830.82507524775;5846.94153058464;6105.175801266861;6107.7862274821055;517.8291163915899;583.8978178818775;592.4608606168366;604.4227762486814;604.4257954942822;3945.881623551298;4249.787510624456;4254.914901702011;4271.67962402821;4395.494518130392;13242.470301188037;13818.65453363674;13855.515056972958;13860.584182474542;13874;10767.730806729738;11517.654470365902;13592.184468931895;13712.17726936387;13780.035397522277;9988.500574971222;10213.182945364353;10251.077403033614;10263.58945642166;10275.897241027644;6559.311272316338;6583.967080164569;6681.164854393201;6851.897221541781;6856.108705868404;12056;12297.692557686129;12341.197822141532;12361.814572781595;12498.750024999266;10396.376217426978;11939.283642981449;12121;12201.69495762613;12515.624531264077;9864.556094975887;10111.696649100539;10150.34022788546;10156.289059765746;10164.18686505063;9943.651972180938;9969.60121595157;10077.14344280715;10097.040781125781;10109.292349535463;7082.113481109709;8426.073131955358;8482.279006284289;8506.659733610586;8547.95726021366;8187.4678145920325;8243.670253189804;8475.703350382708;8573.056963734109;8695;6884.621345826027;7773.1344477326165;7833.255840695125;7837.843243134991;7860.0960889496155;5951.970240148771;5954.821355359346;5974.6713930732485;5987.401259873977;6020.969895150496;5962.612430192024;6070.666113363631;6111.358307377839;6139.508839292756;6154.907676384947 12:51:17 INFO - PID 1930 | |4;prototype.html;339.7978202969234;396.44101816438825;404.2945060868784;408.94479245301875;414.0704119252279;5973.372795856438;5987.461128498434;6301.779437719681;6404;6432.903506447396;4755.381800365947;6061.181740465036;6195.132681424604;6272.592281501699;6285.811425657226;3937.8818635440985;4669.6731228814;4705.364775755281;4709.62323014158;4726.8581942541605;4524.407726157952;4765.451973023095;4772.618190544766;4777.593904518103;4777.832775852846;4489.775511224442;4580.885477863047;4701.200795864711;4707.399484175379;4718.764061796914;3863.3818589025623;4689.554492323224;4693.28325033341;4700.2009658358165;4703.365045718835;4141.088960428701;4165.396017577435;4171.791410429466;4187.874363769061;4190.937135942963;4932.96407754372;5348.438413966555;5934.744796977164;6028.879422411571;6085.574009819315;5571.665700057969;5590.524805391547;5602.38373778884;5610.803621873215;5612.298462692163;5614.691191984439;5820.476157145878;6663.36698013688;6672.699728512229;6694.464442844561;4139.799458157131;4328.610425061728;4360.280553708634;4392.352867674622;4429.867103986886;5281.36623605166;6199;6995.405390541861;7054.929450705478;7153.749618763319;4142.896427589334;4411.404460397869;4485.116251174514;4494.505604383515;4501.572350626685;4260.808263628144;4561.315802629566;4570.634349252052;4581.381513495702;4600.4479462464715;3559.839807208682;5315.920261196085;5398.460153984649;5422.267993820863;5456.263404440349;5626.330145978828;6657.844140927422;6685.760270309501;6700.363465470772;6726.6636668167375;1325.3240847168013;1377.4903285784123;1553.8135423748997;1560.742477491224;1561.554956837296;964.8552717092352;1022.4765100001093;1027.2501074215716;1028.8456731490337;1040.95836166554;5926;6097.908531372033;6392.808215753535;6397.9929433166335;6405.583637063576;6151.3541078187045;6979.40675042627;6987.161540615057;7008.789736307919;7010.474214433938;5870.0607902735355;5875.735591898375;6050.848728781815;6335.493160547145;6416.326285740023;3387;3584.1577229351083;3589.838457269429;3653.926921461556;3659.602960061164;5601.5238704709745;6790.219124800711;6943.062686537252;7178.425725941912;7271.309225623558;6833.589984600841;7133.251008644122;7219;7227.349538541556;7228.602426866468;6428.5178611604315;7023.578585284797;7146.714131434788;7211.3870321023305;7247.528910620793;7003.844365679606;7010.228874823663;7024.683889224895;7027.613481258375;7059.352742721479;5392.352917649907;6508.9349106508325;6651.301613330724;6809.8638027238185;6920;6710.328967103251;6770.695318710768;6909.654517274217;7123.109611298588;7319.194888562148;4255.744655320691;4454.643628509776;4479.417675702138;4498.797554110008;4507.363192532405;6628.237752658506;6890.483213758888;6940.236573976757;6959.40845028158;6970.65146742671;5897.262842144732;6673.332666733288;6743.494237932076;6760.18877734675;7060.399866011447;5616.522595579258;6341.651209183539;6658.267590564937;6743.29195434492;6763.492738044764;6525.836854078686;6565.277819439762;6569.540132190701;6592.80221593353;6639.236487803964;6123;6325.8734825304155;6712.160979877515;6725.630090345078;6740.696668650021;6439.581427207217;6548.541602087808;6557.377049180321;6564.573302735307;6588.736450541925 12:51:17 INFO - PID 1930 | |5;yui.html;708.7306823407105;737.3437640499959;740.996295018525;742.8848528478085;744.7058411927289;13336;15043.92478037611;15556.222188890566;16013.599660008505;16368;14489.347979340928;14910.627234319147;14962.700745985074;15059.698806023873;15108.773368399483;966.8984756600561;991.3159919655415;996.7209181429175;997.7256254530026;1000.8798944126715;960.2030314838668;999.1607050077934;999.6301368493667;1001.3591301566967;1008.2438171371472;1062.5377960587168;1067.2422579968193;1070.3898777696716;1071.4910417551678;1073.50618715391;1060.7242117049545;1064.7178497698117;1065.4033741104968;1066.1151244467112;1067.1729409707461;788.1448628238368;790.332169316932;792.211749309435;793.7182300283432;794.4637369775436;16201.513954581382;16482.917585412117;16548.669026619402;16675.749863752055;16785.412510562073;13053;14244.857551424457;14646.633834154125;14745.336459859225;14878.181700006495;11745.177837551375;11812.940935295268;11898.762024759542;11917.940410297893;12116.27302361861;2977.211039074647;3030.196997795586;3087.6294844618565;3145.779795414322;3156.0847354267235;114359.42820285929;118967;118994.40502797431;121108;121189.78810211873;11336.773264534662;11464.828027579593;11486.429251229602;11603.361815100081;12078.396080195955;24776.380590485383;25140.622890656654;25191.347254647975;25270.74729252721;25297;7664.961675191588;7852.568108753959;7863.29230369258;7916.247956444128;8069.152738962324;3268.3299923515624;3823.713221508398;3854.8650797221962;3860.749051311656;3899.6880249579967;3198.4722520784276;4138.048248902769;4173.373993900939;4174.102567947906;4182.100848317566;658.2989116590816;786.81903162273;790.1624278265058;795.4630624328671;798.2576204130214;483.6396884321203;542.829008862215;546.4971328845675;572.4275724275724;598.5421152818097;8663.740087797376;9477.383970041925;9733.756656083655;9934.01558726133;10201.285909986229;531.521630532516;572.1617829879164;578.0000598963733;589.7464090441151;603.1736520966305;4443.355713421536;4586.954130458719;4683.906321873612;4734.55021772931;4775.761211939389;90883.54558227299;93147.53426232825;94531;102383;109054.45472772585;81676;82858.58570707108;83003.7549436759;84600;86029;51058;57265.14102288469;63675.3632463688;66638.33744107174;67910.32089679138;9840.458774767456;10689.412082335235;10921.941524294012;10995.780084398108;11131.886811319127;30326.84836575803;38191.80904095462;38505.80747096246;39402;39410.423583056356;51224;51716.44850654486;51811.74094129656;51868.740656296475;52471.73764131308;13426.798598021232;13432.529861455194;13578.796318055434;13940.860591393955;13941.442342306194;14323.57029289123;14372.425102995763;14633.707325853211;14775.630609234855;15030.473933412279;13225.735485290434;13331.3334333281;13420.731585368434;13452.39464224132;13615;13201.405936732677;13367.331633418486;13472.595822125351;13931.721365572834;13999.930000349934;10863.619773307897;13124.212547247196;13275.269860157785;13295;13882.375293112036;9645.461952741465;9698.36960597559;9862;9952.25358098131;10803.135749139892;8327.708530201415;9904.563838243559;10204.591816327264;10368.844467332845;11126.721831954266 12:51:17 INFO - PID 1930 | __end_tp_report 12:51:17 INFO - PID 1930 | __start_cc_report 12:51:17 INFO - PID 1930 | _x_x_mozilla_cycle_collect,431 12:51:17 INFO - PID 1930 | __end_cc_report 12:51:17 INFO - PID 1930 | __startTimestamp1490989877273__endTimestamp 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | ------- Summary: start ------- 12:51:17 INFO - PID 1930 | Number of tests: 6 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#0] dojo.html Cycles:165 Average:6081.01 Median:6359.49 stddev:724.45 (11.4%) stddev-sans-first:698.43 12:51:17 INFO - PID 1930 | Values: 3527.6 3530.2 3544.6 3556.3 3570.2 5359.8 6058.5 6154.0 6177.6 6197.1 6102.6 6147.6 6153.2 6246.0 6270.9 5356.0 5404.9 5434.1 5464.8 5507.6 5334.3 5444.8 5457.6 5473.2 5489.1 4718.0 5179.0 5387.9 5404.4 5468.9 5391.8 5395.0 5439.0 5439.3 5485.7 5376.9 5391.9 5406.7 5407.7 5467.1 5259.8 6029.8 6053.5 6141.5 6218.4 6555.3 6631.6 6644.1 6649.2 6652.5 6708.7 6724.0 6727.5 6728.2 6742.4 6147.8 6166.6 6341.1 6373.3 6377.4 6856.6 6892.7 6928.8 6948.5 6973.7 5294.4 6254.7 6379.4 6466.5 6539.2 6479.2 6608.6 6663.1 6745.7 6746.1 6548.2 6553.4 6568.2 6572.7 6589.2 6311.7 6405.6 6422.8 6566.2 6573.8 5310.4 5310.5 5334.4 5337.9 5368.7 4699.4 4708.3 4717.0 4719.9 4774.7 6207.2 6304.1 6372.9 6413.6 6419.7 6647.0 6689.7 6721.1 6737.8 6739.6 5156.4 6371.3 6376.8 6381.2 6382.7 5720.0 5862.3 5880.3 5881.5 5897.7 5738.9 6716.0 6840.4 6932.2 6943.2 6019.3 6202.8 6679.9 6687.3 6721.5 6127.8 6812.9 6832.6 6858.1 6892.5 6343.8 6436.1 6513.3 6517.0 6575.2 6736.6 6748.9 6755.6 6756.0 6776.3 5449.5 6091.6 6269.4 6310.6 6514.2 5486.3 6362.6 6419.3 6489.7 6507.7 6292.8 6342.3 6359.6 6373.2 6402.9 6389.7 6395.0 6420.6 6479.4 6482.5 6358.8 6359.5 6368.6 6368.6 6381.0 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#1] ext.html Cycles:180 Average:51538.15 Median:34272.57 stddev:102422.29 (298.8%) stddev-sans-first:102638.77 12:51:17 INFO - PID 1930 | Values: 801.7 830.9 1099.4 1139.1 1255.2 37844.4 38778.5 38832.8 38936.6 39758.0 38079.0 38478.8 38498.2 38504.0 38509.6 6112.3 6240.7 7940.0 8090.2 8126.8 8422.3 8611.9 8635.4 8650.7 8653.9 8660.7 8664.8 8728.0 8730.0 8738.1 8628.0 8656.2 8696.3 8698.6 8710.2 7250.5 8415.4 8423.2 8499.0 8506.4 38353.4 38494.0 38497.0 38536.6 38569.8 2989.0 2997.4 3013.2 3032.6 3044.5 27436.3 27467.2 27787.0 27894.2 28493.3 2758.6 2793.4 2795.1 2812.5 2832.3 312305.4 315091.0 315511.0 315516.0 316014.0 39908.2 40822.8 48502.8 49533.5 50102.0 51473.0 51599.7 51655.0 51713.7 51789.7 14198.9 14283.0 14308.4 14310.2 14354.4 11405.2 11443.5 11549.6 11610.9 11621.4 12306.0 12323.4 12332.1 12393.4 12447.9 4777.0 5687.6 5737.8 5739.6 5752.1 960.9 984.0 987.7 991.1 1019.4 20651.5 23925.0 24088.4 24128.6 24184.2 1051.2 1084.6 1091.8 1124.5 1127.5 9630.5 10962.9 11183.0 12312.6 12366.6 425706.0 426874.0 427573.0 428239.0 428653.0 54449.0 54522.0 54537.5 54603.2 54666.6 1474.4 1497.9 1536.6 1542.5 1543.7 21102.5 23412.1 23545.9 23582.5 23618.9 37891.6 37944.0 38024.2 38109.2 38256.4 310530.0 426033.0 426826.0 427943.4 429685.1 32934.0 32936.0 33060.0 33121.3 33200.7 32185.4 41954.0 42334.8 42403.0 43067.0 29421.9 29676.7 30142.2 30239.0 30567.7 29099.1 30120.8 30235.4 30256.1 30501.5 29572.7 35344.5 36059.0 36165.3 36254.0 29548.6 30025.2 30219.8 30407.8 30542.7 22376.8 22847.7 23852.6 24401.1 24460.4 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#2] jquery.html Cycles:180 Average:39047.75 Median:11743.01 stddev:115643.57 (984.8%) stddev-sans-first:115931.57 12:51:17 INFO - PID 1930 | Values: 399.9 404.9 413.8 425.9 446.4 19169.7 20685.7 21338.5 21475.6 21579.8 21309.9 21338.6 21672.9 21987.6 22074.1 6072.9 6265.2 6325.7 6326.2 6327.5 6054.9 6123.4 6153.8 6161.7 6240.8 6159.7 6168.6 6171.4 6171.6 6188.0 5425.4 5914.2 6117.4 6187.5 6397.9 5245.8 5455.0 5503.0 5513.1 5541.1 27186.9 27277.6 27675.7 27709.8 28017.6 2037.8 2071.1 2073.8 2097.3 2147.4 15425.6 16485.8 16600.0 16733.3 16778.7 1833.2 1845.5 1868.3 1879.3 1926.4 109089.0 122857.0 131619.3 132204.3 134159.0 11860.8 12287.5 12322.9 12372.4 12422.9 15840.8 16056.5 16067.1 16113.7 16114.0 8543.9 8749.8 8772.5 8781.0 8834.3 7188.6 7933.5 8247.0 8413.6 8437.7 7143.6 7418.6 7757.3 7777.7 7939.2 1919.4 1963.9 2126.4 2130.0 2167.4 920.4 928.9 960.8 963.3 971.7 19294.7 20539.3 20653.3 20661.6 20764.9 873.6 977.8 1001.9 1007.1 1011.6 10083.7 10572.2 10572.9 10588.5 10755.5 627392.0 690022.0 703441.0 723394.0 725657.7 140034.6 141224.0 143053.3 143421.0 146044.3 1119.7 1142.8 1161.3 1163.1 1164.9 17051.1 17750.0 17777.3 17811.0 18009.6 47815.5 59085.4 59883.0 59980.1 61543.7 79812.0 80103.6 81457.0 82024.0 83977.7 8183.8 8357.0 8479.5 8823.0 8886.6 11311.4 13428.4 13684.1 14056.6 14079.7 11740.1 11872.5 11904.9 11906.1 12103.5 10593.5 10681.6 10785.8 10898.0 11088.3 10257.6 11504.0 11829.4 12017.5 12348.6 8295.9 8310.9 8684.9 8845.9 8968.9 11573.3 11617.4 11727.3 11892.5 11996.7 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#3] mootools.html Cycles:180 Average:6699.43 Median:2445.40 stddev:4099.74 (167.7%) stddev-sans-first:4090.85 12:51:17 INFO - PID 1930 | Values: 1259.3 1423.6 1434.3 1441.5 1466.1 8581.6 10804.7 11130.7 11145.9 11153.7 10739.9 10963.0 10964.0 10967.3 10987.8 2381.8 2415.7 2421.6 2425.2 2427.6 2361.6 2436.4 2446.3 2457.9 2462.5 2328.7 2354.3 2362.1 2444.5 2451.6 2362.9 2414.6 2421.4 2427.0 2439.5 2330.5 2408.8 2415.6 2426.1 2435.2 10974.3 11017.4 11021.1 11022.2 11074.4 6158.2 6291.2 6359.2 6361.7 6365.1 3935.0 3975.8 4022.1 4060.6 4083.5 1022.3 1143.0 1171.4 1174.8 1217.2 13699.7 14181.0 14917.6 14959.9 15055.8 4822.7 5109.7 5223.9 5403.7 5428.9 11266.6 11351.7 11400.2 11402.0 11405.9 6099.3 6205.7 6267.0 6285.1 6295.8 5290.1 5370.5 5743.2 5757.6 5810.9 4051.5 4215.0 4220.3 4257.2 4272.1 1241.2 1252.1 1256.1 1256.6 1275.5 664.9 754.7 779.9 784.0 812.6 5308.7 5830.8 5846.9 6105.2 6107.8 517.8 583.9 592.5 604.4 604.4 3945.9 4249.8 4254.9 4271.7 4395.5 13242.5 13818.7 13855.5 13860.6 13874.0 10767.7 11517.7 13592.2 13712.2 13780.0 9988.5 10213.2 10251.1 10263.6 10275.9 6559.3 6584.0 6681.2 6851.9 6856.1 12056.0 12297.7 12341.2 12361.8 12498.8 10396.4 11939.3 12121.0 12201.7 12515.6 9864.6 10111.7 10150.3 10156.3 10164.2 9943.7 9969.6 10077.1 10097.0 10109.3 7082.1 8426.1 8482.3 8506.7 8548.0 8187.5 8243.7 8475.7 8573.1 8695.0 6884.6 7773.1 7833.3 7837.8 7860.1 5952.0 5954.8 5974.7 5987.4 6021.0 5962.6 6070.7 6111.4 6139.5 6154.9 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#4] prototype.html Cycles:180 Average:5405.64 Median:6008.17 stddev:1710.15 (28.5%) stddev-sans-first:1672.15 12:51:17 INFO - PID 1930 | Values: 339.8 396.4 404.3 408.9 414.1 5973.4 5987.5 6301.8 6404.0 6432.9 4755.4 6061.2 6195.1 6272.6 6285.8 3937.9 4669.7 4705.4 4709.6 4726.9 4524.4 4765.5 4772.6 4777.6 4777.8 4489.8 4580.9 4701.2 4707.4 4718.8 3863.4 4689.6 4693.3 4700.2 4703.4 4141.1 4165.4 4171.8 4187.9 4190.9 4933.0 5348.4 5934.7 6028.9 6085.6 5571.7 5590.5 5602.4 5610.8 5612.3 5614.7 5820.5 6663.4 6672.7 6694.5 4139.8 4328.6 4360.3 4392.4 4429.9 5281.4 6199.0 6995.4 7054.9 7153.7 4142.9 4411.4 4485.1 4494.5 4501.6 4260.8 4561.3 4570.6 4581.4 4600.4 3559.8 5315.9 5398.5 5422.3 5456.3 5626.3 6657.8 6685.8 6700.4 6726.7 1325.3 1377.5 1553.8 1560.7 1561.6 964.9 1022.5 1027.3 1028.8 1041.0 5926.0 6097.9 6392.8 6398.0 6405.6 6151.4 6979.4 6987.2 7008.8 7010.5 5870.1 5875.7 6050.8 6335.5 6416.3 3387.0 3584.2 3589.8 3653.9 3659.6 5601.5 6790.2 6943.1 7178.4 7271.3 6833.6 7133.3 7219.0 7227.3 7228.6 6428.5 7023.6 7146.7 7211.4 7247.5 7003.8 7010.2 7024.7 7027.6 7059.4 5392.4 6508.9 6651.3 6809.9 6920.0 6710.3 6770.7 6909.7 7123.1 7319.2 4255.7 4454.6 4479.4 4498.8 4507.4 6628.2 6890.5 6940.2 6959.4 6970.7 5897.3 6673.3 6743.5 6760.2 7060.4 5616.5 6341.7 6658.3 6743.3 6763.5 6525.8 6565.3 6569.5 6592.8 6639.2 6123.0 6325.9 6712.2 6725.6 6740.7 6439.6 6548.5 6557.4 6564.6 6588.7 12:51:17 INFO - PID 1930 | 12:51:17 INFO - PID 1930 | [#5] yui.html Cycles:180 Average:19439.68 Median:16678.52 stddev:28156.54 (168.8%) stddev-sans-first:28200.40 12:51:17 INFO - PID 1930 | Values: 708.7 737.3 741.0 742.9 744.7 13336.0 15043.9 15556.2 16013.6 16368.0 14489.3 14910.6 14962.7 15059.7 15108.8 966.9 991.3 996.7 997.7 1000.9 960.2 999.2 999.6 1001.4 1008.2 1062.5 1067.2 1070.4 1071.5 1073.5 1060.7 1064.7 1065.4 1066.1 1067.2 788.1 790.3 792.2 793.7 794.5 16201.5 16482.9 16548.7 16675.7 16785.4 13053.0 14244.9 14646.6 14745.3 14878.2 11745.2 11812.9 11898.8 11917.9 12116.3 2977.2 3030.2 3087.6 3145.8 3156.1 114359.4 118967.0 118994.4 121108.0 121189.8 11336.8 11464.8 11486.4 11603.4 12078.4 24776.4 25140.6 25191.3 25270.7 25297.0 7665.0 7852.6 7863.3 7916.2 8069.2 3268.3 3823.7 3854.9 3860.7 3899.7 3198.5 4138.0 4173.4 4174.1 4182.1 658.3 786.8 790.2 795.5 798.3 483.6 542.8 546.5 572.4 598.5 8663.7 9477.4 9733.8 9934.0 10201.3 531.5 572.2 578.0 589.7 603.2 4443.4 4587.0 4683.9 4734.6 4775.8 90883.5 93147.5 94531.0 102383.0 109054.5 81676.0 82858.6 83003.8 84600.0 86029.0 51058.0 57265.1 63675.4 66638.3 67910.3 9840.5 10689.4 10921.9 10995.8 11131.9 30326.8 38191.8 38505.8 39402.0 39410.4 51224.0 51716.4 51811.7 51868.7 52471.7 13426.8 13432.5 13578.8 13940.9 13941.4 14323.6 14372.4 14633.7 14775.6 15030.5 13225.7 13331.3 13420.7 13452.4 13615.0 13201.4 13367.3 13472.6 13931.7 13999.9 10863.6 13124.2 13275.3 13295.0 13882.4 9645.5 9698.4 9862.0 9952.3 10803.1 8327.7 9904.6 10204.6 10368.8 11126.7 12:51:17 INFO - PID 1930 | -------- Summary: end -------- 12:51:17 INFO - PID 1930 | 12:51:17 INFO - TEST-INFO | 1930: exit 0 12:51:17 INFO - TEST-OK | dromaeo_css | took 1117022ms 12:51:17 INFO - TEST-START | kraken 12:51:17 INFO - operating with platform_type : mac_ 12:51:17 INFO - Initialising browser for kraken test... 12:51:17 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpykmPso/profile http://localhost:49368/getInfo.html) 12:51:20 INFO - PID 1937 | 2017-03-31 12:51:20.593 plugin-container[1938:17914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 12:51:20 INFO - PID 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:51:20 INFO - PID 1937 | 2017-03-31 12:51:20.597 plugin-container[1938:17914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 12:51:20 INFO - PID 1937 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:51:20 INFO - PID 1937 | 2017-03-31 12:51:20.597 plugin-container[1938:17914] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:51:20 INFO - PID 1937 | __metrics Screen width/height:1600/1200 12:51:20 INFO - PID 1937 | colorDepth:24 12:51:20 INFO - PID 1937 | Browser inner width/height: 1024/689 12:51:20 INFO - PID 1937 | __metrics 12:51:20 ERROR - PID 1937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 12:51:21 INFO - TEST-INFO | 1937: exit 0 12:51:21 INFO - Browser initialized. 12:51:21 INFO - Running cycle 1/1 for kraken test... 12:51:21 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpykmPso/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:24 INFO - PID 1939 | 2017-03-31 12:51:24.121 plugin-container[1940:18041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882b, name = 'com.apple.tsm.portname' 12:51:24 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:51:24 INFO - PID 1939 | 2017-03-31 12:51:24.122 plugin-container[1940:18041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 12:51:24 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:51:24 INFO - PID 1939 | 2017-03-31 12:51:24.122 plugin-container[1940:18041] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:51:33 INFO - PID 1939 | RSS: Main: 229785600 12:51:33 INFO - PID 1939 | 12:51:36 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection) 12:51:37 INFO - PID 1939 | RSS: Main: 244396032 12:51:37 INFO - PID 1939 | 12:51:40 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-dft) 12:51:40 INFO - PID 1939 | RSS: Main: 252301312 12:51:40 INFO - PID 1939 | 12:51:44 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-fft) 12:51:45 INFO - PID 1939 | RSS: Main: 254558208 12:51:45 INFO - PID 1939 | 12:51:47 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator) 12:51:47 INFO - PID 1939 | RSS: Main: 255520768 12:51:47 INFO - PID 1939 | 12:51:49 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:51:50 INFO - PID 1939 | RSS: Main: 255868928 12:51:50 INFO - PID 1939 | 12:51:53 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom) 12:51:54 INFO - PID 1939 | RSS: Main: 261857280 12:51:54 INFO - PID 1939 | 12:51:57 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:58 INFO - PID 1939 | RSS: Main: 259756032 12:51:58 INFO - PID 1939 | 12:52:01 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial) 12:52:02 INFO - PID 1939 | RSS: Main: 262012928 12:52:02 INFO - PID 1939 | 12:52:03 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:52:04 INFO - PID 1939 | RSS: Main: 262496256 12:52:04 INFO - PID 1939 | 12:52:06 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:52:07 INFO - PID 1939 | RSS: Main: 262406144 12:52:07 INFO - PID 1939 | 12:52:09 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:52:10 INFO - PID 1939 | RSS: Main: 262496256 12:52:10 INFO - PID 1939 | 12:52:13 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:52:14 INFO - PID 1939 | RSS: Main: 262926336 12:52:14 INFO - PID 1939 | 12:52:17 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:52:18 INFO - PID 1939 | RSS: Main: 260935680 12:52:18 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49368/tests/kraken/driver.html?testName=ai-astar) 12:52:20 INFO - PID 1939 | RSS: Main: 264466432 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | __start_tp_report 12:52:20 INFO - PID 1939 | _x_x_mozilla_page_load 12:52:20 INFO - PID 1939 | _x_x_mozilla_page_load_details 12:52:20 INFO - PID 1939 | |i|pagename|runs| 12:52:20 INFO - PID 1939 | |0;ai-astar;108;124;126;124;125;124;124;146;159;126 12:52:20 INFO - PID 1939 | |1;audio-beat-detection;160;114;120;176;156;154;119;116;138;121 12:52:20 INFO - PID 1939 | |2;audio-dft;217;215;301;266;225;222;217;213;211;215 12:52:20 INFO - PID 1939 | |3;audio-fft;94;67;60;86;61;62;62;58;78;62 12:52:20 INFO - PID 1939 | |4;audio-oscillator;94;71;89;75;73;74;86;73;77;125 12:52:20 INFO - PID 1939 | |5;imaging-gaussian-blur;92;94;92;92;123;95;139;140;92;92 12:52:20 INFO - PID 1939 | |6;imaging-darkroom;103;101;105;161;159;126;122;157;162;118 12:52:20 INFO - PID 1939 | |7;imaging-desaturate;102;103;101;163;121;101;100;102;101;157 12:52:20 INFO - PID 1939 | |8;json-parse-financial;52;52;53;50;54;77;46;51;62;48 12:52:20 INFO - PID 1939 | |9;json-stringify-tinderbox;52;90;58;72;82;89;88;59;61;61 12:52:20 INFO - PID 1939 | |10;stanford-crypto-aes;91;90;104;114;112;86;89;80;84;83 12:52:20 INFO - PID 1939 | |11;stanford-crypto-ccm;177;169;174;149;173;167;149;175;217;169 12:52:20 INFO - PID 1939 | |12;stanford-crypto-pbkdf2;200;214;235;199;196;198;191;193;196;248 12:52:20 INFO - PID 1939 | |13;stanford-crypto-sha256-iterative;61;85;104;100;70;73;72;73;72;72 12:52:20 INFO - PID 1939 | __end_tp_report 12:52:20 INFO - PID 1939 | __start_cc_report 12:52:20 INFO - PID 1939 | _x_x_mozilla_cycle_collect,1032 12:52:20 INFO - PID 1939 | __end_cc_report 12:52:20 INFO - PID 1939 | __startTimestamp1490989940249__endTimestamp 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | ------- Summary: start ------- 12:52:20 INFO - PID 1939 | Number of tests: 14 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#0] ai-astar Cycles:10 Average:128.60 Median:125.50 stddev:13.99 (11.2%) stddev-sans-first:12.70 12:52:20 INFO - PID 1939 | Values: 108.0 124.0 126.0 124.0 125.0 124.0 124.0 146.0 159.0 126.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:146.00 stddev:22.46 (15.4%) stddev-sans-first:22.28 12:52:20 INFO - PID 1939 | Values: 160.0 114.0 120.0 176.0 156.0 154.0 119.0 116.0 138.0 121.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#2] audio-dft Cycles:10 Average:230.20 Median:219.50 stddev:29.56 (13.5%) stddev-sans-first:30.96 12:52:20 INFO - PID 1939 | Values: 217.0 215.0 301.0 266.0 225.0 222.0 217.0 213.0 211.0 215.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#3] audio-fft Cycles:10 Average:69.00 Median:64.50 stddev:12.53 (19.4%) stddev-sans-first:9.47 12:52:20 INFO - PID 1939 | Values: 94.0 67.0 60.0 86.0 61.0 62.0 62.0 58.0 78.0 62.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:76.00 stddev:16.50 (21.7%) stddev-sans-first:17.07 12:52:20 INFO - PID 1939 | Values: 94.0 71.0 89.0 75.0 73.0 74.0 86.0 73.0 77.0 125.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:105.10 Median:92.00 stddev:20.47 (22.2%) stddev-sans-first:21.15 12:52:20 INFO - PID 1939 | Values: 92.0 94.0 92.0 92.0 123.0 95.0 139.0 140.0 92.0 92.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#6] imaging-darkroom Cycles:10 Average:131.40 Median:141.50 stddev:25.72 (18.2%) stddev-sans-first:25.15 12:52:20 INFO - PID 1939 | Values: 103.0 101.0 105.0 161.0 159.0 126.0 122.0 157.0 162.0 118.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#7] imaging-desaturate Cycles:10 Average:115.10 Median:102.50 stddev:24.49 (23.9%) stddev-sans-first:25.52 12:52:20 INFO - PID 1939 | Values: 102.0 103.0 101.0 163.0 121.0 101.0 100.0 102.0 101.0 157.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:52.50 stddev:8.97 (17.1%) stddev-sans-first:9.47 12:52:20 INFO - PID 1939 | Values: 52.0 52.0 53.0 50.0 54.0 77.0 46.0 51.0 62.0 48.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:77.00 stddev:14.79 (19.2%) stddev-sans-first:13.96 12:52:20 INFO - PID 1939 | Values: 52.0 90.0 58.0 72.0 82.0 89.0 88.0 59.0 61.0 61.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:85.00 stddev:12.25 (14.4%) stddev-sans-first:12.96 12:52:20 INFO - PID 1939 | Values: 91.0 90.0 104.0 114.0 112.0 86.0 89.0 80.0 84.0 83.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:171.90 Median:173.50 stddev:18.75 (10.8%) stddev-sans-first:19.80 12:52:20 INFO - PID 1939 | Values: 177.0 169.0 174.0 149.0 173.0 167.0 149.0 175.0 217.0 169.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.00 Median:199.50 stddev:19.44 (9.7%) stddev-sans-first:20.46 12:52:20 INFO - PID 1939 | Values: 200.0 214.0 235.0 199.0 196.0 198.0 191.0 193.0 196.0 248.0 12:52:20 INFO - PID 1939 | 12:52:20 INFO - PID 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:72.00 stddev:13.82 (19.2%) stddev-sans-first:13.19 12:52:20 INFO - PID 1939 | Values: 61.0 85.0 104.0 100.0 70.0 73.0 72.0 73.0 72.0 72.0 12:52:20 INFO - PID 1939 | -------- Summary: end -------- 12:52:20 INFO - PID 1939 | 12:52:21 INFO - TEST-INFO | 1939: exit 0 12:52:21 INFO - TEST-OK | kraken | took 63399ms 12:52:21 INFO - SUITE-END | took 1180s 12:52:21 INFO - Completed test suite (00:19:40) 12:52:21 INFO - javascript benchmark 12:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7637.624374134253, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3527.629598892116, 3530.240998185388, 3544.556930383702, 3556.2531868307656, 3570.1788588624618, 5359.7856085756575, 6058.454739073482, 6154.046122850959, 6177.598456100356, 6197.070439434087, 6102.603330783496, 6147.631142131475, 6153.230846144232, 6245.968770156154, 6270.937290627093, 5355.973220133894, 5404.864878378053, 5434.076207044812, 5464.781408743665, 5507.586930980173, 5334.253204551366, 5444.7822087116465, 5457.617966742329, 5473.233747275384, 5489.1217405215175, 4717.976410117927, 5179.04187725272, 5387.892242155135, 5404.4325345838515, 5468.863278418032, 5391.78432862685, 5394.973025134888, 5438.972805135989, 5439.347278326587, 5485.6982865942355, 5376.892462150774, 5391.919121213185, 5406.729663516848, 5407.702576358299, 5467.097928841737, 5259.8422047338645, 6029.8191054268445, 6053.51571874249, 6141.486007784275, 6218.409251121137, 6555.311692272338, 6631.635260060695, 6644.069830223772, 6649.202095748493, 6652.50106242029, 6708.731650733965, 6723.966380168117, 6727.461803055744, 6728.158980127484, 6742.359475849787, 6147.815565533041, 6166.599171053867, 6341.143945567382, 6373.267074286424, 6377.394147555929, 6856.588604683735, 6892.689828957608, 6928.757493487704, 6948.513604047769, 6973.686184121727, 5294.444083371268, 6254.74981000764, 6379.393957574023, 6466.515011374166, 6539.247986481616, 6479.222493300834, 6608.636524991171, 6663.100481434944, 6745.730170793211, 6746.055552222692, 6548.1814773153355, 6553.41019308255, 6568.211814582281, 6572.737090516326, 6589.17635295588, 6311.747530098744, 6405.647689377129, 6422.775202867971, 6566.179227596551, 6573.769918052845, 5310.415854256029, 5310.548603368757, 5334.386545547234, 5337.893242135136, 5368.7047212403695, 4699.436067671902, 4708.340832283483, 4717.009428020086, 4719.882002949954, 4774.737389443544, 6207.224096987877, 6304.085907543381, 6372.872542549123, 6413.583117097373, 6419.679016049179, 6646.96676516624, 6689.665516724242, 6721.1262535871, 6737.797866064026, 6739.629320387327, 5156.4070131935305, 6371.267304259976, 6376.776812811529, 6381.23425188971, 6382.680865956683, 5719.971400143056, 5862.325832529228, 5880.323762767251, 5881.470667639933, 5897.67562784051, 5738.942610573841, 6715.966420167868, 6840.3501667341525, 6932.202796678446, 6943.236244013054, 6019.307779605401, 6202.782902598387, 6679.9332006679315, 6687.264400915798, 6721.529492935643, 6127.785527506516, 6812.863742725217, 6832.555883867532, 6858.074159988537, 6892.517523773287, 6343.809685709436, 6436.13112229843, 6513.3161018094315, 6517.0, 6575.243846957661, 6736.5958042517605, 6748.932510675027, 6755.594664320157, 6756.0, 6776.254611992776, 5449.509544141047, 6091.573589848668, 6269.404406581368, 6310.6213627182515, 6514.1531600891585, 5486.286782718221, 6362.586431881913, 6419.325970773189, 6489.707963141575, 6507.707153178213, 6292.811215663537, 6342.270638876404, 6359.586626869239, 6373.171487706569, 6402.903956440564, 6389.680515974275, 6394.968025159845, 6420.6468644225015, 6479.384458476626, 6482.546221764431, 6358.77744278948, 6359.491240700825, 6368.554201205871, 6368.5860419072615, 6381.0], "value": 6034.598452999861, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6713147609481, 830.88367628532, 1099.444780385905, 1139.071656599871, 1255.2092181925386, 37844.43233351498, 38778.509934106, 38832.80583597085, 38936.61063389365, 39757.99999999996, 38079.0, 38478.807605961934, 38498.230035399276, 38504.0, 38509.614903850954, 6112.297085835142, 6240.656763877985, 7940.047194336687, 8090.1909809018925, 8126.75619731409, 8422.28410585101, 8611.913880861173, 8635.43869648474, 8650.65397384104, 8653.870191947095, 8660.65357385707, 8664.826703465927, 8727.996280427737, 8730.0, 8738.126187381275, 8627.95686021569, 8656.220940115389, 8696.347773916981, 8698.608562614634, 8710.21608055278, 7250.4562157837845, 8415.368847336475, 8423.241908228289, 8498.957505212496, 8506.404551681384, 38353.42469862954, 38494.037649058715, 38497.0, 38536.61463385386, 38569.80715096435, 2988.970110298891, 2997.4005198960294, 3013.1976862946362, 3032.5906002689794, 3044.5128779395413, 27436.325699190824, 27467.188602199625, 27787.0, 27894.16317510478, 28493.287667808265, 2758.586212068206, 2793.399419124898, 2795.077624383948, 2812.479691257124, 2832.277769168849, 312305.43847280846, 315091.0, 315511.0, 315516.0, 316014.0, 39908.20183596312, 40822.775316740546, 48502.75748621305, 49533.50466495361, 50102.0, 51473.0, 51599.74200128976, 51655.0, 51713.70715732137, 51789.7410512945, 14198.929005354907, 14283.0, 14308.427662893368, 14310.212938288287, 14354.354054067591, 11405.201635885409, 11443.542258309575, 11549.595764148215, 11610.88389116115, 11621.360825154528, 12305.953993910618, 12323.383830808423, 12332.136750427384, 12393.380330983415, 12447.93776031132, 4776.976115119472, 5687.630304030307, 5737.799177028784, 5739.598228123991, 5752.108423194411, 960.8846938367441, 983.9754006149903, 987.6543209876486, 991.0733464210986, 1019.4240254256322, 20651.4837129073, 23925.0, 24088.397790055387, 24128.63807042896, 24184.153554625504, 1051.2431049644244, 1084.6095405653957, 1091.8416829559828, 1124.4939777100337, 1127.515168477546, 9630.518474076269, 10962.903709629132, 11183.0, 12312.630621081382, 12366.567170149001, 425706.0, 426874.0, 427573.0, 428239.0, 428653.0, 54449.0, 54522.0, 54537.45462545403, 54603.18095228575, 54666.63333416617, 1474.4102359056462, 1497.9325930333162, 1536.5543992242349, 1542.4909779772872, 1543.6989786991653, 21102.47243818917, 23412.063517459792, 23545.882270588536, 23582.528349433258, 23618.881905590362, 37891.62108378991, 37944.0, 38024.239515210094, 38109.23781524299, 38256.426153607164, 310530.0, 426033.0, 426826.0, 427943.44113118184, 429685.07047041843, 32934.01197963969, 32936.0, 33060.0, 33121.33757324888, 33200.66799331976, 32185.356292873545, 41953.95115122147, 42334.7883260594, 42403.0, 43067.0, 29421.85289073541, 29676.70323296826, 30142.246443839078, 30239.0, 30567.694323056483, 29099.05316096311, 30120.84939575288, 30235.395292094476, 30256.09231723052, 30501.54247686242, 29572.704272956995, 35344.469832953044, 36059.0, 36165.27669446649, 36254.0, 29548.55677164801, 30025.249368765955, 30219.848900756235, 30407.78368865309, 30542.694573053985, 22376.77623223812, 22847.657285141067, 23852.642210367205, 24401.145959891317, 24460.388490287885], "value": 17427.732132087804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.85605182134447, 404.9028233224027, 413.83860294485174, 425.8764958162132, 446.3906767262686, 19169.6570972887, 20685.68971465429, 21338.46653833655, 21475.57048859022, 21579.784202157975, 21309.893450532763, 21338.57322853542, 21672.916354182307, 21987.560248795013, 22074.11703531861, 6072.939270607292, 6265.216847894013, 6325.715342809562, 6326.2092238470195, 6327.525435592326, 6054.939450605481, 6123.387661233885, 6153.7538498460235, 6161.661108639023, 6240.750369985218, 6159.661218632973, 6168.599041062339, 6171.352008039158, 6171.629702217859, 6188.0, 5425.403205647375, 5914.172015917775, 6117.4188452097205, 6187.535934804908, 6397.912354899655, 5245.763940622643, 5454.972725136388, 5502.972485137589, 5513.117901135799, 5541.085720856054, 27186.864065679543, 27277.590836137475, 27675.72324276772, 27709.81337146234, 28017.57973630397, 2037.7758446570865, 2071.0576687607104, 2073.7718850926385, 2097.318371529259, 2147.441665167052, 15425.614359641098, 16485.83514164855, 16600.0, 16733.330666773316, 16778.6644267114, 1833.2025568877582, 1845.4648152035893, 1868.2900497810745, 1879.3234435603172, 1926.3546711851548, 109089.0, 122857.0, 131619.34190329083, 132204.3389783045, 134159.0, 11860.822087668692, 12287.508499660093, 12322.876771232352, 12372.381380930918, 12422.937885310515, 15840.841591584167, 16056.518304450885, 16067.11630860314, 16113.677726445405, 16114.0, 8543.914560854311, 8749.825003499895, 8772.473651580925, 8781.034086250507, 8834.29325653959, 7188.568685878864, 7933.484323518953, 8246.958765206136, 8413.579321034047, 8437.704680336159, 7143.571385716874, 7418.629068546551, 7757.301842834172, 7777.733708800984, 7939.166387529226, 1919.4145785535545, 1963.9116239769244, 2126.3833488288533, 2129.968050479244, 2167.425632207466, 920.447731361178, 928.9303302252358, 960.846264597661, 963.3064193780467, 971.6647756523988, 19294.71057934132, 20539.281125160847, 20653.27713530019, 20661.58676826485, 20764.896175519025, 873.5632183908046, 977.8288799460066, 1001.8948010458943, 1007.1338648762058, 1011.6256984915481, 10083.747906302402, 10572.15422766177, 10572.894271057345, 10588.523516441779, 10755.462226888625, 627392.0, 690022.0, 703441.0, 723394.0, 725657.7434225696, 140034.59965400214, 141224.0, 143053.28473357775, 143421.0, 146044.26977865043, 1119.7032786311634, 1142.7942970265265, 1161.3264306702092, 1163.1450883600546, 1164.9184557081091, 17051.14744262757, 17750.0, 17777.288908444036, 17811.02039387846, 18009.639807204043, 47815.521844782495, 59085.409145907994, 59883.0, 59980.10029849468, 61543.69228153831, 79812.0, 80103.59948200222, 81457.0, 82024.0, 83977.74033389382, 8183.79540511492, 8356.958215208884, 8479.491230526188, 8822.95588522079, 8886.555672216493, 11311.434428278717, 13428.39572219272, 13684.110532815335, 14056.578302650936, 14079.718405631626, 11740.119491038036, 11872.46573904159, 11904.880951190376, 11906.107041971714, 12103.455344509342, 10593.52329145175, 10681.626143084955, 10785.838212426977, 10898.0, 11088.279261847954, 10257.640982565574, 11504.022158116653, 11829.408529573659, 12017.519299227934, 12348.629541113782, 8295.921530201034, 8310.87533686983, 8684.869726953975, 8845.911540884767, 8968.910310896808, 11573.305601663928, 11617.361045142261, 11727.296362218294, 11892.524299028288, 11996.700082497659], "value": 10234.019848642565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.2759163480998, 1423.629856237378, 1434.2971943747566, 1441.473862040355, 1466.1056755379216, 8581.613827377767, 10804.72988175294, 11130.666080017612, 11145.944270278636, 11153.72115697108, 10739.892601073987, 10963.0, 10964.0, 10967.341959482417, 10987.780244395108, 2381.833271670984, 2415.722191947922, 2421.5883299838983, 2425.1754403502805, 2427.5509030829353, 2361.5749165150264, 2436.3909022744315, 2446.3394883381475, 2457.8771061446946, 2462.532118897404, 2328.7089113860766, 2354.281944007077, 2362.055177928825, 2444.4622183119686, 2451.6077427611585, 2362.8582285062953, 2414.5895197816412, 2421.3946513371657, 2426.9757302427015, 2439.512097580491, 2330.545543618995, 2408.759124087595, 2415.6376543518613, 2426.0902161689364, 2435.2085572189108, 10974.286671366415, 11017.44912754359, 11021.063209627191, 11022.228444008922, 11074.390908500029, 6158.199434073542, 6291.245050593912, 6359.20509936258, 6361.745530178788, 6365.077063825719, 3935.0, 3975.840966361371, 4022.1151346703678, 4060.614241647039, 4083.4895638045246, 1022.3405903192473, 1142.9657110286705, 1171.4084387384316, 1174.7562156281547, 1217.190568272098, 13699.657508562366, 14181.00732948694, 14917.552473425814, 14959.92520037393, 15055.774163387558, 4822.68652537584, 5109.671485413819, 5223.869403264873, 5403.675779453245, 5428.891422171534, 11266.605668801552, 11351.659450216506, 11400.201985860911, 11402.0, 11405.942970285261, 6099.329073801879, 6205.6586887721605, 6267.0, 6285.057241413733, 6295.779647712399, 5290.074237008585, 5370.516653501204, 5743.195952566644, 5757.625754325955, 5810.854728631818, 4051.4530538376944, 4215.0, 4220.261454245495, 4257.169851878916, 4272.081502476983, 1241.1994263699862, 1252.1485389934749, 1256.133268045046, 1256.604169686546, 1275.489804078376, 664.9468042556584, 754.7320701151123, 779.8869163971192, 783.9608019598998, 812.622130709223, 5308.681479111266, 5830.82507524775, 5846.94153058464, 6105.175801266861, 6107.7862274821055, 517.8291163915899, 583.8978178818775, 592.4608606168366, 604.4227762486814, 604.4257954942822, 3945.881623551298, 4249.787510624456, 4254.914901702011, 4271.67962402821, 4395.494518130392, 13242.470301188037, 13818.65453363674, 13855.515056972958, 13860.584182474542, 13874.0, 10767.730806729738, 11517.654470365902, 13592.184468931895, 13712.17726936387, 13780.035397522277, 9988.500574971222, 10213.182945364353, 10251.077403033614, 10263.58945642166, 10275.897241027644, 6559.311272316338, 6583.967080164569, 6681.164854393201, 6851.897221541781, 6856.108705868404, 12056.0, 12297.692557686129, 12341.197822141532, 12361.814572781595, 12498.750024999266, 10396.376217426978, 11939.283642981449, 12121.0, 12201.69495762613, 12515.624531264077, 9864.556094975887, 10111.696649100539, 10150.34022788546, 10156.289059765746, 10164.18686505063, 9943.651972180938, 9969.60121595157, 10077.14344280715, 10097.040781125781, 10109.292349535463, 7082.113481109709, 8426.073131955358, 8482.279006284289, 8506.659733610586, 8547.95726021366, 8187.4678145920325, 8243.670253189804, 8475.703350382708, 8573.056963734109, 8695.0, 6884.621345826027, 7773.1344477326165, 7833.255840695125, 7837.843243134991, 7860.0960889496155, 5951.970240148771, 5954.821355359346, 5974.6713930732485, 5987.401259873977, 6020.969895150496, 5962.612430192024, 6070.666113363631, 6111.358307377839, 6139.508839292756, 6154.907676384947], "value": 5073.725907539941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.7978202969234, 396.44101816438825, 404.2945060868784, 408.94479245301875, 414.0704119252279, 5973.372795856438, 5987.461128498434, 6301.779437719681, 6404.0, 6432.903506447396, 4755.381800365947, 6061.181740465036, 6195.132681424604, 6272.592281501699, 6285.811425657226, 3937.8818635440985, 4669.6731228814, 4705.364775755281, 4709.62323014158, 4726.8581942541605, 4524.407726157952, 4765.451973023095, 4772.618190544766, 4777.593904518103, 4777.832775852846, 4489.775511224442, 4580.885477863047, 4701.200795864711, 4707.399484175379, 4718.764061796914, 3863.3818589025623, 4689.554492323224, 4693.28325033341, 4700.2009658358165, 4703.365045718835, 4141.088960428701, 4165.396017577435, 4171.791410429466, 4187.874363769061, 4190.937135942963, 4932.96407754372, 5348.438413966555, 5934.744796977164, 6028.879422411571, 6085.574009819315, 5571.665700057969, 5590.524805391547, 5602.38373778884, 5610.803621873215, 5612.298462692163, 5614.691191984439, 5820.476157145878, 6663.36698013688, 6672.699728512229, 6694.464442844561, 4139.799458157131, 4328.610425061728, 4360.280553708634, 4392.352867674622, 4429.867103986886, 5281.36623605166, 6199.0, 6995.405390541861, 7054.929450705478, 7153.749618763319, 4142.896427589334, 4411.404460397869, 4485.116251174514, 4494.505604383515, 4501.572350626685, 4260.808263628144, 4561.315802629566, 4570.634349252052, 4581.381513495702, 4600.4479462464715, 3559.839807208682, 5315.920261196085, 5398.460153984649, 5422.267993820863, 5456.263404440349, 5626.330145978828, 6657.844140927422, 6685.760270309501, 6700.363465470772, 6726.6636668167375, 1325.3240847168013, 1377.4903285784123, 1553.8135423748997, 1560.742477491224, 1561.554956837296, 964.8552717092352, 1022.4765100001093, 1027.2501074215716, 1028.8456731490337, 1040.95836166554, 5926.0, 6097.908531372033, 6392.808215753535, 6397.9929433166335, 6405.583637063576, 6151.3541078187045, 6979.40675042627, 6987.161540615057, 7008.789736307919, 7010.474214433938, 5870.0607902735355, 5875.735591898375, 6050.848728781815, 6335.493160547145, 6416.326285740023, 3387.0, 3584.1577229351083, 3589.838457269429, 3653.926921461556, 3659.602960061164, 5601.5238704709745, 6790.219124800711, 6943.062686537252, 7178.425725941912, 7271.309225623558, 6833.589984600841, 7133.251008644122, 7219.0, 7227.349538541556, 7228.602426866468, 6428.5178611604315, 7023.578585284797, 7146.714131434788, 7211.3870321023305, 7247.528910620793, 7003.844365679606, 7010.228874823663, 7024.683889224895, 7027.613481258375, 7059.352742721479, 5392.352917649907, 6508.9349106508325, 6651.301613330724, 6809.8638027238185, 6920.0, 6710.328967103251, 6770.695318710768, 6909.654517274217, 7123.109611298588, 7319.194888562148, 4255.744655320691, 4454.643628509776, 4479.417675702138, 4498.797554110008, 4507.363192532405, 6628.237752658506, 6890.483213758888, 6940.236573976757, 6959.40845028158, 6970.65146742671, 5897.262842144732, 6673.332666733288, 6743.494237932076, 6760.18877734675, 7060.399866011447, 5616.522595579258, 6341.651209183539, 6658.267590564937, 6743.29195434492, 6763.492738044764, 6525.836854078686, 6565.277819439762, 6569.540132190701, 6592.80221593353, 6639.236487803964, 6123.0, 6325.8734825304155, 6712.160979877515, 6725.630090345078, 6740.696668650021, 6439.581427207217, 6548.541602087808, 6557.377049180321, 6564.573302735307, 6588.736450541925], "value": 4865.242823495977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.7306823407105, 737.3437640499959, 740.996295018525, 742.8848528478085, 744.7058411927289, 13336.0, 15043.92478037611, 15556.222188890566, 16013.599660008505, 16368.0, 14489.347979340928, 14910.627234319147, 14962.700745985074, 15059.698806023873, 15108.773368399483, 966.8984756600561, 991.3159919655415, 996.7209181429175, 997.7256254530026, 1000.8798944126715, 960.2030314838668, 999.1607050077934, 999.6301368493667, 1001.3591301566967, 1008.2438171371472, 1062.5377960587168, 1067.2422579968193, 1070.3898777696716, 1071.4910417551678, 1073.50618715391, 1060.7242117049545, 1064.7178497698117, 1065.4033741104968, 1066.1151244467112, 1067.1729409707461, 788.1448628238368, 790.332169316932, 792.211749309435, 793.7182300283432, 794.4637369775436, 16201.513954581382, 16482.917585412117, 16548.669026619402, 16675.749863752055, 16785.412510562073, 13053.0, 14244.857551424457, 14646.633834154125, 14745.336459859225, 14878.181700006495, 11745.177837551375, 11812.940935295268, 11898.762024759542, 11917.940410297893, 12116.27302361861, 2977.211039074647, 3030.196997795586, 3087.6294844618565, 3145.779795414322, 3156.0847354267235, 114359.42820285929, 118967.0, 118994.40502797431, 121108.0, 121189.78810211873, 11336.773264534662, 11464.828027579593, 11486.429251229602, 11603.361815100081, 12078.396080195955, 24776.380590485383, 25140.622890656654, 25191.347254647975, 25270.74729252721, 25297.0, 7664.961675191588, 7852.568108753959, 7863.29230369258, 7916.247956444128, 8069.152738962324, 3268.3299923515624, 3823.713221508398, 3854.8650797221962, 3860.749051311656, 3899.6880249579967, 3198.4722520784276, 4138.048248902769, 4173.373993900939, 4174.102567947906, 4182.100848317566, 658.2989116590816, 786.81903162273, 790.1624278265058, 795.4630624328671, 798.2576204130214, 483.6396884321203, 542.829008862215, 546.4971328845675, 572.4275724275724, 598.5421152818097, 8663.740087797376, 9477.383970041925, 9733.756656083655, 9934.01558726133, 10201.285909986229, 531.521630532516, 572.1617829879164, 578.0000598963733, 589.7464090441151, 603.1736520966305, 4443.355713421536, 4586.954130458719, 4683.906321873612, 4734.55021772931, 4775.761211939389, 90883.54558227299, 93147.53426232825, 94531.0, 102383.0, 109054.45472772585, 81676.0, 82858.58570707108, 83003.7549436759, 84600.0, 86029.0, 51058.0, 57265.14102288469, 63675.3632463688, 66638.33744107174, 67910.32089679138, 9840.458774767456, 10689.412082335235, 10921.941524294012, 10995.780084398108, 11131.886811319127, 30326.84836575803, 38191.80904095462, 38505.80747096246, 39402.0, 39410.423583056356, 51224.0, 51716.44850654486, 51811.74094129656, 51868.740656296475, 52471.73764131308, 13426.798598021232, 13432.529861455194, 13578.796318055434, 13940.860591393955, 13941.442342306194, 14323.57029289123, 14372.425102995763, 14633.707325853211, 14775.630609234855, 15030.473933412279, 13225.735485290434, 13331.3334333281, 13420.731585368434, 13452.39464224132, 13615.0, 13201.405936732677, 13367.331633418486, 13472.595822125351, 13931.721365572834, 13999.930000349934, 10863.619773307897, 13124.212547247196, 13275.269860157785, 13295.0, 13882.375293112036, 9645.461952741465, 9698.36960597559, 9862.0, 9952.25358098131, 10803.135749139892, 8327.708530201415, 9904.563838243559, 10204.591816327264, 10368.844467332845, 11126.721831954266], "value": 7470.533298905183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1676.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 124.0, 126.0, 124.0, 125.0, 124.0, 124.0, 146.0, 159.0, 126.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 114.0, 120.0, 176.0, 156.0, 154.0, 119.0, 116.0, 138.0, 121.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 215.0, 301.0, 266.0, 225.0, 222.0, 217.0, 213.0, 211.0, 215.0], "value": 230.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 67.0, 60.0, 86.0, 61.0, 62.0, 62.0, 58.0, 78.0, 62.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 89.0, 75.0, 73.0, 74.0, 86.0, 73.0, 77.0, 125.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 92.0, 92.0, 123.0, 95.0, 139.0, 140.0, 92.0, 92.0], "value": 105.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 101.0, 105.0, 161.0, 159.0, 126.0, 122.0, 157.0, 162.0, 118.0], "value": 131.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 101.0, 163.0, 121.0, 101.0, 100.0, 102.0, 101.0, 157.0], "value": 115.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 50.0, 54.0, 77.0, 46.0, 51.0, 62.0, 48.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 90.0, 58.0, 72.0, 82.0, 89.0, 88.0, 59.0, 61.0, 61.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 104.0, 114.0, 112.0, 86.0, 89.0, 80.0, 84.0, 83.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 174.0, 149.0, 173.0, 167.0, 149.0, 175.0, 217.0, 169.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 214.0, 235.0, 199.0, 196.0, 198.0, 191.0, 193.0, 196.0, 248.0], "value": 207.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 85.0, 104.0, 100.0, 70.0, 73.0, 72.0, 73.0, 72.0, 72.0], "value": 78.2, "unit": "score"}]}]} 12:52:21 INFO - Return code: 0 12:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:52:21 ERROR - # TBPL SUCCESS # 12:52:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:52:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:52:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:52:21 INFO - 2017-03-31 12:52:21.607 screenresolution[1944:18437] starting screenresolution argv=screenresolution get 12:52:21 INFO - 2017-03-31 12:52:21.610 screenresolution[1944:18437] Display 0: 1600x1200x32@60 12:52:21 INFO - 2017-03-31 12:52:21.616 screenresolution[1945:18440] starting screenresolution argv=screenresolution list 12:52:21 INFO - Available Modes on Display 0 12:52:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:52:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:52:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:52:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:52:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:52:21 INFO - Intel Iris: 12:52:21 INFO - Chipset Model: Intel Iris 12:52:21 INFO - Type: GPU 12:52:21 INFO - Bus: Built-In 12:52:21 INFO - VRAM (Dynamic, Max): 1536 MB 12:52:21 INFO - Vendor: Intel (0x8086) 12:52:21 INFO - Device ID: 0x0a2e 12:52:21 INFO - Revision ID: 0x0009 12:52:21 INFO - Displays: 12:52:21 INFO - Display: 12:52:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:52:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:52:21 INFO - Display Serial Number: 1600x1200 60 12:52:21 INFO - Main Display: Yes 12:52:21 INFO - Mirror: Off 12:52:21 INFO - Online: Yes 12:52:21 INFO - Rotation: Supported 12:52:21 INFO - Return code: 0 12:52:21 INFO - Running post-action listener: _resource_record_post_action 12:52:21 INFO - [mozharness: 2017-03-31 19:52:21.859096Z] Finished run-tests step (success) 12:52:21 INFO - Running post-run listener: _resource_record_post_run 12:52:21 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1228800; Write bytes: 518883840; Read time: 15; Write time: 1636 12:52:21 INFO - TinderboxPrint: CPU usage
54.3% 12:52:21 INFO - TinderboxPrint: I/O read bytes / time
1,228,800 / 15 12:52:21 INFO - TinderboxPrint: I/O write bytes / time
518,883,840 / 1,636 12:52:21 INFO - TinderboxPrint: CPU idle
2,197.2 (45.7%) 12:52:21 INFO - TinderboxPrint: CPU system
969.4 (20.2%) 12:52:21 INFO - TinderboxPrint: CPU user
1,643.1 (34.2%) 12:52:21 INFO - TinderboxPrint: Swap in / out
213,827,584 / 0 12:52:21 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 211204608; Write bytes: 205944320; Read time: 16275; Write time: 435 12:52:21 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 1224704; Write bytes: 302781440; Read time: 15; Write time: 1165 12:52:22 INFO - Running post-run listener: _upload_blobber_files 12:52:22 INFO - Blob upload gear active. 12:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:52:22 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 12:52:22 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'] 12:52:22 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 12:52:22 INFO - (blobuploader) - INFO - Open directory for files ... 12:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:23 INFO - (blobuploader) - INFO - Done attempting. 12:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:24 INFO - (blobuploader) - INFO - Done attempting. 12:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:25 INFO - (blobuploader) - INFO - Done attempting. 12:52:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:52:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:27 INFO - (blobuploader) - INFO - Done attempting. 12:52:27 INFO - (blobuploader) - INFO - Iteration through files over. 12:52:27 INFO - Return code: 0 12:52:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:52:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:52:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63ecd803023897e4aaf4609bd9bfdadbb75ae067fbebb1f7ecbfafe20b7849f2b7a4b433cf82ad316e36f8ddd2d0e05e28900da4481c37f46f8991867248ec7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bde7dec3a450e8ee21bb7b454b17498167335105481d2b936df3c3575a8611957a35de85b36e86e8001c909366e1f7764eec27535bcc8b776f3fd4c945cb1b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1a35068059cb8b46d6ecc8d1d6248c3d4074e590f259e9b33db69c431a8cd138fe638470d444e0f3bed20a79e34e09375328747a9daac0f2bfa9fb559842a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3a1c5a4bc27968d6ff1c9e8d7c08409c32170a743b0f88daaff0adc881f3f36b0ae21b635799e028f68dba53bac6bd508d985eab5aba481edbfa4a2d91acf55"} 12:52:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:52:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:52:27 INFO - Contents: 12:52:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63ecd803023897e4aaf4609bd9bfdadbb75ae067fbebb1f7ecbfafe20b7849f2b7a4b433cf82ad316e36f8ddd2d0e05e28900da4481c37f46f8991867248ec7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bde7dec3a450e8ee21bb7b454b17498167335105481d2b936df3c3575a8611957a35de85b36e86e8001c909366e1f7764eec27535bcc8b776f3fd4c945cb1b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1a35068059cb8b46d6ecc8d1d6248c3d4074e590f259e9b33db69c431a8cd138fe638470d444e0f3bed20a79e34e09375328747a9daac0f2bfa9fb559842a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3a1c5a4bc27968d6ff1c9e8d7c08409c32170a743b0f88daaff0adc881f3f36b0ae21b635799e028f68dba53bac6bd508d985eab5aba481edbfa4a2d91acf55"} 12:52:27 INFO - Running post-run listener: copy_logs_to_upload_dir 12:52:27 INFO - Copying logs to upload dir... 12:52:27 INFO - mkdir: /builds/slave/test/build/upload/logs 12:52:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.296899 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 12:52:27.512896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:27.516847) ========= 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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63ecd803023897e4aaf4609bd9bfdadbb75ae067fbebb1f7ecbfafe20b7849f2b7a4b433cf82ad316e36f8ddd2d0e05e28900da4481c37f46f8991867248ec7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bde7dec3a450e8ee21bb7b454b17498167335105481d2b936df3c3575a8611957a35de85b36e86e8001c909366e1f7764eec27535bcc8b776f3fd4c945cb1b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1a35068059cb8b46d6ecc8d1d6248c3d4074e590f259e9b33db69c431a8cd138fe638470d444e0f3bed20a79e34e09375328747a9daac0f2bfa9fb559842a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3a1c5a4bc27968d6ff1c9e8d7c08409c32170a743b0f88daaff0adc881f3f36b0ae21b635799e028f68dba53bac6bd508d985eab5aba481edbfa4a2d91acf55"} build_url:https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010873 build_url: 'https://queue.taskcluster.net/v1/task/SVtWWBPLRcuP_fTLuom84w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63ecd803023897e4aaf4609bd9bfdadbb75ae067fbebb1f7ecbfafe20b7849f2b7a4b433cf82ad316e36f8ddd2d0e05e28900da4481c37f46f8991867248ec7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bde7dec3a450e8ee21bb7b454b17498167335105481d2b936df3c3575a8611957a35de85b36e86e8001c909366e1f7764eec27535bcc8b776f3fd4c945cb1b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1a35068059cb8b46d6ecc8d1d6248c3d4074e590f259e9b33db69c431a8cd138fe638470d444e0f3bed20a79e34e09375328747a9daac0f2bfa9fb559842a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3a1c5a4bc27968d6ff1c9e8d7c08409c32170a743b0f88daaff0adc881f3f36b0ae21b635799e028f68dba53bac6bd508d985eab5aba481edbfa4a2d91acf55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:27.550810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:27.551145) ========= 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.w0PYe3G2f2/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.OXXGHFF5Tj/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.005380 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 12:52:27.601780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 12:52:27.602084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 12:52:27.602433) ========= ========= Total master_lag: 0.18 =========