builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1483758294.84 results: success (0) buildid: 20170106160456 builduid: 8fcbc2c2ff5b41a7b86fc234484541ad revision: 04544accd96ac3fa43a676dc5a6f8c116b08271f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:54.838116) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:54.838563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:54.838840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:55.072995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:55.073355) ========= 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.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-06 19:04:55-- 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% 122M=0s 2017-01-06 19:04:55 (122 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.366268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:55.463511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:55.463828) ========= 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.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.022728 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:55.511013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 19:04:55.511335) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04544accd96ac3fa43a676dc5a6f8c116b08271f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04544accd96ac3fa43a676dc5a6f8c116b08271f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-06 19:04:55,613 truncating revision to first 12 chars 2017-01-06 19:04:55,613 Setting DEBUG logging. 2017-01-06 19:04:55,613 attempt 1/10 2017-01-06 19:04:55,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/04544accd96a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 19:04:56,646 unpacking tar archive at: mozilla-aurora-04544accd96a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312554 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 19:04:56.855819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:56.856127) ========= script_repo_revision: 04544accd96ac3fa43a676dc5a6f8c116b08271f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:56.856528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:56.856812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 19:04:56.876387) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-06 19:04:56.876695) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:04:57 INFO - MultiFileLogger online at 20170106 19:04:57 in /builds/slave/test 19:04:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:04:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:57 INFO - {'append_to_log': False, 19:04:57 INFO - 'base_work_dir': '/builds/slave/test', 19:04:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:04:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:57 INFO - 'branch': 'Mozilla-Aurora', 19:04:57 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:57 INFO - 'config_files': ('talos/mac_config.py',), 19:04:57 INFO - 'default_actions': ('clobber', 19:04:57 INFO - 'read-buildbot-config', 19:04:57 INFO - 'download-and-extract', 19:04:57 INFO - 'populate-webroot', 19:04:57 INFO - 'create-virtualenv', 19:04:57 INFO - 'install', 19:04:57 INFO - 'run-tests'), 19:04:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:57 INFO - 'download_minidump_stackwalk': True, 19:04:57 INFO - 'download_symbols': 'ondemand', 19:04:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:57 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:57 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:57 INFO - 'installer_path': 'installer.exe', 19:04:57 INFO - 'log_level': 'info', 19:04:57 INFO - 'log_name': 'talos', 19:04:57 INFO - 'log_to_console': True, 19:04:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:04:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:04:57 INFO - 'opt_config_files': (), 19:04:57 INFO - 'pip_index': False, 19:04:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:04:57 INFO - 'cmd': ('bash', 19:04:57 INFO - '-c', 19:04:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:04:57 INFO - 'enabled': True, 19:04:57 INFO - 'halt_on_failure': False, 19:04:57 INFO - 'name': 'check_screen_resolution'},), 19:04:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:04:57 INFO - 'cmd': ('bash', 19:04:57 INFO - '-c', 19:04:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:04:57 INFO - 'enabled': True, 19:04:57 INFO - 'halt_on_failure': False, 19:04:57 INFO - 'name': 'check_screen_resolution'},), 19:04:57 INFO - 'run_cmd_checks_enabled': True, 19:04:57 INFO - 'sps_profile': False, 19:04:57 INFO - 'sps_profile_interval': 0, 19:04:57 INFO - 'suite': 'dromaeojs-e10s', 19:04:57 INFO - 'system_bits': '32', 19:04:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:57 INFO - 'title': 't-yosemite-r7-0020', 19:04:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:57 INFO - 'use_talos_json': True, 19:04:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:57 INFO - 'work_dir': 'build'} 19:04:57 INFO - [mozharness: 2017-01-07 03:04:57.083714Z] Running clobber step. 19:04:57 INFO - Running pre-action listener: _resource_record_pre_action 19:04:57 INFO - Running main action method: clobber 19:04:57 INFO - rmtree: /builds/slave/test/build 19:04:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:59 INFO - Running post-action listener: _resource_record_post_action 19:04:59 INFO - [mozharness: 2017-01-07 03:04:59.369163Z] Finished clobber step (success) 19:04:59 INFO - [mozharness: 2017-01-07 03:04:59.369318Z] Running read-buildbot-config step. 19:04:59 INFO - Running pre-action listener: _resource_record_pre_action 19:04:59 INFO - Running main action method: read_buildbot_config 19:04:59 INFO - Using buildbot properties: 19:04:59 INFO - { 19:04:59 INFO - "project": "", 19:04:59 INFO - "product": "firefox", 19:04:59 INFO - "script_repo_revision": "production", 19:04:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:04:59 INFO - "repository": "", 19:04:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:04:59 INFO - "buildid": "20170106160456", 19:04:59 INFO - "pgo_build": "False", 19:04:59 INFO - "basedir": "/builds/slave/test", 19:04:59 INFO - "buildnumber": 25, 19:04:59 INFO - "slavename": "t-yosemite-r7-0020", 19:04:59 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:04:59 INFO - "platform": "yosemite_r7", 19:04:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:04:59 INFO - "branch": "mozilla-aurora", 19:04:59 INFO - "repo_path": "releases/mozilla-aurora", 19:04:59 INFO - "revision": "04544accd96ac3fa43a676dc5a6f8c116b08271f", 19:04:59 INFO - "stage_platform": "macosx64", 19:04:59 INFO - "builduid": "8fcbc2c2ff5b41a7b86fc234484541ad", 19:04:59 INFO - "slavebuilddir": "test" 19:04:59 INFO - } 19:04:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 19:04:59 INFO - Running post-action listener: _resource_record_post_action 19:04:59 INFO - [mozharness: 2017-01-07 03:04:59.373050Z] Finished read-buildbot-config step (success) 19:04:59 INFO - [mozharness: 2017-01-07 03:04:59.373213Z] Running download-and-extract step. 19:04:59 INFO - Running pre-action listener: _resource_record_pre_action 19:04:59 INFO - Running main action method: download_and_extract 19:04:59 INFO - mkdir: /builds/slave/test/build/tests 19:04:59 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')]} 19:04:59 INFO - trying https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 19:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 19:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 19:05:00 INFO - Downloaded 1199 bytes. 19:05:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 19:05:00 INFO - Using the following test package requirements: 19:05:00 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 19:05:00 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 19:05:00 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 19:05:00 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'jsshell-mac.zip'], 19:05:00 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 19:05:00 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 19:05:00 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 19:05:00 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 19:05:00 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 19:05:00 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:05:00 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 19:05:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:05:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 19:05:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:05:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 19:05:01 INFO - Http code: 200 19:05:01 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 19:05:01 INFO - x-amz-cf-id: kOrO72eA-d6XePKJdxQl5Y9WfTCXYHHHdCiSEz_aRysZlwIz-CF5_Q== 19:05:01 INFO - x-amz-version-id: zC0YFcEufRg04IBsOEtQ5YmBJicv9FoX 19:05:01 INFO - Expected file size: 16269542 19:05:01 INFO - Obtained file size: 16269542 19:05:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:05:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 19:05:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:05:08 INFO - Fetch https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 19:05:08 INFO - Http code: 200 19:05:08 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 19:05:08 INFO - x-amz-cf-id: 8M1K2SRfww43o2fK7F3vp1-r2Pr2HHID_-DVJ-gB5_RdFdCFhWwiiw== 19:05:08 INFO - x-amz-version-id: zC0YFcEufRg04IBsOEtQ5YmBJicv9FoX 19:05:09 INFO - Expected file size: 16269542 19:05:09 INFO - Obtained file size: 16269542 19:05:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 19:05:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:05:15 INFO - Fetch https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 19:05:16 INFO - Http code: 200 19:05:16 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 19:05:16 INFO - x-amz-cf-id: 6h8f9SrHZOLn-ERz_sNF2qpSAHS0iHsaMSvHZfzGtUXZ3OYTkbdNdA== 19:05:16 INFO - x-amz-version-id: wHyDBQ7HuN5a.Vr1pnl7TFZ23NnFMIsi 19:05:16 INFO - Expected file size: 14409038 19:05:16 INFO - Obtained file size: 14409038 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - trying https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:05:16 INFO - Downloading https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 19:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 19:05:19 INFO - Downloaded 109868021 bytes. 19:05:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:05:19 INFO - mkdir: /builds/slave/test/properties 19:05:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:19 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:19 INFO - Contents: 19:05:19 INFO - build_url:https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:05:20 INFO - Running post-action listener: _resource_record_post_action 19:05:20 INFO - Running post-action listener: set_extra_try_arguments 19:05:20 INFO - [mozharness: 2017-01-07 03:05:20.693027Z] Finished download-and-extract step (success) 19:05:20 INFO - [mozharness: 2017-01-07 03:05:20.693160Z] Running populate-webroot step. 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: populate_webroot 19:05:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:20 INFO - '--tppagecycles', 19:05:20 INFO - '7'], 19:05:20 INFO - 'tests': ['tsvgm']}}, 19:05:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['damp', 'tps']}, 19:05:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'tests': ['damp', 'tps']}, 19:05:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['dromaeo_dom']}, 19:05:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['basic_compositor_video']}, 19:05:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:05:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['a11yr', 19:05:20 INFO - 'ts_paint', 19:05:20 INFO - 'tpaint', 19:05:20 INFO - 'sessionrestore', 19:05:20 INFO - 'sessionrestore_no_auto_restore', 19:05:20 INFO - 'tabpaint']}, 19:05:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['tsvgx', 19:05:20 INFO - 'tsvgr_opacity', 19:05:20 INFO - 'tart', 19:05:20 INFO - 'tscrollx', 19:05:20 INFO - 'cart']}, 19:05:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:20 INFO - 'tsvgr_opacity', 19:05:20 INFO - 'tart', 19:05:20 INFO - 'tscrollx', 19:05:20 INFO - 'cart']}, 19:05:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'talos_options': ['--disable-e10s'], 19:05:20 INFO - 'tests': ['tp5o']}, 19:05:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'tests': ['tp5o']}, 19:05:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'talos_options': ['--disable-e10s', 19:05:20 INFO - '--xperf_path', 19:05:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:20 INFO - 'tests': ['tp5n']}, 19:05:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:20 INFO - 'talos_options': ['--xperf_path', 19:05:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:20 INFO - 'tests': ['tp5n']}}, 19:05:20 INFO - 'talos.zip': {'path': '', 19:05:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:20 INFO - Running post-action listener: _resource_record_post_action 19:05:20 INFO - [mozharness: 2017-01-07 03:05:20.712048Z] Finished populate-webroot step (success) 19:05:20 INFO - [mozharness: 2017-01-07 03:05:20.712183Z] Running create-virtualenv step. 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: create_virtualenv 19:05:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:20 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 19:05:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:20 INFO - Using real prefix '/tools/python27' 19:05:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:24 INFO - Installing pip.................done. 19:05:24 INFO - Return code: 0 19:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:05:24 INFO - Reading from file tmpfile_stdout 19:05:24 INFO - Output received: 19:05:24 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) 19:05:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:24 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 19:05:24 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 19:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:24 INFO - 'HOME': '/Users/cltbld', 19:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:24 INFO - 'LOGNAME': 'cltbld', 19:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:24 INFO - 'MOZ_NO_REMOTE': '1', 19:05:24 INFO - 'NO_EM_RESTART': '1', 19:05:24 INFO - 'PAGER': '/bin/cat', 19:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:24 INFO - 'PWD': '/builds/slave/test', 19:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:24 INFO - 'SHELL': '/bin/bash', 19:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:24 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:24 INFO - 'USER': 'cltbld', 19:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:24 INFO - 'XPC_FLAGS': '0x0', 19:05:24 INFO - 'XPC_SERVICE_NAME': '0', 19:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:24 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 19:05:24 INFO - Cleaning up... 19:05:24 INFO - Return code: 0 19:05:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:24 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 19:05:24 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 19:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:24 INFO - 'HOME': '/Users/cltbld', 19:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:24 INFO - 'LOGNAME': 'cltbld', 19:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:24 INFO - 'MOZ_NO_REMOTE': '1', 19:05:24 INFO - 'NO_EM_RESTART': '1', 19:05:24 INFO - 'PAGER': '/bin/cat', 19:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:24 INFO - 'PWD': '/builds/slave/test', 19:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:24 INFO - 'SHELL': '/bin/bash', 19:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:24 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:24 INFO - 'USER': 'cltbld', 19:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:24 INFO - 'XPC_FLAGS': '0x0', 19:05:24 INFO - 'XPC_SERVICE_NAME': '0', 19:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:25 INFO - Downloading/unpacking psutil>=3.1.1 19:05:25 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 19:05:25 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 19:05:25 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 19:05:25 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 19:05:25 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 19:05:25 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 19:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:29 INFO - Installing collected packages: psutil 19:05:29 INFO - Running setup.py install for psutil 19:05:29 INFO - building 'psutil._psutil_osx' extension 19:05:29 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 19:05:29 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 19:05:29 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 19:05:30 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 19:05:30 INFO - building 'psutil._psutil_posix' extension 19:05:30 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 19:05:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:05:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:05:30 INFO - ^ 19:05:30 INFO - 1 warning generated. 19:05:30 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 19:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:30 INFO - Successfully installed psutil 19:05:30 INFO - Cleaning up... 19:05:30 INFO - Return code: 0 19:05:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:30 INFO - 'HOME': '/Users/cltbld', 19:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:30 INFO - 'LOGNAME': 'cltbld', 19:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:30 INFO - 'MOZ_NO_REMOTE': '1', 19:05:30 INFO - 'NO_EM_RESTART': '1', 19:05:30 INFO - 'PAGER': '/bin/cat', 19:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:30 INFO - 'PWD': '/builds/slave/test', 19:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:30 INFO - 'SHELL': '/bin/bash', 19:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:30 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:30 INFO - 'USER': 'cltbld', 19:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:30 INFO - 'XPC_FLAGS': '0x0', 19:05:30 INFO - 'XPC_SERVICE_NAME': '0', 19:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:33 INFO - Installing collected packages: mozsystemmonitor 19:05:33 INFO - Running setup.py install for mozsystemmonitor 19:05:33 INFO - Successfully installed mozsystemmonitor 19:05:33 INFO - Cleaning up... 19:05:33 INFO - Return code: 0 19:05:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:33 INFO - 'HOME': '/Users/cltbld', 19:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:33 INFO - 'LOGNAME': 'cltbld', 19:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:33 INFO - 'MOZ_NO_REMOTE': '1', 19:05:33 INFO - 'NO_EM_RESTART': '1', 19:05:33 INFO - 'PAGER': '/bin/cat', 19:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:33 INFO - 'PWD': '/builds/slave/test', 19:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:33 INFO - 'SHELL': '/bin/bash', 19:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:33 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:33 INFO - 'USER': 'cltbld', 19:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:33 INFO - 'XPC_FLAGS': '0x0', 19:05:33 INFO - 'XPC_SERVICE_NAME': '0', 19:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:33 INFO - Downloading/unpacking jsonschema==2.5.1 19:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:36 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:36 INFO - warning: no files found matching '*.txt' 19:05:36 INFO - no previously-included directories found matching 'build' 19:05:36 INFO - no previously-included directories found matching 'dist' 19:05:36 INFO - no previously-included directories found matching '.git*' 19:05:36 INFO - Installing collected packages: jsonschema, functools32 19:05:37 INFO - Running setup.py install for functools32 19:05:37 INFO - warning: no files found matching '*.txt' 19:05:37 INFO - no previously-included directories found matching 'build' 19:05:37 INFO - no previously-included directories found matching 'dist' 19:05:37 INFO - no previously-included directories found matching '.git*' 19:05:37 INFO - Successfully installed jsonschema functools32 19:05:37 INFO - Cleaning up... 19:05:37 INFO - Return code: 0 19:05:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05:37 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')]} 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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')]} 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:37 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 19:05:37 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 19:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:37 INFO - 'HOME': '/Users/cltbld', 19:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:37 INFO - 'LOGNAME': 'cltbld', 19:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:37 INFO - 'MOZ_NO_REMOTE': '1', 19:05:37 INFO - 'NO_EM_RESTART': '1', 19:05:37 INFO - 'PAGER': '/bin/cat', 19:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:37 INFO - 'PWD': '/builds/slave/test', 19:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:37 INFO - 'SHELL': '/bin/bash', 19:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:37 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:37 INFO - 'USER': 'cltbld', 19:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:37 INFO - 'XPC_FLAGS': '0x0', 19:05:37 INFO - 'XPC_SERVICE_NAME': '0', 19:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:37 INFO - Cleaning up... 19:05:37 INFO - Return code: 0 19:05:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:37 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')]} 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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')]} 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:37 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 19:05:37 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 19:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:37 INFO - 'HOME': '/Users/cltbld', 19:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:37 INFO - 'LOGNAME': 'cltbld', 19:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:37 INFO - 'MOZ_NO_REMOTE': '1', 19:05:37 INFO - 'NO_EM_RESTART': '1', 19:05:37 INFO - 'PAGER': '/bin/cat', 19:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:37 INFO - 'PWD': '/builds/slave/test', 19:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:37 INFO - 'SHELL': '/bin/bash', 19:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:37 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:37 INFO - 'USER': 'cltbld', 19:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:37 INFO - 'XPC_FLAGS': '0x0', 19:05:37 INFO - 'XPC_SERVICE_NAME': '0', 19:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 INFO - Downloading docopt-0.6.1.tar.gz 19:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:41 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:41 INFO - Running setup.py install for blobuploader 19:05:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:41 INFO - Running setup.py install for requests 19:05:42 INFO - Running setup.py install for docopt 19:05:42 INFO - Successfully installed blobuploader requests docopt 19:05:42 INFO - Cleaning up... 19:05:42 INFO - Return code: 0 19:05:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:42 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 19:05:42 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 19:05:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:42 INFO - 'HOME': '/Users/cltbld', 19:05:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:42 INFO - 'LOGNAME': 'cltbld', 19:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:42 INFO - 'MOZ_NO_REMOTE': '1', 19:05:42 INFO - 'NO_EM_RESTART': '1', 19:05:42 INFO - 'PAGER': '/bin/cat', 19:05:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:42 INFO - 'PWD': '/builds/slave/test', 19:05:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:42 INFO - 'SHELL': '/bin/bash', 19:05:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:42 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:42 INFO - 'USER': 'cltbld', 19:05:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:42 INFO - 'XPC_FLAGS': '0x0', 19:05:42 INFO - 'XPC_SERVICE_NAME': '0', 19:05:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:42 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-I400kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Ql4qRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-XA_EaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-D2iEkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-BcNaDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-W7IKVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Ocajhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-8fMN5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-sdcv8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Xgpg3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:43 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7SAEf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PA1hTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nnmPX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-mh_sPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-KjdDu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-TVYvXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:44 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EdsamG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:44 INFO - Running setup.py install for manifestparser 19:05:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:44 INFO - Running setup.py install for mozcrash 19:05:44 INFO - Running setup.py install for mozdebug 19:05:45 INFO - Running setup.py install for mozdevice 19:05:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Running setup.py install for mozfile 19:05:45 INFO - Running setup.py install for mozhttpd 19:05:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Running setup.py install for mozinfo 19:05:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Running setup.py install for mozInstall 19:05:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:45 INFO - Running setup.py install for mozleak 19:05:45 INFO - Running setup.py install for mozlog 19:05:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Running setup.py install for moznetwork 19:05:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Running setup.py install for mozprocess 19:05:46 INFO - Running setup.py install for mozprofile 19:05:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Running setup.py install for mozrunner 19:05:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:46 INFO - Running setup.py install for mozscreenshot 19:05:46 INFO - Running setup.py install for moztest 19:05:47 INFO - Running setup.py install for mozversion 19:05:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:47 INFO - Cleaning up... 19:05:47 INFO - Return code: 0 19:05:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:47 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')]} 19:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:47 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')]} 19:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:47 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:47 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 19:05:47 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 19:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:47 INFO - 'HOME': '/Users/cltbld', 19:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:47 INFO - 'LOGNAME': 'cltbld', 19:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:47 INFO - 'MOZ_NO_REMOTE': '1', 19:05:47 INFO - 'NO_EM_RESTART': '1', 19:05:47 INFO - 'PAGER': '/bin/cat', 19:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:47 INFO - 'PWD': '/builds/slave/test', 19:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:47 INFO - 'SHELL': '/bin/bash', 19:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:47 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:47 INFO - 'USER': 'cltbld', 19:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:47 INFO - 'XPC_FLAGS': '0x0', 19:05:47 INFO - 'XPC_SERVICE_NAME': '0', 19:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0Mwoxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:47 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)) 19:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Uh5t5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:47 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)) 19:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-OJZBrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:47 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)) 19:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Z0ewXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-xTnYXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cbTu5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-E9irC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-y2ce3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-AckbFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-V1GAt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gWi7TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Om4aCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ayoEyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:48 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)) 19:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-9riwtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:49 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)) 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:49 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-K38s87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:49 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)) 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:49 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PSL5K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:49 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)) 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:49 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-oH6bIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:49 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)) 19:05:49 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)) 19:05:49 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)) 19:05:49 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)) 19:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:51 INFO - Downloading blessings-1.6.tar.gz 19:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:52 INFO - Installing collected packages: blessings 19:05:52 INFO - Running setup.py install for blessings 19:05:52 INFO - Successfully installed blessings 19:05:52 INFO - Cleaning up... 19:05:52 INFO - Return code: 0 19:05:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:52 INFO - Reading from file tmpfile_stdout 19:05:52 INFO - Current package versions: 19:05:52 INFO - blessings == 1.6 19:05:52 INFO - blobuploader == 1.2.4 19:05:52 INFO - docopt == 0.6.1 19:05:52 INFO - functools32 == 3.2.3-2 19:05:52 INFO - jsonschema == 2.5.1 19:05:52 INFO - manifestparser == 1.1 19:05:52 INFO - mozInstall == 1.12 19:05:52 INFO - mozcrash == 1.0 19:05:52 INFO - mozdebug == 0.1 19:05:52 INFO - mozdevice == 0.48 19:05:52 INFO - mozfile == 1.2 19:05:52 INFO - mozhttpd == 0.7 19:05:52 INFO - mozinfo == 0.9 19:05:52 INFO - mozleak == 0.1 19:05:52 INFO - mozlog == 3.4 19:05:52 INFO - moznetwork == 0.27 19:05:52 INFO - mozprocess == 0.23 19:05:52 INFO - mozprofile == 0.28 19:05:52 INFO - mozrunner == 6.13 19:05:52 INFO - mozscreenshot == 0.1 19:05:52 INFO - mozsystemmonitor == 0.3 19:05:52 INFO - moztest == 0.8 19:05:52 INFO - mozversion == 1.4 19:05:52 INFO - psutil == 3.1.1 19:05:52 INFO - requests == 1.2.3 19:05:52 INFO - wsgiref == 0.1.2 19:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:52 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')]} 19:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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')]} 19:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:52 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 19:05:52 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 19:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:52 INFO - 'HOME': '/Users/cltbld', 19:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PAGER': '/bin/cat', 19:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:52 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - 'XPC_FLAGS': '0x0', 19:05:52 INFO - 'XPC_SERVICE_NAME': '0', 19:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 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)) 19:05:52 INFO - Cleaning up... 19:05:52 INFO - Return code: 0 19:05:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:52 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')]} 19:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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')]} 19:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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 0x104988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdbbd7a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, '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.21dOcAYrBq/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.79xI1LdNSV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 19:05:52 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 19:05:52 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 19:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:52 INFO - 'HOME': '/Users/cltbld', 19:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PAGER': '/bin/cat', 19:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:05:52 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - 'XPC_FLAGS': '0x0', 19:05:52 INFO - 'XPC_SERVICE_NAME': '0', 19:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:53 INFO - Cleaning up... 19:05:53 INFO - Return code: 0 19:05:53 INFO - Running post-action listener: _resource_record_post_action 19:05:53 INFO - Running post-action listener: _start_resource_monitoring 19:05:53 INFO - Starting resource monitoring. 19:05:53 INFO - [mozharness: 2017-01-07 03:05:53.186463Z] Finished create-virtualenv step (success) 19:05:53 INFO - [mozharness: 2017-01-07 03:05:53.187433Z] Running install step. 19:05:53 INFO - Running pre-action listener: _resource_record_pre_action 19:05:53 INFO - Running main action method: install 19:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:53 INFO - Reading from file tmpfile_stdout 19:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:53 INFO - Reading from file tmpfile_stdout 19:05:53 INFO - Output received: 19:05:53 INFO - Usage: mozinstall [options] installer 19:05:53 INFO - Options: 19:05:53 INFO - -h, --help show this help message and exit 19:05:53 INFO - -d DEST, --destination=DEST 19:05:53 INFO - Directory to install application into. [default: 19:05:53 INFO - "/builds/slave/test"] 19:05:53 INFO - --app=APP Application being installed. [default: firefox] 19:05:53 INFO - mkdir: /builds/slave/test/build/application 19:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:06:24 INFO - Reading from file tmpfile_stdout 19:06:24 INFO - Output received: 19:06:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:06:24 INFO - Running post-action listener: _resource_record_post_action 19:06:24 INFO - [mozharness: 2017-01-07 03:06:24.525104Z] Finished install step (success) 19:06:24 INFO - [mozharness: 2017-01-07 03:06:24.525243Z] Running run-tests step. 19:06:24 INFO - Running pre-action listener: _resource_record_pre_action 19:06:24 INFO - Running main action method: run_tests 19:06:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:06:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:06:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:06:24 INFO - 2017-01-06 19:06:24.539 screenresolution[1627:8226] starting screenresolution argv=screenresolution get 19:06:24 INFO - 2017-01-06 19:06:24.542 screenresolution[1627:8226] Display 0: 1600x1200x32@60 19:06:24 INFO - 2017-01-06 19:06:24.548 screenresolution[1628:8228] starting screenresolution argv=screenresolution list 19:06:24 INFO - Available Modes on Display 0 19:06:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:06:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:06:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:06:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:06:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:06:24 INFO - Intel Iris: 19:06:24 INFO - Chipset Model: Intel Iris 19:06:24 INFO - Type: GPU 19:06:24 INFO - Bus: Built-In 19:06:24 INFO - VRAM (Dynamic, Max): 1536 MB 19:06:24 INFO - Vendor: Intel (0x8086) 19:06:24 INFO - Device ID: 0x0a2e 19:06:24 INFO - Revision ID: 0x0009 19:06:24 INFO - Displays: 19:06:24 INFO - Display: 19:06:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:06:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:06:24 INFO - Display Serial Number: 1600x1200 60 19:06:24 INFO - Main Display: Yes 19:06:24 INFO - Mirror: Off 19:06:24 INFO - Online: Yes 19:06:24 INFO - Rotation: Supported 19:06:24 INFO - Return code: 0 19:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:24 INFO - Python 2.7.3 19:06:24 INFO - Return code: 0 19:06:24 INFO - grabbing minidump binary from tooltool 19:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10479cd30>, '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 0x104602db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104794b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:06:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:06:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:06:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:24 INFO - Return code: 0 19:06:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 19:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 19:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21dOcAYrBq/Render', 19:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:24 INFO - 'HOME': '/Users/cltbld', 19:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:24 INFO - 'LOGNAME': 'cltbld', 19:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:24 INFO - 'MOZ_NO_REMOTE': '1', 19:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:24 INFO - 'NO_EM_RESTART': '1', 19:06:24 INFO - 'PAGER': '/bin/cat', 19:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:24 INFO - 'PWD': '/builds/slave/test', 19:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:24 INFO - 'SHELL': '/bin/bash', 19:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.79xI1LdNSV/Listeners', 19:06:24 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 19:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:24 INFO - 'USER': 'cltbld', 19:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:24 INFO - 'XPC_FLAGS': '0x0', 19:06:24 INFO - 'XPC_SERVICE_NAME': '0', 19:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 19:06:25 INFO - mozversion application_buildid: 20170106160456 19:06:25 INFO - mozversion application_changeset: 04544accd96ac3fa43a676dc5a6f8c116b08271f 19:06:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:25 INFO - mozversion application_name: Firefox 19:06:25 INFO - mozversion application_remotingname: firefox-dev 19:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:06:25 INFO - mozversion application_vendor: Mozilla 19:06:25 INFO - mozversion application_version: 52.0a2 19:06:25 INFO - mozversion platform_buildid: 20170106160456 19:06:25 INFO - mozversion platform_changeset: 04544accd96ac3fa43a676dc5a6f8c116b08271f 19:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:06:25 INFO - mozversion platform_version: 52.0a2 19:06:25 INFO - using testdate: 1483758385 19:06:25 INFO - actual date: 1483758385 19:06:25 INFO - starting webserver on 'localhost:49250' 19:06:25 INFO - SUITE-START | Running 2 tests 19:06:25 INFO - TEST-START | dromaeo_css 19:06:25 INFO - operating with platform_type : mac_ 19:06:25 INFO - Initialising browser for dromaeo_css test... 19:06:25 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpWsmzFp/profile http://localhost:49250/getInfo.html) 19:06:28 INFO - PROCESS | 1638 | 2017-01-06 19:06:28.310 plugin-container[1641:8414] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b37, name = 'com.apple.tsm.portname' 19:06:28 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:06:28 INFO - PROCESS | 1638 | 2017-01-06 19:06:28.314 plugin-container[1641:8414] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e27, name = 'com.apple.CFPasteboardClient' 19:06:28 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:06:28 INFO - PROCESS | 1638 | 2017-01-06 19:06:28.314 plugin-container[1641:8414] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:06:28 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 19:06:28 INFO - PROCESS | 1638 | colorDepth:24 19:06:28 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 19:06:28 INFO - PROCESS | 1638 | __metrics 19:06:28 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 19:06:29 INFO - TEST-INFO | 1638: exit 0 19:06:29 INFO - Browser initialized. 19:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:29 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpWsmzFp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:31 INFO - PROCESS | 1642 | 2017-01-06 19:06:31.734 plugin-container[1643:8541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 19:06:31 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:06:31 INFO - PROCESS | 1642 | 2017-01-06 19:06:31.735 plugin-container[1643:8541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 19:06:31 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:06:31 INFO - PROCESS | 1642 | 2017-01-06 19:06:31.735 plugin-container[1643:8541] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:06:41 INFO - PROCESS | 1642 | RSS: Main: 229642240 19:06:41 INFO - PROCESS | 1642 | 19:09:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 19:09:46 INFO - PROCESS | 1642 | RSS: Main: 232304640 19:09:46 INFO - PROCESS | 1642 | 19:12:49 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 19:12:49 INFO - PROCESS | 1642 | RSS: Main: 243200000 19:12:49 INFO - PROCESS | 1642 | 19:15:51 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 19:15:52 INFO - PROCESS | 1642 | RSS: Main: 248578048 19:15:52 INFO - PROCESS | 1642 | 19:18:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 19:18:55 INFO - PROCESS | 1642 | RSS: Main: 247828480 19:18:55 INFO - PROCESS | 1642 | 19:21:57 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 19:21:58 INFO - PROCESS | 1642 | RSS: Main: 251727872 19:21:58 INFO - PROCESS | 1642 | 19:25:00 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 19:25:01 INFO - PROCESS | 1642 | RSS: Main: 252899328 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | __start_tp_report 19:25:01 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 19:25:01 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 19:25:01 INFO - PROCESS | 1642 | |i|pagename|runs| 19:25:01 INFO - PROCESS | 1642 | |0;dojo.html;3370.6292307846134;3377.3076519313527;3405.8637654493828;3418.2138108235104;3418.384690755663;5664.263645726055;5797.217375654285;5829.708514574276;5854.238948936632;5890.263717035371;5745.454181852718;5802.883942321151;5803.274590676166;5830.562707796911;5884.382139875315;5222.009878136549;5254.080535906221;5275.050490911634;5279.076161671711;5317.335333083364;5326.7070311132875;5329.120695085326;5342.412334643186;5349.545288650469;5355.384130824947;5208.7395630218525;5222.9477705223035;5306.70813105279;5319.122344813101;5321.946780532203;5300.787968481256;5311.814086506973;5325.573954083664;5336.893262134774;5346.304980352529;4527.773611319454;5028.742814296426;5259.947400526023;5292;5312.521873031407;5751.568632352591;5812.302523697141;5879.382664820175;5901.439363260483;5929.377415371367;6036.060749644638;6194.690265486708;6234.937650623527;6240.750369985195;6242.063690446424;5284.418713941502;6275.403836635513;6296.401841825065;6298.622082675009;6308.3060863305;5773.278340207474;5836.358000619928;5857;5951.5238780897425;6005;6243;6263.686815659199;6284.874302513924;6294.181756371734;6316.747330106744;6139.26328840542;6169.444749972524;6183.628982261079;6184.226971628546;6184.721687523982;6262.342454042351;6283.37166283368;6291.339409362043;6324.620522768649;6329.145565348711;6113.510919126459;6124.234470691164;6151.753929842756;6166.7224974876235;6224.751009959641;6167.167432396569;6204.3795620437595;6224.595401298901;6232.3144454110015;6237.906431403532;4987.600991920638;4998.825041123616;5005.3242812220615;5008.649394542347;5011.724355160502;4326.918270432392;4362.1275744851155;4373.715708478939;4408.647308215335;4470.083632855257;4798.328234047236;5806.44838740319;5977.193078934288;5978.252718410199;6002.249718785152;6300.810975670737;6305.653189074645;6307.873842523216;6323.019931910561;6340.904886426707;5792.768289268382;5866.67733274674;5869.236999190078;5938.8812223755285;5977.521798256129;5386.192071189353;5433.293671822637;5464.0711079116645;5490.972545137249;5538.141588053858;5202.7918883245;5301.814436494781;6151.231096112986;6332.778352757631;6399.552031357946;6169.5064394849205;6171.783987560414;6211.099390588249;6238.282597501346;6298.590591611531;6150.7847225346895;6251.124842522141;6355.777547785805;6368.42684158428;6382.489400848014;3048.725614694688;4167.083241686824;5105.4384017757275;5730;6036.456718895321;4816.54242846929;6161.537884658579;6221.471174949999;6293.213348331458;6318.020706790455;5414.106672399168;5888.440598143169;6208.937910620836;6215.502759779117;6215.564910456224;6050.848728781815;6148.723307451265;6198.2252218472695;6203.627782333075;6205.503559715122;5930.140129681258;5975.940240597538;6070.666113363807;6110.114033465212;6138.07928810682;6113.537117903944;6116.366205733216;6163.7842675506145;6167.537434692326;6245.375462453719;5517.751701173376;5642.294713160855;6076.54425918049;6126.111713801563;6149.077638354103 19:25:01 INFO - PROCESS | 1642 | |1;ext.html;499.55539569782877;506.8580797376734;538.5503104907402;564.0861803877718;583.00015473463;36715.26569468609;39091.413628795555;39153.60846391535;39163.608363916355;39167.82496525102;39844.800775996155;40350.39474407886;40397.7980110099;40411.59588404115;40430.98922526931;9183.81632367354;9292.72121836346;9359.532023398837;9364.765880853;9376.156145946863;7937.880931786028;8012.5593092379895;9319.440833550008;9329.860052099224;9343.672971446002;9330.113639204264;9362.859557106614;9363.531823408837;9391.201747851406;9392.154706076451;8047.718329858485;9264.073592640716;9315.906840931606;9347.859782103274;9366.95316523413;9261.16649501548;9287.76780580484;9335.90664093364;9367.953160234223;9384.390014649027;38355.424668629996;38459.23081538382;38800.80599596984;38831.8058409709;38873.611263887564;2870.2680816391894;3172.1118086935694;3696.815159242027;3865;3907.648311651965;28407.857960710066;28568.42863142746;29521;30443.847780760956;30583.2354191147;3108.1607965849093;3209.8555564999397;3212.6626704195955;3250.6261779895376;3251.057193413907;453511;457138;457599;457738;458028.7098564519;33679.663203368145;34331.4850277246;34689.13277168041;35785.64214357823;35805.28389432197;35635.64364356375;35821.10447238788;35875.282494349965;35947.281054378764;35956.460653090224;14531.200783956983;14650.706985860223;14683.339249733788;14698.33857476416;14745.483908063166;12293.955013823746;12366.876331236752;12384.318862462651;12512.249265044127;12530.81203781944;7865.252800983897;7885.29032387088;7917.960410197912;7960.800979975431;7963.805429185552;2831.9858400707863;3173.4287828191145;3255.9023229303157;3297.060337803762;3310.1724568857785;758.7973062695689;825.7646570727314;888.8888888888889;995.840665493532;1070.1171533484905;29519.704802952125;29745.851270743507;29939.550906736415;29979.364013823797;30195;807.725373373056;936.7892224249625;947.8767760191131;1074.6775967209805;1088.6788397422622;14929.40282388714;15294.464693735667;15387.307571159325;15669.451569195024;15713.607159820867;648958;678761.6061919659;682975;686598;689315;56686.43313566894;56718;57089.42910570924;57232.71383643139;57241.71379143161;1352.2832898563777;1374.9656258593416;1388.1324172392256;1388.4585011845388;1392.6796836727406;28726.569101463076;29159.125226243246;29426.852865735535;29536.852315738284;30003.549946751253;47600.761996189794;47847.52152478431;48006.519934800206;48021.03957920752;48070.75964620154;601211;603469;603802;604331;605197;26337.604935925592;26418.339541511617;26720;26735;26766.598501022112;44761.77619112014;44884;45028.32457513074;45698.31452528281;46004;37781;37784.433233502066;38343.84968450951;38441.80779096087;39070;30889.382212355176;37024.62975370212;37285.81357093197;37321;38515;32509.837450813542;33606.159846003065;36766;37658.2468350626;38234.80882595569;32198.83900580482;33931.83034084814;34153.48769768406;34472.13819654529;34711.95864123979;25091.247262581423;25420.85606147691;25599;25602.23193304204;25979.843225083896 19:25:01 INFO - PROCESS | 1642 | |2;jquery.html;366.24005189232344;367.6819551088308;378.4947095627338;387.1965671232194;397.85279446604744;18474.538136546595;19407;20280.39158825234;20414.591708165826;20607.587848243027;18970.525736856587;19110.904445477787;19575.048810614793;19869.801301986976;20048.59902801943;5560.221568980346;5631.380548139711;5733.455321744427;5883.3528311885875;5891.70382515848;5628.099504079348;5781.306243250816;5784.45047720468;5790.478856902878;5799.710014499279;5560.944390556103;5696.971515142419;5750.741216645261;5755.712214389285;5895.380984996578;5949.345571987078;5994.820155395323;6000.159977603139;6003.369646187153;6030.698465076729;5565.833025009256;5740.167675687044;5782.335031471351;5803.361630220672;5826.126081087828;12650;12819.87180128196;12875.356232188353;13006.609801705965;13063.412146453338;2163.7511686156136;2198.296545105567;2212;2234.184522649238;2661.321363052409;8976.596053177558;9910.504474776304;10036.59853605855;11618.360990145538;15388.461403850812;1606.3333716507636;1610.6778644271076;1776;1838.843698285634;1900.6293772714325;108380;108941;110967;111526;115451;11468.770624587461;11564.595239166589;11821.172517923662;11830.112741544419;11838.230515016496;12927;14388.28058597066;14793.778093328609;14814.259287035606;14880.404783808526;8211.71259005932;8348.916510834813;8483.575821208915;8571.057183709787;8585.570721464026;6841.760538381132;8397.370197235232;8398.958005209935;8476.279516241066;8537.18896704812;4443.666724995638;4446.799894004777;4549.977250113729;4566.88582785433;4704.835330763475;1829.9203469952793;1946.7371904792672;1953.619044286379;1980.227711192636;2000.7098970649465;700.6041586503609;766.1954947305308;861.237804542984;908.5593487158723;931.7437704631145;18585.5353616158;19830.801691982895;19921.402357929284;20146.39560813178;20257.29099481511;864.6195673903462;911.6581282019242;941.8807682713893;945.9716208513755;949.3876449690049;10510.684679459628;10524.36853788775;10561;10611.31026483276;10635.627753028763;565762;572140;575600;576192;580020;102910;126761;129041;130655.34672326577;132053.33973330073;959.1080295325274;975.1077763846143;990.4008075114596;991.108002797488;994.945357920592;17823.554411139306;18520.79614825032;18796.68423210362;18799.248030078645;18895.866248025162;37792.86621401362;49367.753161233966;49645.503544964085;53568.464315356345;54197.72901135469;61588.69205653943;78344.99032611094;80390.5980470094;81183;82883.17116828755;7725.652345644572;7873.488223265469;7906.644201011083;8047.436679432383;8107.270345668918;10346.861845197172;10896.727581810519;11991.520339186334;12005.63983080509;12510.499580016698;9898.861630912537;10599.364038157426;10689.091427228772;10836.078933290759;10914.945425272823;10003.549840257352;10407.895921040996;10565.577376904837;10581.841272380767;10669.679909602724;10786.460676965964;10963.068139208257;11109.777804444027;11183.552657893593;11284.21010529255;7698.307152356315;7876.881846772418;8101.9594902027475;8204.302634275915;8352.958235208785;8027.959860200662;9289.76775580589;10773.62292319765;10808.783824323313;10994.890051099386 19:25:01 INFO - PROCESS | 1642 | |3;mootools.html;1432.3983926750766;1458.0814087125113;1616.1030628001463;1741.2425594866227;1781.9198136083876;7622.199669034755;7819.413543984196;8065.758027259177;8585.527795971211;8616.31069514439;8064.072631647362;8393.328533717304;8400.3279737621;8490.448120872154;8506.064332923374;1936.893470859102;2318.130700987134;2361.988190059047;2363.385519764865;2376.5603363377745;1975.664137096697;2023.2008356699096;2093.675480300556;2400.3999000249937;2409.831311808174;2327.9883600581975;2349.753275906031;2363.6218205087102;2366.089055713554;2371.691680081587;2297.5519773644064;2316.270374831931;2328.6739856420113;2334.579775640384;2340.4382948092507;2149.000714667687;2242.6299660555987;2360.3155085025323;2378.797802186816;2382.9046838126455;8216.753497395088;8348;8486.830263394697;8516.063233044422;8553.358498112666;4527.366168736379;5203.505666961632;5241.68549887008;5267.841964741064;5287.762050707727;3338.3657105149946;3416.299658569987;3648.799316037617;3649.3431182387158;3652.2330310634798;1015.2182819229226;1047.6909311752975;1087.276960821053;1099.9725006874892;1116.3413585984308;11093.27893686916;11153.553857845676;11165.609203677914;11213.495392707266;11222.326660400402;4491.820327186876;4533.206688829442;4556.430446194226;4570.177368073712;4811.639127065484;9496.287778416647;9546.809063818684;9591.712248632552;9607.807843843084;9616.423014619146;5261.868453288622;5263.34208223972;5263.684178949199;5270.051390749625;5281.445448227881;4137.627613514798;4697.389339385858;4743.66794324394;4816.638752093537;4824.34871292371;3272.9018129456153;3306.93386132276;3862.420636904487;3957.52509698838;4006.7996600169877;1240.3860089255695;1251.7621651886113;1254.5420921363636;1262.5896583610363;1265.4368805881295;872.6029656506274;880.5465185429509;882.2236431939851;883.88067610873;919.8298314811781;5587.832365029056;5817.592768506164;5841.415858414124;5848.1227815827115;5933.258342707161;910.5629297937028;918.7703074231442;920.6409500294891;948.3219498058921;982.3565564555228;3589.0847833802736;3639.872604458831;3683.1528748388023;3689.096171438015;3726.869559565402;10099.848502272473;10410.427426491464;10443.477826108665;10449.320794148356;10454.63408780689;10231.7442063949;10392.42841643717;10393.37639741618;10406.635767748092;10420.010099040579;6882.965585172142;7938.722144724907;8073.192680731997;8104.716334928367;8145.470544414594;4347.869563913087;5099;5486.286782718221;5637.943620563906;5702.344230413555;9439.386439881386;9468.47923364194;9479.810403791747;9497.28770342241;9668.70993870185;9656.71029869105;9657.034296570288;9657.46883921391;9658;9796.363236389612;5296.973515132399;5419.512243898068;5808.767649293981;6879.105716256855;6990.8951365728535;7034.507584469038;7320.524165929198;8070.273675369245;8213.835723285381;8215.958920205361;7199.496035277481;7275.308845659654;7307.7807665770115;7324.670389832577;7366.63166841645;6468.320826313357;6987.196472405535;7041.5775053496955;7060;7125.752058264741;6749.097887908247;6759.86480270382;6844.760433384808;6849.280825513449;6850.965745171242;4006.6193711597352;4418.7569683666425;4826.9517304827905;4970;5214.582833373397;4817.253325734517;4876.341693871424;4916.360873086476;5049.166887463527;5106.336176297058 19:25:01 INFO - PROCESS | 1642 | |4;prototype.html;282.1605722974151;303.8222639755744;307.14000797766255;311.6322739167781;318.15688425671965;4499.437570303712;4818.566329030386;5447.891042179159;5472.616916815819;5587.7253900765845;4473.859165912688;5036.82371117011;5049.166887463573;5409.483835506922;5441.347038355393;3615.6022837487853;4154.023804405962;4197.9370309445385;4204.768737719424;4213.831446742134;3516.7010804081683;3622;4136.503619565657;4151.958480415203;4217.1987322408795;3386.7967921924765;3477.7565570410084;3564.488978356317;3823.254465379252;4181.205570941512;3653.780773153619;4083.530394004668;4143.647789937859;4189;4204.810783514749;3190.3140824722564;3520.419130843408;3651.5618125824803;3654.4152935530187;3671.4859919611276;4553.476350219734;4764.094821983812;5064.784451731594;5357.4106848246665;5432.130859062531;4683.314006957493;4732.574068333832;4741.407324084489;4742.668013239075;4745.596624286905;4836.661433699643;5484.670919744828;5771.210924613383;5810.302763668386;5813;3463.9134021649406;3795.2599243147597;3870.322693528621;3903.33643280643;3908.804559772;5268.367795864482;6047.7580896764075;6057.757689692407;6061.424164704346;6064.4541991221;3259.6414394416597;3955.723099383073;3959.1883663848844;4004.1991601679197;4017.7544961062163;3182.3794360100023;3304.5538852255117;3669.9357186416173;3818.694504439638;3997.600239975979;4690.460597031317;4692.498400511871;4697;4732.053589282157;4762.238041913277;5594.440555944454;5620.91568626471;5659.679531392109;5839.9124013139835;5850.034744267148;1023.7747695506977;1053.3679792124817;1143.1540659911605;1294.792833146692;1323.444153455551;777.3081957058223;797.5932274540027;805.7381351060928;842.5618678287378;853.8505761491838;4161.625453709181;4621.792019359137;4655.952410707564;4718.551737584924;4792.400949881265;4882.072406242803;5150.793968241303;5245.344331958505;5715.914261286084;5718.799842005593;4244.2996905510245;4274.850380236677;4692.53074692528;5063.620228482879;5123.462036486189;2532.5821239495276;2548.5922252439523;2897.855586865704;2948.2039849241014;2957.985210073936;5082.33929589151;5274.314339135888;5493.587980901449;5731.942680573141;5741.655500669973;5328.733563321818;5534.496966064858;5701.600887937804;5806.477417032487;5863.501602363762;5731.541476681772;5750.942490575125;5798.884022319615;5809.912851307234;5856.62369343204;5226.712530810842;5326.97336513315;5560.414407300625;5587.814945481036;5644.717764111696;5122.692638441706;5201.748906933167;5488.368837583729;5516.738137363662;5524.806631767869;4738.772776794901;5467.644603100785;5552.750126244409;5812.244408226903;5819.272590926134;3114.8909788157307;3709.9814500927323;3735.6637902588895;3740.682042026458;3791.6966642667967;5263.947360526346;5668.971655141863;5683.460071293221;5716.199732037435;5732.885342293047;5011.498850114959;5104.668196567211;5361;5432.918506222489;5475.6440831345835;4640.512746161605;5379.515843574097;5383;5390.838274851761;5426.918596220981;4626.861194164046;5113.977204559029;5250.212468129658;5546.306711661043;5674.4892959633835;5793.826185214451;5840.561957853263;5882.23530940975;5886.970565147147;5931.881362372815;5116.030328323548;5321.600879933943;5348.625596208228;5681.886362272814;5692.658440493584 19:25:01 INFO - PROCESS | 1642 | |5;yui.html;618.6319140111632;728.7194430144393;733.9963300183498;741.0884611927329;777.6228529163357;13987.930060349696;14392.71214575708;14916.627084322898;14938.551843444715;15099.6980060399;13441;13450.93274533626;13570.525031623894;13575.796363054562;13667;814.3485211830541;830.0620299062051;831.5343407691712;832.8459235041506;836.7155167243136;807.5679511461369;831.8876951611516;839.5634270179534;840.4537050916891;841.1924552429675;858.2361698088706;871.8910136232971;871.9694810681596;872.2237208884098;874.54960695242;848.8429640516493;862.5687156421789;863.5897948474487;864.0020776003695;864.0322838420946;608.8295277322356;637.1621317966905;644.6390021587926;644.9516286278548;646.7283740828816;13633.113847599874;14105.717885642332;14217.644558886008;14273.500427484989;14289.285535723173;9849;11892.108091893142;11976;12134.393280335948;12202.450889709984;10661.307015043998;11157.832632510519;11272;11360.943195284053;11514.654560363202;3517.978232945309;3584.874529391459;3640.3447379471686;3650.269946010782;3658.1951970566433;55923;57944.8411031777;75969;85062.14937850666;87670;10267;10464.52909619069;10556.313839600401;10615.946920265504;10936.781264374828;19716.60566788656;19885;19899.204031838563;19908.50228744293;20248.29130980438;7710.884336734954;7720.266574675396;7733.304002639789;7764.068311802507;7800;4173.812178451977;4179.623833854967;4306.332518459643;4321.632661223831;4349.608535231844;2886.1918662774456;3112.486439737463;3422.3326451342245;3451.2924850405607;3487.4245749451566;558.5168828962918;645.6223109480912;653.5163978655855;665.0954701605813;676.2797620534116;536.2760273630568;596.4631831351732;645.4320198225626;659.2484567592948;680.4522359500551;8087.272145506932;8395.832083358298;8966.730998070068;9253.67612133572;9290.142668625378;602.6835911146595;625.7246811402969;641.153677146172;659.4262991197688;686.4748467422426;4419.226635338803;4569.405977222939;4581.679282450264;4582.473015603248;4686.601638860667;108516;111833;113097;118983.40508297403;122359;87715;97181;99269.50365248272;102773;104058;73940;92738;93787;95434.52282738542;96075.51962240283;8756.562171891508;8874.467531948103;8910.420822646507;8967.551622418723;9076.049424425224;44924.77537612291;54378.728106359216;56342.43657563536;57070.00764919624;57733;50304;71126.57746845137;79987;80072.59963700145;81766.59116704378;9867.703968880658;10434.956504349504;10490.265681402228;10572.577096916037;10802.703675558669;12112.515499379926;12254.931350800522;12272.566881861481;12317.75364492723;12473.064520160842;11462.656120316404;11634.825477617673;11730.12024098179;11744.236624619372;11868.109891758326;11574.594889178838;11638.41807909618;11719.123030399165;11723.237989530653;11915.52337906474;11578.826317605075;11619.825702614298;11644.475998580254;11702.765944681229;11863.34751588671;8216.835663286582;10008.199344052313;10036.899631003596;10082.747931301776;10118;10105.797884042426;10333.276670632984;10344.689659310232;10350.689479315633;10351.120154786626 19:25:01 INFO - PROCESS | 1642 | __end_tp_report 19:25:01 INFO - PROCESS | 1642 | __start_cc_report 19:25:01 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,375 19:25:01 INFO - PROCESS | 1642 | __end_cc_report 19:25:01 INFO - PROCESS | 1642 | __startTimestamp1483759501075__endTimestamp 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | ------- Summary: start ------- 19:25:01 INFO - PROCESS | 1642 | Number of tests: 6 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5717.00 Median:5951.52 stddev:687.79 (11.6%) stddev-sans-first:664.81 19:25:01 INFO - PROCESS | 1642 | Values: 3370.6 3377.3 3405.9 3418.2 3418.4 5664.3 5797.2 5829.7 5854.2 5890.3 5745.5 5802.9 5803.3 5830.6 5884.4 5222.0 5254.1 5275.1 5279.1 5317.3 5326.7 5329.1 5342.4 5349.5 5355.4 5208.7 5222.9 5306.7 5319.1 5321.9 5300.8 5311.8 5325.6 5336.9 5346.3 4527.8 5028.7 5259.9 5292.0 5312.5 5751.6 5812.3 5879.4 5901.4 5929.4 6036.1 6194.7 6234.9 6240.8 6242.1 5284.4 6275.4 6296.4 6298.6 6308.3 5773.3 5836.4 5857.0 5951.5 6005.0 6243.0 6263.7 6284.9 6294.2 6316.7 6139.3 6169.4 6183.6 6184.2 6184.7 6262.3 6283.4 6291.3 6324.6 6329.1 6113.5 6124.2 6151.8 6166.7 6224.8 6167.2 6204.4 6224.6 6232.3 6237.9 4987.6 4998.8 5005.3 5008.6 5011.7 4326.9 4362.1 4373.7 4408.6 4470.1 4798.3 5806.4 5977.2 5978.3 6002.2 6300.8 6305.7 6307.9 6323.0 6340.9 5792.8 5866.7 5869.2 5938.9 5977.5 5386.2 5433.3 5464.1 5491.0 5538.1 5202.8 5301.8 6151.2 6332.8 6399.6 6169.5 6171.8 6211.1 6238.3 6298.6 6150.8 6251.1 6355.8 6368.4 6382.5 3048.7 4167.1 5105.4 5730.0 6036.5 4816.5 6161.5 6221.5 6293.2 6318.0 5414.1 5888.4 6208.9 6215.5 6215.6 6050.8 6148.7 6198.2 6203.6 6205.5 5930.1 5975.9 6070.7 6110.1 6138.1 6113.5 6116.4 6163.8 6167.5 6245.4 5517.8 5642.3 6076.5 6126.1 6149.1 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:68644.15 Median:38450.52 stddev:157440.58 (409.5%) stddev-sans-first:157799.11 19:25:01 INFO - PROCESS | 1642 | Values: 499.6 506.9 538.6 564.1 583.0 36715.3 39091.4 39153.6 39163.6 39167.8 39844.8 40350.4 40397.8 40411.6 40431.0 9183.8 9292.7 9359.5 9364.8 9376.2 7937.9 8012.6 9319.4 9329.9 9343.7 9330.1 9362.9 9363.5 9391.2 9392.2 8047.7 9264.1 9315.9 9347.9 9367.0 9261.2 9287.8 9335.9 9368.0 9384.4 38355.4 38459.2 38800.8 38831.8 38873.6 2870.3 3172.1 3696.8 3865.0 3907.6 28407.9 28568.4 29521.0 30443.8 30583.2 3108.2 3209.9 3212.7 3250.6 3251.1 453511.0 457138.0 457599.0 457738.0 458028.7 33679.7 34331.5 34689.1 35785.6 35805.3 35635.6 35821.1 35875.3 35947.3 35956.5 14531.2 14650.7 14683.3 14698.3 14745.5 12294.0 12366.9 12384.3 12512.2 12530.8 7865.3 7885.3 7918.0 7960.8 7963.8 2832.0 3173.4 3255.9 3297.1 3310.2 758.8 825.8 888.9 995.8 1070.1 29519.7 29745.9 29939.6 29979.4 30195.0 807.7 936.8 947.9 1074.7 1088.7 14929.4 15294.5 15387.3 15669.5 15713.6 648958.0 678761.6 682975.0 686598.0 689315.0 56686.4 56718.0 57089.4 57232.7 57241.7 1352.3 1375.0 1388.1 1388.5 1392.7 28726.6 29159.1 29426.9 29536.9 30003.5 47600.8 47847.5 48006.5 48021.0 48070.8 601211.0 603469.0 603802.0 604331.0 605197.0 26337.6 26418.3 26720.0 26735.0 26766.6 44761.8 44884.0 45028.3 45698.3 46004.0 37781.0 37784.4 38343.8 38441.8 39070.0 30889.4 37024.6 37285.8 37321.0 38515.0 32509.8 33606.2 36766.0 37658.2 38234.8 32198.8 33931.8 34153.5 34472.1 34712.0 25091.2 25420.9 25599.0 25602.2 25979.8 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:33395.32 Median:366.96 stddev:95848.95 (26119.7%) stddev-sans-first:96085.75 19:25:01 INFO - PROCESS | 1642 | Values: 366.2 367.7 378.5 387.2 397.9 18474.5 19407.0 20280.4 20414.6 20607.6 18970.5 19110.9 19575.0 19869.8 20048.6 5560.2 5631.4 5733.5 5883.4 5891.7 5628.1 5781.3 5784.5 5790.5 5799.7 5560.9 5697.0 5750.7 5755.7 5895.4 5949.3 5994.8 6000.2 6003.4 6030.7 5565.8 5740.2 5782.3 5803.4 5826.1 12650.0 12819.9 12875.4 13006.6 13063.4 2163.8 2198.3 2212.0 2234.2 2661.3 8976.6 9910.5 10036.6 11618.4 15388.5 1606.3 1610.7 1776.0 1838.8 1900.6 108380.0 108941.0 110967.0 111526.0 115451.0 11468.8 11564.6 11821.2 11830.1 11838.2 12927.0 14388.3 14793.8 14814.3 14880.4 8211.7 8348.9 8483.6 8571.1 8585.6 6841.8 8397.4 8399.0 8476.3 8537.2 4443.7 4446.8 4550.0 4566.9 4704.8 1829.9 1946.7 1953.6 1980.2 2000.7 700.6 766.2 861.2 908.6 931.7 18585.5 19830.8 19921.4 20146.4 20257.3 864.6 911.7 941.9 946.0 949.4 10510.7 10524.4 10561.0 10611.3 10635.6 565762.0 572140.0 575600.0 576192.0 580020.0 102910.0 126761.0 129041.0 130655.3 132053.3 959.1 975.1 990.4 991.1 994.9 17823.6 18520.8 18796.7 18799.2 18895.9 37792.9 49367.8 49645.5 53568.5 54197.7 61588.7 78345.0 80390.6 81183.0 82883.2 7725.7 7873.5 7906.6 8047.4 8107.3 10346.9 10896.7 11991.5 12005.6 12510.5 9898.9 10599.4 10689.1 10836.1 10914.9 10003.5 10407.9 10565.6 10581.8 10669.7 10786.5 10963.1 11109.8 11183.6 11284.2 7698.3 7876.9 8102.0 8204.3 8353.0 8028.0 9289.8 10773.6 10808.8 10994.9 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5464.64 Median:5102.67 stddev:3051.95 (59.8%) stddev-sans-first:3045.47 19:25:01 INFO - PROCESS | 1642 | Values: 1432.4 1458.1 1616.1 1741.2 1781.9 7622.2 7819.4 8065.8 8585.5 8616.3 8064.1 8393.3 8400.3 8490.4 8506.1 1936.9 2318.1 2362.0 2363.4 2376.6 1975.7 2023.2 2093.7 2400.4 2409.8 2328.0 2349.8 2363.6 2366.1 2371.7 2297.6 2316.3 2328.7 2334.6 2340.4 2149.0 2242.6 2360.3 2378.8 2382.9 8216.8 8348.0 8486.8 8516.1 8553.4 4527.4 5203.5 5241.7 5267.8 5287.8 3338.4 3416.3 3648.8 3649.3 3652.2 1015.2 1047.7 1087.3 1100.0 1116.3 11093.3 11153.6 11165.6 11213.5 11222.3 4491.8 4533.2 4556.4 4570.2 4811.6 9496.3 9546.8 9591.7 9607.8 9616.4 5261.9 5263.3 5263.7 5270.1 5281.4 4137.6 4697.4 4743.7 4816.6 4824.3 3272.9 3306.9 3862.4 3957.5 4006.8 1240.4 1251.8 1254.5 1262.6 1265.4 872.6 880.5 882.2 883.9 919.8 5587.8 5817.6 5841.4 5848.1 5933.3 910.6 918.8 920.6 948.3 982.4 3589.1 3639.9 3683.2 3689.1 3726.9 10099.8 10410.4 10443.5 10449.3 10454.6 10231.7 10392.4 10393.4 10406.6 10420.0 6883.0 7938.7 8073.2 8104.7 8145.5 4347.9 5099.0 5486.3 5637.9 5702.3 9439.4 9468.5 9479.8 9497.3 9668.7 9656.7 9657.0 9657.5 9658.0 9796.4 5297.0 5419.5 5808.8 6879.1 6990.9 7034.5 7320.5 8070.3 8213.8 8216.0 7199.5 7275.3 7307.8 7324.7 7366.6 6468.3 6987.2 7041.6 7060.0 7125.8 6749.1 6759.9 6844.8 6849.3 6851.0 4006.6 4418.8 4827.0 4970.0 5214.6 4817.3 4876.3 4916.4 5049.2 5106.3 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4488.36 Median:5056.39 stddev:1408.43 (27.9%) stddev-sans-first:1376.54 19:25:01 INFO - PROCESS | 1642 | Values: 282.2 303.8 307.1 311.6 318.2 4499.4 4818.6 5447.9 5472.6 5587.7 4473.9 5036.8 5049.2 5409.5 5441.3 3615.6 4154.0 4197.9 4204.8 4213.8 3516.7 3622.0 4136.5 4152.0 4217.2 3386.8 3477.8 3564.5 3823.3 4181.2 3653.8 4083.5 4143.6 4189.0 4204.8 3190.3 3520.4 3651.6 3654.4 3671.5 4553.5 4764.1 5064.8 5357.4 5432.1 4683.3 4732.6 4741.4 4742.7 4745.6 4836.7 5484.7 5771.2 5810.3 5813.0 3463.9 3795.3 3870.3 3903.3 3908.8 5268.4 6047.8 6057.8 6061.4 6064.5 3259.6 3955.7 3959.2 4004.2 4017.8 3182.4 3304.6 3669.9 3818.7 3997.6 4690.5 4692.5 4697.0 4732.1 4762.2 5594.4 5620.9 5659.7 5839.9 5850.0 1023.8 1053.4 1143.2 1294.8 1323.4 777.3 797.6 805.7 842.6 853.9 4161.6 4621.8 4656.0 4718.6 4792.4 4882.1 5150.8 5245.3 5715.9 5718.8 4244.3 4274.9 4692.5 5063.6 5123.5 2532.6 2548.6 2897.9 2948.2 2958.0 5082.3 5274.3 5493.6 5731.9 5741.7 5328.7 5534.5 5701.6 5806.5 5863.5 5731.5 5750.9 5798.9 5809.9 5856.6 5226.7 5327.0 5560.4 5587.8 5644.7 5122.7 5201.7 5488.4 5516.7 5524.8 4738.8 5467.6 5552.8 5812.2 5819.3 3114.9 3710.0 3735.7 3740.7 3791.7 5263.9 5669.0 5683.5 5716.2 5732.9 5011.5 5104.7 5361.0 5432.9 5475.6 4640.5 5379.5 5383.0 5390.8 5426.9 4626.9 5114.0 5250.2 5546.3 5674.5 5793.8 5840.6 5882.2 5887.0 5931.9 5116.0 5321.6 5348.6 5681.9 5692.7 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20112.46 Median:24747.09 stddev:30323.64 (122.5%) stddev-sans-first:30373.38 19:25:01 INFO - PROCESS | 1642 | Values: 618.6 728.7 734.0 741.1 777.6 13987.9 14392.7 14916.6 14938.6 15099.7 13441.0 13450.9 13570.5 13575.8 13667.0 814.3 830.1 831.5 832.8 836.7 807.6 831.9 839.6 840.5 841.2 858.2 871.9 872.0 872.2 874.5 848.8 862.6 863.6 864.0 864.0 608.8 637.2 644.6 645.0 646.7 13633.1 14105.7 14217.6 14273.5 14289.3 9849.0 11892.1 11976.0 12134.4 12202.5 10661.3 11157.8 11272.0 11360.9 11514.7 3518.0 3584.9 3640.3 3650.3 3658.2 55923.0 57944.8 75969.0 85062.1 87670.0 10267.0 10464.5 10556.3 10615.9 10936.8 19716.6 19885.0 19899.2 19908.5 20248.3 7710.9 7720.3 7733.3 7764.1 7800.0 4173.8 4179.6 4306.3 4321.6 4349.6 2886.2 3112.5 3422.3 3451.3 3487.4 558.5 645.6 653.5 665.1 676.3 536.3 596.5 645.4 659.2 680.5 8087.3 8395.8 8966.7 9253.7 9290.1 602.7 625.7 641.2 659.4 686.5 4419.2 4569.4 4581.7 4582.5 4686.6 108516.0 111833.0 113097.0 118983.4 122359.0 87715.0 97181.0 99269.5 102773.0 104058.0 73940.0 92738.0 93787.0 95434.5 96075.5 8756.6 8874.5 8910.4 8967.6 9076.0 44924.8 54378.7 56342.4 57070.0 57733.0 50304.0 71126.6 79987.0 80072.6 81766.6 9867.7 10435.0 10490.3 10572.6 10802.7 12112.5 12254.9 12272.6 12317.8 12473.1 11462.7 11634.8 11730.1 11744.2 11868.1 11574.6 11638.4 11719.1 11723.2 11915.5 11578.8 11619.8 11644.5 11702.8 11863.3 8216.8 10008.2 10036.9 10082.7 10118.0 10105.8 10333.3 10344.7 10350.7 10351.1 19:25:01 INFO - PROCESS | 1642 | -------- Summary: end -------- 19:25:01 INFO - PROCESS | 1642 | 19:25:01 INFO - TEST-INFO | 1642: exit 0 19:25:01 INFO - TEST-OK | dromaeo_css | took 1116685ms 19:25:01 INFO - TEST-START | kraken 19:25:01 INFO - operating with platform_type : mac_ 19:25:01 INFO - Initialising browser for kraken test... 19:25:01 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpvkG3Qd/profile http://localhost:49250/getInfo.html) 19:25:04 INFO - PROCESS | 1649 | 2017-01-06 19:25:04.809 plugin-container[1650:10708] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 19:25:04 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:04 INFO - PROCESS | 1649 | 2017-01-06 19:25:04.812 plugin-container[1650:10708] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.CFPasteboardClient' 19:25:04 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:04 INFO - PROCESS | 1649 | 2017-01-06 19:25:04.812 plugin-container[1650:10708] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:25:04 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 19:25:04 INFO - PROCESS | 1649 | colorDepth:24 19:25:04 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 19:25:04 INFO - PROCESS | 1649 | __metrics 19:25:05 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 19:25:05 INFO - TEST-INFO | 1649: exit 0 19:25:05 INFO - Browser initialized. 19:25:05 INFO - Running cycle 1/1 for kraken test... 19:25:05 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpvkG3Qd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:08 INFO - PROCESS | 1651 | 2017-01-06 19:25:08.663 plugin-container[1652:10828] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 19:25:08 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:08 INFO - PROCESS | 1651 | 2017-01-06 19:25:08.664 plugin-container[1652:10828] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4227, name = 'com.apple.CFPasteboardClient' 19:25:08 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:08 INFO - PROCESS | 1651 | 2017-01-06 19:25:08.664 plugin-container[1652:10828] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:25:18 INFO - PROCESS | 1651 | RSS: Main: 229617664 19:25:18 INFO - PROCESS | 1651 | 19:25:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:21 INFO - PROCESS | 1651 | RSS: Main: 241790976 19:25:21 INFO - PROCESS | 1651 | 19:25:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 19:25:25 INFO - PROCESS | 1651 | RSS: Main: 249458688 19:25:25 INFO - PROCESS | 1651 | 19:25:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 19:25:29 INFO - PROCESS | 1651 | RSS: Main: 253247488 19:25:29 INFO - PROCESS | 1651 | 19:25:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 19:25:31 INFO - PROCESS | 1651 | RSS: Main: 253648896 19:25:31 INFO - PROCESS | 1651 | 19:25:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:34 INFO - PROCESS | 1651 | RSS: Main: 253603840 19:25:34 INFO - PROCESS | 1651 | 19:25:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:38 INFO - PROCESS | 1651 | RSS: Main: 259289088 19:25:38 INFO - PROCESS | 1651 | 19:25:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:42 INFO - PROCESS | 1651 | RSS: Main: 258412544 19:25:42 INFO - PROCESS | 1651 | 19:25:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 19:25:45 INFO - PROCESS | 1651 | RSS: Main: 258424832 19:25:45 INFO - PROCESS | 1651 | 19:25:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:47 INFO - PROCESS | 1651 | RSS: Main: 257384448 19:25:47 INFO - PROCESS | 1651 | 19:25:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:50 INFO - PROCESS | 1651 | RSS: Main: 257388544 19:25:50 INFO - PROCESS | 1651 | 19:25:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:53 INFO - PROCESS | 1651 | RSS: Main: 257400832 19:25:53 INFO - PROCESS | 1651 | 19:25:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:57 INFO - PROCESS | 1651 | RSS: Main: 257802240 19:25:57 INFO - PROCESS | 1651 | 19:26:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:26:00 INFO - PROCESS | 1651 | RSS: Main: 257859584 19:26:00 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 19:26:02 INFO - PROCESS | 1651 | RSS: Main: 259645440 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | __start_tp_report 19:26:02 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 19:26:02 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 19:26:02 INFO - PROCESS | 1651 | |i|pagename|runs| 19:26:02 INFO - PROCESS | 1651 | |0;ai-astar;115;118;124;130;118;129;169;123;118;121 19:26:02 INFO - PROCESS | 1651 | |1;audio-beat-detection;158;138;102;174;147;141;117;119;173;138 19:26:02 INFO - PROCESS | 1651 | |2;audio-dft;199;199;197;196;195;185;197;197;200;197 19:26:02 INFO - PROCESS | 1651 | |3;audio-fft;84;59;60;85;59;63;82;83;106;77 19:26:02 INFO - PROCESS | 1651 | |4;audio-oscillator;84;71;90;72;69;71;86;70;70;88 19:26:02 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;76;110;79;117;134;121;90;88;89;74 19:26:02 INFO - PROCESS | 1651 | |6;imaging-darkroom;99;124;169;119;168;95;127;169;122;98 19:26:02 INFO - PROCESS | 1651 | |7;imaging-desaturate;135;110;134;139;134;89;90;91;89;86 19:26:02 INFO - PROCESS | 1651 | |8;json-parse-financial;57;56;57;69;64;58;61;59;61;60 19:26:02 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;74;72;60;119;109;104;99;79;71;73 19:26:02 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;87;85;84;84;83;84;86;86;87;84 19:26:02 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;152;152;145;139;169;151;157;165;212;186 19:26:02 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;191;222;171;172;168;170;222;167;225;225 19:26:02 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;68;68;70;68;69;69;68;79;67 19:26:02 INFO - PROCESS | 1651 | __end_tp_report 19:26:02 INFO - PROCESS | 1651 | __start_cc_report 19:26:02 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1010 19:26:02 INFO - PROCESS | 1651 | __end_cc_report 19:26:02 INFO - PROCESS | 1651 | __startTimestamp1483759562924__endTimestamp 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | ------- Summary: start ------- 19:26:02 INFO - PROCESS | 1651 | Number of tests: 14 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:126.50 Median:123.50 stddev:15.71 (12.7%) stddev-sans-first:16.11 19:26:02 INFO - PROCESS | 1651 | Values: 115.0 118.0 124.0 130.0 118.0 129.0 169.0 123.0 118.0 121.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:144.00 stddev:23.66 (16.4%) stddev-sans-first:24.25 19:26:02 INFO - PROCESS | 1651 | Values: 158.0 138.0 102.0 174.0 147.0 141.0 117.0 119.0 173.0 138.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:196.20 Median:197.00 stddev:4.21 (2.1%) stddev-sans-first:4.34 19:26:02 INFO - PROCESS | 1651 | Values: 199.0 199.0 197.0 196.0 195.0 185.0 197.0 197.0 200.0 197.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:75.80 Median:79.50 stddev:15.40 (19.4%) stddev-sans-first:16.04 19:26:02 INFO - PROCESS | 1651 | Values: 84.0 59.0 60.0 85.0 59.0 63.0 82.0 83.0 106.0 77.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.00 stddev:8.69 (11.1%) stddev-sans-first:8.85 19:26:02 INFO - PROCESS | 1651 | Values: 84.0 71.0 90.0 72.0 69.0 71.0 86.0 70.0 70.0 88.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:77.50 stddev:21.07 (27.2%) stddev-sans-first:20.82 19:26:02 INFO - PROCESS | 1651 | Values: 76.0 110.0 79.0 117.0 134.0 121.0 90.0 88.0 89.0 74.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:129.00 Median:169.00 stddev:29.66 (17.5%) stddev-sans-first:29.40 19:26:02 INFO - PROCESS | 1651 | Values: 99.0 124.0 169.0 119.0 168.0 95.0 127.0 169.0 122.0 98.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:109.70 Median:87.50 stddev:23.18 (26.5%) stddev-sans-first:22.71 19:26:02 INFO - PROCESS | 1651 | Values: 135.0 110.0 134.0 139.0 134.0 89.0 90.0 91.0 89.0 86.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:3.91 (6.5%) stddev-sans-first:3.97 19:26:02 INFO - PROCESS | 1651 | Values: 57.0 56.0 57.0 69.0 64.0 58.0 61.0 59.0 61.0 60.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:86.00 Median:72.50 stddev:19.92 (27.5%) stddev-sans-first:20.65 19:26:02 INFO - PROCESS | 1651 | Values: 74.0 72.0 60.0 119.0 109.0 104.0 99.0 79.0 71.0 73.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:1.41 (1.7%) stddev-sans-first:1.30 19:26:02 INFO - PROCESS | 1651 | Values: 87.0 85.0 84.0 84.0 83.0 84.0 86.0 86.0 87.0 84.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:162.80 Median:161.00 stddev:21.84 (13.6%) stddev-sans-first:22.81 19:26:02 INFO - PROCESS | 1651 | Values: 152.0 152.0 145.0 139.0 169.0 151.0 157.0 165.0 212.0 186.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.30 Median:206.50 stddev:26.85 (13.0%) stddev-sans-first:28.47 19:26:02 INFO - PROCESS | 1651 | Values: 191.0 222.0 171.0 172.0 168.0 170.0 222.0 167.0 225.0 225.0 19:26:02 INFO - PROCESS | 1651 | 19:26:02 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:3.86 (5.6%) stddev-sans-first:3.64 19:26:02 INFO - PROCESS | 1651 | Values: 64.0 68.0 68.0 70.0 68.0 69.0 69.0 68.0 79.0 67.0 19:26:02 INFO - PROCESS | 1651 | -------- Summary: end -------- 19:26:02 INFO - PROCESS | 1651 | 19:26:03 INFO - TEST-INFO | 1651: exit 0 19:26:04 INFO - TEST-OK | kraken | took 62209ms 19:26:04 INFO - SUITE-END | took 1178s 19:26:04 INFO - Completed test suite (00:19:38) 19:26:04 INFO - javascript benchmark 19:26:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7007.503082745725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.6292307846134, 3377.3076519313527, 3405.8637654493828, 3418.2138108235104, 3418.384690755663, 5664.263645726055, 5797.217375654285, 5829.708514574276, 5854.238948936632, 5890.263717035371, 5745.454181852718, 5802.883942321151, 5803.274590676166, 5830.562707796911, 5884.382139875315, 5222.009878136549, 5254.080535906221, 5275.050490911634, 5279.076161671711, 5317.335333083364, 5326.7070311132875, 5329.120695085326, 5342.412334643186, 5349.545288650469, 5355.384130824947, 5208.7395630218525, 5222.9477705223035, 5306.70813105279, 5319.122344813101, 5321.946780532203, 5300.787968481256, 5311.814086506973, 5325.573954083664, 5336.893262134774, 5346.304980352529, 4527.773611319454, 5028.742814296426, 5259.947400526023, 5292.0, 5312.521873031407, 5751.568632352591, 5812.302523697141, 5879.382664820175, 5901.439363260483, 5929.377415371367, 6036.060749644638, 6194.690265486708, 6234.937650623527, 6240.750369985195, 6242.063690446424, 5284.418713941502, 6275.403836635513, 6296.401841825065, 6298.622082675009, 6308.3060863305, 5773.278340207474, 5836.358000619928, 5857.0, 5951.5238780897425, 6005.0, 6243.0, 6263.686815659199, 6284.874302513924, 6294.181756371734, 6316.747330106744, 6139.26328840542, 6169.444749972524, 6183.628982261079, 6184.226971628546, 6184.721687523982, 6262.342454042351, 6283.37166283368, 6291.339409362043, 6324.620522768649, 6329.145565348711, 6113.510919126459, 6124.234470691164, 6151.753929842756, 6166.7224974876235, 6224.751009959641, 6167.167432396569, 6204.3795620437595, 6224.595401298901, 6232.3144454110015, 6237.906431403532, 4987.600991920638, 4998.825041123616, 5005.3242812220615, 5008.649394542347, 5011.724355160502, 4326.918270432392, 4362.1275744851155, 4373.715708478939, 4408.647308215335, 4470.083632855257, 4798.328234047236, 5806.44838740319, 5977.193078934288, 5978.252718410199, 6002.249718785152, 6300.810975670737, 6305.653189074645, 6307.873842523216, 6323.019931910561, 6340.904886426707, 5792.768289268382, 5866.67733274674, 5869.236999190078, 5938.8812223755285, 5977.521798256129, 5386.192071189353, 5433.293671822637, 5464.0711079116645, 5490.972545137249, 5538.141588053858, 5202.7918883245, 5301.814436494781, 6151.231096112986, 6332.778352757631, 6399.552031357946, 6169.5064394849205, 6171.783987560414, 6211.099390588249, 6238.282597501346, 6298.590591611531, 6150.7847225346895, 6251.124842522141, 6355.777547785805, 6368.42684158428, 6382.489400848014, 3048.725614694688, 4167.083241686824, 5105.4384017757275, 5730.0, 6036.456718895321, 4816.54242846929, 6161.537884658579, 6221.471174949999, 6293.213348331458, 6318.020706790455, 5414.106672399168, 5888.440598143169, 6208.937910620836, 6215.502759779117, 6215.564910456224, 6050.848728781815, 6148.723307451265, 6198.2252218472695, 6203.627782333075, 6205.503559715122, 5930.140129681258, 5975.940240597538, 6070.666113363807, 6110.114033465212, 6138.07928810682, 6113.537117903944, 6116.366205733216, 6163.7842675506145, 6167.537434692326, 6245.375462453719, 5517.751701173376, 5642.294713160855, 6076.54425918049, 6126.111713801563, 6149.077638354103], "value": 5676.062090169412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.55539569782877, 506.8580797376734, 538.5503104907402, 564.0861803877718, 583.00015473463, 36715.26569468609, 39091.413628795555, 39153.60846391535, 39163.608363916355, 39167.82496525102, 39844.800775996155, 40350.39474407886, 40397.7980110099, 40411.59588404115, 40430.98922526931, 9183.81632367354, 9292.72121836346, 9359.532023398837, 9364.765880853, 9376.156145946863, 7937.880931786028, 8012.5593092379895, 9319.440833550008, 9329.860052099224, 9343.672971446002, 9330.113639204264, 9362.859557106614, 9363.531823408837, 9391.201747851406, 9392.154706076451, 8047.718329858485, 9264.073592640716, 9315.906840931606, 9347.859782103274, 9366.95316523413, 9261.16649501548, 9287.76780580484, 9335.90664093364, 9367.953160234223, 9384.390014649027, 38355.424668629996, 38459.23081538382, 38800.80599596984, 38831.8058409709, 38873.611263887564, 2870.2680816391894, 3172.1118086935694, 3696.815159242027, 3865.0, 3907.648311651965, 28407.857960710066, 28568.42863142746, 29521.0, 30443.847780760956, 30583.2354191147, 3108.1607965849093, 3209.8555564999397, 3212.6626704195955, 3250.6261779895376, 3251.057193413907, 453511.0, 457138.0, 457599.0, 457738.0, 458028.7098564519, 33679.663203368145, 34331.4850277246, 34689.13277168041, 35785.64214357823, 35805.28389432197, 35635.64364356375, 35821.10447238788, 35875.282494349965, 35947.281054378764, 35956.460653090224, 14531.200783956983, 14650.706985860223, 14683.339249733788, 14698.33857476416, 14745.483908063166, 12293.955013823746, 12366.876331236752, 12384.318862462651, 12512.249265044127, 12530.81203781944, 7865.252800983897, 7885.29032387088, 7917.960410197912, 7960.800979975431, 7963.805429185552, 2831.9858400707863, 3173.4287828191145, 3255.9023229303157, 3297.060337803762, 3310.1724568857785, 758.7973062695689, 825.7646570727314, 888.8888888888889, 995.840665493532, 1070.1171533484905, 29519.704802952125, 29745.851270743507, 29939.550906736415, 29979.364013823797, 30195.0, 807.725373373056, 936.7892224249625, 947.8767760191131, 1074.6775967209805, 1088.6788397422622, 14929.40282388714, 15294.464693735667, 15387.307571159325, 15669.451569195024, 15713.607159820867, 648958.0, 678761.6061919659, 682975.0, 686598.0, 689315.0, 56686.43313566894, 56718.0, 57089.42910570924, 57232.71383643139, 57241.71379143161, 1352.2832898563777, 1374.9656258593416, 1388.1324172392256, 1388.4585011845388, 1392.6796836727406, 28726.569101463076, 29159.125226243246, 29426.852865735535, 29536.852315738284, 30003.549946751253, 47600.761996189794, 47847.52152478431, 48006.519934800206, 48021.03957920752, 48070.75964620154, 601211.0, 603469.0, 603802.0, 604331.0, 605197.0, 26337.604935925592, 26418.339541511617, 26720.0, 26735.0, 26766.598501022112, 44761.77619112014, 44884.0, 45028.32457513074, 45698.31452528281, 46004.0, 37781.0, 37784.433233502066, 38343.84968450951, 38441.80779096087, 39070.0, 30889.382212355176, 37024.62975370212, 37285.81357093197, 37321.0, 38515.0, 32509.837450813542, 33606.159846003065, 36766.0, 37658.2468350626, 38234.80882595569, 32198.83900580482, 33931.83034084814, 34153.48769768406, 34472.13819654529, 34711.95864123979, 25091.247262581423, 25420.85606147691, 25599.0, 25602.23193304204, 25979.843225083896], "value": 18056.622301130144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.24005189232344, 367.6819551088308, 378.4947095627338, 387.1965671232194, 397.85279446604744, 18474.538136546595, 19407.0, 20280.39158825234, 20414.591708165826, 20607.587848243027, 18970.525736856587, 19110.904445477787, 19575.048810614793, 19869.801301986976, 20048.59902801943, 5560.221568980346, 5631.380548139711, 5733.455321744427, 5883.3528311885875, 5891.70382515848, 5628.099504079348, 5781.306243250816, 5784.45047720468, 5790.478856902878, 5799.710014499279, 5560.944390556103, 5696.971515142419, 5750.741216645261, 5755.712214389285, 5895.380984996578, 5949.345571987078, 5994.820155395323, 6000.159977603139, 6003.369646187153, 6030.698465076729, 5565.833025009256, 5740.167675687044, 5782.335031471351, 5803.361630220672, 5826.126081087828, 12650.0, 12819.87180128196, 12875.356232188353, 13006.609801705965, 13063.412146453338, 2163.7511686156136, 2198.296545105567, 2212.0, 2234.184522649238, 2661.321363052409, 8976.596053177558, 9910.504474776304, 10036.59853605855, 11618.360990145538, 15388.461403850812, 1606.3333716507636, 1610.6778644271076, 1776.0, 1838.843698285634, 1900.6293772714325, 108380.0, 108941.0, 110967.0, 111526.0, 115451.0, 11468.770624587461, 11564.595239166589, 11821.172517923662, 11830.112741544419, 11838.230515016496, 12927.0, 14388.28058597066, 14793.778093328609, 14814.259287035606, 14880.404783808526, 8211.71259005932, 8348.916510834813, 8483.575821208915, 8571.057183709787, 8585.570721464026, 6841.760538381132, 8397.370197235232, 8398.958005209935, 8476.279516241066, 8537.18896704812, 4443.666724995638, 4446.799894004777, 4549.977250113729, 4566.88582785433, 4704.835330763475, 1829.9203469952793, 1946.7371904792672, 1953.619044286379, 1980.227711192636, 2000.7098970649465, 700.6041586503609, 766.1954947305308, 861.237804542984, 908.5593487158723, 931.7437704631145, 18585.5353616158, 19830.801691982895, 19921.402357929284, 20146.39560813178, 20257.29099481511, 864.6195673903462, 911.6581282019242, 941.8807682713893, 945.9716208513755, 949.3876449690049, 10510.684679459628, 10524.36853788775, 10561.0, 10611.31026483276, 10635.627753028763, 565762.0, 572140.0, 575600.0, 576192.0, 580020.0, 102910.0, 126761.0, 129041.0, 130655.34672326577, 132053.33973330073, 959.1080295325274, 975.1077763846143, 990.4008075114596, 991.108002797488, 994.945357920592, 17823.554411139306, 18520.79614825032, 18796.68423210362, 18799.248030078645, 18895.866248025162, 37792.86621401362, 49367.753161233966, 49645.503544964085, 53568.464315356345, 54197.72901135469, 61588.69205653943, 78344.99032611094, 80390.5980470094, 81183.0, 82883.17116828755, 7725.652345644572, 7873.488223265469, 7906.644201011083, 8047.436679432383, 8107.270345668918, 10346.861845197172, 10896.727581810519, 11991.520339186334, 12005.63983080509, 12510.499580016698, 9898.861630912537, 10599.364038157426, 10689.091427228772, 10836.078933290759, 10914.945425272823, 10003.549840257352, 10407.895921040996, 10565.577376904837, 10581.841272380767, 10669.679909602724, 10786.460676965964, 10963.068139208257, 11109.777804444027, 11183.552657893593, 11284.21010529255, 7698.307152356315, 7876.881846772418, 8101.9594902027475, 8204.302634275915, 8352.958235208785, 8027.959860200662, 9289.76775580589, 10773.62292319765, 10808.783824323313, 10994.890051099386], "value": 9171.688320140622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.3983926750766, 1458.0814087125113, 1616.1030628001463, 1741.2425594866227, 1781.9198136083876, 7622.199669034755, 7819.413543984196, 8065.758027259177, 8585.527795971211, 8616.31069514439, 8064.072631647362, 8393.328533717304, 8400.3279737621, 8490.448120872154, 8506.064332923374, 1936.893470859102, 2318.130700987134, 2361.988190059047, 2363.385519764865, 2376.5603363377745, 1975.664137096697, 2023.2008356699096, 2093.675480300556, 2400.3999000249937, 2409.831311808174, 2327.9883600581975, 2349.753275906031, 2363.6218205087102, 2366.089055713554, 2371.691680081587, 2297.5519773644064, 2316.270374831931, 2328.6739856420113, 2334.579775640384, 2340.4382948092507, 2149.000714667687, 2242.6299660555987, 2360.3155085025323, 2378.797802186816, 2382.9046838126455, 8216.753497395088, 8348.0, 8486.830263394697, 8516.063233044422, 8553.358498112666, 4527.366168736379, 5203.505666961632, 5241.68549887008, 5267.841964741064, 5287.762050707727, 3338.3657105149946, 3416.299658569987, 3648.799316037617, 3649.3431182387158, 3652.2330310634798, 1015.2182819229226, 1047.6909311752975, 1087.276960821053, 1099.9725006874892, 1116.3413585984308, 11093.27893686916, 11153.553857845676, 11165.609203677914, 11213.495392707266, 11222.326660400402, 4491.820327186876, 4533.206688829442, 4556.430446194226, 4570.177368073712, 4811.639127065484, 9496.287778416647, 9546.809063818684, 9591.712248632552, 9607.807843843084, 9616.423014619146, 5261.868453288622, 5263.34208223972, 5263.684178949199, 5270.051390749625, 5281.445448227881, 4137.627613514798, 4697.389339385858, 4743.66794324394, 4816.638752093537, 4824.34871292371, 3272.9018129456153, 3306.93386132276, 3862.420636904487, 3957.52509698838, 4006.7996600169877, 1240.3860089255695, 1251.7621651886113, 1254.5420921363636, 1262.5896583610363, 1265.4368805881295, 872.6029656506274, 880.5465185429509, 882.2236431939851, 883.88067610873, 919.8298314811781, 5587.832365029056, 5817.592768506164, 5841.415858414124, 5848.1227815827115, 5933.258342707161, 910.5629297937028, 918.7703074231442, 920.6409500294891, 948.3219498058921, 982.3565564555228, 3589.0847833802736, 3639.872604458831, 3683.1528748388023, 3689.096171438015, 3726.869559565402, 10099.848502272473, 10410.427426491464, 10443.477826108665, 10449.320794148356, 10454.63408780689, 10231.7442063949, 10392.42841643717, 10393.37639741618, 10406.635767748092, 10420.010099040579, 6882.965585172142, 7938.722144724907, 8073.192680731997, 8104.716334928367, 8145.470544414594, 4347.869563913087, 5099.0, 5486.286782718221, 5637.943620563906, 5702.344230413555, 9439.386439881386, 9468.47923364194, 9479.810403791747, 9497.28770342241, 9668.70993870185, 9656.71029869105, 9657.034296570288, 9657.46883921391, 9658.0, 9796.363236389612, 5296.973515132399, 5419.512243898068, 5808.767649293981, 6879.105716256855, 6990.8951365728535, 7034.507584469038, 7320.524165929198, 8070.273675369245, 8213.835723285381, 8215.958920205361, 7199.496035277481, 7275.308845659654, 7307.7807665770115, 7324.670389832577, 7366.63166841645, 6468.320826313357, 6987.196472405535, 7041.5775053496955, 7060.0, 7125.752058264741, 6749.097887908247, 6759.86480270382, 6844.760433384808, 6849.280825513449, 6850.965745171242, 4006.6193711597352, 4418.7569683666425, 4826.9517304827905, 4970.0, 5214.582833373397, 4817.253325734517, 4876.341693871424, 4916.360873086476, 5049.166887463527, 5106.336176297058], "value": 4418.191104386182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.1605722974151, 303.8222639755744, 307.14000797766255, 311.6322739167781, 318.15688425671965, 4499.437570303712, 4818.566329030386, 5447.891042179159, 5472.616916815819, 5587.7253900765845, 4473.859165912688, 5036.82371117011, 5049.166887463573, 5409.483835506922, 5441.347038355393, 3615.6022837487853, 4154.023804405962, 4197.9370309445385, 4204.768737719424, 4213.831446742134, 3516.7010804081683, 3622.0, 4136.503619565657, 4151.958480415203, 4217.1987322408795, 3386.7967921924765, 3477.7565570410084, 3564.488978356317, 3823.254465379252, 4181.205570941512, 3653.780773153619, 4083.530394004668, 4143.647789937859, 4189.0, 4204.810783514749, 3190.3140824722564, 3520.419130843408, 3651.5618125824803, 3654.4152935530187, 3671.4859919611276, 4553.476350219734, 4764.094821983812, 5064.784451731594, 5357.4106848246665, 5432.130859062531, 4683.314006957493, 4732.574068333832, 4741.407324084489, 4742.668013239075, 4745.596624286905, 4836.661433699643, 5484.670919744828, 5771.210924613383, 5810.302763668386, 5813.0, 3463.9134021649406, 3795.2599243147597, 3870.322693528621, 3903.33643280643, 3908.804559772, 5268.367795864482, 6047.7580896764075, 6057.757689692407, 6061.424164704346, 6064.4541991221, 3259.6414394416597, 3955.723099383073, 3959.1883663848844, 4004.1991601679197, 4017.7544961062163, 3182.3794360100023, 3304.5538852255117, 3669.9357186416173, 3818.694504439638, 3997.600239975979, 4690.460597031317, 4692.498400511871, 4697.0, 4732.053589282157, 4762.238041913277, 5594.440555944454, 5620.91568626471, 5659.679531392109, 5839.9124013139835, 5850.034744267148, 1023.7747695506977, 1053.3679792124817, 1143.1540659911605, 1294.792833146692, 1323.444153455551, 777.3081957058223, 797.5932274540027, 805.7381351060928, 842.5618678287378, 853.8505761491838, 4161.625453709181, 4621.792019359137, 4655.952410707564, 4718.551737584924, 4792.400949881265, 4882.072406242803, 5150.793968241303, 5245.344331958505, 5715.914261286084, 5718.799842005593, 4244.2996905510245, 4274.850380236677, 4692.53074692528, 5063.620228482879, 5123.462036486189, 2532.5821239495276, 2548.5922252439523, 2897.855586865704, 2948.2039849241014, 2957.985210073936, 5082.33929589151, 5274.314339135888, 5493.587980901449, 5731.942680573141, 5741.655500669973, 5328.733563321818, 5534.496966064858, 5701.600887937804, 5806.477417032487, 5863.501602363762, 5731.541476681772, 5750.942490575125, 5798.884022319615, 5809.912851307234, 5856.62369343204, 5226.712530810842, 5326.97336513315, 5560.414407300625, 5587.814945481036, 5644.717764111696, 5122.692638441706, 5201.748906933167, 5488.368837583729, 5516.738137363662, 5524.806631767869, 4738.772776794901, 5467.644603100785, 5552.750126244409, 5812.244408226903, 5819.272590926134, 3114.8909788157307, 3709.9814500927323, 3735.6637902588895, 3740.682042026458, 3791.6966642667967, 5263.947360526346, 5668.971655141863, 5683.460071293221, 5716.199732037435, 5732.885342293047, 5011.498850114959, 5104.668196567211, 5361.0, 5432.918506222489, 5475.6440831345835, 4640.512746161605, 5379.515843574097, 5383.0, 5390.838274851761, 5426.918596220981, 4626.861194164046, 5113.977204559029, 5250.212468129658, 5546.306711661043, 5674.4892959633835, 5793.826185214451, 5840.561957853263, 5882.23530940975, 5886.970565147147, 5931.881362372815, 5116.030328323548, 5321.600879933943, 5348.625596208228, 5681.886362272814, 5692.658440493584], "value": 4028.6708923110136, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.6319140111632, 728.7194430144393, 733.9963300183498, 741.0884611927329, 777.6228529163357, 13987.930060349696, 14392.71214575708, 14916.627084322898, 14938.551843444715, 15099.6980060399, 13441.0, 13450.93274533626, 13570.525031623894, 13575.796363054562, 13667.0, 814.3485211830541, 830.0620299062051, 831.5343407691712, 832.8459235041506, 836.7155167243136, 807.5679511461369, 831.8876951611516, 839.5634270179534, 840.4537050916891, 841.1924552429675, 858.2361698088706, 871.8910136232971, 871.9694810681596, 872.2237208884098, 874.54960695242, 848.8429640516493, 862.5687156421789, 863.5897948474487, 864.0020776003695, 864.0322838420946, 608.8295277322356, 637.1621317966905, 644.6390021587926, 644.9516286278548, 646.7283740828816, 13633.113847599874, 14105.717885642332, 14217.644558886008, 14273.500427484989, 14289.285535723173, 9849.0, 11892.108091893142, 11976.0, 12134.393280335948, 12202.450889709984, 10661.307015043998, 11157.832632510519, 11272.0, 11360.943195284053, 11514.654560363202, 3517.978232945309, 3584.874529391459, 3640.3447379471686, 3650.269946010782, 3658.1951970566433, 55923.0, 57944.8411031777, 75969.0, 85062.14937850666, 87670.0, 10267.0, 10464.52909619069, 10556.313839600401, 10615.946920265504, 10936.781264374828, 19716.60566788656, 19885.0, 19899.204031838563, 19908.50228744293, 20248.29130980438, 7710.884336734954, 7720.266574675396, 7733.304002639789, 7764.068311802507, 7800.0, 4173.812178451977, 4179.623833854967, 4306.332518459643, 4321.632661223831, 4349.608535231844, 2886.1918662774456, 3112.486439737463, 3422.3326451342245, 3451.2924850405607, 3487.4245749451566, 558.5168828962918, 645.6223109480912, 653.5163978655855, 665.0954701605813, 676.2797620534116, 536.2760273630568, 596.4631831351732, 645.4320198225626, 659.2484567592948, 680.4522359500551, 8087.272145506932, 8395.832083358298, 8966.730998070068, 9253.67612133572, 9290.142668625378, 602.6835911146595, 625.7246811402969, 641.153677146172, 659.4262991197688, 686.4748467422426, 4419.226635338803, 4569.405977222939, 4581.679282450264, 4582.473015603248, 4686.601638860667, 108516.0, 111833.0, 113097.0, 118983.40508297403, 122359.0, 87715.0, 97181.0, 99269.50365248272, 102773.0, 104058.0, 73940.0, 92738.0, 93787.0, 95434.52282738542, 96075.51962240283, 8756.562171891508, 8874.467531948103, 8910.420822646507, 8967.551622418723, 9076.049424425224, 44924.77537612291, 54378.728106359216, 56342.43657563536, 57070.00764919624, 57733.0, 50304.0, 71126.57746845137, 79987.0, 80072.59963700145, 81766.59116704378, 9867.703968880658, 10434.956504349504, 10490.265681402228, 10572.577096916037, 10802.703675558669, 12112.515499379926, 12254.931350800522, 12272.566881861481, 12317.75364492723, 12473.064520160842, 11462.656120316404, 11634.825477617673, 11730.12024098179, 11744.236624619372, 11868.109891758326, 11574.594889178838, 11638.41807909618, 11719.123030399165, 11723.237989530653, 11915.52337906474, 11578.826317605075, 11619.825702614298, 11644.475998580254, 11702.765944681229, 11863.34751588671, 8216.835663286582, 10008.199344052313, 10036.899631003596, 10082.747931301776, 10118.0, 10105.797884042426, 10333.276670632984, 10344.689659310232, 10350.689479315633, 10351.120154786626], "value": 7076.150078291358, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 124.0, 130.0, 118.0, 129.0, 169.0, 123.0, 118.0, 121.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 138.0, 102.0, 174.0, 147.0, 141.0, 117.0, 119.0, 173.0, 138.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 199.0, 197.0, 196.0, 195.0, 185.0, 197.0, 197.0, 200.0, 197.0], "value": 196.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 85.0, 59.0, 63.0, 82.0, 83.0, 106.0, 77.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 90.0, 72.0, 69.0, 71.0, 86.0, 70.0, 70.0, 88.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 110.0, 79.0, 117.0, 134.0, 121.0, 90.0, 88.0, 89.0, 74.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 124.0, 169.0, 119.0, 168.0, 95.0, 127.0, 169.0, 122.0, 98.0], "value": 129.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 110.0, 134.0, 139.0, 134.0, 89.0, 90.0, 91.0, 89.0, 86.0], "value": 109.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 69.0, 64.0, 58.0, 61.0, 59.0, 61.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 60.0, 119.0, 109.0, 104.0, 99.0, 79.0, 71.0, 73.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 84.0, 83.0, 84.0, 86.0, 86.0, 87.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 145.0, 139.0, 169.0, 151.0, 157.0, 165.0, 212.0, 186.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 222.0, 171.0, 172.0, 168.0, 170.0, 222.0, 167.0, 225.0, 225.0], "value": 193.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0, 68.0, 79.0, 67.0], "value": 69.0, "unit": "score"}]}]} 19:26:04 INFO - Return code: 0 19:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:04 ERROR - # TBPL SUCCESS # 19:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:26:04 INFO - 2017-01-06 19:26:04.278 screenresolution[1656:11208] starting screenresolution argv=screenresolution get 19:26:04 INFO - 2017-01-06 19:26:04.281 screenresolution[1656:11208] Display 0: 1600x1200x32@60 19:26:04 INFO - 2017-01-06 19:26:04.287 screenresolution[1657:11211] starting screenresolution argv=screenresolution list 19:26:04 INFO - Available Modes on Display 0 19:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:26:04 INFO - Intel Iris: 19:26:04 INFO - Chipset Model: Intel Iris 19:26:04 INFO - Type: GPU 19:26:04 INFO - Bus: Built-In 19:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:26:04 INFO - Vendor: Intel (0x8086) 19:26:04 INFO - Device ID: 0x0a2e 19:26:04 INFO - Revision ID: 0x0009 19:26:04 INFO - Displays: 19:26:04 INFO - Display: 19:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:26:04 INFO - Display Serial Number: 1600x1200 60 19:26:04 INFO - Main Display: Yes 19:26:04 INFO - Mirror: Off 19:26:04 INFO - Online: Yes 19:26:04 INFO - Rotation: Supported 19:26:04 INFO - Return code: 0 19:26:04 INFO - Running post-action listener: _resource_record_post_action 19:26:04 INFO - [mozharness: 2017-01-07 03:26:04.539874Z] Finished run-tests step (success) 19:26:04 INFO - Running post-run listener: _resource_record_post_run 19:26:04 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 34517504; Write bytes: 656340480; Read time: 319; Write time: 1924 19:26:04 INFO - TinderboxPrint: CPU usage
54.3% 19:26:04 INFO - TinderboxPrint: I/O read bytes / time
34,517,504 / 319 19:26:04 INFO - TinderboxPrint: I/O write bytes / time
656,340,480 / 1,924 19:26:04 INFO - TinderboxPrint: CPU idle
2,210.8 (45.7%) 19:26:04 INFO - TinderboxPrint: CPU system
977.8 (20.2%) 19:26:04 INFO - TinderboxPrint: CPU user
1,653.1 (34.1%) 19:26:04 INFO - TinderboxPrint: Swap in / out
379,609,088 / 0 19:26:04 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 346315264; Write bytes: 346019328; Read time: 27031; Write time: 642 19:26:04 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 32449024; Write bytes: 303165440; Read time: 296; Write time: 1254 19:26:05 INFO - Running post-run listener: _upload_blobber_files 19:26:05 INFO - Blob upload gear active. 19:26:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:05 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 19:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:07 INFO - (blobuploader) - INFO - Done attempting. 19:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:08 INFO - (blobuploader) - INFO - Done attempting. 19:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:11 INFO - (blobuploader) - INFO - Done attempting. 19:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:11 INFO - Return code: 0 19:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7fdc061cc4764e7713807ce77c6dd75c5d4baced78e3ff6d4627851dee3860bce6e1f2fb09f13a656cf71b4f2cb870ffcfc495c47cbbac5726923450f11dfdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e02acc84897559ad0c9743c2354647a15ecd7c92766ca031a2c2ccd4958970dc246bd75164d6a5ac2b348b1d49d37a3badaa7a5753d5e3e0d24f50f68d3cf1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d48b0d019826f44341d9cc72bfa45fe0780d9e964b7199202d9515e84565941d19e441d6c309ae70d1ca271fba723eb0c05c05b59401705d2fc45717cf2eefb"} 19:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:11 INFO - Contents: 19:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7fdc061cc4764e7713807ce77c6dd75c5d4baced78e3ff6d4627851dee3860bce6e1f2fb09f13a656cf71b4f2cb870ffcfc495c47cbbac5726923450f11dfdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e02acc84897559ad0c9743c2354647a15ecd7c92766ca031a2c2ccd4958970dc246bd75164d6a5ac2b348b1d49d37a3badaa7a5753d5e3e0d24f50f68d3cf1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d48b0d019826f44341d9cc72bfa45fe0780d9e964b7199202d9515e84565941d19e441d6c309ae70d1ca271fba723eb0c05c05b59401705d2fc45717cf2eefb"} 19:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:11 INFO - Copying logs to upload dir... 19:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.163735 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-06 19:26:11.100465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 19:26:11.104963) ========= 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.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/Mozilla-Aurora/sha512/e7fdc061cc4764e7713807ce77c6dd75c5d4baced78e3ff6d4627851dee3860bce6e1f2fb09f13a656cf71b4f2cb870ffcfc495c47cbbac5726923450f11dfdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e02acc84897559ad0c9743c2354647a15ecd7c92766ca031a2c2ccd4958970dc246bd75164d6a5ac2b348b1d49d37a3badaa7a5753d5e3e0d24f50f68d3cf1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d48b0d019826f44341d9cc72bfa45fe0780d9e964b7199202d9515e84565941d19e441d6c309ae70d1ca271fba723eb0c05c05b59401705d2fc45717cf2eefb"} build_url:https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/LP_inqA-TpOZp71Kxclq4g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7fdc061cc4764e7713807ce77c6dd75c5d4baced78e3ff6d4627851dee3860bce6e1f2fb09f13a656cf71b4f2cb870ffcfc495c47cbbac5726923450f11dfdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e02acc84897559ad0c9743c2354647a15ecd7c92766ca031a2c2ccd4958970dc246bd75164d6a5ac2b348b1d49d37a3badaa7a5753d5e3e0d24f50f68d3cf1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d48b0d019826f44341d9cc72bfa45fe0780d9e964b7199202d9515e84565941d19e441d6c309ae70d1ca271fba723eb0c05c05b59401705d2fc45717cf2eefb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 19:26:11.142254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:26:11.142649) ========= 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.21dOcAYrBq/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.79xI1LdNSV/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005212 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 19:26:11.194673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 19:26:11.195096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 19:26:11.195513) ========= ========= Total master_lag: 0.21 =========