builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1475779645.2 results: success (0) buildid: 20161006094701 builduid: e195d20f67e74b48b49034b2f7f2a19f revision: ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.198701) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.199724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.200267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.225843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.226457) ========= 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.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-06 11:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-10-06 11:47:25 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184290 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.439459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.440172) ========= 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.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.027545 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:25.491537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 11:47:25.492344) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-06 11:47:25,566 truncating revision to first 12 chars 2016-10-06 11:47:25,566 Setting DEBUG logging. 2016-10-06 11:47:25,567 attempt 1/10 2016-10-06 11:47:25,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ed4bc0d84b0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 11:47:26,986 unpacking tar archive at: autoland-ed4bc0d84b0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.666167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 11:47:27.181873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:27.182252) ========= script_repo_revision: ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:27.182690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:27.183036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 11:47:27.202867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-06 11:47:27.203705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:47:27 INFO - MultiFileLogger online at 20161006 11:47:27 in /builds/slave/test 11:47:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 11:47:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:27 INFO - {'append_to_log': False, 11:47:27 INFO - 'base_work_dir': '/builds/slave/test', 11:47:27 INFO - 'blob_upload_branch': 'Autoland', 11:47:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:27 INFO - 'branch': 'Autoland', 11:47:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:27 INFO - 'config_files': ('talos/mac_config.py',), 11:47:27 INFO - 'default_actions': ('clobber', 11:47:27 INFO - 'read-buildbot-config', 11:47:27 INFO - 'download-and-extract', 11:47:27 INFO - 'populate-webroot', 11:47:27 INFO - 'create-virtualenv', 11:47:27 INFO - 'install', 11:47:27 INFO - 'run-tests'), 11:47:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:27 INFO - 'download_minidump_stackwalk': True, 11:47:27 INFO - 'download_symbols': 'ondemand', 11:47:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:47:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:47:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:47:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:47:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:27 INFO - 'installer_path': 'installer.exe', 11:47:27 INFO - 'log_level': 'info', 11:47:27 INFO - 'log_name': 'talos', 11:47:27 INFO - 'log_to_console': True, 11:47:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:47:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:47:27 INFO - 'opt_config_files': (), 11:47:27 INFO - 'pip_index': False, 11:47:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:47:27 INFO - 'cmd': ('bash', 11:47:27 INFO - '-c', 11:47:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:47:27 INFO - 'enabled': True, 11:47:27 INFO - 'halt_on_failure': False, 11:47:27 INFO - 'name': 'check_screen_resolution'},), 11:47:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:47:27 INFO - 'cmd': ('bash', 11:47:27 INFO - '-c', 11:47:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:47:27 INFO - 'enabled': True, 11:47:27 INFO - 'halt_on_failure': False, 11:47:27 INFO - 'name': 'check_screen_resolution'},), 11:47:27 INFO - 'run_cmd_checks_enabled': True, 11:47:27 INFO - 'sps_profile': False, 11:47:27 INFO - 'sps_profile_interval': 0, 11:47:27 INFO - 'suite': 'dromaeojs', 11:47:27 INFO - 'system_bits': '32', 11:47:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:27 INFO - 'title': 't-yosemite-r7-0084', 11:47:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:27 INFO - 'use_talos_json': True, 11:47:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:27 INFO - 'work_dir': 'build'} 11:47:27 INFO - [mozharness: 2016-10-06 18:47:27.408284Z] Running clobber step. 11:47:27 INFO - Running pre-action listener: _resource_record_pre_action 11:47:27 INFO - Running main action method: clobber 11:47:27 INFO - rmtree: /builds/slave/test/build 11:47:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:29 INFO - Running post-action listener: _resource_record_post_action 11:47:29 INFO - [mozharness: 2016-10-06 18:47:29.548296Z] Finished clobber step (success) 11:47:29 INFO - [mozharness: 2016-10-06 18:47:29.548425Z] Running read-buildbot-config step. 11:47:29 INFO - Running pre-action listener: _resource_record_pre_action 11:47:29 INFO - Running main action method: read_buildbot_config 11:47:29 INFO - Using buildbot properties: 11:47:29 INFO - { 11:47:29 INFO - "project": "", 11:47:29 INFO - "product": "firefox", 11:47:29 INFO - "script_repo_revision": "production", 11:47:29 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 11:47:29 INFO - "repository": "", 11:47:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 11:47:29 INFO - "buildid": "20161006094701", 11:47:29 INFO - "pgo_build": "False", 11:47:29 INFO - "basedir": "/builds/slave/test", 11:47:29 INFO - "buildnumber": 398, 11:47:29 INFO - "slavename": "t-yosemite-r7-0084", 11:47:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:47:29 INFO - "platform": "yosemite_r7", 11:47:29 INFO - "scheduler": "tests-autoland-macosx64-talos", 11:47:29 INFO - "branch": "autoland", 11:47:29 INFO - "repo_path": "integration/autoland", 11:47:29 INFO - "revision": "ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2", 11:47:29 INFO - "stage_platform": "macosx64", 11:47:29 INFO - "builduid": "e195d20f67e74b48b49034b2f7f2a19f", 11:47:29 INFO - "slavebuilddir": "test" 11:47:29 INFO - } 11:47:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 11:47:29 INFO - Running post-action listener: _resource_record_post_action 11:47:29 INFO - [mozharness: 2016-10-06 18:47:29.551730Z] Finished read-buildbot-config step (success) 11:47:29 INFO - [mozharness: 2016-10-06 18:47:29.551844Z] Running download-and-extract step. 11:47:29 INFO - Running pre-action listener: _resource_record_pre_action 11:47:29 INFO - Running main action method: download_and_extract 11:47:29 INFO - mkdir: /builds/slave/test/build/tests 11:47:29 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')]} 11:47:29 INFO - trying https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 11:47:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 11:47:30 INFO - Downloaded 1199 bytes. 11:47:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:47:30 INFO - Using the following test package requirements: 11:47:30 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:47:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 11:47:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 11:47:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'jsshell-mac.zip'], 11:47:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 11:47:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:47:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 11:47:30 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 11:47:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 11:47:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:47:30 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 11:47:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:47:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:47:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:47:30 INFO - Fetch https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:47:31 INFO - Http code: 200 11:47:31 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 11:47:31 INFO - x-amz-cf-id: hoQoj8LTD5RVTgNMyQlYEebMvK5ZkvW1NISZizqCoAdpLwsqBrTzQQ== 11:47:31 INFO - x-amz-version-id: TGbbH2YxYv6fF_ux6tmSxDcJUqBZCNiC 11:47:31 INFO - Expected file size: 16478189 11:47:31 INFO - Obtained file size: 16478189 11:47:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:47:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:47:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:47:38 INFO - Fetch https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:47:38 INFO - Http code: 200 11:47:38 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 11:47:38 INFO - x-amz-cf-id: eWfZqffxvZR2mTMEbkKTgyfen3Bsox3NOWvvM9yvVVLah1zZFmDpUw== 11:47:38 INFO - x-amz-version-id: TGbbH2YxYv6fF_ux6tmSxDcJUqBZCNiC 11:47:39 INFO - Expected file size: 16478189 11:47:39 INFO - Obtained file size: 16478189 11:47:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 11:47:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:47:45 INFO - Fetch https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 11:47:46 INFO - Http code: 200 11:47:46 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 11:47:46 INFO - x-amz-cf-id: bGe1a3C9CZGGjEHhl2SYkeQLxjMRPWqvES8_sCkKzdUUAMOQzBBsvw== 11:47:46 INFO - x-amz-version-id: OckNwrT0LToNANhI0ZW3Ul7rSZsITwJ3 11:47:47 INFO - Expected file size: 14409006 11:47:47 INFO - Obtained file size: 14409006 11:47: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')]} 11:47:47 INFO - trying https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:47:47 INFO - Downloading https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 11:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 11:47:50 INFO - Downloaded 111671698 bytes. 11:47:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:47:50 INFO - mkdir: /builds/slave/test/properties 11:47:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:50 INFO - Contents: 11:47:50 INFO - build_url:https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:47:51 INFO - Running post-action listener: _resource_record_post_action 11:47:51 INFO - Running post-action listener: set_extra_try_arguments 11:47:51 INFO - [mozharness: 2016-10-06 18:47:51.194843Z] Finished download-and-extract step (success) 11:47:51 INFO - [mozharness: 2016-10-06 18:47:51.194989Z] Running populate-webroot step. 11:47:51 INFO - Running pre-action listener: _resource_record_pre_action 11:47:51 INFO - Running main action method: populate_webroot 11:47:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:51 INFO - '--tppagecycles', 11:47:51 INFO - '7'], 11:47:51 INFO - 'tests': ['tsvgm']}}, 11:47:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['damp', 'tps']}, 11:47:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'tests': ['damp', 'tps']}, 11:47:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['dromaeo_dom']}, 11:47:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['basic_compositor_video']}, 11:47:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['a11yr', 11:47:51 INFO - 'ts_paint', 11:47:51 INFO - 'tpaint', 11:47:51 INFO - 'sessionrestore', 11:47:51 INFO - 'sessionrestore_no_auto_restore', 11:47:51 INFO - 'tabpaint']}, 11:47:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['tsvgx', 11:47:51 INFO - 'tsvgr_opacity', 11:47:51 INFO - 'tart', 11:47:51 INFO - 'tscrollx', 11:47:51 INFO - 'cart']}, 11:47:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:51 INFO - 'tsvgr_opacity', 11:47:51 INFO - 'tart', 11:47:51 INFO - 'tscrollx', 11:47:51 INFO - 'cart']}, 11:47:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'talos_options': ['--disable-e10s'], 11:47:51 INFO - 'tests': ['tp5o']}, 11:47:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'tests': ['tp5o']}, 11:47:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'talos_options': ['--disable-e10s', 11:47:51 INFO - '--xperf_path', 11:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:51 INFO - 'tests': ['tp5n']}, 11:47:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:51 INFO - 'talos_options': ['--xperf_path', 11:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:51 INFO - 'tests': ['tp5n']}}, 11:47:51 INFO - 'talos.zip': {'path': '', 11:47:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:51 INFO - Running post-action listener: _resource_record_post_action 11:47:51 INFO - [mozharness: 2016-10-06 18:47:51.213945Z] Finished populate-webroot step (success) 11:47:51 INFO - [mozharness: 2016-10-06 18:47:51.214046Z] Running create-virtualenv step. 11:47:51 INFO - Running pre-action listener: _resource_record_pre_action 11:47:51 INFO - Running main action method: create_virtualenv 11:47:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:51 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 11:47:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:51 INFO - Using real prefix '/tools/python27' 11:47:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:54 INFO - Installing pip.................done. 11:47:54 INFO - Return code: 0 11:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:55 INFO - Reading from file tmpfile_stdout 11:47:55 INFO - Output received: 11:47:55 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) 11:47:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:55 INFO - 'HOME': '/Users/cltbld', 11:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:55 INFO - 'LOGNAME': 'cltbld', 11:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:55 INFO - 'MOZ_NO_REMOTE': '1', 11:47:55 INFO - 'NO_EM_RESTART': '1', 11:47:55 INFO - 'PAGER': '/bin/cat', 11:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:55 INFO - 'PWD': '/builds/slave/test', 11:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:55 INFO - 'SHELL': '/bin/bash', 11:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:47:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:55 INFO - 'USER': 'cltbld', 11:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:55 INFO - 'XPC_FLAGS': '0x0', 11:47:55 INFO - 'XPC_SERVICE_NAME': '0', 11:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:55 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 11:47:55 INFO - Cleaning up... 11:47:55 INFO - Return code: 0 11:47:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:55 INFO - 'HOME': '/Users/cltbld', 11:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:55 INFO - 'LOGNAME': 'cltbld', 11:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:55 INFO - 'MOZ_NO_REMOTE': '1', 11:47:55 INFO - 'NO_EM_RESTART': '1', 11:47:55 INFO - 'PAGER': '/bin/cat', 11:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:55 INFO - 'PWD': '/builds/slave/test', 11:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:55 INFO - 'SHELL': '/bin/bash', 11:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:47:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:55 INFO - 'USER': 'cltbld', 11:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:55 INFO - 'XPC_FLAGS': '0x0', 11:47:55 INFO - 'XPC_SERVICE_NAME': '0', 11:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:55 INFO - Downloading/unpacking psutil>=3.1.1 11:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:59 INFO - Installing collected packages: psutil 11:47:59 INFO - Running setup.py install for psutil 11:47:59 INFO - building 'psutil._psutil_osx' extension 11:47:59 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 11:47:59 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 11:47:59 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 11:47:59 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 11:47:59 INFO - building 'psutil._psutil_posix' extension 11:48:00 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 11:48:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:48:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:48:00 INFO - ^ 11:48:00 INFO - 1 warning generated. 11:48:00 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 11:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:00 INFO - Successfully installed psutil 11:48:00 INFO - Cleaning up... 11:48:00 INFO - Return code: 0 11:48:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:00 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')]} 11:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:00 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')]} 11:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:00 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:00 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 11:48:00 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 11:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:00 INFO - 'HOME': '/Users/cltbld', 11:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:00 INFO - 'LOGNAME': 'cltbld', 11:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:00 INFO - 'MOZ_NO_REMOTE': '1', 11:48:00 INFO - 'NO_EM_RESTART': '1', 11:48:00 INFO - 'PAGER': '/bin/cat', 11:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:00 INFO - 'PWD': '/builds/slave/test', 11:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:00 INFO - 'SHELL': '/bin/bash', 11:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:00 INFO - 'USER': 'cltbld', 11:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:00 INFO - 'XPC_FLAGS': '0x0', 11:48:00 INFO - 'XPC_SERVICE_NAME': '0', 11:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:03 INFO - Installing collected packages: mozsystemmonitor 11:48:03 INFO - Running setup.py install for mozsystemmonitor 11:48:03 INFO - Successfully installed mozsystemmonitor 11:48:03 INFO - Cleaning up... 11:48:03 INFO - Return code: 0 11:48:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:03 INFO - 'HOME': '/Users/cltbld', 11:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:03 INFO - 'LOGNAME': 'cltbld', 11:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:03 INFO - 'MOZ_NO_REMOTE': '1', 11:48:03 INFO - 'NO_EM_RESTART': '1', 11:48:03 INFO - 'PAGER': '/bin/cat', 11:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:03 INFO - 'PWD': '/builds/slave/test', 11:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:03 INFO - 'SHELL': '/bin/bash', 11:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:03 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:03 INFO - 'USER': 'cltbld', 11:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:03 INFO - 'XPC_FLAGS': '0x0', 11:48:03 INFO - 'XPC_SERVICE_NAME': '0', 11:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:06 INFO - warning: no files found matching '*.txt' 11:48:06 INFO - no previously-included directories found matching 'build' 11:48:06 INFO - no previously-included directories found matching 'dist' 11:48:06 INFO - no previously-included directories found matching '.git*' 11:48:06 INFO - Installing collected packages: jsonschema, functools32 11:48:06 INFO - Running setup.py install for functools32 11:48:06 INFO - warning: no files found matching '*.txt' 11:48:06 INFO - no previously-included directories found matching 'build' 11:48:06 INFO - no previously-included directories found matching 'dist' 11:48:06 INFO - no previously-included directories found matching '.git*' 11:48:06 INFO - Successfully installed jsonschema functools32 11:48:06 INFO - Cleaning up... 11:48:06 INFO - Return code: 0 11:48:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:06 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:06 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 11:48:06 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 11:48:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:06 INFO - 'HOME': '/Users/cltbld', 11:48:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:06 INFO - 'LOGNAME': 'cltbld', 11:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:06 INFO - 'MOZ_NO_REMOTE': '1', 11:48:06 INFO - 'NO_EM_RESTART': '1', 11:48:06 INFO - 'PAGER': '/bin/cat', 11:48:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:06 INFO - 'PWD': '/builds/slave/test', 11:48:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:06 INFO - 'SHELL': '/bin/bash', 11:48:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:06 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:06 INFO - 'USER': 'cltbld', 11:48:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:06 INFO - 'XPC_FLAGS': '0x0', 11:48:06 INFO - 'XPC_SERVICE_NAME': '0', 11:48:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:07 INFO - Cleaning up... 11:48:07 INFO - Return code: 0 11:48:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:07 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')]} 11:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:07 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')]} 11:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:07 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:07 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 11:48:07 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 11:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:07 INFO - 'HOME': '/Users/cltbld', 11:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:07 INFO - 'LOGNAME': 'cltbld', 11:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:07 INFO - 'MOZ_NO_REMOTE': '1', 11:48:07 INFO - 'NO_EM_RESTART': '1', 11:48:07 INFO - 'PAGER': '/bin/cat', 11:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:07 INFO - 'PWD': '/builds/slave/test', 11:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:07 INFO - 'SHELL': '/bin/bash', 11:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:07 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:07 INFO - 'USER': 'cltbld', 11:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:07 INFO - 'XPC_FLAGS': '0x0', 11:48:07 INFO - 'XPC_SERVICE_NAME': '0', 11:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:07 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:09 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:09 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 11:48:09 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 11:48:09 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 11:48:09 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 11:48:09 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 11:48:09 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 11:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:10 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 11:48:10 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 11:48:10 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 11:48:10 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 11:48:10 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 11:48:10 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 11:48:10 INFO - Downloading docopt-0.6.1.tar.gz 11:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:10 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:10 INFO - Running setup.py install for blobuploader 11:48:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:11 INFO - Running setup.py install for requests 11:48:11 INFO - Running setup.py install for docopt 11:48:11 INFO - Successfully installed blobuploader requests docopt 11:48:11 INFO - Cleaning up... 11:48:11 INFO - Return code: 0 11:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:11 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:11 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 11:48:11 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 11:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:11 INFO - 'HOME': '/Users/cltbld', 11:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:11 INFO - 'LOGNAME': 'cltbld', 11:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:11 INFO - 'MOZ_NO_REMOTE': '1', 11:48:11 INFO - 'NO_EM_RESTART': '1', 11:48:11 INFO - 'PAGER': '/bin/cat', 11:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:11 INFO - 'PWD': '/builds/slave/test', 11:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:11 INFO - 'SHELL': '/bin/bash', 11:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:11 INFO - 'USER': 'cltbld', 11:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:11 INFO - 'XPC_FLAGS': '0x0', 11:48:11 INFO - 'XPC_SERVICE_NAME': '0', 11:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-HBjJ28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Hhvj65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-iby76u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-1805qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-DcTUjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_u0uwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dAhyXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UCjmV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-u332Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-z02P_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-sPOtWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Zs0A4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Y58HjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-t2xe8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-J2U6Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cl0SK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qs97iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:13 INFO - Running setup.py install for manifestparser 11:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:14 INFO - Running setup.py install for mozcrash 11:48:14 INFO - Running setup.py install for mozdebug 11:48:14 INFO - Running setup.py install for mozdevice 11:48:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:14 INFO - Running setup.py install for mozfile 11:48:14 INFO - Running setup.py install for mozhttpd 11:48:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:14 INFO - Running setup.py install for mozinfo 11:48:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:14 INFO - Running setup.py install for mozInstall 11:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Running setup.py install for mozleak 11:48:15 INFO - Running setup.py install for mozlog 11:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Running setup.py install for moznetwork 11:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Running setup.py install for mozprocess 11:48:15 INFO - Running setup.py install for mozprofile 11:48:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Running setup.py install for mozrunner 11:48:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Running setup.py install for mozscreenshot 11:48:16 INFO - Running setup.py install for moztest 11:48:16 INFO - Running setup.py install for mozversion 11:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:16 INFO - Cleaning up... 11:48:16 INFO - Return code: 0 11:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:16 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:16 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 11:48:16 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 11:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:16 INFO - 'HOME': '/Users/cltbld', 11:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:16 INFO - 'LOGNAME': 'cltbld', 11:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:16 INFO - 'MOZ_NO_REMOTE': '1', 11:48:16 INFO - 'NO_EM_RESTART': '1', 11:48:16 INFO - 'PAGER': '/bin/cat', 11:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:16 INFO - 'PWD': '/builds/slave/test', 11:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:16 INFO - 'SHELL': '/bin/bash', 11:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:16 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:16 INFO - 'USER': 'cltbld', 11:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:16 INFO - 'XPC_FLAGS': '0x0', 11:48:16 INFO - 'XPC_SERVICE_NAME': '0', 11:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:16 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WGfKWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:16 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)) 11:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:16 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-bh76cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:16 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fqHitp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-yB43rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wcmUHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xh5Ywi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-l5Ah_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-M3VXsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-34NL7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-PyeC3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ghLknG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:17 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-eLjuQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:17 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)) 11:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XsZPHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qK4j7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-2ho23W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Rq_G71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:18 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ETmz05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:18 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)) 11:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:18 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)) 11:48:18 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)) 11:48:18 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)) 11:48:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:18 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 11:48:18 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 11:48:18 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 11:48:18 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 11:48:18 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 11:48:18 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 11:48:20 INFO - Downloading blessings-1.6.tar.gz 11:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:21 INFO - Installing collected packages: blessings 11:48:21 INFO - Running setup.py install for blessings 11:48:21 INFO - Successfully installed blessings 11:48:21 INFO - Cleaning up... 11:48:21 INFO - Return code: 0 11:48:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:21 INFO - Reading from file tmpfile_stdout 11:48:21 INFO - Current package versions: 11:48:21 INFO - blessings == 1.6 11:48:21 INFO - blobuploader == 1.2.4 11:48:21 INFO - docopt == 0.6.1 11:48:21 INFO - functools32 == 3.2.3-2 11:48:21 INFO - jsonschema == 2.5.1 11:48:21 INFO - manifestparser == 1.1 11:48:21 INFO - mozInstall == 1.12 11:48:21 INFO - mozcrash == 0.17 11:48:21 INFO - mozdebug == 0.1 11:48:21 INFO - mozdevice == 0.48 11:48:21 INFO - mozfile == 1.2 11:48:21 INFO - mozhttpd == 0.7 11:48:21 INFO - mozinfo == 0.9 11:48:21 INFO - mozleak == 0.1 11:48:21 INFO - mozlog == 3.4 11:48:21 INFO - moznetwork == 0.27 11:48:21 INFO - mozprocess == 0.23 11:48:21 INFO - mozprofile == 0.28 11:48:21 INFO - mozrunner == 6.12 11:48:21 INFO - mozscreenshot == 0.1 11:48:21 INFO - mozsystemmonitor == 0.3 11:48:21 INFO - moztest == 0.7 11:48:21 INFO - mozversion == 1.4 11:48:21 INFO - psutil == 3.1.1 11:48:21 INFO - requests == 1.2.3 11:48:21 INFO - wsgiref == 0.1.2 11:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:21 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')]} 11:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:21 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')]} 11:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:22 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:22 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 11:48:22 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 11:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:22 INFO - 'HOME': '/Users/cltbld', 11:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:22 INFO - 'LOGNAME': 'cltbld', 11:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:22 INFO - 'MOZ_NO_REMOTE': '1', 11:48:22 INFO - 'NO_EM_RESTART': '1', 11:48:22 INFO - 'PAGER': '/bin/cat', 11:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:22 INFO - 'PWD': '/builds/slave/test', 11:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:22 INFO - 'SHELL': '/bin/bash', 11:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:22 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:22 INFO - 'USER': 'cltbld', 11:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:22 INFO - 'XPC_FLAGS': '0x0', 11:48:22 INFO - 'XPC_SERVICE_NAME': '0', 11:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 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)) 11:48:22 INFO - Cleaning up... 11:48:22 INFO - Return code: 0 11:48:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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 0x107cad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9761c5e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, '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.QEzPAymWor/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.r8FqP2aTUH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 11:48:23 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 11:48:23 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 11:48:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:23 INFO - 'HOME': '/Users/cltbld', 11:48:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PAGER': '/bin/cat', 11:48:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - 'XPC_FLAGS': '0x0', 11:48:23 INFO - 'XPC_SERVICE_NAME': '0', 11:48:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:48:23 INFO - Cleaning up... 11:48:23 INFO - Return code: 0 11:48:23 INFO - Running post-action listener: _resource_record_post_action 11:48:23 INFO - Running post-action listener: _start_resource_monitoring 11:48:23 INFO - Starting resource monitoring. 11:48:23 INFO - [mozharness: 2016-10-06 18:48:23.659512Z] Finished create-virtualenv step (success) 11:48:23 INFO - [mozharness: 2016-10-06 18:48:23.660489Z] Running install step. 11:48:23 INFO - Running pre-action listener: _resource_record_pre_action 11:48:23 INFO - Running main action method: install 11:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:23 INFO - Reading from file tmpfile_stdout 11:48:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:24 INFO - Reading from file tmpfile_stdout 11:48:24 INFO - Output received: 11:48:24 INFO - Usage: mozinstall [options] installer 11:48:24 INFO - Options: 11:48:24 INFO - -h, --help show this help message and exit 11:48:24 INFO - -d DEST, --destination=DEST 11:48:24 INFO - Directory to install application into. [default: 11:48:24 INFO - "/builds/slave/test"] 11:48:24 INFO - --app=APP Application being installed. [default: firefox] 11:48:24 INFO - mkdir: /builds/slave/test/build/application 11:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:48:58 INFO - Reading from file tmpfile_stdout 11:48:58 INFO - Output received: 11:48:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:48:58 INFO - Running post-action listener: _resource_record_post_action 11:48:58 INFO - [mozharness: 2016-10-06 18:48:58.382373Z] Finished install step (success) 11:48:58 INFO - [mozharness: 2016-10-06 18:48:58.382510Z] Running run-tests step. 11:48:58 INFO - Running pre-action listener: _resource_record_pre_action 11:48:58 INFO - Running main action method: run_tests 11:48:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:48:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:48:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:48:58 INFO - 2016-10-06 11:48:58.397 screenresolution[1638:7622] starting screenresolution argv=screenresolution get 11:48:58 INFO - 2016-10-06 11:48:58.399 screenresolution[1638:7622] Display 0: 1600x1200x32@60 11:48:58 INFO - 2016-10-06 11:48:58.405 screenresolution[1639:7624] starting screenresolution argv=screenresolution list 11:48:58 INFO - Available Modes on Display 0 11:48:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:48:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:48:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:48:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:48:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:48:58 INFO - Intel Iris: 11:48:58 INFO - Chipset Model: Intel Iris 11:48:58 INFO - Type: GPU 11:48:58 INFO - Bus: Built-In 11:48:58 INFO - VRAM (Dynamic, Max): 1536 MB 11:48:58 INFO - Vendor: Intel (0x8086) 11:48:58 INFO - Device ID: 0x0a2e 11:48:58 INFO - Revision ID: 0x0009 11:48:58 INFO - Displays: 11:48:58 INFO - Display: 11:48:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:48:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:48:58 INFO - Display Serial Number: 1600x1200 60 11:48:58 INFO - Main Display: Yes 11:48:58 INFO - Mirror: Off 11:48:58 INFO - Online: Yes 11:48:58 INFO - Rotation: Supported 11:48:58 INFO - Return code: 0 11:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:58 INFO - Python 2.7.3 11:48:58 INFO - Return code: 0 11:48:58 INFO - grabbing minidump binary from tooltool 11:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:58 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 0x107ac1d30>, '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 0x1078e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:58 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 11:48:58 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 11:48:58 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 11:48:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:58 INFO - Return code: 0 11:48:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:48:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:48:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QEzPAymWor/Render', 11:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:58 INFO - 'HOME': '/Users/cltbld', 11:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:58 INFO - 'LOGNAME': 'cltbld', 11:48:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:58 INFO - 'MOZ_NO_REMOTE': '1', 11:48:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:58 INFO - 'NO_EM_RESTART': '1', 11:48:58 INFO - 'PAGER': '/bin/cat', 11:48:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:58 INFO - 'PWD': '/builds/slave/test', 11:48:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:58 INFO - 'SHELL': '/bin/bash', 11:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r8FqP2aTUH/Listeners', 11:48:58 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 11:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:58 INFO - 'USER': 'cltbld', 11:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:58 INFO - 'XPC_FLAGS': '0x0', 11:48:58 INFO - 'XPC_SERVICE_NAME': '0', 11:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:48:58 INFO - mozversion application_buildid: 20161006094701 11:48:58 INFO - mozversion application_changeset: ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 11:48:58 INFO - mozversion application_display_name: Nightly 11:48:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:58 INFO - mozversion application_name: Firefox 11:48:58 INFO - mozversion application_remotingname: firefox 11:48:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:48:58 INFO - mozversion application_vendor: Mozilla 11:48:58 INFO - mozversion application_version: 52.0a1 11:48:58 INFO - mozversion platform_buildid: 20161006094701 11:48:58 INFO - mozversion platform_changeset: ed4bc0d84b0bb24f2c528b3e489ee727d763b0d2 11:48:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:48:58 INFO - mozversion platform_version: 52.0a1 11:48:58 INFO - using testdate: 1475779738 11:48:58 INFO - actual date: 1475779738 11:48:58 INFO - starting webserver on 'localhost:49277' 11:48:58 INFO - SUITE-START | Running 2 tests 11:48:58 INFO - TEST-START | dromaeo_css 11:48:58 INFO - operating with platform_type : mac_ 11:48:58 INFO - Initialising browser for dromaeo_css test... 11:48:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpAzFu7N/profile http://localhost:49277/getInfo.html) 11:49:01 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:49:01 INFO - PROCESS | 1649 | colorDepth:24 11:49:01 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:49:01 INFO - PROCESS | 1649 | __metrics 11:49:01 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:49:01 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:02 INFO - TEST-INFO | 1649: exit 0 11:49:02 INFO - Browser initialized. 11:49:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:02 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpAzFu7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:14 INFO - PROCESS | 1651 | RSS: Main: 243916800 11:49:14 INFO - PROCESS | 1651 | 11:50:05 INFO - PROCESS | 1651 | 1475779805345 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:52:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 11:52:21 INFO - PROCESS | 1651 | RSS: Main: 358653952 11:52:21 INFO - PROCESS | 1651 | 11:55:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 11:55:24 INFO - PROCESS | 1651 | RSS: Main: 375140352 11:55:24 INFO - PROCESS | 1651 | 11:58:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 11:58:27 INFO - PROCESS | 1651 | RSS: Main: 364015616 11:58:27 INFO - PROCESS | 1651 | 12:01:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 12:01:30 INFO - PROCESS | 1651 | RSS: Main: 360931328 12:01:30 INFO - PROCESS | 1651 | 12:04:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 12:04:34 INFO - PROCESS | 1651 | RSS: Main: 342999040 12:04:34 INFO - PROCESS | 1651 | 12:07:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 12:07:38 INFO - PROCESS | 1651 | RSS: Main: 418189312 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | __start_tp_report 12:07:38 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:07:38 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:07:38 INFO - PROCESS | 1651 | |i|pagename|runs| 12:07:38 INFO - PROCESS | 1651 | |0;dojo.html;3315.4032274190636;3318.6847249511297;3336.1659585103725;3373.797572145673;3374.9662503374975;4813;5508.779648814043;5659.943400565999;5682.346530149034;5704.3154821421385;5596.468335508131;5636.0982242841155;5643;5645.294338207724;5657.519110875581;5080.314157588725;5114.948850511503;5116.130257856174;5131;5207.270982062514;5159.432462429129;5202.895942081156;5224.1902505111575;5224.63427560071;5237.188235823434;5110.718910459923;5151.922721159167;5195.506426889439;5206.3231779868565;5241.082810508165;5212.843614691566;5220.138677118271;5226.869328266824;5228.189630607262;5250.5274525292525;5050.141475949097;5057.190849464105;5115;5147.974260128713;5155.149400348938;5546.334439867242;5559.666420014772;5602.187682785973;5648.378678345379;5662.66024038559;6159.983602705548;6177.691115444255;6193.318734939198;6208;6210.472109870667;6118.388161183846;6159.907601385983;6227.252729672468;6263.404976527223;6277.905831412532;5674.546036317126;5683;5687.260656114679;5687.459691329317;5691.402402747734;6196.10156527301;6237;6292.653904035231;6294.8111556653375;6305.3379395163765;6087.269527656621;6088.634681919099;6096.847578810476;6099.11054637865;6117;5559.610827242135;5965.612235204698;6194.566380353332;6224.688765561704;6245.250569931546;5410.593245756053;5758.3090029196765;6145.8156255312415;6152.261728592597;6172.135900973867;6089.111364424805;6106.419890110433;6126.090206827809;6127.3259941407305;6142.78500252489;4900.705957642482;4904.8773780655765;4905.386826646669;4921.188003979375;4955.72743499111;4360.672949528798;4386.71486353386;4391.407160033355;4411.735295882258;4424.491183513937;5130.948155628087;5424.972875135599;5696.316442026983;5698.287714035746;5735.598508104393;6210.689465526705;6254.499640028786;6293.213348331458;6299.748010079637;6302.275238347557;5726.541876649858;5735.139729040678;5754.395788442237;5766.826995190151;5802.1296805479515;4533.977330113263;5263.421023687391;5369.758360873692;5372.140457526777;5383.946160538423;6230.657313847782;6230.875382492415;6270;6284.842878928063;6300.905486417799;6243.250809902841;6245.281792593728;6261.24865016201;6279.937200627935;6280.340564240689;6224.782132625336;6257.7184026718;6261.373862613702;6285.59143655661;6286.811395658137;4992.350994370709;5995.790147344822;6092.543059270483;6107.037103281039;6125.326214116532;6004.309504406874;6127.403330890726;6173.382661733791;6182.876342473035;6187.16473276102;6023.30731965812;6046.244219472566;6060.787872424444;6097.969510152421;6100.0849872519475;6053.152558641706;6058.151858739868;6064.818055458343;6068.8786224276155;6070.666113363807;4718.504557021463;5789.710514474344;5798.913016304675;5882.382349853375;5886.499647530008;6055.6063855849225;6091.994820854509;6093.786717464867;6139.539534535017;6140.17107690456;5838.095095260242;5893.705314734332;5897.3807750187325;5924.496417804535;5966.522678185648 12:07:38 INFO - PROCESS | 1651 | |1;ext.html;461.46470094690164;498.42183067641537;505.73954413477054;507.5077175140113;537.3685919045121;40064.59935400645;42365.788171059176;42459.36310955338;42491.99999999996;44058.33912491315;43069;43432.56567434325;43645.563544364544;43698.781506092506;43808.78095609525;9826.017398260152;10029.297949143564;10031.498425078753;10046.899531004707;10076.596936122547;9937.006299370078;10053.296269261118;10060.849087263698;10076.39541627501;10085.798284034316;9953.552090155925;10033.297669163161;10060.647877324294;10097.596096156145;10100.343477673927;10027.448490333029;10048.196144308438;10060.144887684555;10069.345492542961;10084.243681723827;9842.114209721089;9914;9926.90073099267;9943.850842237372;9948.005199480067;41354.58645413537;41476.37785433221;41607;41660.791696041626;41786.582134178876;3276.3938671345877;3315.0717799016315;3348.5479460272795;3354.513595528659;3469.5836499619954;25599.74400255992;26387.73612263872;30929.91745288904;31910;32287.51568726471;3180.4116238495953;3302.9669703302898;3331.850066747002;3385.407553678121;3394.541736865516;456187;459218;459344;463972.6801366005;471397;60616.09075863865;61098.38901611016;61111;61218.38781612216;61257;64030;64154;64199.037014444824;64350;64371.678141608994;13334.66663333405;16272.837271627131;16279.674406511804;16291.02253864772;16291.674166516841;12576.748465030649;12629.179103358436;12711.682207944876;12720.809187862189;12724.809127863089;14290;17422.39021634262;17723.911380443016;17773.644527109387;17809.46571602854;5870.412958704095;6116.449519543263;6923.6192009438955;6940.681270558679;6973.755918542826;687.5771400588602;853.7268074216315;1022.6778564752228;1025.768952528263;1026.1790567546082;29024;29852.850735746182;29958.850205749266;30687;30690;973.1630797514132;987.4420952162005;995.1839491616805;1019.7654539455966;1053.3153450257241;14031.22828244436;14589.124652520883;15295.15876626774;15397.769033464507;15744.370225190863;617312;618410;618454;620270;622245;58072.419275807544;58285.125723114186;58326.54265131617;58364.12453813196;58412;1365;1389.6867460249966;1404.5014020022745;1405.7399381114321;1406.2827957741422;29017.854910725313;29286.853565732887;29567.852160739058;30213.395732084795;30363.089107326814;41524.79237603793;51369.229461557356;51394.48605514046;51395.74302128465;51404.48595514146;550868;554579;556718;557714;558362;25445.745542544337;25777.484450310512;25818.741812582386;25836.095736649128;26521.204363869114;35296.29407411889;38863.41704874486;45536.861578460805;47963.80090497765;47973.760131199124;36388.81805590955;39547.81356559308;39895.80052099837;40637.59362406338;41209;33996.66003339935;38083.71618682886;38984.41523377208;40122.59877401305;40351.798241008604;29904.551431728978;37577.43633845549;38124.809375952944;38727;38782.8365149046;33072.50391244085;34094;34449.827750861084;34791.65208347884;34805.825970870996;23330.40158314559;24534.754652453248;25388.49223015566;25896.22311330663;26179.869100654374 12:07:38 INFO - PROCESS | 1651 | |2;jquery.html;348.7558708903768;366.86242659002875;373.9551253849539;380.9923801523969;403.58229232744117;14763.77854332186;15018.174000429972;15682.061230072864;19906.701399479018;20721.963901804887;15917.920410397961;19054.809451905476;20305.390838274838;20622.793772062276;21331.893340533275;5716.428357164282;6104.969475152618;6109.236345456818;6124.1732366130445;6139.754409823602;5610.775568977236;5897.587168898179;5956.86819504295;6043.486303664194;6049.879002419949;3796.126890815114;4014.8394064237395;5835.0372188588835;6029.9447596670625;6100.115483254947;5870.354261031283;6180;6186.721597528122;6191.318954914956;6213.689315534205;5813.7383817728305;5861.062230043172;5868.207791948118;5870.324912635059;5877.265341832271;13338.799918001238;13603.795943060863;23628.17301394443;24343.41767785106;25416.36459088519;2186.7157269555014;2205.4155648753094;2233.229535810143;2437.9390515237083;2828.8868445262165;10226.89773102267;10456.63401780934;13658.521951731642;15252.771208431883;15259.847401525954;1820.1316690994672;1858.3561535103433;1864.3474783825689;1883.3878989328523;1934.2456441987636;93615.53192234064;122742;123226;124853.5029299418;132505.67494325028;9281;10045;10766.416060145666;11562.826557601642;11728.94135529317;14691.485797997018;14693.693918868383;14736;14739.484118055816;14744.336504857307;8251.711190108437;8597.18326758957;8603.612837422332;8745.562721863882;8775;8464.111268316861;8491.363147763943;8517.233448989497;8638.827223455495;8678.218960293478;3925.7644541327613;4385.758783266887;4539.002838750939;4540.160070386989;4625.352450656911;1696.3808210003506;1875.2217829600836;1975.9506012349807;1989.254029738848;1998.1208268361875;811.8985126859143;861.2679222660688;896.188949001155;979.7648564344506;1000.9749756256152;21095.26166584193;21192;21223.044962976703;21248.043838027326;21265.57468850614;855.5935930432995;887.7203680840514;893.4639216470196;920.9171174594319;937.3579098317538;10487.318324308895;10999.725006874893;11110.722231944266;11228.98939095469;11333.773324533464;572527;583469;589990;603896;607432;102773;122402;126136;131560;139036.6096339044;922.7462447826902;961.4519723757392;970.5001924009141;973.9659111931048;976.6581696406344;12977.35113244353;18342.541436464195;19437.12532935993;19497.805021950167;19611.11749971226;53035;54624.72687636536;55907;56055.43944560502;56769.71615142063;68551;82414.58792706238;83886;85012.04915655845;86949;7972.6412311444965;8200.917990820015;8259.174082591693;8332.791680208044;8500.787480313042;12782.041346899206;13174.868251317748;13260.668483287609;13311.068225224528;13376.732465350444;8673.913260867563;10688.038076573146;11324.924132207427;11361.886381136082;11563.30620162793;10514.474276286308;11182.32906025641;11460.255083419552;11952.64142075739;12012.039036877204;5812.94187058141;6595.703193356407;11326.490307936327;11507.561554805648;12015.75968480608;6881.518293719391;8095.23095305945;8439.70461033861;8484.19400156984;8561;10870.347779133277;10991.395473249047;11234.494447750034;11524.711882203012;11561.942190288995 12:07:38 INFO - PROCESS | 1651 | |3;mootools.html;1536.9769453458193;1549.4267121165167;1768.301520899245;1876.0713446843815;1925.6437559051576;8426.410151289412;8824.338174636903;8889.866652000224;8904.065073167314;8915.465072095678;7855.05739311282;8103.068147163078;8109.270165685102;8542.70100546481;8683.565821708906;2327.5112226432425;2365.82256330775;2366.7041619797524;2366.8343215974887;2370.0756704885107;2075.2840270106863;2338.2166974063625;2359.575276450238;2364.917227897024;2368.2895131460577;2333.8599684018927;2350.4006478347997;2350.4476448034698;2362.2558893948435;2363.2201373546686;2313.3869524576003;2329.0683726509365;2331.895064722092;2333.4866329407505;2335.07764433048;2301.171578231835;2348.9177878774162;2349.4361353275262;2350.7296660883876;2354.1407386303877;8868.068852770495;8940.418872773314;8941.016488186295;8945.15021072997;8957.865632015524;5174.7153906535505;5338.332708411449;5345.412004679482;5348.946510534884;5357.544608708265;3416.4021296273054;3519.683228509421;3625.619309972468;3655.5430571178604;3662.7069834413182;1065.1638463805953;1068.150820098016;1072.1637123044038;1092.0280949954547;1095.413953534855;11584.47869845859;11797.469113889896;11801.173917825756;11804.350760708157;11831;4487.820487180542;4537.069900670421;4718.834840780556;4757.286407038971;4763.571278584944;9915.950420247997;9923.801523969625;9924.305298629026;9930.354526955725;9938.354006989668;5316;5317.441668624816;5324.946750532523;5326.36083669962;5331.1470164773455;4343.587359200871;4345.804438800262;4818.975905120452;4856.95143048565;4875.756212189376;3507.8424120040327;3621.3300539400293;3805.5052843130215;3911.6675082617726;3940.5074365704286;1077.5959015369237;1088.5645741703224;1244.8941839943707;1263.1726219326356;1267.7781388257017;752.1876373516699;760.8288135169543;813.0812182234038;857.7426771968385;909.9980043903439;5685.459881311269;5849.678267695318;6033.577649564576;6171.907421388682;6234.345393733593;794.3287921706149;900.2078171209293;960.7598100474881;968.4479846487435;970.5520076377799;3894.922101557953;3903.765774053566;3914.7651140931634;3997.3804060370107;4024.054347228399;8370.246677798905;10883.768827390366;10885.455727213608;10897;10900.400477973788;10024.09542186982;10335.534900929477;10665.36007839532;10845.403502807263;10867.184961127947;7772.883406748903;8024.759257222293;8037.196280371916;8039.5176289422825;8049.71825986076;5818.650880947157;6013.939860601338;6036.486898613667;6072.603301240651;6094.634321940698;8479.533625650649;9465.337426380087;9985.950070249603;10139.493025348556;10204.336718113298;10086.041826026516;10140.312817103326;10172.847407289044;10200.132988695746;10204.897951020395;6873.965630171817;7112.928870711226;7294.562326260441;7424.777256682092;7605.771826845204;7283.162436319679;8338.499690018376;8494.74515764528;8497.980242370955;8523.019852717018;7323.340899319087;7524.360429363565;7558.395328373607;7605.087389513294;7805.687772489036;7213.9639301805255;7321.524100933422;7392.815179620553;7579.962100189464;7581.50720203185;6727.697253623696;6852.8286792828585;6895.379415852397;6908.032875397549;6922.965385173042;4894.388201474816;4942;4945.62907781925;4979.128652485873;5136.178211486294;4926.926096108633;5038.672486288379;5045.376404269832;5150.253213284128;5217.843464696065 12:07:38 INFO - PROCESS | 1651 | |4;prototype.html;277.38835866913456;291.1135592121988;308.7128970057846;311.2902582112782;315.2214031342586;4466.731996080238;5182.507661772131;5187.818426355078;5325.946740532603;5326.215717734553;4241.024564350201;4508.5266047065;5027.290721154815;5158.019976204528;5178.844634660957;3515.630858759832;3837.771912987845;3959.030037640775;4060.1473690525027;4081.3265811141127;3568.3398571264397;4061.1268577255883;4075.7758323292205;4079.8368065277355;4081.3469844824835;3606.917924622616;3759.567649720276;3969.8610548630804;3999.280129576675;4049.048473608714;3032.6057612510454;3350.3801796667694;3775.6596408275077;3992.323224245824;4015.277250094982;2894.8999380235587;3510.701590364822;3516.2440075383915;3522.383582872987;3524.1894364296354;4139.3583994480905;4284.850030248957;5083.805305753145;5120;5124.385073791132;3819.751716138442;3972.741771784825;4438.955610443886;4553.476350219734;4590.357349971006;4468.084042771224;5437.700926449043;5476.618705035955;5492.780288788444;5525.336959564878;3194.6645602211897;3683.3001729671546;3821.293060783736;3861.3242682530727;3894.883153505399;5511.9724401378135;5661.179129026268;5771.711414429304;5797.449242321973;5875.559333050039;3428.348613763427;3709.3879509880567;3729.8437484379388;3891.727579069438;3914.4911161548816;3593.7484376093944;3620.9637903621156;3940.408938659224;3953.6046395360236;3962.7517332040316;4004.439378487014;4400.581944715247;4592.448906131219;4604.723716577016;4621.989434595962;4775.806048487878;4790.736509491941;5009.248612708123;5258.07983602868;5543.473370029921;1151.41277948247;1166.2943918929095;1284.9743005139844;1354.214555557774;1358.98076442668;826.5454000299811;856.1866227084171;863.8531449653574;897.2597606974273;920.8296465153968;4357.956420435755;4749.976250118727;4841.927371089437;5223.817166399158;5228.830035535287;4872.634552408584;5384.192371144281;5637.872425514914;5667.943320566824;5680.8863822723315;4350.891227719332;4569.81720731167;4968.552830245223;5221.634485586049;5254.528731955059;2081.5420607466335;2240.6302960011417;2377.9774696880163;2507.3731567108225;2513.8617376044494;4081.2858599387732;4667.755909642833;4963.478834722375;5009.674371165863;5020.748962551857;4142.032534546127;4653.18525774948;4798.5441383068555;4818.518148185153;4939.703617782944;4266.743995360288;4514.796834142471;4922.34193535494;4922.975385123052;4936.457724272074;3853.5183102112237;4380.8247670094115;4579.564941330568;4770.499097594841;4821.710697358169;3635.4910312556794;4167.562405947332;4229.534751177306;4502.729836209838;4672.999890117541;4216.536181020147;4295.487140023121;4353.604188732794;4843.75781210931;4910.852674419773;2894.233028247474;2905.677916548008;3370.2137866930566;3394.978469162398;3466.6360032196258;3969.8213580388374;4325.767156360422;4417.977910110429;4590.839320623762;4796.304535842353;3680.742348035719;4453.334117716254;4502;4602.792874320597;4636.397268355227;3865.3042452358845;4115.97942010288;4566.4748553916725;4629.513901040477;4710.034442939121;4324.978375108104;4499.775011249359;4517.68376213675;4593.54064593538;4606.401167848292;3799.765076350142;4125.711200215956;4610.847288177955;4622.352870598052;4704.223803072455;3693.778373297611;4054.878353649395;4130.008797888425;4564.543545645409;4566.634669226388 12:07:38 INFO - PROCESS | 1651 | |5;yui.html;712.2023333866069;714.3245286001512;768.5964868444066;813.9186081391862;821.8397412504564;14738.852611473882;15441.536753897373;15452.69094618107;15453.30460129294;15467.30397132129;13770.10494317871;13842.377093030813;13862.861371386283;13873.375698093585;13877.16736995781;670.3932940688685;690.533889624504;694.8158737934451;832.2883934236231;835.6281454752638;842.6208206307156;851.9957400212991;852.4885068958637;855.6748435594466;859.8839156713857;915.4690279637828;918.6049998500642;918.6325469812095;920.0247737398346;922.1884741427568;699.6152116336045;910.3536489092752;911.289194428347;912.6303846942;915.4095608332622;532.6165161084052;658.789187460013;673.8685956238536;681.0193321616856;681.4241965539112;14638.048526845721;14646.267686615627;14657.267136643126;14660.853391466055;14662.046966947115;13001.674958126028;13444.932775336158;13554.525591604344;13677.679988457618;13828.585142445743;11927.284362938164;12181.93909030458;12284.877151228462;12462.314572698499;12797.296148711817;4478.753668548228;4492.438445194351;4518.254488009507;4683.180443422388;4702.412198475191;99962;101997.4900125502;102144.48927755462;102208.48895755474;103003;10543.420111893765;10560.735981600368;10618.840717389245;10659.25385223027;10868.510917008754;20528.486787830425;20600.38198854037;20671.379858604265;20704.275350362666;20939.68590471144;7699.499532530368;7724.343430808444;7770.650320735581;7771;7931.127575966754;4175.102352994121;4249;4277.743335399886;4279.3153095505195;4284.700070995001;3326.5176549400203;3424.3493736190044;3428.674275943781;3435.9656403436147;3443.0531603808654;654.715198888485;663.1081195791653;683.8119517132828;724.9093863267092;729.6388287797574;538.2921458282347;565.3667891960948;654.2182092399632;659.7394029358377;692.8960655901656;7743.612819359009;9493.430394176372;9532;9548.331616786898;9610.375325603813;555.6416111608071;596.3648714119449;638.5179189711831;663.2670898657011;678.6572780745691;4218.303979843353;4225.149890336224;4423.093265880487;4621.09888571732;4685.695429797052;89653.55173224222;122458;127207;141458;141828;104637;132548;135637;136368;137441;102168;105812.47093764482;105895;106673.46663266789;108724;8527.757032611402;8971;8976.466884223426;8996.775080623036;9132.452052876848;55296.17055744086;58675;65414;65515.344846552834;66448.33551664422;60424.39575604188;63354.68322658357;73949.15127121865;84572;85765;13355.3990070449;13472.482948888814;13487.460501579826;13514.93242533781;13572.1856688599;12134.878651213729;13489;14836.554903352917;14969.77545336799;15315.846841531442;13683.452661893412;13739;13827.58517244444;14135.222562759147;14310.356033978704;13604.455821767415;13753.931230343784;13756.449742010207;14596.109166691664;14647.26763661834;11568.537258509901;11817.940910295394;12020.63938081859;12171.965382942195;12315.199512032048;10864.565417383215;11171.162162837658;11370.772584548427;11553;11647.59233426826;9326.347155699308;11244.26912250701;11269.28113722486;11470.426478675867;11713.765724685289 12:07:38 INFO - PROCESS | 1651 | __end_tp_report 12:07:38 INFO - PROCESS | 1651 | __start_cc_report 12:07:38 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2341 12:07:38 INFO - PROCESS | 1651 | __end_cc_report 12:07:38 INFO - PROCESS | 1651 | __startTimestamp1475780858019__endTimestamp 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:07:38 INFO - PROCESS | 1651 | Number of tests: 6 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5667.99 Median:5838.10 stddev:647.48 (11.1%) stddev-sans-first:622.61 12:07:38 INFO - PROCESS | 1651 | Values: 3315.4 3318.7 3336.2 3373.8 3375.0 4813.0 5508.8 5659.9 5682.3 5704.3 5596.5 5636.1 5643.0 5645.3 5657.5 5080.3 5114.9 5116.1 5131.0 5207.3 5159.4 5202.9 5224.2 5224.6 5237.2 5110.7 5151.9 5195.5 5206.3 5241.1 5212.8 5220.1 5226.9 5228.2 5250.5 5050.1 5057.2 5115.0 5148.0 5155.1 5546.3 5559.7 5602.2 5648.4 5662.7 6160.0 6177.7 6193.3 6208.0 6210.5 6118.4 6159.9 6227.3 6263.4 6277.9 5674.5 5683.0 5687.3 5687.5 5691.4 6196.1 6237.0 6292.7 6294.8 6305.3 6087.3 6088.6 6096.8 6099.1 6117.0 5559.6 5965.6 6194.6 6224.7 6245.3 5410.6 5758.3 6145.8 6152.3 6172.1 6089.1 6106.4 6126.1 6127.3 6142.8 4900.7 4904.9 4905.4 4921.2 4955.7 4360.7 4386.7 4391.4 4411.7 4424.5 5130.9 5425.0 5696.3 5698.3 5735.6 6210.7 6254.5 6293.2 6299.7 6302.3 5726.5 5735.1 5754.4 5766.8 5802.1 4534.0 5263.4 5369.8 5372.1 5383.9 6230.7 6230.9 6270.0 6284.8 6300.9 6243.3 6245.3 6261.2 6279.9 6280.3 6224.8 6257.7 6261.4 6285.6 6286.8 4992.4 5995.8 6092.5 6107.0 6125.3 6004.3 6127.4 6173.4 6182.9 6187.2 6023.3 6046.2 6060.8 6098.0 6100.1 6053.2 6058.2 6064.8 6068.9 6070.7 4718.5 5789.7 5798.9 5882.4 5886.5 6055.6 6092.0 6093.8 6139.5 6140.2 5838.1 5893.7 5897.4 5924.5 5966.5 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:68245.71 Median:36983.13 stddev:146675.12 (396.6%) stddev-sans-first:146998.29 12:07:38 INFO - PROCESS | 1651 | Values: 461.5 498.4 505.7 507.5 537.4 40064.6 42365.8 42459.4 42492.0 44058.3 43069.0 43432.6 43645.6 43698.8 43808.8 9826.0 10029.3 10031.5 10046.9 10076.6 9937.0 10053.3 10060.8 10076.4 10085.8 9953.6 10033.3 10060.6 10097.6 10100.3 10027.4 10048.2 10060.1 10069.3 10084.2 9842.1 9914.0 9926.9 9943.9 9948.0 41354.6 41476.4 41607.0 41660.8 41786.6 3276.4 3315.1 3348.5 3354.5 3469.6 25599.7 26387.7 30929.9 31910.0 32287.5 3180.4 3303.0 3331.9 3385.4 3394.5 456187.0 459218.0 459344.0 463972.7 471397.0 60616.1 61098.4 61111.0 61218.4 61257.0 64030.0 64154.0 64199.0 64350.0 64371.7 13334.7 16272.8 16279.7 16291.0 16291.7 12576.7 12629.2 12711.7 12720.8 12724.8 14290.0 17422.4 17723.9 17773.6 17809.5 5870.4 6116.4 6923.6 6940.7 6973.8 687.6 853.7 1022.7 1025.8 1026.2 29024.0 29852.9 29958.9 30687.0 30690.0 973.2 987.4 995.2 1019.8 1053.3 14031.2 14589.1 15295.2 15397.8 15744.4 617312.0 618410.0 618454.0 620270.0 622245.0 58072.4 58285.1 58326.5 58364.1 58412.0 1365.0 1389.7 1404.5 1405.7 1406.3 29017.9 29286.9 29567.9 30213.4 30363.1 41524.8 51369.2 51394.5 51395.7 51404.5 550868.0 554579.0 556718.0 557714.0 558362.0 25445.7 25777.5 25818.7 25836.1 26521.2 35296.3 38863.4 45536.9 47963.8 47973.8 36388.8 39547.8 39895.8 40637.6 41209.0 33996.7 38083.7 38984.4 40122.6 40351.8 29904.6 37577.4 38124.8 38727.0 38782.8 33072.5 34094.0 34449.8 34791.7 34805.8 23330.4 24534.8 25388.5 25896.2 26179.9 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34708.23 Median:1588.82 stddev:98883.70 (6223.7%) stddev-sans-first:99127.44 12:07:38 INFO - PROCESS | 1651 | Values: 348.8 366.9 374.0 381.0 403.6 14763.8 15018.2 15682.1 19906.7 20722.0 15917.9 19054.8 20305.4 20622.8 21331.9 5716.4 6105.0 6109.2 6124.2 6139.8 5610.8 5897.6 5956.9 6043.5 6049.9 3796.1 4014.8 5835.0 6029.9 6100.1 5870.4 6180.0 6186.7 6191.3 6213.7 5813.7 5861.1 5868.2 5870.3 5877.3 13338.8 13603.8 23628.2 24343.4 25416.4 2186.7 2205.4 2233.2 2437.9 2828.9 10226.9 10456.6 13658.5 15252.8 15259.8 1820.1 1858.4 1864.3 1883.4 1934.2 93615.5 122742.0 123226.0 124853.5 132505.7 9281.0 10045.0 10766.4 11562.8 11728.9 14691.5 14693.7 14736.0 14739.5 14744.3 8251.7 8597.2 8603.6 8745.6 8775.0 8464.1 8491.4 8517.2 8638.8 8678.2 3925.8 4385.8 4539.0 4540.2 4625.4 1696.4 1875.2 1976.0 1989.3 1998.1 811.9 861.3 896.2 979.8 1001.0 21095.3 21192.0 21223.0 21248.0 21265.6 855.6 887.7 893.5 920.9 937.4 10487.3 10999.7 11110.7 11229.0 11333.8 572527.0 583469.0 589990.0 603896.0 607432.0 102773.0 122402.0 126136.0 131560.0 139036.6 922.7 961.5 970.5 974.0 976.7 12977.4 18342.5 19437.1 19497.8 19611.1 53035.0 54624.7 55907.0 56055.4 56769.7 68551.0 82414.6 83886.0 85012.0 86949.0 7972.6 8200.9 8259.2 8332.8 8500.8 12782.0 13174.9 13260.7 13311.1 13376.7 8673.9 10688.0 11324.9 11361.9 11563.3 10514.5 11182.3 11460.3 11952.6 12012.0 5812.9 6595.7 11326.5 11507.6 12015.8 6881.5 8095.2 8439.7 8484.2 8561.0 10870.3 10991.4 11234.5 11524.7 11561.9 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5678.69 Median:5008.90 stddev:3179.56 (63.5%) stddev-sans-first:3173.25 12:07:38 INFO - PROCESS | 1651 | Values: 1537.0 1549.4 1768.3 1876.1 1925.6 8426.4 8824.3 8889.9 8904.1 8915.5 7855.1 8103.1 8109.3 8542.7 8683.6 2327.5 2365.8 2366.7 2366.8 2370.1 2075.3 2338.2 2359.6 2364.9 2368.3 2333.9 2350.4 2350.4 2362.3 2363.2 2313.4 2329.1 2331.9 2333.5 2335.1 2301.2 2348.9 2349.4 2350.7 2354.1 8868.1 8940.4 8941.0 8945.2 8957.9 5174.7 5338.3 5345.4 5348.9 5357.5 3416.4 3519.7 3625.6 3655.5 3662.7 1065.2 1068.2 1072.2 1092.0 1095.4 11584.5 11797.5 11801.2 11804.4 11831.0 4487.8 4537.1 4718.8 4757.3 4763.6 9916.0 9923.8 9924.3 9930.4 9938.4 5316.0 5317.4 5324.9 5326.4 5331.1 4343.6 4345.8 4819.0 4857.0 4875.8 3507.8 3621.3 3805.5 3911.7 3940.5 1077.6 1088.6 1244.9 1263.2 1267.8 752.2 760.8 813.1 857.7 910.0 5685.5 5849.7 6033.6 6171.9 6234.3 794.3 900.2 960.8 968.4 970.6 3894.9 3903.8 3914.8 3997.4 4024.1 8370.2 10883.8 10885.5 10897.0 10900.4 10024.1 10335.5 10665.4 10845.4 10867.2 7772.9 8024.8 8037.2 8039.5 8049.7 5818.7 6013.9 6036.5 6072.6 6094.6 8479.5 9465.3 9986.0 10139.5 10204.3 10086.0 10140.3 10172.8 10200.1 10204.9 6874.0 7112.9 7294.6 7424.8 7605.8 7283.2 8338.5 8494.7 8498.0 8523.0 7323.3 7524.4 7558.4 7605.1 7805.7 7214.0 7321.5 7392.8 7580.0 7581.5 6727.7 6852.8 6895.4 6908.0 6923.0 4894.4 4942.0 4945.6 4979.1 5136.2 4926.9 5038.7 5045.4 5150.3 5217.8 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4063.95 Median:4409.28 stddev:1215.80 (27.6%) stddev-sans-first:1185.52 12:07:38 INFO - PROCESS | 1651 | Values: 277.4 291.1 308.7 311.3 315.2 4466.7 5182.5 5187.8 5325.9 5326.2 4241.0 4508.5 5027.3 5158.0 5178.8 3515.6 3837.8 3959.0 4060.1 4081.3 3568.3 4061.1 4075.8 4079.8 4081.3 3606.9 3759.6 3969.9 3999.3 4049.0 3032.6 3350.4 3775.7 3992.3 4015.3 2894.9 3510.7 3516.2 3522.4 3524.2 4139.4 4284.9 5083.8 5120.0 5124.4 3819.8 3972.7 4439.0 4553.5 4590.4 4468.1 5437.7 5476.6 5492.8 5525.3 3194.7 3683.3 3821.3 3861.3 3894.9 5512.0 5661.2 5771.7 5797.4 5875.6 3428.3 3709.4 3729.8 3891.7 3914.5 3593.7 3621.0 3940.4 3953.6 3962.8 4004.4 4400.6 4592.4 4604.7 4622.0 4775.8 4790.7 5009.2 5258.1 5543.5 1151.4 1166.3 1285.0 1354.2 1359.0 826.5 856.2 863.9 897.3 920.8 4358.0 4750.0 4841.9 5223.8 5228.8 4872.6 5384.2 5637.9 5667.9 5680.9 4350.9 4569.8 4968.6 5221.6 5254.5 2081.5 2240.6 2378.0 2507.4 2513.9 4081.3 4667.8 4963.5 5009.7 5020.7 4142.0 4653.2 4798.5 4818.5 4939.7 4266.7 4514.8 4922.3 4923.0 4936.5 3853.5 4380.8 4579.6 4770.5 4821.7 3635.5 4167.6 4229.5 4502.7 4673.0 4216.5 4295.5 4353.6 4843.8 4910.9 2894.2 2905.7 3370.2 3395.0 3466.6 3969.8 4325.8 4418.0 4590.8 4796.3 3680.7 4453.3 4502.0 4602.8 4636.4 3865.3 4116.0 4566.5 4629.5 4710.0 4325.0 4499.8 4517.7 4593.5 4606.4 3799.8 4125.7 4610.8 4622.4 4704.2 3693.8 4054.9 4130.0 4564.5 4566.6 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:23268.64 Median:3439.51 stddev:36332.02 (1056.3%) stddev-sans-first:36394.46 12:07:38 INFO - PROCESS | 1651 | Values: 712.2 714.3 768.6 813.9 821.8 14738.9 15441.5 15452.7 15453.3 15467.3 13770.1 13842.4 13862.9 13873.4 13877.2 670.4 690.5 694.8 832.3 835.6 842.6 852.0 852.5 855.7 859.9 915.5 918.6 918.6 920.0 922.2 699.6 910.4 911.3 912.6 915.4 532.6 658.8 673.9 681.0 681.4 14638.0 14646.3 14657.3 14660.9 14662.0 13001.7 13444.9 13554.5 13677.7 13828.6 11927.3 12181.9 12284.9 12462.3 12797.3 4478.8 4492.4 4518.3 4683.2 4702.4 99962.0 101997.5 102144.5 102208.5 103003.0 10543.4 10560.7 10618.8 10659.3 10868.5 20528.5 20600.4 20671.4 20704.3 20939.7 7699.5 7724.3 7770.7 7771.0 7931.1 4175.1 4249.0 4277.7 4279.3 4284.7 3326.5 3424.3 3428.7 3436.0 3443.1 654.7 663.1 683.8 724.9 729.6 538.3 565.4 654.2 659.7 692.9 7743.6 9493.4 9532.0 9548.3 9610.4 555.6 596.4 638.5 663.3 678.7 4218.3 4225.1 4423.1 4621.1 4685.7 89653.6 122458.0 127207.0 141458.0 141828.0 104637.0 132548.0 135637.0 136368.0 137441.0 102168.0 105812.5 105895.0 106673.5 108724.0 8527.8 8971.0 8976.5 8996.8 9132.5 55296.2 58675.0 65414.0 65515.3 66448.3 60424.4 63354.7 73949.2 84572.0 85765.0 13355.4 13472.5 13487.5 13514.9 13572.2 12134.9 13489.0 14836.6 14969.8 15315.8 13683.5 13739.0 13827.6 14135.2 14310.4 13604.5 13753.9 13756.4 14596.1 14647.3 11568.5 11817.9 12020.6 12172.0 12315.2 10864.6 11171.2 11370.8 11553.0 11647.6 9326.3 11244.3 11269.3 11470.4 11713.8 12:07:38 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:07:38 INFO - PROCESS | 1651 | 12:07:38 INFO - TEST-INFO | 1651: exit 0 12:07:38 INFO - TEST-OK | dromaeo_css | took 1119691ms 12:07:38 INFO - TEST-START | kraken 12:07:38 INFO - operating with platform_type : mac_ 12:07:38 INFO - Initialising browser for kraken test... 12:07:38 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpcZ99kz/profile http://localhost:49277/getInfo.html) 12:07:40 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:07:40 INFO - PROCESS | 1662 | colorDepth:24 12:07:40 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:07:40 INFO - PROCESS | 1662 | __metrics 12:07:40 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:07:40 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:41 INFO - TEST-INFO | 1662: exit 0 12:07:41 INFO - Browser initialized. 12:07:41 INFO - Running cycle 1/1 for kraken test... 12:07:41 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpcZ99kz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:53 INFO - PROCESS | 1663 | RSS: Main: 236048384 12:07:53 INFO - PROCESS | 1663 | 12:07:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:57 INFO - PROCESS | 1663 | RSS: Main: 294899712 12:07:57 INFO - PROCESS | 1663 | 12:07:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 12:08:00 INFO - PROCESS | 1663 | RSS: Main: 294289408 12:08:00 INFO - PROCESS | 1663 | 12:08:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 12:08:04 INFO - PROCESS | 1663 | RSS: Main: 383307776 12:08:04 INFO - PROCESS | 1663 | 12:08:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 12:08:07 INFO - PROCESS | 1663 | RSS: Main: 288120832 12:08:07 INFO - PROCESS | 1663 | 12:08:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:10 INFO - PROCESS | 1663 | RSS: Main: 289198080 12:08:10 INFO - PROCESS | 1663 | 12:08:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:13 INFO - PROCESS | 1663 | RSS: Main: 330174464 12:08:13 INFO - PROCESS | 1663 | 12:08:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:17 INFO - PROCESS | 1663 | RSS: Main: 330301440 12:08:17 INFO - PROCESS | 1663 | 12:08:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 12:08:20 INFO - PROCESS | 1663 | RSS: Main: 328667136 12:08:20 INFO - PROCESS | 1663 | 12:08:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:22 INFO - PROCESS | 1663 | RSS: Main: 302161920 12:08:22 INFO - PROCESS | 1663 | 12:08:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:25 INFO - PROCESS | 1663 | RSS: Main: 307970048 12:08:25 INFO - PROCESS | 1663 | 12:08:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:28 INFO - PROCESS | 1663 | RSS: Main: 310095872 12:08:28 INFO - PROCESS | 1663 | 12:08:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:31 INFO - PROCESS | 1663 | RSS: Main: 318840832 12:08:31 INFO - PROCESS | 1663 | 12:08:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:35 INFO - PROCESS | 1663 | RSS: Main: 318152704 12:08:35 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 12:08:37 INFO - PROCESS | 1663 | RSS: Main: 362512384 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | __start_tp_report 12:08:37 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 12:08:37 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 12:08:37 INFO - PROCESS | 1663 | |i|pagename|runs| 12:08:37 INFO - PROCESS | 1663 | |0;ai-astar;113;114;113;114;114;113;113;112;113;113 12:08:37 INFO - PROCESS | 1663 | |1;audio-beat-detection;150;119;128;150;116;111;108;111;146;117 12:08:37 INFO - PROCESS | 1663 | |2;audio-dft;254;262;184;186;184;183;181;183;181;182 12:08:37 INFO - PROCESS | 1663 | |3;audio-fft;80;60;58;91;62;60;57;60;85;57 12:08:37 INFO - PROCESS | 1663 | |4;audio-oscillator;92;72;130;103;99;68;92;68;66;91 12:08:37 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;85;89;130;91;86;94;87;90;86 12:08:37 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;110;149;149;94;94;94;101;94;88 12:08:37 INFO - PROCESS | 1663 | |7;imaging-desaturate;83;98;141;135;85;86;86;86;85;86 12:08:37 INFO - PROCESS | 1663 | |8;json-parse-financial;56;54;54;52;53;53;53;54;54;54 12:08:37 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;69;74;70;78;72;71;71;71;70;71 12:08:37 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;91;86;90;97;110;106;88;85;87 12:08:37 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;148;145;141;138;146;146;147;144;196;142 12:08:37 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;173;171;170;170;171;172;171;233;223;175 12:08:37 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;69;69;68;69;68;68;68;68;67;69 12:08:37 INFO - PROCESS | 1663 | __end_tp_report 12:08:37 INFO - PROCESS | 1663 | __start_cc_report 12:08:37 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1927 12:08:37 INFO - PROCESS | 1663 | __end_cc_report 12:08:37 INFO - PROCESS | 1663 | __startTimestamp1475780917378__endTimestamp 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | ------- Summary: start ------- 12:08:37 INFO - PROCESS | 1663 | Number of tests: 14 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 12:08:37 INFO - PROCESS | 1663 | Values: 113.0 114.0 113.0 114.0 114.0 113.0 113.0 112.0 113.0 113.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:123.50 stddev:16.86 (13.7%) stddev-sans-first:15.40 12:08:37 INFO - PROCESS | 1663 | Values: 150.0 119.0 128.0 150.0 116.0 111.0 108.0 111.0 146.0 117.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:198.00 Median:184.00 stddev:31.71 (17.2%) stddev-sans-first:26.38 12:08:37 INFO - PROCESS | 1663 | Values: 254.0 262.0 184.0 186.0 184.0 183.0 181.0 183.0 181.0 182.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.00 stddev:13.00 (21.3%) stddev-sans-first:12.91 12:08:37 INFO - PROCESS | 1663 | Values: 80.0 60.0 58.0 91.0 62.0 60.0 57.0 60.0 85.0 57.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:81.50 stddev:20.25 (24.8%) stddev-sans-first:21.43 12:08:37 INFO - PROCESS | 1663 | Values: 92.0 72.0 130.0 103.0 99.0 68.0 92.0 68.0 66.0 91.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:89.00 stddev:13.38 (15.0%) stddev-sans-first:14.13 12:08:37 INFO - PROCESS | 1663 | Values: 89.0 85.0 89.0 130.0 91.0 86.0 94.0 87.0 90.0 86.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:93.50 stddev:23.10 (24.7%) stddev-sans-first:23.98 12:08:37 INFO - PROCESS | 1663 | Values: 93.0 110.0 149.0 149.0 94.0 94.0 94.0 101.0 94.0 88.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:86.00 stddev:21.98 (25.6%) stddev-sans-first:22.72 12:08:37 INFO - PROCESS | 1663 | Values: 83.0 98.0 141.0 135.0 85.0 86.0 86.0 86.0 85.0 86.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:0.73 12:08:37 INFO - PROCESS | 1663 | Values: 56.0 54.0 54.0 52.0 53.0 53.0 53.0 54.0 54.0 54.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:2.55 12:08:37 INFO - PROCESS | 1663 | Values: 69.0 74.0 70.0 78.0 72.0 71.0 71.0 71.0 70.0 71.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:87.50 stddev:8.96 (10.2%) stddev-sans-first:9.08 12:08:37 INFO - PROCESS | 1663 | Values: 85.0 91.0 86.0 90.0 97.0 110.0 106.0 88.0 85.0 87.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:146.00 stddev:16.69 (11.4%) stddev-sans-first:17.69 12:08:37 INFO - PROCESS | 1663 | Values: 148.0 145.0 141.0 138.0 146.0 146.0 147.0 144.0 196.0 142.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:172.50 stddev:23.93 (13.9%) stddev-sans-first:25.11 12:08:37 INFO - PROCESS | 1663 | Values: 173.0 171.0 170.0 170.0 171.0 172.0 171.0 233.0 223.0 175.0 12:08:37 INFO - PROCESS | 1663 | 12:08:37 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 12:08:37 INFO - PROCESS | 1663 | Values: 69.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 67.0 69.0 12:08:37 INFO - PROCESS | 1663 | -------- Summary: end -------- 12:08:37 INFO - PROCESS | 1663 | 12:08:38 INFO - TEST-INFO | 1663: exit 0 12:08:38 INFO - TEST-OK | kraken | took 59599ms 12:08:38 INFO - SUITE-END | took 1179s 12:08:38 INFO - Completed test suite (00:19:39) 12:08:38 INFO - javascript benchmark 12:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.4032274190636, 3318.6847249511297, 3336.1659585103725, 3373.797572145673, 3374.9662503374975, 4813.0, 5508.779648814043, 5659.943400565999, 5682.346530149034, 5704.3154821421385, 5596.468335508131, 5636.0982242841155, 5643.0, 5645.294338207724, 5657.519110875581, 5080.314157588725, 5114.948850511503, 5116.130257856174, 5131.0, 5207.270982062514, 5159.432462429129, 5202.895942081156, 5224.1902505111575, 5224.63427560071, 5237.188235823434, 5110.718910459923, 5151.922721159167, 5195.506426889439, 5206.3231779868565, 5241.082810508165, 5212.843614691566, 5220.138677118271, 5226.869328266824, 5228.189630607262, 5250.5274525292525, 5050.141475949097, 5057.190849464105, 5115.0, 5147.974260128713, 5155.149400348938, 5546.334439867242, 5559.666420014772, 5602.187682785973, 5648.378678345379, 5662.66024038559, 6159.983602705548, 6177.691115444255, 6193.318734939198, 6208.0, 6210.472109870667, 6118.388161183846, 6159.907601385983, 6227.252729672468, 6263.404976527223, 6277.905831412532, 5674.546036317126, 5683.0, 5687.260656114679, 5687.459691329317, 5691.402402747734, 6196.10156527301, 6237.0, 6292.653904035231, 6294.8111556653375, 6305.3379395163765, 6087.269527656621, 6088.634681919099, 6096.847578810476, 6099.11054637865, 6117.0, 5559.610827242135, 5965.612235204698, 6194.566380353332, 6224.688765561704, 6245.250569931546, 5410.593245756053, 5758.3090029196765, 6145.8156255312415, 6152.261728592597, 6172.135900973867, 6089.111364424805, 6106.419890110433, 6126.090206827809, 6127.3259941407305, 6142.78500252489, 4900.705957642482, 4904.8773780655765, 4905.386826646669, 4921.188003979375, 4955.72743499111, 4360.672949528798, 4386.71486353386, 4391.407160033355, 4411.735295882258, 4424.491183513937, 5130.948155628087, 5424.972875135599, 5696.316442026983, 5698.287714035746, 5735.598508104393, 6210.689465526705, 6254.499640028786, 6293.213348331458, 6299.748010079637, 6302.275238347557, 5726.541876649858, 5735.139729040678, 5754.395788442237, 5766.826995190151, 5802.1296805479515, 4533.977330113263, 5263.421023687391, 5369.758360873692, 5372.140457526777, 5383.946160538423, 6230.657313847782, 6230.875382492415, 6270.0, 6284.842878928063, 6300.905486417799, 6243.250809902841, 6245.281792593728, 6261.24865016201, 6279.937200627935, 6280.340564240689, 6224.782132625336, 6257.7184026718, 6261.373862613702, 6285.59143655661, 6286.811395658137, 4992.350994370709, 5995.790147344822, 6092.543059270483, 6107.037103281039, 6125.326214116532, 6004.309504406874, 6127.403330890726, 6173.382661733791, 6182.876342473035, 6187.16473276102, 6023.30731965812, 6046.244219472566, 6060.787872424444, 6097.969510152421, 6100.0849872519475, 6053.152558641706, 6058.151858739868, 6064.818055458343, 6068.8786224276155, 6070.666113363807, 4718.504557021463, 5789.710514474344, 5798.913016304675, 5882.382349853375, 5886.499647530008, 6055.6063855849225, 6091.994820854509, 6093.786717464867, 6139.539534535017, 6140.17107690456, 5838.095095260242, 5893.705314734332, 5897.3807750187325, 5924.496417804535, 5966.522678185648], "value": 5627.293691110428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.46470094690164, 498.42183067641537, 505.73954413477054, 507.5077175140113, 537.3685919045121, 40064.59935400645, 42365.788171059176, 42459.36310955338, 42491.99999999996, 44058.33912491315, 43069.0, 43432.56567434325, 43645.563544364544, 43698.781506092506, 43808.78095609525, 9826.017398260152, 10029.297949143564, 10031.498425078753, 10046.899531004707, 10076.596936122547, 9937.006299370078, 10053.296269261118, 10060.849087263698, 10076.39541627501, 10085.798284034316, 9953.552090155925, 10033.297669163161, 10060.647877324294, 10097.596096156145, 10100.343477673927, 10027.448490333029, 10048.196144308438, 10060.144887684555, 10069.345492542961, 10084.243681723827, 9842.114209721089, 9914.0, 9926.90073099267, 9943.850842237372, 9948.005199480067, 41354.58645413537, 41476.37785433221, 41607.0, 41660.791696041626, 41786.582134178876, 3276.3938671345877, 3315.0717799016315, 3348.5479460272795, 3354.513595528659, 3469.5836499619954, 25599.74400255992, 26387.73612263872, 30929.91745288904, 31910.0, 32287.51568726471, 3180.4116238495953, 3302.9669703302898, 3331.850066747002, 3385.407553678121, 3394.541736865516, 456187.0, 459218.0, 459344.0, 463972.6801366005, 471397.0, 60616.09075863865, 61098.38901611016, 61111.0, 61218.38781612216, 61257.0, 64030.0, 64154.0, 64199.037014444824, 64350.0, 64371.678141608994, 13334.66663333405, 16272.837271627131, 16279.674406511804, 16291.02253864772, 16291.674166516841, 12576.748465030649, 12629.179103358436, 12711.682207944876, 12720.809187862189, 12724.809127863089, 14290.0, 17422.39021634262, 17723.911380443016, 17773.644527109387, 17809.46571602854, 5870.412958704095, 6116.449519543263, 6923.6192009438955, 6940.681270558679, 6973.755918542826, 687.5771400588602, 853.7268074216315, 1022.6778564752228, 1025.768952528263, 1026.1790567546082, 29024.0, 29852.850735746182, 29958.850205749266, 30687.0, 30690.0, 973.1630797514132, 987.4420952162005, 995.1839491616805, 1019.7654539455966, 1053.3153450257241, 14031.22828244436, 14589.124652520883, 15295.15876626774, 15397.769033464507, 15744.370225190863, 617312.0, 618410.0, 618454.0, 620270.0, 622245.0, 58072.419275807544, 58285.125723114186, 58326.54265131617, 58364.12453813196, 58412.0, 1365.0, 1389.6867460249966, 1404.5014020022745, 1405.7399381114321, 1406.2827957741422, 29017.854910725313, 29286.853565732887, 29567.852160739058, 30213.395732084795, 30363.089107326814, 41524.79237603793, 51369.229461557356, 51394.48605514046, 51395.74302128465, 51404.48595514146, 550868.0, 554579.0, 556718.0, 557714.0, 558362.0, 25445.745542544337, 25777.484450310512, 25818.741812582386, 25836.095736649128, 26521.204363869114, 35296.29407411889, 38863.41704874486, 45536.861578460805, 47963.80090497765, 47973.760131199124, 36388.81805590955, 39547.81356559308, 39895.80052099837, 40637.59362406338, 41209.0, 33996.66003339935, 38083.71618682886, 38984.41523377208, 40122.59877401305, 40351.798241008604, 29904.551431728978, 37577.43633845549, 38124.809375952944, 38727.0, 38782.8365149046, 33072.50391244085, 34094.0, 34449.827750861084, 34791.65208347884, 34805.825970870996, 23330.40158314559, 24534.754652453248, 25388.49223015566, 25896.22311330663, 26179.869100654374], "value": 19787.120087984036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7558708903768, 366.86242659002875, 373.9551253849539, 380.9923801523969, 403.58229232744117, 14763.77854332186, 15018.174000429972, 15682.061230072864, 19906.701399479018, 20721.963901804887, 15917.920410397961, 19054.809451905476, 20305.390838274838, 20622.793772062276, 21331.893340533275, 5716.428357164282, 6104.969475152618, 6109.236345456818, 6124.1732366130445, 6139.754409823602, 5610.775568977236, 5897.587168898179, 5956.86819504295, 6043.486303664194, 6049.879002419949, 3796.126890815114, 4014.8394064237395, 5835.0372188588835, 6029.9447596670625, 6100.115483254947, 5870.354261031283, 6180.0, 6186.721597528122, 6191.318954914956, 6213.689315534205, 5813.7383817728305, 5861.062230043172, 5868.207791948118, 5870.324912635059, 5877.265341832271, 13338.799918001238, 13603.795943060863, 23628.17301394443, 24343.41767785106, 25416.36459088519, 2186.7157269555014, 2205.4155648753094, 2233.229535810143, 2437.9390515237083, 2828.8868445262165, 10226.89773102267, 10456.63401780934, 13658.521951731642, 15252.771208431883, 15259.847401525954, 1820.1316690994672, 1858.3561535103433, 1864.3474783825689, 1883.3878989328523, 1934.2456441987636, 93615.53192234064, 122742.0, 123226.0, 124853.5029299418, 132505.67494325028, 9281.0, 10045.0, 10766.416060145666, 11562.826557601642, 11728.94135529317, 14691.485797997018, 14693.693918868383, 14736.0, 14739.484118055816, 14744.336504857307, 8251.711190108437, 8597.18326758957, 8603.612837422332, 8745.562721863882, 8775.0, 8464.111268316861, 8491.363147763943, 8517.233448989497, 8638.827223455495, 8678.218960293478, 3925.7644541327613, 4385.758783266887, 4539.002838750939, 4540.160070386989, 4625.352450656911, 1696.3808210003506, 1875.2217829600836, 1975.9506012349807, 1989.254029738848, 1998.1208268361875, 811.8985126859143, 861.2679222660688, 896.188949001155, 979.7648564344506, 1000.9749756256152, 21095.26166584193, 21192.0, 21223.044962976703, 21248.043838027326, 21265.57468850614, 855.5935930432995, 887.7203680840514, 893.4639216470196, 920.9171174594319, 937.3579098317538, 10487.318324308895, 10999.725006874893, 11110.722231944266, 11228.98939095469, 11333.773324533464, 572527.0, 583469.0, 589990.0, 603896.0, 607432.0, 102773.0, 122402.0, 126136.0, 131560.0, 139036.6096339044, 922.7462447826902, 961.4519723757392, 970.5001924009141, 973.9659111931048, 976.6581696406344, 12977.35113244353, 18342.541436464195, 19437.12532935993, 19497.805021950167, 19611.11749971226, 53035.0, 54624.72687636536, 55907.0, 56055.43944560502, 56769.71615142063, 68551.0, 82414.58792706238, 83886.0, 85012.04915655845, 86949.0, 7972.6412311444965, 8200.917990820015, 8259.174082591693, 8332.791680208044, 8500.787480313042, 12782.041346899206, 13174.868251317748, 13260.668483287609, 13311.068225224528, 13376.732465350444, 8673.913260867563, 10688.038076573146, 11324.924132207427, 11361.886381136082, 11563.30620162793, 10514.474276286308, 11182.32906025641, 11460.255083419552, 11952.64142075739, 12012.039036877204, 5812.94187058141, 6595.703193356407, 11326.490307936327, 11507.561554805648, 12015.75968480608, 6881.518293719391, 8095.23095305945, 8439.70461033861, 8484.19400156984, 8561.0, 10870.347779133277, 10991.395473249047, 11234.494447750034, 11524.711882203012, 11561.942190288995], "value": 9469.266388827598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.9769453458193, 1549.4267121165167, 1768.301520899245, 1876.0713446843815, 1925.6437559051576, 8426.410151289412, 8824.338174636903, 8889.866652000224, 8904.065073167314, 8915.465072095678, 7855.05739311282, 8103.068147163078, 8109.270165685102, 8542.70100546481, 8683.565821708906, 2327.5112226432425, 2365.82256330775, 2366.7041619797524, 2366.8343215974887, 2370.0756704885107, 2075.2840270106863, 2338.2166974063625, 2359.575276450238, 2364.917227897024, 2368.2895131460577, 2333.8599684018927, 2350.4006478347997, 2350.4476448034698, 2362.2558893948435, 2363.2201373546686, 2313.3869524576003, 2329.0683726509365, 2331.895064722092, 2333.4866329407505, 2335.07764433048, 2301.171578231835, 2348.9177878774162, 2349.4361353275262, 2350.7296660883876, 2354.1407386303877, 8868.068852770495, 8940.418872773314, 8941.016488186295, 8945.15021072997, 8957.865632015524, 5174.7153906535505, 5338.332708411449, 5345.412004679482, 5348.946510534884, 5357.544608708265, 3416.4021296273054, 3519.683228509421, 3625.619309972468, 3655.5430571178604, 3662.7069834413182, 1065.1638463805953, 1068.150820098016, 1072.1637123044038, 1092.0280949954547, 1095.413953534855, 11584.47869845859, 11797.469113889896, 11801.173917825756, 11804.350760708157, 11831.0, 4487.820487180542, 4537.069900670421, 4718.834840780556, 4757.286407038971, 4763.571278584944, 9915.950420247997, 9923.801523969625, 9924.305298629026, 9930.354526955725, 9938.354006989668, 5316.0, 5317.441668624816, 5324.946750532523, 5326.36083669962, 5331.1470164773455, 4343.587359200871, 4345.804438800262, 4818.975905120452, 4856.95143048565, 4875.756212189376, 3507.8424120040327, 3621.3300539400293, 3805.5052843130215, 3911.6675082617726, 3940.5074365704286, 1077.5959015369237, 1088.5645741703224, 1244.8941839943707, 1263.1726219326356, 1267.7781388257017, 752.1876373516699, 760.8288135169543, 813.0812182234038, 857.7426771968385, 909.9980043903439, 5685.459881311269, 5849.678267695318, 6033.577649564576, 6171.907421388682, 6234.345393733593, 794.3287921706149, 900.2078171209293, 960.7598100474881, 968.4479846487435, 970.5520076377799, 3894.922101557953, 3903.765774053566, 3914.7651140931634, 3997.3804060370107, 4024.054347228399, 8370.246677798905, 10883.768827390366, 10885.455727213608, 10897.0, 10900.400477973788, 10024.09542186982, 10335.534900929477, 10665.36007839532, 10845.403502807263, 10867.184961127947, 7772.883406748903, 8024.759257222293, 8037.196280371916, 8039.5176289422825, 8049.71825986076, 5818.650880947157, 6013.939860601338, 6036.486898613667, 6072.603301240651, 6094.634321940698, 8479.533625650649, 9465.337426380087, 9985.950070249603, 10139.493025348556, 10204.336718113298, 10086.041826026516, 10140.312817103326, 10172.847407289044, 10200.132988695746, 10204.897951020395, 6873.965630171817, 7112.928870711226, 7294.562326260441, 7424.777256682092, 7605.771826845204, 7283.162436319679, 8338.499690018376, 8494.74515764528, 8497.980242370955, 8523.019852717018, 7323.340899319087, 7524.360429363565, 7558.395328373607, 7605.087389513294, 7805.687772489036, 7213.9639301805255, 7321.524100933422, 7392.815179620553, 7579.962100189464, 7581.50720203185, 6727.697253623696, 6852.8286792828585, 6895.379415852397, 6908.032875397549, 6922.965385173042, 4894.388201474816, 4942.0, 4945.62907781925, 4979.128652485873, 5136.178211486294, 4926.926096108633, 5038.672486288379, 5045.376404269832, 5150.253213284128, 5217.843464696065], "value": 4556.682687648052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.38835866913456, 291.1135592121988, 308.7128970057846, 311.2902582112782, 315.2214031342586, 4466.731996080238, 5182.507661772131, 5187.818426355078, 5325.946740532603, 5326.215717734553, 4241.024564350201, 4508.5266047065, 5027.290721154815, 5158.019976204528, 5178.844634660957, 3515.630858759832, 3837.771912987845, 3959.030037640775, 4060.1473690525027, 4081.3265811141127, 3568.3398571264397, 4061.1268577255883, 4075.7758323292205, 4079.8368065277355, 4081.3469844824835, 3606.917924622616, 3759.567649720276, 3969.8610548630804, 3999.280129576675, 4049.048473608714, 3032.6057612510454, 3350.3801796667694, 3775.6596408275077, 3992.323224245824, 4015.277250094982, 2894.8999380235587, 3510.701590364822, 3516.2440075383915, 3522.383582872987, 3524.1894364296354, 4139.3583994480905, 4284.850030248957, 5083.805305753145, 5120.0, 5124.385073791132, 3819.751716138442, 3972.741771784825, 4438.955610443886, 4553.476350219734, 4590.357349971006, 4468.084042771224, 5437.700926449043, 5476.618705035955, 5492.780288788444, 5525.336959564878, 3194.6645602211897, 3683.3001729671546, 3821.293060783736, 3861.3242682530727, 3894.883153505399, 5511.9724401378135, 5661.179129026268, 5771.711414429304, 5797.449242321973, 5875.559333050039, 3428.348613763427, 3709.3879509880567, 3729.8437484379388, 3891.727579069438, 3914.4911161548816, 3593.7484376093944, 3620.9637903621156, 3940.408938659224, 3953.6046395360236, 3962.7517332040316, 4004.439378487014, 4400.581944715247, 4592.448906131219, 4604.723716577016, 4621.989434595962, 4775.806048487878, 4790.736509491941, 5009.248612708123, 5258.07983602868, 5543.473370029921, 1151.41277948247, 1166.2943918929095, 1284.9743005139844, 1354.214555557774, 1358.98076442668, 826.5454000299811, 856.1866227084171, 863.8531449653574, 897.2597606974273, 920.8296465153968, 4357.956420435755, 4749.976250118727, 4841.927371089437, 5223.817166399158, 5228.830035535287, 4872.634552408584, 5384.192371144281, 5637.872425514914, 5667.943320566824, 5680.8863822723315, 4350.891227719332, 4569.81720731167, 4968.552830245223, 5221.634485586049, 5254.528731955059, 2081.5420607466335, 2240.6302960011417, 2377.9774696880163, 2507.3731567108225, 2513.8617376044494, 4081.2858599387732, 4667.755909642833, 4963.478834722375, 5009.674371165863, 5020.748962551857, 4142.032534546127, 4653.18525774948, 4798.5441383068555, 4818.518148185153, 4939.703617782944, 4266.743995360288, 4514.796834142471, 4922.34193535494, 4922.975385123052, 4936.457724272074, 3853.5183102112237, 4380.8247670094115, 4579.564941330568, 4770.499097594841, 4821.710697358169, 3635.4910312556794, 4167.562405947332, 4229.534751177306, 4502.729836209838, 4672.999890117541, 4216.536181020147, 4295.487140023121, 4353.604188732794, 4843.75781210931, 4910.852674419773, 2894.233028247474, 2905.677916548008, 3370.2137866930566, 3394.978469162398, 3466.6360032196258, 3969.8213580388374, 4325.767156360422, 4417.977910110429, 4590.839320623762, 4796.304535842353, 3680.742348035719, 4453.334117716254, 4502.0, 4602.792874320597, 4636.397268355227, 3865.3042452358845, 4115.97942010288, 4566.4748553916725, 4629.513901040477, 4710.034442939121, 4324.978375108104, 4499.775011249359, 4517.68376213675, 4593.54064593538, 4606.401167848292, 3799.765076350142, 4125.711200215956, 4610.847288177955, 4622.352870598052, 4704.223803072455, 3693.778373297611, 4054.878353649395, 4130.008797888425, 4564.543545645409, 4566.634669226388], "value": 3694.4146095717183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.2023333866069, 714.3245286001512, 768.5964868444066, 813.9186081391862, 821.8397412504564, 14738.852611473882, 15441.536753897373, 15452.69094618107, 15453.30460129294, 15467.30397132129, 13770.10494317871, 13842.377093030813, 13862.861371386283, 13873.375698093585, 13877.16736995781, 670.3932940688685, 690.533889624504, 694.8158737934451, 832.2883934236231, 835.6281454752638, 842.6208206307156, 851.9957400212991, 852.4885068958637, 855.6748435594466, 859.8839156713857, 915.4690279637828, 918.6049998500642, 918.6325469812095, 920.0247737398346, 922.1884741427568, 699.6152116336045, 910.3536489092752, 911.289194428347, 912.6303846942, 915.4095608332622, 532.6165161084052, 658.789187460013, 673.8685956238536, 681.0193321616856, 681.4241965539112, 14638.048526845721, 14646.267686615627, 14657.267136643126, 14660.853391466055, 14662.046966947115, 13001.674958126028, 13444.932775336158, 13554.525591604344, 13677.679988457618, 13828.585142445743, 11927.284362938164, 12181.93909030458, 12284.877151228462, 12462.314572698499, 12797.296148711817, 4478.753668548228, 4492.438445194351, 4518.254488009507, 4683.180443422388, 4702.412198475191, 99962.0, 101997.4900125502, 102144.48927755462, 102208.48895755474, 103003.0, 10543.420111893765, 10560.735981600368, 10618.840717389245, 10659.25385223027, 10868.510917008754, 20528.486787830425, 20600.38198854037, 20671.379858604265, 20704.275350362666, 20939.68590471144, 7699.499532530368, 7724.343430808444, 7770.650320735581, 7771.0, 7931.127575966754, 4175.102352994121, 4249.0, 4277.743335399886, 4279.3153095505195, 4284.700070995001, 3326.5176549400203, 3424.3493736190044, 3428.674275943781, 3435.9656403436147, 3443.0531603808654, 654.715198888485, 663.1081195791653, 683.8119517132828, 724.9093863267092, 729.6388287797574, 538.2921458282347, 565.3667891960948, 654.2182092399632, 659.7394029358377, 692.8960655901656, 7743.612819359009, 9493.430394176372, 9532.0, 9548.331616786898, 9610.375325603813, 555.6416111608071, 596.3648714119449, 638.5179189711831, 663.2670898657011, 678.6572780745691, 4218.303979843353, 4225.149890336224, 4423.093265880487, 4621.09888571732, 4685.695429797052, 89653.55173224222, 122458.0, 127207.0, 141458.0, 141828.0, 104637.0, 132548.0, 135637.0, 136368.0, 137441.0, 102168.0, 105812.47093764482, 105895.0, 106673.46663266789, 108724.0, 8527.757032611402, 8971.0, 8976.466884223426, 8996.775080623036, 9132.452052876848, 55296.17055744086, 58675.0, 65414.0, 65515.344846552834, 66448.33551664422, 60424.39575604188, 63354.68322658357, 73949.15127121865, 84572.0, 85765.0, 13355.3990070449, 13472.482948888814, 13487.460501579826, 13514.93242533781, 13572.1856688599, 12134.878651213729, 13489.0, 14836.554903352917, 14969.77545336799, 15315.846841531442, 13683.452661893412, 13739.0, 13827.58517244444, 14135.222562759147, 14310.356033978704, 13604.455821767415, 13753.931230343784, 13756.449742010207, 14596.109166691664, 14647.26763661834, 11568.537258509901, 11817.940910295394, 12020.63938081859, 12171.965382942195, 12315.199512032048, 10864.565417383215, 11171.162162837658, 11370.772584548427, 11553.0, 11647.59233426826, 9326.347155699308, 11244.26912250701, 11269.28113722486, 11470.426478675867, 11713.765724685289], "value": 7650.258580497008, "unit": "score"}], "name": "dromaeo_css", "value": 7169.464171685922, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 128.0, 150.0, 116.0, 111.0, 108.0, 111.0, 146.0, 117.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [254.0, 262.0, 184.0, 186.0, 184.0, 183.0, 181.0, 183.0, 181.0, 182.0], "value": 198.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 91.0, 62.0, 60.0, 57.0, 60.0, 85.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 130.0, 103.0, 99.0, 68.0, 92.0, 68.0, 66.0, 91.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 130.0, 91.0, 86.0, 94.0, 87.0, 90.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 149.0, 149.0, 94.0, 94.0, 94.0, 101.0, 94.0, 88.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 98.0, 141.0, 135.0, 85.0, 86.0, 86.0, 86.0, 85.0, 86.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 52.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 70.0, 78.0, 72.0, 71.0, 71.0, 71.0, 70.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 86.0, 90.0, 97.0, 110.0, 106.0, 88.0, 85.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 141.0, 138.0, 146.0, 146.0, 147.0, 144.0, 196.0, 142.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 170.0, 171.0, 172.0, 171.0, 233.0, 223.0, 175.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1506.7000000000003, "alertThreshold": 2.0}]} 12:08:38 INFO - Return code: 0 12:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:38 INFO - # TBPL SUCCESS # 12:08:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:08:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:08:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:08:38 INFO - 2016-10-06 12:08:38.703 screenresolution[1667:10229] starting screenresolution argv=screenresolution get 12:08:38 INFO - 2016-10-06 12:08:38.705 screenresolution[1667:10229] Display 0: 1600x1200x32@60 12:08:38 INFO - 2016-10-06 12:08:38.711 screenresolution[1668:10233] starting screenresolution argv=screenresolution list 12:08:38 INFO - Available Modes on Display 0 12:08:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:08:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:08:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:08:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:08:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:08:38 INFO - Intel Iris: 12:08:38 INFO - Chipset Model: Intel Iris 12:08:38 INFO - Type: GPU 12:08:38 INFO - Bus: Built-In 12:08:38 INFO - VRAM (Dynamic, Max): 1536 MB 12:08:38 INFO - Vendor: Intel (0x8086) 12:08:38 INFO - Device ID: 0x0a2e 12:08:38 INFO - Revision ID: 0x0009 12:08:38 INFO - Displays: 12:08:38 INFO - Display: 12:08:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:08:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:08:38 INFO - Display Serial Number: 1600x1200 60 12:08:38 INFO - Main Display: Yes 12:08:38 INFO - Mirror: Off 12:08:38 INFO - Online: Yes 12:08:38 INFO - Rotation: Supported 12:08:38 INFO - Return code: 0 12:08:38 INFO - Running post-action listener: _resource_record_post_action 12:08:38 INFO - [mozharness: 2016-10-06 19:08:38.946628Z] Finished run-tests step (success) 12:08:38 INFO - Running post-run listener: _resource_record_post_run 12:08:39 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38695936; Write bytes: 707915776; Read time: 378; Write time: 1995 12:08:39 INFO - TinderboxPrint: CPU usage
53.8% 12:08:39 INFO - TinderboxPrint: I/O read bytes / time
38,695,936 / 378 12:08:39 INFO - TinderboxPrint: I/O write bytes / time
707,915,776 / 1,995 12:08:39 INFO - TinderboxPrint: CPU idle
2,244.9 (46.2%) 12:08:39 INFO - TinderboxPrint: CPU system
976.3 (20.1%) 12:08:39 INFO - TinderboxPrint: CPU user
1,636.5 (33.7%) 12:08:39 INFO - TinderboxPrint: Swap in / out
446,464,000 / 0 12:08:39 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393931264; Write bytes: 387971072; Read time: 29484; Write time: 784 12:08:39 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37725184; Write bytes: 297699328; Read time: 362; Write time: 1129 12:08:39 INFO - Running post-run listener: _upload_blobber_files 12:08:39 INFO - Blob upload gear active. 12:08:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:08:39 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:39 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:39 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:41 INFO - (blobuploader) - INFO - Done attempting. 12:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:42 INFO - (blobuploader) - INFO - Done attempting. 12:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:44 INFO - (blobuploader) - INFO - Done attempting. 12:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:44 INFO - Return code: 0 12:08:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/524e741a29b8b2e34814bbb271d475cd3f7b1fde8a8c84a47a8938f1f0a8eed5658ede33b1e388802f579bd1471ca1575f05df2c50f7427409b7416af42f9677", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/733ca3f7a432340f44eff31b95e1d66def576a901282331c73a49f180e6bbada96d8f7a9a5e973e5e273cd25b1b2cd805e0a1558970dd541bbc980ad9a71398e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/83913ac8a05835a1ddd71700ed599e5c92e2131c4f33a380f87c6d4c51fc4b70990b48852904bdc711fe1546f53ad70a551c13282cfbfe2535c7b4aa096ea47e"} 12:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:44 INFO - Contents: 12:08:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/524e741a29b8b2e34814bbb271d475cd3f7b1fde8a8c84a47a8938f1f0a8eed5658ede33b1e388802f579bd1471ca1575f05df2c50f7427409b7416af42f9677", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/733ca3f7a432340f44eff31b95e1d66def576a901282331c73a49f180e6bbada96d8f7a9a5e973e5e273cd25b1b2cd805e0a1558970dd541bbc980ad9a71398e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/83913ac8a05835a1ddd71700ed599e5c92e2131c4f33a380f87c6d4c51fc4b70990b48852904bdc711fe1546f53ad70a551c13282cfbfe2535c7b4aa096ea47e"} 12:08:44 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:44 INFO - Copying logs to upload dir... 12:08:44 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.146366 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-06 12:08:44.389858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 12:08:44.393648) ========= 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.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/524e741a29b8b2e34814bbb271d475cd3f7b1fde8a8c84a47a8938f1f0a8eed5658ede33b1e388802f579bd1471ca1575f05df2c50f7427409b7416af42f9677", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/733ca3f7a432340f44eff31b95e1d66def576a901282331c73a49f180e6bbada96d8f7a9a5e973e5e273cd25b1b2cd805e0a1558970dd541bbc980ad9a71398e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/83913ac8a05835a1ddd71700ed599e5c92e2131c4f33a380f87c6d4c51fc4b70990b48852904bdc711fe1546f53ad70a551c13282cfbfe2535c7b4aa096ea47e"} build_url:https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/KR4vo4cURdm95-U8E0U2Sg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/524e741a29b8b2e34814bbb271d475cd3f7b1fde8a8c84a47a8938f1f0a8eed5658ede33b1e388802f579bd1471ca1575f05df2c50f7427409b7416af42f9677", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/733ca3f7a432340f44eff31b95e1d66def576a901282331c73a49f180e6bbada96d8f7a9a5e973e5e273cd25b1b2cd805e0a1558970dd541bbc980ad9a71398e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/83913ac8a05835a1ddd71700ed599e5c92e2131c4f33a380f87c6d4c51fc4b70990b48852904bdc711fe1546f53ad70a551c13282cfbfe2535c7b4aa096ea47e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 12:08:44.425800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:08:44.426130) ========= 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.QEzPAymWor/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.r8FqP2aTUH/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:08:44.475220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 12:08:44.475539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 12:08:44.475865) ========= ========= Total master_lag: 0.18 =========