builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1476393309.63 results: success (0) buildid: 20161013101223 builduid: e6343d5833a043288fc2a028ac52039d revision: dcfc73c043c01c3185631262605e3511bebe4cca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.630963) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.631395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.631667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.655476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.655757) ========= 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.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-13 14:15:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2016-10-13 14:15:09 (17.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.789634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.790029) ========= 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.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.032530 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:09.843309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 14:15:09.843699) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev dcfc73c043c01c3185631262605e3511bebe4cca --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 dcfc73c043c01c3185631262605e3511bebe4cca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-13 14:15:09,915 truncating revision to first 12 chars 2016-10-13 14:15:09,915 Setting DEBUG logging. 2016-10-13 14:15:09,915 attempt 1/10 2016-10-13 14:15:09,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/dcfc73c043c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 14:15:10,959 unpacking tar archive at: autoland-dcfc73c043c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 14:15:11.172163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:11.172499) ========= script_repo_revision: dcfc73c043c01c3185631262605e3511bebe4cca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:11.172917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:11.173220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:15:11.191135) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-13 14:15:11.191426) ========= /tools/buildbot/bin/python -u 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', '-u', '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.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:11 INFO - MultiFileLogger online at 20161013 14:15:11 in /builds/slave/test 14:15:11 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 14:15:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:11 INFO - {'append_to_log': False, 14:15:11 INFO - 'base_work_dir': '/builds/slave/test', 14:15:11 INFO - 'blob_upload_branch': 'Autoland', 14:15:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:11 INFO - 'branch': 'Autoland', 14:15:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:11 INFO - 'config_files': ('talos/mac_config.py',), 14:15:11 INFO - 'default_actions': ('clobber', 14:15:11 INFO - 'read-buildbot-config', 14:15:11 INFO - 'download-and-extract', 14:15:11 INFO - 'populate-webroot', 14:15:11 INFO - 'create-virtualenv', 14:15:11 INFO - 'install', 14:15:11 INFO - 'run-tests'), 14:15:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:11 INFO - 'download_minidump_stackwalk': True, 14:15:11 INFO - 'download_symbols': 'ondemand', 14:15:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:11 INFO - 'installer_path': 'installer.exe', 14:15:11 INFO - 'log_level': 'info', 14:15:11 INFO - 'log_name': 'talos', 14:15:11 INFO - 'log_to_console': True, 14:15:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:15:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:15:11 INFO - 'opt_config_files': (), 14:15:11 INFO - 'pip_index': False, 14:15:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:11 INFO - 'cmd': ('bash', 14:15:11 INFO - '-c', 14:15:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:11 INFO - 'enabled': True, 14:15:11 INFO - 'halt_on_failure': False, 14:15:11 INFO - 'name': 'check_screen_resolution'},), 14:15:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:11 INFO - 'cmd': ('bash', 14:15:11 INFO - '-c', 14:15:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:11 INFO - 'enabled': True, 14:15:11 INFO - 'halt_on_failure': False, 14:15:11 INFO - 'name': 'check_screen_resolution'},), 14:15:11 INFO - 'run_cmd_checks_enabled': True, 14:15:11 INFO - 'sps_profile': False, 14:15:11 INFO - 'sps_profile_interval': 0, 14:15:11 INFO - 'suite': 'dromaeojs', 14:15:11 INFO - 'system_bits': '32', 14:15:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:11 INFO - 'title': 't-yosemite-r7-0106', 14:15:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:11 INFO - 'use_talos_json': True, 14:15:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:11 INFO - 'work_dir': 'build'} 14:15:11 INFO - [mozharness: 2016-10-13 21:15:11.393408Z] Running clobber step. 14:15:11 INFO - Running pre-action listener: _resource_record_pre_action 14:15:11 INFO - Running main action method: clobber 14:15:11 INFO - rmtree: /builds/slave/test/build 14:15:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:13 INFO - Running post-action listener: _resource_record_post_action 14:15:13 INFO - [mozharness: 2016-10-13 21:15:13.668298Z] Finished clobber step (success) 14:15:13 INFO - [mozharness: 2016-10-13 21:15:13.668451Z] Running read-buildbot-config step. 14:15:13 INFO - Running pre-action listener: _resource_record_pre_action 14:15:13 INFO - Running main action method: read_buildbot_config 14:15:13 INFO - Using buildbot properties: 14:15:13 INFO - { 14:15:13 INFO - "project": "", 14:15:13 INFO - "product": "firefox", 14:15:13 INFO - "script_repo_revision": "production", 14:15:13 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:15:13 INFO - "repository": "", 14:15:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:15:13 INFO - "buildid": "20161013101223", 14:15:13 INFO - "pgo_build": "False", 14:15:13 INFO - "basedir": "/builds/slave/test", 14:15:13 INFO - "buildnumber": 261, 14:15:13 INFO - "slavename": "t-yosemite-r7-0106", 14:15:13 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:15:13 INFO - "platform": "yosemite_r7", 14:15:13 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:15:13 INFO - "branch": "autoland", 14:15:13 INFO - "repo_path": "integration/autoland", 14:15:13 INFO - "revision": "dcfc73c043c01c3185631262605e3511bebe4cca", 14:15:13 INFO - "stage_platform": "macosx64", 14:15:13 INFO - "builduid": "e6343d5833a043288fc2a028ac52039d", 14:15:13 INFO - "slavebuilddir": "test" 14:15:13 INFO - } 14:15:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:15:13 INFO - Running post-action listener: _resource_record_post_action 14:15:13 INFO - [mozharness: 2016-10-13 21:15:13.671800Z] Finished read-buildbot-config step (success) 14:15:13 INFO - [mozharness: 2016-10-13 21:15:13.671901Z] Running download-and-extract step. 14:15:13 INFO - Running pre-action listener: _resource_record_pre_action 14:15:13 INFO - Running main action method: download_and_extract 14:15:13 INFO - mkdir: /builds/slave/test/build/tests 14:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:13 INFO - trying https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:15:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/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 14:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/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 14:15:15 INFO - Downloaded 1199 bytes. 14:15:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:15:15 INFO - Using the following test package requirements: 14:15:15 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:15:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:15:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:15:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'jsshell-mac.zip'], 14:15:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:15:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:15:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:15:15 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:15:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:15:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:15:15 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:15:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:15:15 INFO - Http code: 200 14:15:15 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 14:15:15 INFO - x-amz-cf-id: dpUqwY76P2-9TQHbZU_EmQb-bSWCADkmQDTwHSg-XMfldVjHSCikRw== 14:15:15 INFO - x-amz-version-id: X98.oRG84gDSXahuGvoa6HpZTL31qPT. 14:15:16 INFO - Expected file size: 16515416 14:15:16 INFO - Obtained file size: 16515416 14:15:22 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 14:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:15:23 INFO - Http code: 200 14:15:23 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 14:15:23 INFO - x-amz-cf-id: LHhnW5Hcjq3ptzIOFAcRBZ8-_xuC8o5s4tMM4HVEfxgfmKFRXNAFAw== 14:15:23 INFO - x-amz-version-id: X98.oRG84gDSXahuGvoa6HpZTL31qPT. 14:15:23 INFO - Expected file size: 16515416 14:15:23 INFO - Obtained file size: 16515416 14:15:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:15:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:15:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:15:30 INFO - Http code: 200 14:15:30 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:15:30 INFO - x-amz-cf-id: hlKW0W-bMv1CHLjVAwBqqoMwyEhi4EkUMqO7hqtf9nZctD8cFE4HQw== 14:15:30 INFO - x-amz-version-id: YHFN3aecRUKXUVYSPiNhuKacfXQuO91G 14:15:31 INFO - Expected file size: 14409006 14:15:31 INFO - Obtained file size: 14409006 14:15:31 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')]} 14:15:31 INFO - trying https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/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 14:15:34 INFO - Downloaded 111676563 bytes. 14:15:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:15:34 INFO - mkdir: /builds/slave/test/properties 14:15:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:34 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:34 INFO - Contents: 14:15:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:15:34 INFO - Running post-action listener: _resource_record_post_action 14:15:34 INFO - Running post-action listener: set_extra_try_arguments 14:15:34 INFO - [mozharness: 2016-10-13 21:15:34.960683Z] Finished download-and-extract step (success) 14:15:34 INFO - [mozharness: 2016-10-13 21:15:34.960802Z] Running populate-webroot step. 14:15:34 INFO - Running pre-action listener: _resource_record_pre_action 14:15:34 INFO - Running main action method: populate_webroot 14:15:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:34 INFO - '--tppagecycles', 14:15:34 INFO - '7'], 14:15:34 INFO - 'tests': ['tsvgm']}}, 14:15:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['damp', 'tps']}, 14:15:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'tests': ['damp', 'tps']}, 14:15:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['dromaeo_dom']}, 14:15:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['basic_compositor_video']}, 14:15:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:15:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['a11yr', 14:15:34 INFO - 'ts_paint', 14:15:34 INFO - 'tpaint', 14:15:34 INFO - 'sessionrestore', 14:15:34 INFO - 'sessionrestore_no_auto_restore', 14:15:34 INFO - 'tabpaint']}, 14:15:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['tsvgx', 14:15:34 INFO - 'tsvgr_opacity', 14:15:34 INFO - 'tart', 14:15:34 INFO - 'tscrollx', 14:15:34 INFO - 'cart']}, 14:15:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:34 INFO - 'tsvgr_opacity', 14:15:34 INFO - 'tart', 14:15:34 INFO - 'tscrollx', 14:15:34 INFO - 'cart']}, 14:15:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'talos_options': ['--disable-e10s'], 14:15:34 INFO - 'tests': ['tp5o']}, 14:15:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'tests': ['tp5o']}, 14:15:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'talos_options': ['--disable-e10s', 14:15:34 INFO - '--xperf_path', 14:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:34 INFO - 'tests': ['tp5n']}, 14:15:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:34 INFO - 'talos_options': ['--xperf_path', 14:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:34 INFO - 'tests': ['tp5n']}}, 14:15:34 INFO - 'talos.zip': {'path': '', 14:15:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:34 INFO - Running post-action listener: _resource_record_post_action 14:15:34 INFO - [mozharness: 2016-10-13 21:15:34.979320Z] Finished populate-webroot step (success) 14:15:34 INFO - [mozharness: 2016-10-13 21:15:34.979458Z] Running create-virtualenv step. 14:15:34 INFO - Running pre-action listener: _resource_record_pre_action 14:15:34 INFO - Running main action method: create_virtualenv 14:15:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:34 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 14:15:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:35 INFO - Using real prefix '/tools/python27' 14:15:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:38 INFO - Installing pip.................done. 14:15:38 INFO - Return code: 0 14:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:15:38 INFO - Reading from file tmpfile_stdout 14:15:38 INFO - Output received: 14:15:38 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) 14:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:38 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')]} 14:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:38 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')]} 14:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:38 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:38 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 14:15:38 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 14:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:38 INFO - 'HOME': '/Users/cltbld', 14:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:38 INFO - 'LOGNAME': 'cltbld', 14:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:38 INFO - 'MOZ_NO_REMOTE': '1', 14:15:38 INFO - 'NO_EM_RESTART': '1', 14:15:38 INFO - 'PAGER': '/bin/cat', 14:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:38 INFO - 'PWD': '/builds/slave/test', 14:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:38 INFO - 'SHELL': '/bin/bash', 14:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:38 INFO - 'USER': 'cltbld', 14:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:38 INFO - 'XPC_FLAGS': '0x0', 14:15:38 INFO - 'XPC_SERVICE_NAME': '0', 14:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:39 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 14:15:39 INFO - Cleaning up... 14:15:39 INFO - Return code: 0 14:15:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:39 INFO - 'HOME': '/Users/cltbld', 14:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:39 INFO - 'LOGNAME': 'cltbld', 14:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:39 INFO - 'MOZ_NO_REMOTE': '1', 14:15:39 INFO - 'NO_EM_RESTART': '1', 14:15:39 INFO - 'PAGER': '/bin/cat', 14:15:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:39 INFO - 'PWD': '/builds/slave/test', 14:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:39 INFO - 'SHELL': '/bin/bash', 14:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:39 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:39 INFO - 'USER': 'cltbld', 14:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:39 INFO - 'XPC_FLAGS': '0x0', 14:15:39 INFO - 'XPC_SERVICE_NAME': '0', 14:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:39 INFO - Downloading/unpacking psutil>=3.1.1 14:15:39 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 14:15:39 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 14:15:39 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 14:15:39 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 14:15:39 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 14:15:39 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 14:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:42 INFO - Installing collected packages: psutil 14:15:42 INFO - Running setup.py install for psutil 14:15:43 INFO - building 'psutil._psutil_osx' extension 14:15:43 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 14:15:43 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 14:15:43 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 14:15:43 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 14:15:43 INFO - building 'psutil._psutil_posix' extension 14:15:43 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 14:15:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:15:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:15:43 INFO - ^ 14:15:43 INFO - 1 warning generated. 14:15:43 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 14:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:44 INFO - Successfully installed psutil 14:15:44 INFO - Cleaning up... 14:15:44 INFO - Return code: 0 14:15:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15:44 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')]} 14:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 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')]} 14:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:44 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 14:15:44 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 14:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:44 INFO - 'HOME': '/Users/cltbld', 14:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:44 INFO - 'LOGNAME': 'cltbld', 14:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:44 INFO - 'MOZ_NO_REMOTE': '1', 14:15:44 INFO - 'NO_EM_RESTART': '1', 14:15:44 INFO - 'PAGER': '/bin/cat', 14:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:44 INFO - 'PWD': '/builds/slave/test', 14:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:44 INFO - 'SHELL': '/bin/bash', 14:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:44 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:44 INFO - 'USER': 'cltbld', 14:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:44 INFO - 'XPC_FLAGS': '0x0', 14:15:44 INFO - 'XPC_SERVICE_NAME': '0', 14:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:44 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 14:15:44 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 14:15:44 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 14:15:44 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 14:15:44 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 14:15:44 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 14:15:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:47 INFO - Installing collected packages: mozsystemmonitor 14:15:47 INFO - Running setup.py install for mozsystemmonitor 14:15:47 INFO - Successfully installed mozsystemmonitor 14:15:47 INFO - Cleaning up... 14:15:47 INFO - Return code: 0 14:15:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:47 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:47 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 14:15:47 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 14:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:47 INFO - 'HOME': '/Users/cltbld', 14:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:47 INFO - 'LOGNAME': 'cltbld', 14:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:47 INFO - 'MOZ_NO_REMOTE': '1', 14:15:47 INFO - 'NO_EM_RESTART': '1', 14:15:47 INFO - 'PAGER': '/bin/cat', 14:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:47 INFO - 'PWD': '/builds/slave/test', 14:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:47 INFO - 'SHELL': '/bin/bash', 14:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:47 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:47 INFO - 'USER': 'cltbld', 14:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:47 INFO - 'XPC_FLAGS': '0x0', 14:15:47 INFO - 'XPC_SERVICE_NAME': '0', 14:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:47 INFO - Downloading/unpacking jsonschema==2.5.1 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:50 INFO - warning: no files found matching '*.txt' 14:15:50 INFO - no previously-included directories found matching 'build' 14:15:50 INFO - no previously-included directories found matching 'dist' 14:15:50 INFO - no previously-included directories found matching '.git*' 14:15:50 INFO - Installing collected packages: jsonschema, functools32 14:15:50 INFO - Running setup.py install for functools32 14:15:50 INFO - warning: no files found matching '*.txt' 14:15:50 INFO - no previously-included directories found matching 'build' 14:15:50 INFO - no previously-included directories found matching 'dist' 14:15:50 INFO - no previously-included directories found matching '.git*' 14:15:50 INFO - Successfully installed jsonschema functools32 14:15:50 INFO - Cleaning up... 14:15:51 INFO - Return code: 0 14:15:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:15:51 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')]} 14:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 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')]} 14:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:51 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 14:15:51 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 14:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:51 INFO - 'HOME': '/Users/cltbld', 14:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:51 INFO - 'LOGNAME': 'cltbld', 14:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:51 INFO - 'MOZ_NO_REMOTE': '1', 14:15:51 INFO - 'NO_EM_RESTART': '1', 14:15:51 INFO - 'PAGER': '/bin/cat', 14:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:51 INFO - 'PWD': '/builds/slave/test', 14:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:51 INFO - 'SHELL': '/bin/bash', 14:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:51 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:51 INFO - 'USER': 'cltbld', 14:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:51 INFO - 'XPC_FLAGS': '0x0', 14:15:51 INFO - 'XPC_SERVICE_NAME': '0', 14:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:15:51 INFO - Cleaning up... 14:15:51 INFO - Return code: 0 14:15:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:51 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')]} 14:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 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')]} 14:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:51 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 14:15:51 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 14:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:51 INFO - 'HOME': '/Users/cltbld', 14:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:51 INFO - 'LOGNAME': 'cltbld', 14:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:51 INFO - 'MOZ_NO_REMOTE': '1', 14:15:51 INFO - 'NO_EM_RESTART': '1', 14:15:51 INFO - 'PAGER': '/bin/cat', 14:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:51 INFO - 'PWD': '/builds/slave/test', 14:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:51 INFO - 'SHELL': '/bin/bash', 14:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:51 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:51 INFO - 'USER': 'cltbld', 14:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:51 INFO - 'XPC_FLAGS': '0x0', 14:15:51 INFO - 'XPC_SERVICE_NAME': '0', 14:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:55 INFO - Downloading docopt-0.6.1.tar.gz 14:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:55 INFO - Running setup.py install for blobuploader 14:15:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:55 INFO - Running setup.py install for requests 14:15:56 INFO - Running setup.py install for docopt 14:15:56 INFO - Successfully installed blobuploader requests docopt 14:15:56 INFO - Cleaning up... 14:15:56 INFO - Return code: 0 14:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:56 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')]} 14:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:56 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')]} 14:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:56 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:15:56 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 14:15:56 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 14:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:56 INFO - 'HOME': '/Users/cltbld', 14:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:56 INFO - 'LOGNAME': 'cltbld', 14:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:56 INFO - 'MOZ_NO_REMOTE': '1', 14:15:56 INFO - 'NO_EM_RESTART': '1', 14:15:56 INFO - 'PAGER': '/bin/cat', 14:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:56 INFO - 'PWD': '/builds/slave/test', 14:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:56 INFO - 'SHELL': '/bin/bash', 14:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:15:56 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:56 INFO - 'USER': 'cltbld', 14:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:56 INFO - 'XPC_FLAGS': '0x0', 14:15:56 INFO - 'XPC_SERVICE_NAME': '0', 14:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:56 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fLuAyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:56 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9LZblr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:56 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-AQZz1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:56 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-m08q3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:56 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-K_hdcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-clFxYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fYSsmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-idRhqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fRP9D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MCtY_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-atB9hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-KhAtPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ajyTaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-esDZQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:57 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ZAtqVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:58 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-KpmsZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:58 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-V_iGZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:58 INFO - Running setup.py install for manifestparser 14:15:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:58 INFO - Running setup.py install for mozcrash 14:15:58 INFO - Running setup.py install for mozdebug 14:15:58 INFO - Running setup.py install for mozdevice 14:15:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:58 INFO - Running setup.py install for mozfile 14:15:58 INFO - Running setup.py install for mozhttpd 14:15:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Running setup.py install for mozinfo 14:15:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Running setup.py install for mozInstall 14:15:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Running setup.py install for mozleak 14:15:59 INFO - Running setup.py install for mozlog 14:15:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Running setup.py install for moznetwork 14:15:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:59 INFO - Running setup.py install for mozprocess 14:16:00 INFO - Running setup.py install for mozprofile 14:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Running setup.py install for mozrunner 14:16:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Running setup.py install for mozscreenshot 14:16:00 INFO - Running setup.py install for moztest 14:16:00 INFO - Running setup.py install for mozversion 14:16:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:00 INFO - Cleaning up... 14:16:00 INFO - Return code: 0 14:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:00 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:16:00 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 14:16:00 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 14:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:00 INFO - 'HOME': '/Users/cltbld', 14:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:00 INFO - 'LOGNAME': 'cltbld', 14:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:00 INFO - 'MOZ_NO_REMOTE': '1', 14:16:00 INFO - 'NO_EM_RESTART': '1', 14:16:00 INFO - 'PAGER': '/bin/cat', 14:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:00 INFO - 'PWD': '/builds/slave/test', 14:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:00 INFO - 'SHELL': '/bin/bash', 14:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:16:00 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:00 INFO - 'USER': 'cltbld', 14:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:00 INFO - 'XPC_FLAGS': '0x0', 14:16:00 INFO - 'XPC_SERVICE_NAME': '0', 14:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lvTLZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vLEHxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-K4EFBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-J0bS8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HcvEjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-EK1IkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-X7TA8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-wfZAJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:01 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)) 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2ZjDg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-B51y6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-h4K4lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-P5huMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-s8x3sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-q21xSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-afRYXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-X_6NVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:02 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)) 14:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-G95F4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:02 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)) 14:16:02 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)) 14:16:02 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)) 14:16:02 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)) 14:16:02 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)) 14:16:02 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)) 14:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:05 INFO - Downloading blessings-1.6.tar.gz 14:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:05 INFO - Installing collected packages: blessings 14:16:05 INFO - Running setup.py install for blessings 14:16:05 INFO - Successfully installed blessings 14:16:05 INFO - Cleaning up... 14:16:05 INFO - Return code: 0 14:16:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:05 INFO - Reading from file tmpfile_stdout 14:16:05 INFO - Current package versions: 14:16:05 INFO - blessings == 1.6 14:16:05 INFO - blobuploader == 1.2.4 14:16:05 INFO - docopt == 0.6.1 14:16:05 INFO - functools32 == 3.2.3-2 14:16:05 INFO - jsonschema == 2.5.1 14:16:05 INFO - manifestparser == 1.1 14:16:05 INFO - mozInstall == 1.12 14:16:05 INFO - mozcrash == 0.17 14:16:05 INFO - mozdebug == 0.1 14:16:05 INFO - mozdevice == 0.48 14:16:05 INFO - mozfile == 1.2 14:16:05 INFO - mozhttpd == 0.7 14:16:05 INFO - mozinfo == 0.9 14:16:05 INFO - mozleak == 0.1 14:16:05 INFO - mozlog == 3.4 14:16:05 INFO - moznetwork == 0.27 14:16:05 INFO - mozprocess == 0.23 14:16:05 INFO - mozprofile == 0.28 14:16:05 INFO - mozrunner == 6.12 14:16:05 INFO - mozscreenshot == 0.1 14:16:05 INFO - mozsystemmonitor == 0.3 14:16:05 INFO - moztest == 0.7 14:16:05 INFO - mozversion == 1.4 14:16:05 INFO - psutil == 3.1.1 14:16:05 INFO - requests == 1.2.3 14:16:05 INFO - wsgiref == 0.1.2 14:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:05 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 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:16:05 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 14:16:05 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 14:16:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:16:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:05 INFO - 'HOME': '/Users/cltbld', 14:16:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:05 INFO - 'LOGNAME': 'cltbld', 14:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:05 INFO - 'MOZ_NO_REMOTE': '1', 14:16:05 INFO - 'NO_EM_RESTART': '1', 14:16:05 INFO - 'PAGER': '/bin/cat', 14:16:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:05 INFO - 'PWD': '/builds/slave/test', 14:16:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:05 INFO - 'SHELL': '/bin/bash', 14:16:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:16:05 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:16:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:05 INFO - 'USER': 'cltbld', 14:16:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:05 INFO - 'XPC_FLAGS': '0x0', 14:16:05 INFO - 'XPC_SERVICE_NAME': '0', 14:16:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 INFO - Cleaning up... 14:16:06 INFO - Return code: 0 14:16:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10667b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcadbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, '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.czh93bfaHt/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.X1ukMgAr0z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 14:16: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', 'jsonschema'] in /builds/slave/test/build 14:16: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 jsonschema 14:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:06 INFO - 'HOME': '/Users/cltbld', 14:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:06 INFO - 'LOGNAME': 'cltbld', 14:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:06 INFO - 'MOZ_NO_REMOTE': '1', 14:16:06 INFO - 'NO_EM_RESTART': '1', 14:16:06 INFO - 'PAGER': '/bin/cat', 14:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:06 INFO - 'PWD': '/builds/slave/test', 14:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:06 INFO - 'SHELL': '/bin/bash', 14:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:16:06 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:06 INFO - 'USER': 'cltbld', 14:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:06 INFO - 'XPC_FLAGS': '0x0', 14:16:06 INFO - 'XPC_SERVICE_NAME': '0', 14:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:16:07 INFO - Cleaning up... 14:16:07 INFO - Return code: 0 14:16:07 INFO - Running post-action listener: _resource_record_post_action 14:16:07 INFO - Running post-action listener: _start_resource_monitoring 14:16:07 INFO - Starting resource monitoring. 14:16:07 INFO - [mozharness: 2016-10-13 21:16:07.230848Z] Finished create-virtualenv step (success) 14:16:07 INFO - [mozharness: 2016-10-13 21:16:07.231811Z] Running install step. 14:16:07 INFO - Running pre-action listener: _resource_record_pre_action 14:16:07 INFO - Running main action method: install 14:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:07 INFO - Reading from file tmpfile_stdout 14:16:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:07 INFO - Reading from file tmpfile_stdout 14:16:07 INFO - Output received: 14:16:07 INFO - Usage: mozinstall [options] installer 14:16:07 INFO - Options: 14:16:07 INFO - -h, --help show this help message and exit 14:16:07 INFO - -d DEST, --destination=DEST 14:16:07 INFO - Directory to install application into. [default: 14:16:07 INFO - "/builds/slave/test"] 14:16:07 INFO - --app=APP Application being installed. [default: firefox] 14:16:07 INFO - mkdir: /builds/slave/test/build/application 14:16:07 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'] 14:16:07 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 14:16:41 INFO - Reading from file tmpfile_stdout 14:16:41 INFO - Output received: 14:16:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:16:41 INFO - Running post-action listener: _resource_record_post_action 14:16:41 INFO - [mozharness: 2016-10-13 21:16:41.450577Z] Finished install step (success) 14:16:41 INFO - [mozharness: 2016-10-13 21:16:41.450731Z] Running run-tests step. 14:16:41 INFO - Running pre-action listener: _resource_record_pre_action 14:16:41 INFO - Running main action method: run_tests 14:16:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:41 INFO - 2016-10-13 14:16:41.465 screenresolution[1637:7369] starting screenresolution argv=screenresolution get 14:16:41 INFO - 2016-10-13 14:16:41.468 screenresolution[1637:7369] Display 0: 1600x1200x32@60 14:16:41 INFO - 2016-10-13 14:16:41.473 screenresolution[1638:7371] starting screenresolution argv=screenresolution list 14:16:41 INFO - Available Modes on Display 0 14:16:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:41 INFO - Intel Iris: 14:16:41 INFO - Chipset Model: Intel Iris 14:16:41 INFO - Type: GPU 14:16:41 INFO - Bus: Built-In 14:16:41 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:41 INFO - Vendor: Intel (0x8086) 14:16:41 INFO - Device ID: 0x0a2e 14:16:41 INFO - Revision ID: 0x0009 14:16:41 INFO - Displays: 14:16:41 INFO - Display: 14:16:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:41 INFO - Display Serial Number: 1600x1200 60 14:16:41 INFO - Main Display: Yes 14:16:41 INFO - Mirror: Off 14:16:41 INFO - Online: Yes 14:16:41 INFO - Rotation: Supported 14:16:41 INFO - Return code: 0 14:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:41 INFO - Python 2.7.3 14:16:41 INFO - Return code: 0 14:16:41 INFO - grabbing minidump binary from tooltool 14:16:41 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')]} 14:16:41 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 0x10648fd30>, '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 0x1062b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106487b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:41 INFO - Return code: 0 14:16:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:16:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:16:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:41 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/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 14:16:41 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/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 14:16:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.czh93bfaHt/Render', 14:16:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:41 INFO - 'HOME': '/Users/cltbld', 14:16:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:41 INFO - 'LOGNAME': 'cltbld', 14:16:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:41 INFO - 'MOZ_NO_REMOTE': '1', 14:16:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:41 INFO - 'NO_EM_RESTART': '1', 14:16:41 INFO - 'PAGER': '/bin/cat', 14:16:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:41 INFO - 'PWD': '/builds/slave/test', 14:16:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:41 INFO - 'SHELL': '/bin/bash', 14:16:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1ukMgAr0z/Listeners', 14:16:41 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 14:16:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:41 INFO - 'USER': 'cltbld', 14:16:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:41 INFO - 'XPC_FLAGS': '0x0', 14:16:41 INFO - 'XPC_SERVICE_NAME': '0', 14:16:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:41 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/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 14:16:42 INFO - mozversion application_buildid: 20161013101223 14:16:42 INFO - mozversion application_changeset: dcfc73c043c01c3185631262605e3511bebe4cca 14:16:42 INFO - mozversion application_display_name: Nightly 14:16:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:42 INFO - mozversion application_name: Firefox 14:16:42 INFO - mozversion application_remotingname: firefox 14:16:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:16:42 INFO - mozversion application_vendor: Mozilla 14:16:42 INFO - mozversion application_version: 52.0a1 14:16:42 INFO - mozversion platform_buildid: 20161013101223 14:16:42 INFO - mozversion platform_changeset: dcfc73c043c01c3185631262605e3511bebe4cca 14:16:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:16:42 INFO - mozversion platform_version: 52.0a1 14:16:42 INFO - using testdate: 1476393402 14:16:42 INFO - actual date: 1476393402 14:16:42 INFO - starting webserver on 'localhost:49266' 14:16:42 INFO - SUITE-START | Running 2 tests 14:16:42 INFO - TEST-START | dromaeo_css 14:16:42 INFO - operating with platform_type : mac_ 14:16:42 INFO - Initialising browser for dromaeo_css test... 14:16:42 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpr6qW09/profile http://localhost:49266/getInfo.html) 14:16:44 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:16:44 INFO - PROCESS | 1648 | colorDepth:24 14:16:44 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:16:44 INFO - PROCESS | 1648 | __metrics 14:16:44 INFO - PROCESS | 1648 | 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" 14:16:44 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:45 INFO - TEST-INFO | 1648: exit 0 14:16:45 INFO - Browser initialized. 14:16:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:45 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpr6qW09/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:57 INFO - PROCESS | 1650 | RSS: Main: 234622976 14:16:57 INFO - PROCESS | 1650 | 14:17:48 INFO - PROCESS | 1650 | 1476393468920 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] 14:20:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 14:20:04 INFO - PROCESS | 1650 | RSS: Main: 369680384 14:20:04 INFO - PROCESS | 1650 | 14:23:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 14:23:07 INFO - PROCESS | 1650 | RSS: Main: 369037312 14:23:07 INFO - PROCESS | 1650 | 14:26:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 14:26:10 INFO - PROCESS | 1650 | RSS: Main: 343228416 14:26:10 INFO - PROCESS | 1650 | 14:29:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 14:29:13 INFO - PROCESS | 1650 | RSS: Main: 348340224 14:29:13 INFO - PROCESS | 1650 | 14:32:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 14:32:17 INFO - PROCESS | 1650 | RSS: Main: 338821120 14:32:17 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 14:35:21 INFO - PROCESS | 1650 | RSS: Main: 391249920 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | __start_tp_report 14:35:21 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:35:21 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:35:21 INFO - PROCESS | 1650 | |i|pagename|runs| 14:35:21 INFO - PROCESS | 1650 | |0;dojo.html;3287.4247006773808;3290.55577497038;3311.5032745088233;3327.8502467388967;3358.4290670585997;5488.862778430531;5520.282363292771;5571.275734154565;5608.747606357713;5656.434356564341;5556.027695153352;5588.050031494646;5623.0721930881455;5624.100143976964;5664.943350566504;5062.341895553573;5118.385793704742;5123.385193776733;5136.614753893473;5160.535551800337;5174.611904107207;5268.473152684739;5273.393559740641;5279.128943724281;5317.760700768475;5044.47033061527;5218.66078704883;5235.973820130913;5238.1618940969265;5317.574594032468;5060.5951523878;5148.330717006803;5149.304843846107;5158.509941555546;5169.224616307546;5033.572146367563;5089.51649593288;5104.387473503203;5106.770195341219;5123.871903202413;5579.38626751057;5582.190582365575;5583.888322233533;5606.551475881961;5607.915881261784;6005.369436209223;6007.219061522018;6010.939890601082;6017.157597936292;6018.6689732064715;6097.101247991087;6113.205283313186;6121.849011664688;6131.193168498072;6135.330836454432;5591.832245032615;5658.603897727119;5661.264035675335;5663.207150998864;5666.660000399989;6218.409251121137;6279.905801412982;6296.527760417987;6322.178116844781;6334.873302534015;5642.181883626933;5993.310769261503;6006.219191505076;6014.609050411709;6020.849478762978;5646.632968857011;6005.219321488178;6091.238595175603;6097.3292937776805;6123.162701465792;6030.638161710312;6034.0043892758085;6041;6051.394860513913;6063.757449701962;6048.848778780566;6054.576179667381;6057.151998720183;6061.7575296987625;6062.939370606237;4171.20747058058;4714.669973101919;4791.760411979387;4850.6362022848425;4870.659053866196;4214.915701686011;4221.767802770877;4249.5113061997645;4332.0469496710675;4361.302191649384;5567.3040869891265;5661.34894487131;5666.943330566724;5671.404502527175;5676.68778217202;6039.909401358983;6109.816705498843;6114.785982490592;6190.81427557174;6238.376162383725;5492.038893193675;5585.916211256835;5621.971890140605;5642.294713160855;5678.233438485834;5305.8938821223355;5309.867253318698;5321.494458026481;5328.387235467893;5333.86665333362;6190.071489276645;6255.530835187288;6301.936980630135;6325.588836725782;6366.745330186741;6100.520618786844;6126.120738204555;6139.754409823557;6183.381661833961;6270.278917924497;6277.340879207617;6286.717097730521;6301.716422761078;6304.211973503312;6314.179156709598;5936.762529498772;5970.462658360769;6102.633841969496;6131.141640170291;6158.107074474266;6044.758209671564;6128.877422451436;6135.570510064253;6138.725610151984;6195.783147589813;5450.700211488248;5809.709514524172;6056.9091463628965;6082.391760823883;6089.421504957022;5914.467697907209;5987.700614969147;6044.911915855188;6052.6973651316375;6052.788152414644;5713.771449141987;5778.508826749605;5781.913271300849;5793.8551536211935;5861.325947515919;5954.255718035246;5967.701614919323;5977.641341519523;6071.848203794941;6095.451409373178;5857.648541087548;5858.209141765978;5902.4097590240635;5912.320083190488;5951.077582974646 14:35:21 INFO - PROCESS | 1650 | |1;ext.html;518.3986575572336;528.6299590286798;549.4478049560191;570.8829689913568;572.9398413166617;37681.81159094204;39190.60809391905;39333.01667458315;41089.178216435655;41218.76343709686;40020.79989600055;40340.39489407654;40428;40431;40464.19071618566;9455.054494550559;9621.08599683029;9645.662401815938;9658.227341812673;9661.806763864754;9526.571304291323;9618.27862910281;9623.95188024059;9630.903690963105;9642.2768292378;9619.903800962005;9664.80670386592;9672.371295865782;9679.370840895355;9683.176929960962;9598.328117031811;9634.421934683942;9648.421094734338;9649.131578157929;9654.758631034245;9444.952775236148;9520.381175223589;9536.475493847836;9541.093596108358;9542.236621070368;38647.806760966014;39006.60993390058;39022.80488597539;39063.60936390628;39124.02189945274;3195.5526226328334;3301.6533264007176;3700.6484383983748;3925.2738243425056;4075.510938687347;28933.71066289352;30036.098917032523;30330.393392132035;30431.934882279234;30502;3104.363605460875;3234.498652708834;3265.2000259936467;3272.2310257089566;3305.140663427502;466728;467453;468394;469523;474732.62633686955;49045;50957.49042509602;54588.72705636446;54637.1804422934;54690.72654636701;56321;56806.17147542423;57082;57149.71425142931;57174;14358.784618230735;14564.635884102981;14583.708325833637;14598.708025839423;14775.26123693811;11217.719557010976;11296.491657875415;11297.152713546517;11302.039326657326;11326.660200194008;14048.578542643738;14426.567202983928;14441.133531987904;14569.781453278209;14632;5806.635440671439;5817.592768506249;6953.965230173817;7013.964930175419;7050.717971281091;851.7955690634327;882.0165515450227;938.7746940734174;977.8337682593976;1027.773889744255;24892.904354394635;26832.32919176997;27326.72673273242;27965.580516292273;29477.968271110407;839.7019058234239;959.5010594490826;1012.7215015870547;1050.7058023753361;1059.327327147267;13430.597082087357;14184.290785460686;15078.246087695572;16524.586885327964;16739.91630041842;516366;658190;661587;664987;666793;59003;60280.79438411207;60317.396826032054;60345.698271508365;60352.39647603556;1224.9510019599295;1260.9180403273758;1332.8800407963329;1341.3159288762802;1378.4486205517874;24891.25326240216;30083.79664813383;30235.848820755757;30869.382612347177;30936.381272374878;48371.758141209066;49043.75478122586;49086.01827963349;49129.75435122944;49174.75412622914;436431;438311;438705;441143;441169;36655.45016824803;37038;37277.81361093177;37347.62652373441;38493;45828.77085614551;46106;46448;46607.53392466032;46828.29757553571;37842;37986.933462631874;38035.61964380431;39519;39729;35724.821375892956;37768.62231377651;38267.61732382752;38619.420708689955;40540.905341565696;36595.26809463849;37098.44352334771;37893.81053094717;37936.62063379331;38145.61854381532;32850.50724239091;33609.49585756167;34251.314973700886;34522.48216276808;34527.30945381028;24891.626625600267;25026.873790679827;25119.623205651566;25219.747802522474;25270.74729252684 14:35:21 INFO - PROCESS | 1650 | |2;jquery.html;338.44832922336604;348.9302139572086;372.8844058341914;377.47153984421806;378.8692900949172;14683;14943.5516934492;15697.058176509403;20105.59788804223;20702.275420360253;19132.713009304873;19845.900770496162;20042.899785501053;20238.898805505953;20274.39176824694;5049.621278404116;5580.581456390767;5931.228940237763;5942.376050514698;5946.167536544887;4799.376081109468;5408.134698448249;5823.097419899922;5891;5907.379725128864;5794.362620111805;5844.152597873306;5844.736986835603;5850.590458667895;5852.853678658046;7459.515131516461;7692.576908270043;7766.301032907038;7850.489718168358;7860.056793184797;7366.558006519626;7385.66764495599;7498.3626391756225;7566.092068951761;7575.659095340723;28187.57718634222;28651;28684;28993.85503072471;29201;2322.11759531377;2369.620860662303;2379.0483806477373;2387.9522409551887;2439.926802195937;13825.79261311081;15476.993995390376;16276.348946042144;16591.419300324553;16703.582410439714;1917.424772568224;1935.6225536020481;1988.99005504973;2017.2566503786675;2055.845811564139;104464.59818616285;109104.4544777279;109490.3576446354;109688.4515577417;110765;16357.345706171858;16908.40820571274;20604.484887877625;20846.166153354;20903.79096209049;34207.65792342094;34361.82819085888;34364.969050928514;34422.65577344244;34424.48363274553;8977.32670049749;9412.870455545379;9461.38500997433;10089.949550252202;10270.33242839213;7566.583837888969;8187.631556579849;8260.793480162924;8326.6669333226;8492.490450572985;9223.677171299107;9351.579178936829;9493.620255189715;9498.762530936781;9541;3105.0657129013316;3545.592256890439;3676.981615091961;3684.7236457265813;3687.8893633191046;703.2088899987514;709.5879200391288;775.4106878772061;822.8313195794848;834.7245409015011;18995.24019039223;20383.8980805098;20485;20725.860077695568;20807.271745488837;891.3404080980029;936.5364144748393;963.9903600963901;975.4634950777186;977.1596427072711;8771.868421973675;9420.811583768285;10448.791024179474;10821.513031913582;10859.945700271448;521248;525749;564969;609406;617242.9137854282;121548;122011.38994305149;129291;130318;131012.3449382747;973.8295798235281;991.5092029445326;1035.2494441529982;1037.061459379263;1038.7091614347994;14377.856221437652;16769.74845377345;18098.728519072487;19435;19494.296083744044;40246;56418.7179064102;57113;57301.426985731276;58893;80551;81547.59226204068;82276.17723822685;84162.73755893543;84527.5773621128;7677.923220767944;7820.335271501986;8139.511629302261;8158.3473322132895;8367.790805229917;9058.818823623358;12179.573714919936;12380.876191238332;12657.493700252255;12876.871231287567;10843;10973.670789876316;11509;11511.76976460483;11630.069594432594;11056.834147487954;11129.777404452028;11164.44177791091;11363.147763917905;11640.650780476599;10962.397068161328;11064.944675276573;11093.50079246452;11243.156763242627;11837.171398002058;6486.416222539994;7969.72105976288;8084.312833409226;8130.471519351223;8193.672253110048;10684;10930.070943969851;11123.610673626385;11233.32600044;11248.381339026431 14:35:21 INFO - PROCESS | 1650 | |3;mootools.html;1492.4925525321391;1517.0897461523089;1682.8653707703386;1847.113385574925;1849.6763066463366;8298.25315721585;8797.472151670889;8798.032216456184;8801.16388943051;8805.779855503615;7624.504407213527;7868.685252589889;7870.2916737493615;8372.204640559152;8604.612792424341;2336.4626135988733;2338.8362814602983;2342.3324352559525;2344.1443872986406;2370.9288721338344;2269.841111122222;2291.644795056769;2293.1515339324474;2330.1844354475966;2345.8944347504403;1997.6504111780453;2315.143396943133;2327.976720232793;2337.076854642415;2340.555294494049;1977.7132315814126;2167.295628920607;2253.5154941687533;2260.2315212827716;2266.1048885690225;2290.7823756743082;2326.162581470669;2333.778291062363;2335.065973610552;2336.0655737705056;8675.219230269244;8723.214910658071;8772.912270877274;8794.42836215644;8795.560221988875;5018.372703412074;5183.5853131749745;5197;5201.531862132389;5206.739663016834;3061.800982936102;3353.429916914106;3397.405454045532;3550.8934731958084;3609.187932715144;1070.71626019105;1072.8229842076048;1076.7684947736195;1092.759592889563;1099.0108901988194;11232.438378081064;11358.148138889615;11384.146189035773;11414.42927853604;11426.086347981212;3972.900677483086;4507.5943165115295;4546.204414227497;4719.121335985046;4739.289106634033;9850.950745246371;9851.852222216672;9852.014798520091;9856.408615483095;9881;5204.609654275944;5211.062008838446;5216.008958297912;5218.582513398919;5222.973885130626;4223.915521689549;4243.702940794176;4400.977995110068;4789.928151077736;4821.011692603008;3779.3952967525065;3826.215625796761;3913.92172156561;3950.466686997276;3956.1098752780968;1072.8498010278568;1254.8807863252975;1265.7531781302557;1283.685497053228;1286.9163504372186;743.624469642827;744.8994385757961;762.3405754022731;868.6134670071883;898.6719847255705;5512.586556008316;5610.382857885629;5661.3206415229615;5714.857128571736;5727.656340619576;419.17004331423954;426.67785821704416;433.97830108494446;435.8975640724427;444.6642784697597;3786.9431958520645;3833.118382771978;3853.9807300963316;3896.688264938855;3902.824372903169;10129.088382045651;10657.200709946785;10668.093212077061;10678.09236214915;10686;10600.363978161335;10615.150787936947;10622.203334749925;10629.84055239172;10633.680989570325;7217.8556428871125;7385.852282954311;8052.758417247492;8066.15305392937;8076.8384632307025;5569.860753481195;5594.4964953152785;5606.495415412633;5655.4344565543115;5732.767454997195;9597.28020398459;9727.805443891224;9742.659006934724;9875.456849873039;9898.604055837686;9851.064148905842;9976.700698979042;10021.448820314661;10097.545610447694;10134.442605656464;6718.395344419026;6881.931180688129;6947.756828510978;7305.552639865705;7399.704011839682;7686.692532298645;8136.796580085545;8206.548639824867;8308.958455207685;8332.291755200633;7176.282371762782;7307.525010874276;7317.2316906726155;7400.6669699864715;7472.252774722484;6931.965340173469;6995.825104372431;7134.851888563857;7193.496455248082;7310.086239220098;6601.3728695773825;6668.6665666717445;6740;6742.8651426972165;6760.763373282109;4764.952350476451;4770.666053376231;4817.9036419272115;4863.562279394871;4965.155923492943;4066.410370496202;4762.309465127606;4899.828506002273;4940.333055037668;5045.9243111352625 14:35:21 INFO - PROCESS | 1650 | |4;prototype.html;259.56781958039863;290.11514879617175;294.70971093472923;303.0741085982324;303.3599105886578;4403.823847046122;4831.782569784359;4858.5627293543575;5215.478452154783;5287.339082614673;4265.402843601898;4820.276958456225;4844.152273352167;5124.6925184488955;5209.879875826697;3969.364901615742;4007.0383108054148;4010.1578668479583;4035.959640403588;4036.374361973899;3972.443857859902;3985.8640287518065;4012.277789997799;4017.4978127734034;4045.422285308732;3735.794531300777;3777.395616701315;3956.2680904032704;3963.8414463421573;4006.939895901564;3303.702666760003;3569.0542006368205;4027.51669799623;4037.9905023744063;4049.514058312992;3287.1946373138735;3455.7926524408363;3458.723302135823;3462;3469.462233353834;4393.644537504619;5126.820561280338;5141.640085194038;5165.302684137669;5179.948200517984;4308.978455107705;4471.8434854779925;4489.326601009842;4535.394361482597;4621.74580398078;4553.886152846172;4936.987917476945;5545.72271386429;5582.720863956826;5602.935442265956;3205.294835136266;3359.6472370401243;3854.6916246700475;3863.864764733221;3868.5357757069332;5119.6432945269535;5330.173823057394;5465.152901300345;5696.686682232434;5839.357670656224;3865.536135663738;3897.629725176104;3898.4990778549895;3902.8829135125993;3913.6673382762783;3477.4783782432837;3695.870644527429;3705.555333360014;3870.148567315186;3984.382420724792;3698.6671199592165;4282.272013757669;4556.681032327771;4629.398178236807;4643.560496246175;4796.496367881322;5208.765605547759;5526.861828454321;5566.582506312043;5582.190582365615;1141.9543218271342;1148.8047032004579;1339.9732005359838;1362.4686372314804;1363.5363976248123;864.464032299978;887.3123329419623;893.1381217125505;908.5411867007119;936.578539657157;4246.8725938221905;4480.706680589764;4501.369808226851;4560.065186636798;5097;5009.5741861941415;5601.851620417805;5687.374388817227;5689.402612725687;5707.68607726579;4952.975235123873;5005.924911126336;5064.848054558295;5072.087024335581;5139.019368766107;2502.2618327593405;2598.8175380201965;2694.986525067362;2845.701201373867;2950.9557356639666;4646.814127434933;4747.578734845254;5128.461511541309;5231.921521177185;5743.511801496836;4677.391939047902;5400.000999814968;5417.702026388508;5453.836384908459;5747.224124743189;5719.8570035749435;5733.827985160452;5737;5745.9425405745405;5746.310442746897;4301.462317210348;4889.266610008385;5534.86162845916;5566.860828479321;5591.496765290981;5318;5555.111422004532;5692.5445964321925;5697.54419646419;5701.458361455655;5860.827834433216;5976;5976.970115149396;6019.668918209365;6022.175918291829;3027.5307327364294;3322.983385083059;3558.4128618777613;3766.4350347447007;3788.564315103688;4751.714897106184;5078.873028174326;5491.929073830564;5692.373838877803;5723.513501352431;4615.353850461005;5593.776248949996;5598.412166722435;5606.523445507178;5611;4234.87295381139;4321.870343889688;4809.567138957511;5284.398537550209;5622.606417550732;5107.897842043064;5110.7580708013;5215.739213039409;5337.092694242066;5469.371022332482;4511.751853648081;5396.541293989898;5407.567394608343;5415.675059496442;5416.458354164552;4288.8284468620905;4973.776180071833;5366.973165134149;5473.808416705396;5492.093804522369 14:35:21 INFO - PROCESS | 1650 | |5;yui.html;651.5764752910608;701.8910122007228;718.7520305494605;764.8011517005577;775.9107702614198;13665.863341366583;14197.29013549321;14230.928845355784;14239.715205695893;14311;12619.621411357673;12627.873721262784;12652.177608455444;12683.746325073516;12690.873091269084;670.0451856105055;695.7564852301679;697.052009267396;806.2018601584418;829.0590180145518;711.8042538301956;791.2404092071619;814.8288859339546;816.302061737215;816.3510009542427;891.7592250092504;893.7631527645179;893.8525143351371;894.7539426657656;896.1083721696921;697.8429853283021;721.7870728135213;852.86780549015;879.169185120065;882.4308321132866;663.383053760003;664.3954001858285;665.8169003524022;666.8566258254499;670.6009924095156;13778.517751878637;13783.931080344533;13791.793123103162;13798.379072941741;13806;13072.607821765363;13098.738025239441;13115.081944263906;13356;13450.394732236975;10805.351678899213;11867.821982670266;12195.207311524722;12280.201786883825;12699.111062225647;4345.152695224432;4347.347897815322;4422.137683151755;4541.750203738793;4545.772711364419;111730;114006.42996784963;114593.42703286513;115277;115876.42061789721;8499.915000849913;9444.291678124167;9801.460919649488;10514.214046822748;10664.360138391721;17088.91455542714;20246.898765506077;20427.489312767004;20450.79549204489;20471.795282047286;6205.720742566596;7292.854142917112;7364.374028207555;7508.474406791582;7591;4159.584041595876;4181.435506206623;4193.622573968297;4194.0563373240775;4231.703780735319;3274.3942370661503;3365.8317084145697;3380.002899144758;3387.356402283558;3389.6101948275773;611.9265688117455;613.6594190224379;616.4390404731672;632.9461995730322;634.7143785296543;604.2959951656271;606.7057477123592;607.3076692570473;608.2275510102146;613.2487702564412;7548.282913123245;8358.916410835935;8533.615987280587;8700.477971321741;8997.775055623531;536.7691842990009;574.944975969093;583.5419195931258;603.3483837455537;615.5783288447428;4140.668746500272;4221.451211342506;4265.808038638207;4270.167317373082;4419.226635338803;99038;102464.48767756263;148023;154428;159126;76305.61847190729;78762.60618696985;106020.46989765156;126715;128231;92548.53725731463;112311;113779;114084;117598.23602645966;7131.429485641032;8194.34445244391;8252.83494330098;8286.502809831429;8435.915640843514;50931.745341273054;52540.73729631327;55936.160957586486;55960.72019640038;65414;54855;61765.691171543855;64213;94860.52569737108;96436.51781741047;10710.410927399067;10899.29154604948;10934.671959841218;10976.725581860517;11025.44872756375;11920.76158476843;12599.93700031494;12786.488540458278;14482.275886205436;15001.86627516335;13471;13556.59330220095;13864.584062478141;13891.374888129856;14227.715445691236;13595.728085438433;13620.455181792617;13961.720765584834;14237.857621423653;14276.857231427968;13265.118589345586;13431;13482.460701571827;13740.435287462205;14143.36354864013;11135.610253641084;11423.600173993871;11435.142364322543;11516.654500365003;11518.256566616052;11027.44862756875;11049.226554141133;11172.72068198269;11432.771344573228;11489.195756296978 14:35:21 INFO - PROCESS | 1650 | __end_tp_report 14:35:21 INFO - PROCESS | 1650 | __start_cc_report 14:35:21 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1756 14:35:21 INFO - PROCESS | 1650 | __end_cc_report 14:35:21 INFO - PROCESS | 1650 | __startTimestamp1476394521484__endTimestamp 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:35:21 INFO - PROCESS | 1650 | Number of tests: 6 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5642.98 Median:5809.71 stddev:635.71 (10.9%) stddev-sans-first:610.21 14:35:21 INFO - PROCESS | 1650 | Values: 3287.4 3290.6 3311.5 3327.9 3358.4 5488.9 5520.3 5571.3 5608.7 5656.4 5556.0 5588.1 5623.1 5624.1 5664.9 5062.3 5118.4 5123.4 5136.6 5160.5 5174.6 5268.5 5273.4 5279.1 5317.8 5044.5 5218.7 5236.0 5238.2 5317.6 5060.6 5148.3 5149.3 5158.5 5169.2 5033.6 5089.5 5104.4 5106.8 5123.9 5579.4 5582.2 5583.9 5606.6 5607.9 6005.4 6007.2 6010.9 6017.2 6018.7 6097.1 6113.2 6121.8 6131.2 6135.3 5591.8 5658.6 5661.3 5663.2 5666.7 6218.4 6279.9 6296.5 6322.2 6334.9 5642.2 5993.3 6006.2 6014.6 6020.8 5646.6 6005.2 6091.2 6097.3 6123.2 6030.6 6034.0 6041.0 6051.4 6063.8 6048.8 6054.6 6057.2 6061.8 6062.9 4171.2 4714.7 4791.8 4850.6 4870.7 4214.9 4221.8 4249.5 4332.0 4361.3 5567.3 5661.3 5666.9 5671.4 5676.7 6039.9 6109.8 6114.8 6190.8 6238.4 5492.0 5585.9 5622.0 5642.3 5678.2 5305.9 5309.9 5321.5 5328.4 5333.9 6190.1 6255.5 6301.9 6325.6 6366.7 6100.5 6126.1 6139.8 6183.4 6270.3 6277.3 6286.7 6301.7 6304.2 6314.2 5936.8 5970.5 6102.6 6131.1 6158.1 6044.8 6128.9 6135.6 6138.7 6195.8 5450.7 5809.7 6056.9 6082.4 6089.4 5914.5 5987.7 6044.9 6052.7 6052.8 5713.8 5778.5 5781.9 5793.9 5861.3 5954.3 5967.7 5977.6 6071.8 6095.5 5857.6 5858.2 5902.4 5912.3 5951.1 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:65122.08 Median:40180.60 stddev:139397.64 (346.9%) stddev-sans-first:139704.29 14:35:21 INFO - PROCESS | 1650 | Values: 518.4 528.6 549.4 570.9 572.9 37681.8 39190.6 39333.0 41089.2 41218.8 40020.8 40340.4 40428.0 40431.0 40464.2 9455.1 9621.1 9645.7 9658.2 9661.8 9526.6 9618.3 9624.0 9630.9 9642.3 9619.9 9664.8 9672.4 9679.4 9683.2 9598.3 9634.4 9648.4 9649.1 9654.8 9445.0 9520.4 9536.5 9541.1 9542.2 38647.8 39006.6 39022.8 39063.6 39124.0 3195.6 3301.7 3700.6 3925.3 4075.5 28933.7 30036.1 30330.4 30431.9 30502.0 3104.4 3234.5 3265.2 3272.2 3305.1 466728.0 467453.0 468394.0 469523.0 474732.6 49045.0 50957.5 54588.7 54637.2 54690.7 56321.0 56806.2 57082.0 57149.7 57174.0 14358.8 14564.6 14583.7 14598.7 14775.3 11217.7 11296.5 11297.2 11302.0 11326.7 14048.6 14426.6 14441.1 14569.8 14632.0 5806.6 5817.6 6954.0 7014.0 7050.7 851.8 882.0 938.8 977.8 1027.8 24892.9 26832.3 27326.7 27965.6 29478.0 839.7 959.5 1012.7 1050.7 1059.3 13430.6 14184.3 15078.2 16524.6 16739.9 516366.0 658190.0 661587.0 664987.0 666793.0 59003.0 60280.8 60317.4 60345.7 60352.4 1225.0 1260.9 1332.9 1341.3 1378.4 24891.3 30083.8 30235.8 30869.4 30936.4 48371.8 49043.8 49086.0 49129.8 49174.8 436431.0 438311.0 438705.0 441143.0 441169.0 36655.5 37038.0 37277.8 37347.6 38493.0 45828.8 46106.0 46448.0 46607.5 46828.3 37842.0 37986.9 38035.6 39519.0 39729.0 35724.8 37768.6 38267.6 38619.4 40540.9 36595.3 37098.4 37893.8 37936.6 38145.6 32850.5 33609.5 34251.3 34522.5 34527.3 24891.6 25026.9 25119.6 25219.7 25270.7 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35166.47 Median:34363.40 stddev:94918.60 (276.2%) stddev-sans-first:95148.85 14:35:21 INFO - PROCESS | 1650 | Values: 338.4 348.9 372.9 377.5 378.9 14683.0 14943.6 15697.1 20105.6 20702.3 19132.7 19845.9 20042.9 20238.9 20274.4 5049.6 5580.6 5931.2 5942.4 5946.2 4799.4 5408.1 5823.1 5891.0 5907.4 5794.4 5844.2 5844.7 5850.6 5852.9 7459.5 7692.6 7766.3 7850.5 7860.1 7366.6 7385.7 7498.4 7566.1 7575.7 28187.6 28651.0 28684.0 28993.9 29201.0 2322.1 2369.6 2379.0 2388.0 2439.9 13825.8 15477.0 16276.3 16591.4 16703.6 1917.4 1935.6 1989.0 2017.3 2055.8 104464.6 109104.5 109490.4 109688.5 110765.0 16357.3 16908.4 20604.5 20846.2 20903.8 34207.7 34361.8 34365.0 34422.7 34424.5 8977.3 9412.9 9461.4 10089.9 10270.3 7566.6 8187.6 8260.8 8326.7 8492.5 9223.7 9351.6 9493.6 9498.8 9541.0 3105.1 3545.6 3677.0 3684.7 3687.9 703.2 709.6 775.4 822.8 834.7 18995.2 20383.9 20485.0 20725.9 20807.3 891.3 936.5 964.0 975.5 977.2 8771.9 9420.8 10448.8 10821.5 10859.9 521248.0 525749.0 564969.0 609406.0 617242.9 121548.0 122011.4 129291.0 130318.0 131012.3 973.8 991.5 1035.2 1037.1 1038.7 14377.9 16769.7 18098.7 19435.0 19494.3 40246.0 56418.7 57113.0 57301.4 58893.0 80551.0 81547.6 82276.2 84162.7 84527.6 7677.9 7820.3 8139.5 8158.3 8367.8 9058.8 12179.6 12380.9 12657.5 12876.9 10843.0 10973.7 11509.0 11511.8 11630.1 11056.8 11129.8 11164.4 11363.1 11640.7 10962.4 11064.9 11093.5 11243.2 11837.2 6486.4 7969.7 8084.3 8130.5 8193.7 10684.0 10930.1 11123.6 11233.3 11248.4 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5550.57 Median:4803.92 stddev:3165.58 (65.9%) stddev-sans-first:3159.78 14:35:21 INFO - PROCESS | 1650 | Values: 1492.5 1517.1 1682.9 1847.1 1849.7 8298.3 8797.5 8798.0 8801.2 8805.8 7624.5 7868.7 7870.3 8372.2 8604.6 2336.5 2338.8 2342.3 2344.1 2370.9 2269.8 2291.6 2293.2 2330.2 2345.9 1997.7 2315.1 2328.0 2337.1 2340.6 1977.7 2167.3 2253.5 2260.2 2266.1 2290.8 2326.2 2333.8 2335.1 2336.1 8675.2 8723.2 8772.9 8794.4 8795.6 5018.4 5183.6 5197.0 5201.5 5206.7 3061.8 3353.4 3397.4 3550.9 3609.2 1070.7 1072.8 1076.8 1092.8 1099.0 11232.4 11358.1 11384.1 11414.4 11426.1 3972.9 4507.6 4546.2 4719.1 4739.3 9851.0 9851.9 9852.0 9856.4 9881.0 5204.6 5211.1 5216.0 5218.6 5223.0 4223.9 4243.7 4401.0 4789.9 4821.0 3779.4 3826.2 3913.9 3950.5 3956.1 1072.8 1254.9 1265.8 1283.7 1286.9 743.6 744.9 762.3 868.6 898.7 5512.6 5610.4 5661.3 5714.9 5727.7 419.2 426.7 434.0 435.9 444.7 3786.9 3833.1 3854.0 3896.7 3902.8 10129.1 10657.2 10668.1 10678.1 10686.0 10600.4 10615.2 10622.2 10629.8 10633.7 7217.9 7385.9 8052.8 8066.2 8076.8 5569.9 5594.5 5606.5 5655.4 5732.8 9597.3 9727.8 9742.7 9875.5 9898.6 9851.1 9976.7 10021.4 10097.5 10134.4 6718.4 6881.9 6947.8 7305.6 7399.7 7686.7 8136.8 8206.5 8309.0 8332.3 7176.3 7307.5 7317.2 7400.7 7472.3 6932.0 6995.8 7134.9 7193.5 7310.1 6601.4 6668.7 6740.0 6742.9 6760.8 4765.0 4770.7 4817.9 4863.6 4965.2 4066.4 4762.3 4899.8 4940.3 5045.9 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4390.29 Median:4826.03 stddev:1353.55 (28.0%) stddev-sans-first:1321.36 14:35:21 INFO - PROCESS | 1650 | Values: 259.6 290.1 294.7 303.1 303.4 4403.8 4831.8 4858.6 5215.5 5287.3 4265.4 4820.3 4844.2 5124.7 5209.9 3969.4 4007.0 4010.2 4036.0 4036.4 3972.4 3985.9 4012.3 4017.5 4045.4 3735.8 3777.4 3956.3 3963.8 4006.9 3303.7 3569.1 4027.5 4038.0 4049.5 3287.2 3455.8 3458.7 3462.0 3469.5 4393.6 5126.8 5141.6 5165.3 5179.9 4309.0 4471.8 4489.3 4535.4 4621.7 4553.9 4937.0 5545.7 5582.7 5602.9 3205.3 3359.6 3854.7 3863.9 3868.5 5119.6 5330.2 5465.2 5696.7 5839.4 3865.5 3897.6 3898.5 3902.9 3913.7 3477.5 3695.9 3705.6 3870.1 3984.4 3698.7 4282.3 4556.7 4629.4 4643.6 4796.5 5208.8 5526.9 5566.6 5582.2 1142.0 1148.8 1340.0 1362.5 1363.5 864.5 887.3 893.1 908.5 936.6 4246.9 4480.7 4501.4 4560.1 5097.0 5009.6 5601.9 5687.4 5689.4 5707.7 4953.0 5005.9 5064.8 5072.1 5139.0 2502.3 2598.8 2695.0 2845.7 2951.0 4646.8 4747.6 5128.5 5231.9 5743.5 4677.4 5400.0 5417.7 5453.8 5747.2 5719.9 5733.8 5737.0 5745.9 5746.3 4301.5 4889.3 5534.9 5566.9 5591.5 5318.0 5555.1 5692.5 5697.5 5701.5 5860.8 5976.0 5977.0 6019.7 6022.2 3027.5 3323.0 3558.4 3766.4 3788.6 4751.7 5078.9 5491.9 5692.4 5723.5 4615.4 5593.8 5598.4 5606.5 5611.0 4234.9 4321.9 4809.6 5284.4 5622.6 5107.9 5110.8 5215.7 5337.1 5469.4 4511.8 5396.5 5407.6 5415.7 5416.5 4288.8 4973.8 5367.0 5473.8 5492.1 14:35:21 INFO - PROCESS | 1650 | 14:35:21 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:22796.70 Median:4187.53 stddev:36521.64 (872.2%) stddev-sans-first:36586.24 14:35:21 INFO - PROCESS | 1650 | Values: 651.6 701.9 718.8 764.8 775.9 13665.9 14197.3 14230.9 14239.7 14311.0 12619.6 12627.9 12652.2 12683.7 12690.9 670.0 695.8 697.1 806.2 829.1 711.8 791.2 814.8 816.3 816.4 891.8 893.8 893.9 894.8 896.1 697.8 721.8 852.9 879.2 882.4 663.4 664.4 665.8 666.9 670.6 13778.5 13783.9 13791.8 13798.4 13806.0 13072.6 13098.7 13115.1 13356.0 13450.4 10805.4 11867.8 12195.2 12280.2 12699.1 4345.2 4347.3 4422.1 4541.8 4545.8 111730.0 114006.4 114593.4 115277.0 115876.4 8499.9 9444.3 9801.5 10514.2 10664.4 17088.9 20246.9 20427.5 20450.8 20471.8 6205.7 7292.9 7364.4 7508.5 7591.0 4159.6 4181.4 4193.6 4194.1 4231.7 3274.4 3365.8 3380.0 3387.4 3389.6 611.9 613.7 616.4 632.9 634.7 604.3 606.7 607.3 608.2 613.2 7548.3 8358.9 8533.6 8700.5 8997.8 536.8 574.9 583.5 603.3 615.6 4140.7 4221.5 4265.8 4270.2 4419.2 99038.0 102464.5 148023.0 154428.0 159126.0 76305.6 78762.6 106020.5 126715.0 128231.0 92548.5 112311.0 113779.0 114084.0 117598.2 7131.4 8194.3 8252.8 8286.5 8435.9 50931.7 52540.7 55936.2 55960.7 65414.0 54855.0 61765.7 64213.0 94860.5 96436.5 10710.4 10899.3 10934.7 10976.7 11025.4 11920.8 12599.9 12786.5 14482.3 15001.9 13471.0 13556.6 13864.6 13891.4 14227.7 13595.7 13620.5 13961.7 14237.9 14276.9 13265.1 13431.0 13482.5 13740.4 14143.4 11135.6 11423.6 11435.1 11516.7 11518.3 11027.4 11049.2 11172.7 11432.8 11489.2 14:35:21 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:35:21 INFO - PROCESS | 1650 | 14:35:22 INFO - TEST-INFO | 1650: exit 0 14:35:22 INFO - TEST-OK | dromaeo_css | took 1120021ms 14:35:22 INFO - TEST-START | kraken 14:35:22 INFO - operating with platform_type : mac_ 14:35:22 INFO - Initialising browser for kraken test... 14:35:22 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp4PlzLb/profile http://localhost:49266/getInfo.html) 14:35:24 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 14:35:24 INFO - PROCESS | 1661 | colorDepth:24 14:35:24 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 14:35:24 INFO - PROCESS | 1661 | __metrics 14:35:24 INFO - PROCESS | 1661 | 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" 14:35:24 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:25 INFO - TEST-INFO | 1661: exit 0 14:35:25 INFO - Browser initialized. 14:35:25 INFO - Running cycle 1/1 for kraken test... 14:35:25 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp4PlzLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:37 INFO - PROCESS | 1662 | RSS: Main: 234700800 14:35:37 INFO - PROCESS | 1662 | 14:35:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:41 INFO - PROCESS | 1662 | RSS: Main: 293560320 14:35:41 INFO - PROCESS | 1662 | 14:35:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 14:35:44 INFO - PROCESS | 1662 | RSS: Main: 293347328 14:35:44 INFO - PROCESS | 1662 | 14:35:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 14:35:48 INFO - PROCESS | 1662 | RSS: Main: 382828544 14:35:48 INFO - PROCESS | 1662 | 14:35:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 14:35:51 INFO - PROCESS | 1662 | RSS: Main: 285204480 14:35:51 INFO - PROCESS | 1662 | 14:35:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:53 INFO - PROCESS | 1662 | RSS: Main: 289308672 14:35:53 INFO - PROCESS | 1662 | 14:35:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:57 INFO - PROCESS | 1662 | RSS: Main: 325570560 14:35:57 INFO - PROCESS | 1662 | 14:36:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:00 INFO - PROCESS | 1662 | RSS: Main: 328343552 14:36:00 INFO - PROCESS | 1662 | 14:36:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 14:36:04 INFO - PROCESS | 1662 | RSS: Main: 326324224 14:36:04 INFO - PROCESS | 1662 | 14:36:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:06 INFO - PROCESS | 1662 | RSS: Main: 301740032 14:36:06 INFO - PROCESS | 1662 | 14:36:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:08 INFO - PROCESS | 1662 | RSS: Main: 305950720 14:36:08 INFO - PROCESS | 1662 | 14:36:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:11 INFO - PROCESS | 1662 | RSS: Main: 312815616 14:36:11 INFO - PROCESS | 1662 | 14:36:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:15 INFO - PROCESS | 1662 | RSS: Main: 327618560 14:36:15 INFO - PROCESS | 1662 | 14:36:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:36:19 INFO - PROCESS | 1662 | RSS: Main: 321527808 14:36:19 INFO - PROCESS | 1662 | 14:36:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 14:36:21 INFO - PROCESS | 1662 | RSS: Main: 365056000 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | __start_tp_report 14:36:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:36:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:36:21 INFO - PROCESS | 1662 | |i|pagename|runs| 14:36:21 INFO - PROCESS | 1662 | |0;ai-astar;113;113;112;118;163;160;112;113;113;112 14:36:21 INFO - PROCESS | 1662 | |1;audio-beat-detection;148;103;116;174;141;139;113;113;135;112 14:36:21 INFO - PROCESS | 1662 | |2;audio-dft;183;183;186;184;186;184;183;178;183;183 14:36:21 INFO - PROCESS | 1662 | |3;audio-fft;78;60;58;89;63;58;58;60;82;74 14:36:21 INFO - PROCESS | 1662 | |4;audio-oscillator;84;70;91;70;83;100;131;86;68;88 14:36:21 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;84;87;85;87;84;87;85;87;84 14:36:21 INFO - PROCESS | 1662 | |6;imaging-darkroom;142;105;94;94;94;99;143;94;93;119 14:36:21 INFO - PROCESS | 1662 | |7;imaging-desaturate;84;84;83;86;86;84;83;85;86;86 14:36:21 INFO - PROCESS | 1662 | |8;json-parse-financial;57;53;54;55;55;55;54;56;55;54 14:36:21 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;70;66;65;78;71;69;70;71;71;71 14:36:21 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;87;88;91;89;85;86;89;86;90;86 14:36:21 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;153;158;149;146;140;145;146;159;190;285 14:36:21 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;171;172;171;172;170;171;172;170;172;169 14:36:21 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;68;68;68;69;70;73;86;89;74 14:36:21 INFO - PROCESS | 1662 | __end_tp_report 14:36:21 INFO - PROCESS | 1662 | __start_cc_report 14:36:21 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2050 14:36:21 INFO - PROCESS | 1662 | __end_cc_report 14:36:21 INFO - PROCESS | 1662 | __startTimestamp1476394581166__endTimestamp 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:36:21 INFO - PROCESS | 1662 | Number of tests: 14 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:122.90 Median:113.00 stddev:20.43 (18.1%) stddev-sans-first:21.35 14:36:21 INFO - PROCESS | 1662 | Values: 113.0 113.0 112.0 118.0 163.0 160.0 112.0 113.0 113.0 112.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:137.00 stddev:21.88 (16.0%) stddev-sans-first:22.15 14:36:21 INFO - PROCESS | 1662 | Values: 148.0 103.0 116.0 174.0 141.0 139.0 113.0 113.0 135.0 112.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:2.21 (1.2%) stddev-sans-first:2.35 14:36:21 INFO - PROCESS | 1662 | Values: 183.0 183.0 186.0 184.0 186.0 184.0 183.0 178.0 183.0 183.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:68.00 Median:68.50 stddev:11.67 (17.0%) stddev-sans-first:11.81 14:36:21 INFO - PROCESS | 1662 | Values: 78.0 60.0 58.0 89.0 63.0 58.0 58.0 60.0 82.0 74.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:83.50 stddev:18.52 (22.2%) stddev-sans-first:19.61 14:36:21 INFO - PROCESS | 1662 | Values: 84.0 70.0 91.0 70.0 83.0 100.0 131.0 86.0 68.0 88.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.42 (1.6%) stddev-sans-first:1.42 14:36:21 INFO - PROCESS | 1662 | Values: 87.0 84.0 87.0 85.0 87.0 84.0 87.0 85.0 87.0 84.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:94.00 stddev:20.00 (21.3%) stddev-sans-first:16.93 14:36:21 INFO - PROCESS | 1662 | Values: 142.0 105.0 94.0 94.0 94.0 99.0 143.0 94.0 93.0 119.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 14:36:21 INFO - PROCESS | 1662 | Values: 84.0 84.0 83.0 86.0 86.0 84.0 83.0 85.0 86.0 86.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 14:36:21 INFO - PROCESS | 1662 | Values: 57.0 53.0 54.0 55.0 55.0 55.0 54.0 56.0 55.0 54.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:71.00 stddev:3.49 (4.9%) stddev-sans-first:3.70 14:36:21 INFO - PROCESS | 1662 | Values: 70.0 66.0 65.0 78.0 71.0 69.0 70.0 71.0 71.0 71.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.50 stddev:2.00 (2.3%) stddev-sans-first:2.11 14:36:21 INFO - PROCESS | 1662 | Values: 87.0 88.0 91.0 89.0 85.0 86.0 89.0 86.0 90.0 86.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:167.10 Median:155.50 stddev:43.73 (28.1%) stddev-sans-first:46.09 14:36:21 INFO - PROCESS | 1662 | Values: 153.0 158.0 149.0 146.0 140.0 145.0 146.0 159.0 190.0 285.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:1.05 (0.6%) stddev-sans-first:1.12 14:36:21 INFO - PROCESS | 1662 | Values: 171.0 172.0 171.0 172.0 170.0 171.0 172.0 170.0 172.0 169.0 14:36:21 INFO - PROCESS | 1662 | 14:36:21 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:71.50 stddev:7.82 (10.9%) stddev-sans-first:8.05 14:36:21 INFO - PROCESS | 1662 | Values: 68.0 68.0 68.0 68.0 69.0 70.0 73.0 86.0 89.0 74.0 14:36:21 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:36:21 INFO - PROCESS | 1662 | 14:36:22 INFO - TEST-INFO | 1662: exit 0 14:36:22 INFO - TEST-OK | kraken | took 59996ms 14:36:22 INFO - SUITE-END | took 1180s 14:36:22 INFO - Completed test suite (00:19:40) 14:36:22 INFO - javascript benchmark 14:36:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.4247006773808, 3290.55577497038, 3311.5032745088233, 3327.8502467388967, 3358.4290670585997, 5488.862778430531, 5520.282363292771, 5571.275734154565, 5608.747606357713, 5656.434356564341, 5556.027695153352, 5588.050031494646, 5623.0721930881455, 5624.100143976964, 5664.943350566504, 5062.341895553573, 5118.385793704742, 5123.385193776733, 5136.614753893473, 5160.535551800337, 5174.611904107207, 5268.473152684739, 5273.393559740641, 5279.128943724281, 5317.760700768475, 5044.47033061527, 5218.66078704883, 5235.973820130913, 5238.1618940969265, 5317.574594032468, 5060.5951523878, 5148.330717006803, 5149.304843846107, 5158.509941555546, 5169.224616307546, 5033.572146367563, 5089.51649593288, 5104.387473503203, 5106.770195341219, 5123.871903202413, 5579.38626751057, 5582.190582365575, 5583.888322233533, 5606.551475881961, 5607.915881261784, 6005.369436209223, 6007.219061522018, 6010.939890601082, 6017.157597936292, 6018.6689732064715, 6097.101247991087, 6113.205283313186, 6121.849011664688, 6131.193168498072, 6135.330836454432, 5591.832245032615, 5658.603897727119, 5661.264035675335, 5663.207150998864, 5666.660000399989, 6218.409251121137, 6279.905801412982, 6296.527760417987, 6322.178116844781, 6334.873302534015, 5642.181883626933, 5993.310769261503, 6006.219191505076, 6014.609050411709, 6020.849478762978, 5646.632968857011, 6005.219321488178, 6091.238595175603, 6097.3292937776805, 6123.162701465792, 6030.638161710312, 6034.0043892758085, 6041.0, 6051.394860513913, 6063.757449701962, 6048.848778780566, 6054.576179667381, 6057.151998720183, 6061.7575296987625, 6062.939370606237, 4171.20747058058, 4714.669973101919, 4791.760411979387, 4850.6362022848425, 4870.659053866196, 4214.915701686011, 4221.767802770877, 4249.5113061997645, 4332.0469496710675, 4361.302191649384, 5567.3040869891265, 5661.34894487131, 5666.943330566724, 5671.404502527175, 5676.68778217202, 6039.909401358983, 6109.816705498843, 6114.785982490592, 6190.81427557174, 6238.376162383725, 5492.038893193675, 5585.916211256835, 5621.971890140605, 5642.294713160855, 5678.233438485834, 5305.8938821223355, 5309.867253318698, 5321.494458026481, 5328.387235467893, 5333.86665333362, 6190.071489276645, 6255.530835187288, 6301.936980630135, 6325.588836725782, 6366.745330186741, 6100.520618786844, 6126.120738204555, 6139.754409823557, 6183.381661833961, 6270.278917924497, 6277.340879207617, 6286.717097730521, 6301.716422761078, 6304.211973503312, 6314.179156709598, 5936.762529498772, 5970.462658360769, 6102.633841969496, 6131.141640170291, 6158.107074474266, 6044.758209671564, 6128.877422451436, 6135.570510064253, 6138.725610151984, 6195.783147589813, 5450.700211488248, 5809.709514524172, 6056.9091463628965, 6082.391760823883, 6089.421504957022, 5914.467697907209, 5987.700614969147, 6044.911915855188, 6052.6973651316375, 6052.788152414644, 5713.771449141987, 5778.508826749605, 5781.913271300849, 5793.8551536211935, 5861.325947515919, 5954.255718035246, 5967.701614919323, 5977.641341519523, 6071.848203794941, 6095.451409373178, 5857.648541087548, 5858.209141765978, 5902.4097590240635, 5912.320083190488, 5951.077582974646], "value": 5601.343591322816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.3986575572336, 528.6299590286798, 549.4478049560191, 570.8829689913568, 572.9398413166617, 37681.81159094204, 39190.60809391905, 39333.01667458315, 41089.178216435655, 41218.76343709686, 40020.79989600055, 40340.39489407654, 40428.0, 40431.0, 40464.19071618566, 9455.054494550559, 9621.08599683029, 9645.662401815938, 9658.227341812673, 9661.806763864754, 9526.571304291323, 9618.27862910281, 9623.95188024059, 9630.903690963105, 9642.2768292378, 9619.903800962005, 9664.80670386592, 9672.371295865782, 9679.370840895355, 9683.176929960962, 9598.328117031811, 9634.421934683942, 9648.421094734338, 9649.131578157929, 9654.758631034245, 9444.952775236148, 9520.381175223589, 9536.475493847836, 9541.093596108358, 9542.236621070368, 38647.806760966014, 39006.60993390058, 39022.80488597539, 39063.60936390628, 39124.02189945274, 3195.5526226328334, 3301.6533264007176, 3700.6484383983748, 3925.2738243425056, 4075.510938687347, 28933.71066289352, 30036.098917032523, 30330.393392132035, 30431.934882279234, 30502.0, 3104.363605460875, 3234.498652708834, 3265.2000259936467, 3272.2310257089566, 3305.140663427502, 466728.0, 467453.0, 468394.0, 469523.0, 474732.62633686955, 49045.0, 50957.49042509602, 54588.72705636446, 54637.1804422934, 54690.72654636701, 56321.0, 56806.17147542423, 57082.0, 57149.71425142931, 57174.0, 14358.784618230735, 14564.635884102981, 14583.708325833637, 14598.708025839423, 14775.26123693811, 11217.719557010976, 11296.491657875415, 11297.152713546517, 11302.039326657326, 11326.660200194008, 14048.578542643738, 14426.567202983928, 14441.133531987904, 14569.781453278209, 14632.0, 5806.635440671439, 5817.592768506249, 6953.965230173817, 7013.964930175419, 7050.717971281091, 851.7955690634327, 882.0165515450227, 938.7746940734174, 977.8337682593976, 1027.773889744255, 24892.904354394635, 26832.32919176997, 27326.72673273242, 27965.580516292273, 29477.968271110407, 839.7019058234239, 959.5010594490826, 1012.7215015870547, 1050.7058023753361, 1059.327327147267, 13430.597082087357, 14184.290785460686, 15078.246087695572, 16524.586885327964, 16739.91630041842, 516366.0, 658190.0, 661587.0, 664987.0, 666793.0, 59003.0, 60280.79438411207, 60317.396826032054, 60345.698271508365, 60352.39647603556, 1224.9510019599295, 1260.9180403273758, 1332.8800407963329, 1341.3159288762802, 1378.4486205517874, 24891.25326240216, 30083.79664813383, 30235.848820755757, 30869.382612347177, 30936.381272374878, 48371.758141209066, 49043.75478122586, 49086.01827963349, 49129.75435122944, 49174.75412622914, 436431.0, 438311.0, 438705.0, 441143.0, 441169.0, 36655.45016824803, 37038.0, 37277.81361093177, 37347.62652373441, 38493.0, 45828.77085614551, 46106.0, 46448.0, 46607.53392466032, 46828.29757553571, 37842.0, 37986.933462631874, 38035.61964380431, 39519.0, 39729.0, 35724.821375892956, 37768.62231377651, 38267.61732382752, 38619.420708689955, 40540.905341565696, 36595.26809463849, 37098.44352334771, 37893.81053094717, 37936.62063379331, 38145.61854381532, 32850.50724239091, 33609.49585756167, 34251.314973700886, 34522.48216276808, 34527.30945381028, 24891.626625600267, 25026.873790679827, 25119.623205651566, 25219.747802522474, 25270.74729252684], "value": 19361.170595806656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.44832922336604, 348.9302139572086, 372.8844058341914, 377.47153984421806, 378.8692900949172, 14683.0, 14943.5516934492, 15697.058176509403, 20105.59788804223, 20702.275420360253, 19132.713009304873, 19845.900770496162, 20042.899785501053, 20238.898805505953, 20274.39176824694, 5049.621278404116, 5580.581456390767, 5931.228940237763, 5942.376050514698, 5946.167536544887, 4799.376081109468, 5408.134698448249, 5823.097419899922, 5891.0, 5907.379725128864, 5794.362620111805, 5844.152597873306, 5844.736986835603, 5850.590458667895, 5852.853678658046, 7459.515131516461, 7692.576908270043, 7766.301032907038, 7850.489718168358, 7860.056793184797, 7366.558006519626, 7385.66764495599, 7498.3626391756225, 7566.092068951761, 7575.659095340723, 28187.57718634222, 28651.0, 28684.0, 28993.85503072471, 29201.0, 2322.11759531377, 2369.620860662303, 2379.0483806477373, 2387.9522409551887, 2439.926802195937, 13825.79261311081, 15476.993995390376, 16276.348946042144, 16591.419300324553, 16703.582410439714, 1917.424772568224, 1935.6225536020481, 1988.99005504973, 2017.2566503786675, 2055.845811564139, 104464.59818616285, 109104.4544777279, 109490.3576446354, 109688.4515577417, 110765.0, 16357.345706171858, 16908.40820571274, 20604.484887877625, 20846.166153354, 20903.79096209049, 34207.65792342094, 34361.82819085888, 34364.969050928514, 34422.65577344244, 34424.48363274553, 8977.32670049749, 9412.870455545379, 9461.38500997433, 10089.949550252202, 10270.33242839213, 7566.583837888969, 8187.631556579849, 8260.793480162924, 8326.6669333226, 8492.490450572985, 9223.677171299107, 9351.579178936829, 9493.620255189715, 9498.762530936781, 9541.0, 3105.0657129013316, 3545.592256890439, 3676.981615091961, 3684.7236457265813, 3687.8893633191046, 703.2088899987514, 709.5879200391288, 775.4106878772061, 822.8313195794848, 834.7245409015011, 18995.24019039223, 20383.8980805098, 20485.0, 20725.860077695568, 20807.271745488837, 891.3404080980029, 936.5364144748393, 963.9903600963901, 975.4634950777186, 977.1596427072711, 8771.868421973675, 9420.811583768285, 10448.791024179474, 10821.513031913582, 10859.945700271448, 521248.0, 525749.0, 564969.0, 609406.0, 617242.9137854282, 121548.0, 122011.38994305149, 129291.0, 130318.0, 131012.3449382747, 973.8295798235281, 991.5092029445326, 1035.2494441529982, 1037.061459379263, 1038.7091614347994, 14377.856221437652, 16769.74845377345, 18098.728519072487, 19435.0, 19494.296083744044, 40246.0, 56418.7179064102, 57113.0, 57301.426985731276, 58893.0, 80551.0, 81547.59226204068, 82276.17723822685, 84162.73755893543, 84527.5773621128, 7677.923220767944, 7820.335271501986, 8139.511629302261, 8158.3473322132895, 8367.790805229917, 9058.818823623358, 12179.573714919936, 12380.876191238332, 12657.493700252255, 12876.871231287567, 10843.0, 10973.670789876316, 11509.0, 11511.76976460483, 11630.069594432594, 11056.834147487954, 11129.777404452028, 11164.44177791091, 11363.147763917905, 11640.650780476599, 10962.397068161328, 11064.944675276573, 11093.50079246452, 11243.156763242627, 11837.171398002058, 6486.416222539994, 7969.72105976288, 8084.312833409226, 8130.471519351223, 8193.672253110048, 10684.0, 10930.070943969851, 11123.610673626385, 11233.32600044, 11248.381339026431], "value": 10478.207440827964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.4925525321391, 1517.0897461523089, 1682.8653707703386, 1847.113385574925, 1849.6763066463366, 8298.25315721585, 8797.472151670889, 8798.032216456184, 8801.16388943051, 8805.779855503615, 7624.504407213527, 7868.685252589889, 7870.2916737493615, 8372.204640559152, 8604.612792424341, 2336.4626135988733, 2338.8362814602983, 2342.3324352559525, 2344.1443872986406, 2370.9288721338344, 2269.841111122222, 2291.644795056769, 2293.1515339324474, 2330.1844354475966, 2345.8944347504403, 1997.6504111780453, 2315.143396943133, 2327.976720232793, 2337.076854642415, 2340.555294494049, 1977.7132315814126, 2167.295628920607, 2253.5154941687533, 2260.2315212827716, 2266.1048885690225, 2290.7823756743082, 2326.162581470669, 2333.778291062363, 2335.065973610552, 2336.0655737705056, 8675.219230269244, 8723.214910658071, 8772.912270877274, 8794.42836215644, 8795.560221988875, 5018.372703412074, 5183.5853131749745, 5197.0, 5201.531862132389, 5206.739663016834, 3061.800982936102, 3353.429916914106, 3397.405454045532, 3550.8934731958084, 3609.187932715144, 1070.71626019105, 1072.8229842076048, 1076.7684947736195, 1092.759592889563, 1099.0108901988194, 11232.438378081064, 11358.148138889615, 11384.146189035773, 11414.42927853604, 11426.086347981212, 3972.900677483086, 4507.5943165115295, 4546.204414227497, 4719.121335985046, 4739.289106634033, 9850.950745246371, 9851.852222216672, 9852.014798520091, 9856.408615483095, 9881.0, 5204.609654275944, 5211.062008838446, 5216.008958297912, 5218.582513398919, 5222.973885130626, 4223.915521689549, 4243.702940794176, 4400.977995110068, 4789.928151077736, 4821.011692603008, 3779.3952967525065, 3826.215625796761, 3913.92172156561, 3950.466686997276, 3956.1098752780968, 1072.8498010278568, 1254.8807863252975, 1265.7531781302557, 1283.685497053228, 1286.9163504372186, 743.624469642827, 744.8994385757961, 762.3405754022731, 868.6134670071883, 898.6719847255705, 5512.586556008316, 5610.382857885629, 5661.3206415229615, 5714.857128571736, 5727.656340619576, 419.17004331423954, 426.67785821704416, 433.97830108494446, 435.8975640724427, 444.6642784697597, 3786.9431958520645, 3833.118382771978, 3853.9807300963316, 3896.688264938855, 3902.824372903169, 10129.088382045651, 10657.200709946785, 10668.093212077061, 10678.09236214915, 10686.0, 10600.363978161335, 10615.150787936947, 10622.203334749925, 10629.84055239172, 10633.680989570325, 7217.8556428871125, 7385.852282954311, 8052.758417247492, 8066.15305392937, 8076.8384632307025, 5569.860753481195, 5594.4964953152785, 5606.495415412633, 5655.4344565543115, 5732.767454997195, 9597.28020398459, 9727.805443891224, 9742.659006934724, 9875.456849873039, 9898.604055837686, 9851.064148905842, 9976.700698979042, 10021.448820314661, 10097.545610447694, 10134.442605656464, 6718.395344419026, 6881.931180688129, 6947.756828510978, 7305.552639865705, 7399.704011839682, 7686.692532298645, 8136.796580085545, 8206.548639824867, 8308.958455207685, 8332.291755200633, 7176.282371762782, 7307.525010874276, 7317.2316906726155, 7400.6669699864715, 7472.252774722484, 6931.965340173469, 6995.825104372431, 7134.851888563857, 7193.496455248082, 7310.086239220098, 6601.3728695773825, 6668.6665666717445, 6740.0, 6742.8651426972165, 6760.763373282109, 4764.952350476451, 4770.666053376231, 4817.9036419272115, 4863.562279394871, 4965.155923492943, 4066.410370496202, 4762.309465127606, 4899.828506002273, 4940.333055037668, 5045.9243111352625], "value": 4371.147073798197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.56781958039863, 290.11514879617175, 294.70971093472923, 303.0741085982324, 303.3599105886578, 4403.823847046122, 4831.782569784359, 4858.5627293543575, 5215.478452154783, 5287.339082614673, 4265.402843601898, 4820.276958456225, 4844.152273352167, 5124.6925184488955, 5209.879875826697, 3969.364901615742, 4007.0383108054148, 4010.1578668479583, 4035.959640403588, 4036.374361973899, 3972.443857859902, 3985.8640287518065, 4012.277789997799, 4017.4978127734034, 4045.422285308732, 3735.794531300777, 3777.395616701315, 3956.2680904032704, 3963.8414463421573, 4006.939895901564, 3303.702666760003, 3569.0542006368205, 4027.51669799623, 4037.9905023744063, 4049.514058312992, 3287.1946373138735, 3455.7926524408363, 3458.723302135823, 3462.0, 3469.462233353834, 4393.644537504619, 5126.820561280338, 5141.640085194038, 5165.302684137669, 5179.948200517984, 4308.978455107705, 4471.8434854779925, 4489.326601009842, 4535.394361482597, 4621.74580398078, 4553.886152846172, 4936.987917476945, 5545.72271386429, 5582.720863956826, 5602.935442265956, 3205.294835136266, 3359.6472370401243, 3854.6916246700475, 3863.864764733221, 3868.5357757069332, 5119.6432945269535, 5330.173823057394, 5465.152901300345, 5696.686682232434, 5839.357670656224, 3865.536135663738, 3897.629725176104, 3898.4990778549895, 3902.8829135125993, 3913.6673382762783, 3477.4783782432837, 3695.870644527429, 3705.555333360014, 3870.148567315186, 3984.382420724792, 3698.6671199592165, 4282.272013757669, 4556.681032327771, 4629.398178236807, 4643.560496246175, 4796.496367881322, 5208.765605547759, 5526.861828454321, 5566.582506312043, 5582.190582365615, 1141.9543218271342, 1148.8047032004579, 1339.9732005359838, 1362.4686372314804, 1363.5363976248123, 864.464032299978, 887.3123329419623, 893.1381217125505, 908.5411867007119, 936.578539657157, 4246.8725938221905, 4480.706680589764, 4501.369808226851, 4560.065186636798, 5097.0, 5009.5741861941415, 5601.851620417805, 5687.374388817227, 5689.402612725687, 5707.68607726579, 4952.975235123873, 5005.924911126336, 5064.848054558295, 5072.087024335581, 5139.019368766107, 2502.2618327593405, 2598.8175380201965, 2694.986525067362, 2845.701201373867, 2950.9557356639666, 4646.814127434933, 4747.578734845254, 5128.461511541309, 5231.921521177185, 5743.511801496836, 4677.391939047902, 5400.000999814968, 5417.702026388508, 5453.836384908459, 5747.224124743189, 5719.8570035749435, 5733.827985160452, 5737.0, 5745.9425405745405, 5746.310442746897, 4301.462317210348, 4889.266610008385, 5534.86162845916, 5566.860828479321, 5591.496765290981, 5318.0, 5555.111422004532, 5692.5445964321925, 5697.54419646419, 5701.458361455655, 5860.827834433216, 5976.0, 5976.970115149396, 6019.668918209365, 6022.175918291829, 3027.5307327364294, 3322.983385083059, 3558.4128618777613, 3766.4350347447007, 3788.564315103688, 4751.714897106184, 5078.873028174326, 5491.929073830564, 5692.373838877803, 5723.513501352431, 4615.353850461005, 5593.776248949996, 5598.412166722435, 5606.523445507178, 5611.0, 4234.87295381139, 4321.870343889688, 4809.567138957511, 5284.398537550209, 5622.606417550732, 5107.897842043064, 5110.7580708013, 5215.739213039409, 5337.092694242066, 5469.371022332482, 4511.751853648081, 5396.541293989898, 5407.567394608343, 5415.675059496442, 5416.458354164552, 4288.8284468620905, 4973.776180071833, 5366.973165134149, 5473.808416705396, 5492.093804522369], "value": 3961.247414587495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.5764752910608, 701.8910122007228, 718.7520305494605, 764.8011517005577, 775.9107702614198, 13665.863341366583, 14197.29013549321, 14230.928845355784, 14239.715205695893, 14311.0, 12619.621411357673, 12627.873721262784, 12652.177608455444, 12683.746325073516, 12690.873091269084, 670.0451856105055, 695.7564852301679, 697.052009267396, 806.2018601584418, 829.0590180145518, 711.8042538301956, 791.2404092071619, 814.8288859339546, 816.302061737215, 816.3510009542427, 891.7592250092504, 893.7631527645179, 893.8525143351371, 894.7539426657656, 896.1083721696921, 697.8429853283021, 721.7870728135213, 852.86780549015, 879.169185120065, 882.4308321132866, 663.383053760003, 664.3954001858285, 665.8169003524022, 666.8566258254499, 670.6009924095156, 13778.517751878637, 13783.931080344533, 13791.793123103162, 13798.379072941741, 13806.0, 13072.607821765363, 13098.738025239441, 13115.081944263906, 13356.0, 13450.394732236975, 10805.351678899213, 11867.821982670266, 12195.207311524722, 12280.201786883825, 12699.111062225647, 4345.152695224432, 4347.347897815322, 4422.137683151755, 4541.750203738793, 4545.772711364419, 111730.0, 114006.42996784963, 114593.42703286513, 115277.0, 115876.42061789721, 8499.915000849913, 9444.291678124167, 9801.460919649488, 10514.214046822748, 10664.360138391721, 17088.91455542714, 20246.898765506077, 20427.489312767004, 20450.79549204489, 20471.795282047286, 6205.720742566596, 7292.854142917112, 7364.374028207555, 7508.474406791582, 7591.0, 4159.584041595876, 4181.435506206623, 4193.622573968297, 4194.0563373240775, 4231.703780735319, 3274.3942370661503, 3365.8317084145697, 3380.002899144758, 3387.356402283558, 3389.6101948275773, 611.9265688117455, 613.6594190224379, 616.4390404731672, 632.9461995730322, 634.7143785296543, 604.2959951656271, 606.7057477123592, 607.3076692570473, 608.2275510102146, 613.2487702564412, 7548.282913123245, 8358.916410835935, 8533.615987280587, 8700.477971321741, 8997.775055623531, 536.7691842990009, 574.944975969093, 583.5419195931258, 603.3483837455537, 615.5783288447428, 4140.668746500272, 4221.451211342506, 4265.808038638207, 4270.167317373082, 4419.226635338803, 99038.0, 102464.48767756263, 148023.0, 154428.0, 159126.0, 76305.61847190729, 78762.60618696985, 106020.46989765156, 126715.0, 128231.0, 92548.53725731463, 112311.0, 113779.0, 114084.0, 117598.23602645966, 7131.429485641032, 8194.34445244391, 8252.83494330098, 8286.502809831429, 8435.915640843514, 50931.745341273054, 52540.73729631327, 55936.160957586486, 55960.72019640038, 65414.0, 54855.0, 61765.691171543855, 64213.0, 94860.52569737108, 96436.51781741047, 10710.410927399067, 10899.29154604948, 10934.671959841218, 10976.725581860517, 11025.44872756375, 11920.76158476843, 12599.93700031494, 12786.488540458278, 14482.275886205436, 15001.86627516335, 13471.0, 13556.59330220095, 13864.584062478141, 13891.374888129856, 14227.715445691236, 13595.728085438433, 13620.455181792617, 13961.720765584834, 14237.857621423653, 14276.857231427968, 13265.118589345586, 13431.0, 13482.460701571827, 13740.435287462205, 14143.36354864013, 11135.610253641084, 11423.600173993871, 11435.142364322543, 11516.654500365003, 11518.256566616052, 11027.44862756875, 11049.226554141133, 11172.72068198269, 11432.771344573228, 11489.195756296978], "value": 7353.313039966529, "unit": "score"}], "name": "dromaeo_css", "value": 7245.669379277332, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 118.0, 163.0, 160.0, 112.0, 113.0, 113.0, 112.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 103.0, 116.0, 174.0, 141.0, 139.0, 113.0, 113.0, 135.0, 112.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 186.0, 184.0, 186.0, 184.0, 183.0, 178.0, 183.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 58.0, 89.0, 63.0, 58.0, 58.0, 60.0, 82.0, 74.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 91.0, 70.0, 83.0, 100.0, 131.0, 86.0, 68.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 84.0, 87.0, 85.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 105.0, 94.0, 94.0, 94.0, 99.0, 143.0, 94.0, 93.0, 119.0], "value": 107.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 86.0, 84.0, 83.0, 85.0, 86.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0, 56.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 65.0, 78.0, 71.0, 69.0, 70.0, 71.0, 71.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 91.0, 89.0, 85.0, 86.0, 89.0, 86.0, 90.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 149.0, 146.0, 140.0, 145.0, 146.0, 159.0, 190.0, 285.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 171.0, 172.0, 170.0, 171.0, 172.0, 170.0, 172.0, 169.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 70.0, 73.0, 86.0, 89.0, 74.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1492.9, "alertThreshold": 2.0}]} 14:36:22 INFO - Return code: 0 14:36:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:36:22 INFO - # TBPL SUCCESS # 14:36:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:22 INFO - 2016-10-13 14:36:22.475 screenresolution[1666:9635] starting screenresolution argv=screenresolution get 14:36:22 INFO - 2016-10-13 14:36:22.477 screenresolution[1666:9635] Display 0: 1600x1200x32@60 14:36:22 INFO - 2016-10-13 14:36:22.484 screenresolution[1667:9638] starting screenresolution argv=screenresolution list 14:36:22 INFO - Available Modes on Display 0 14:36:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:22 INFO - Intel Iris: 14:36:22 INFO - Chipset Model: Intel Iris 14:36:22 INFO - Type: GPU 14:36:22 INFO - Bus: Built-In 14:36:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:36:22 INFO - Vendor: Intel (0x8086) 14:36:22 INFO - Device ID: 0x0a2e 14:36:22 INFO - Revision ID: 0x0009 14:36:22 INFO - Displays: 14:36:22 INFO - Display: 14:36:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:22 INFO - Display Serial Number: 1600x1200 60 14:36:22 INFO - Main Display: Yes 14:36:22 INFO - Mirror: Off 14:36:22 INFO - Online: Yes 14:36:22 INFO - Rotation: Supported 14:36:22 INFO - Return code: 0 14:36:22 INFO - Running post-action listener: _resource_record_post_action 14:36:22 INFO - [mozharness: 2016-10-13 21:36:22.723065Z] Finished run-tests step (success) 14:36:22 INFO - Running post-run listener: _resource_record_post_run 14:36:22 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38425600; Write bytes: 709101568; Read time: 377; Write time: 1822 14:36:22 INFO - TinderboxPrint: CPU usage
53.6% 14:36:22 INFO - TinderboxPrint: I/O read bytes / time
38,425,600 / 377 14:36:22 INFO - TinderboxPrint: I/O write bytes / time
709,101,568 / 1,822 14:36:22 INFO - TinderboxPrint: CPU idle
2,258.2 (46.4%) 14:36:22 INFO - TinderboxPrint: CPU system
977.6 (20.1%) 14:36:22 INFO - TinderboxPrint: CPU user
1,625.9 (33.4%) 14:36:22 INFO - TinderboxPrint: Swap in / out
445,927,424 / 0 14:36:22 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405905920; Write bytes: 400734208; Read time: 30011; Write time: 709 14:36:22 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34501632; Write bytes: 297345024; Read time: 345; Write time: 1077 14:36:23 INFO - Running post-run listener: _upload_blobber_files 14:36:23 INFO - Blob upload gear active. 14:36:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:36:23 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 14:36:23 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'] 14:36:23 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 14:36:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:24 INFO - (blobuploader) - INFO - Done attempting. 14:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:25 INFO - (blobuploader) - INFO - Done attempting. 14:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:28 INFO - (blobuploader) - INFO - Done attempting. 14:36:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:28 INFO - Return code: 0 14:36:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c11cd1648dab1698d0c53a3a1a8c95a035a859a8ca6f9ed0addb156b7c6893b9fc049fcb7b226597bab047962ffd86e460751d3706bd35e8f057e6f9bf26be51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/faf5daff334da13d7aaedec5d486daf0af21a574228e6c4c13a6e1381fa531aaa7fa28f192839cc112533b8940d2d231822a576053910d5c7c15c0047d690017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22196c77b08d00cbc6eaa5d6514fac29a8057e28ac2b3aa84c6a8a0bc983cd1c9fbd35a09d08777fa719626e68436ca934f85a758e59f2972f95456c616d495e"} 14:36:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:28 INFO - Contents: 14:36:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c11cd1648dab1698d0c53a3a1a8c95a035a859a8ca6f9ed0addb156b7c6893b9fc049fcb7b226597bab047962ffd86e460751d3706bd35e8f057e6f9bf26be51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/faf5daff334da13d7aaedec5d486daf0af21a574228e6c4c13a6e1381fa531aaa7fa28f192839cc112533b8940d2d231822a576053910d5c7c15c0047d690017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22196c77b08d00cbc6eaa5d6514fac29a8057e28ac2b3aa84c6a8a0bc983cd1c9fbd35a09d08777fa719626e68436ca934f85a758e59f2972f95456c616d495e"} 14:36:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:28 INFO - Copying logs to upload dir... 14:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.004340 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-13 14:36:28.242562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:36:28.248179) ========= 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.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/c11cd1648dab1698d0c53a3a1a8c95a035a859a8ca6f9ed0addb156b7c6893b9fc049fcb7b226597bab047962ffd86e460751d3706bd35e8f057e6f9bf26be51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/faf5daff334da13d7aaedec5d486daf0af21a574228e6c4c13a6e1381fa531aaa7fa28f192839cc112533b8940d2d231822a576053910d5c7c15c0047d690017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22196c77b08d00cbc6eaa5d6514fac29a8057e28ac2b3aa84c6a8a0bc983cd1c9fbd35a09d08777fa719626e68436ca934f85a758e59f2972f95456c616d495e"} build_url:https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/ORu8KoqgS6qcyvR_ysSqtw/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/c11cd1648dab1698d0c53a3a1a8c95a035a859a8ca6f9ed0addb156b7c6893b9fc049fcb7b226597bab047962ffd86e460751d3706bd35e8f057e6f9bf26be51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/faf5daff334da13d7aaedec5d486daf0af21a574228e6c4c13a6e1381fa531aaa7fa28f192839cc112533b8940d2d231822a576053910d5c7c15c0047d690017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22196c77b08d00cbc6eaa5d6514fac29a8057e28ac2b3aa84c6a8a0bc983cd1c9fbd35a09d08777fa719626e68436ca934f85a758e59f2972f95456c616d495e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:36:28.281894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:36:28.282209) ========= 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.czh93bfaHt/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.X1ukMgAr0z/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005006 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:36:28.331360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:36:28.334916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:36:28.335262) ========= ========= Total master_lag: 0.18 =========