builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1480574973.95 results: success (0) buildid: 20161130195843 builduid: 47e8b6511f164c04bfaa92d90279950a revision: 2d3e477fd282afeeaf7f849c52aec99f509dbda0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:33.945531) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:33.945996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:33.946279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:33.977192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:33.977647) ========= 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.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-11-30 22:49:33-- 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% 19.2M=0.001s 2016-11-30 22:49:34 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:34.124333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:34.124747) ========= 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.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.024641 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:34.174343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 22:49:34.174797) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 2d3e477fd282afeeaf7f849c52aec99f509dbda0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 2d3e477fd282afeeaf7f849c52aec99f509dbda0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-11-30 22:49:34,270 truncating revision to first 12 chars 2016-11-30 22:49:34,271 Setting DEBUG logging. 2016-11-30 22:49:34,271 attempt 1/10 2016-11-30 22:49:34,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2d3e477fd282?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 22:49:35,005 unpacking tar archive at: graphics-2d3e477fd282/testing/mozharness/ program finished with exit code 0 elapsedTime=1.031647 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 22:49:35.231557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:35.232096) ========= script_repo_revision: 2d3e477fd282afeeaf7f849c52aec99f509dbda0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:35.232759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:35.233216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 22:49:35.253720) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-30 22:49:35.254213) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:49:35 INFO - MultiFileLogger online at 20161130 22:49:35 in /builds/slave/test 22:49:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 22:49:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:49:35 INFO - {'append_to_log': False, 22:49:35 INFO - 'base_work_dir': '/builds/slave/test', 22:49:35 INFO - 'blob_upload_branch': 'Graphics', 22:49:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:49:35 INFO - 'branch': 'Graphics', 22:49:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:49:35 INFO - 'config_files': ('talos/mac_config.py',), 22:49:35 INFO - 'default_actions': ('clobber', 22:49:35 INFO - 'read-buildbot-config', 22:49:35 INFO - 'download-and-extract', 22:49:35 INFO - 'populate-webroot', 22:49:35 INFO - 'create-virtualenv', 22:49:35 INFO - 'install', 22:49:35 INFO - 'run-tests'), 22:49:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:49:35 INFO - 'download_minidump_stackwalk': True, 22:49:35 INFO - 'download_symbols': 'ondemand', 22:49:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:49:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:49:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:49:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:49:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:49:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:49:35 INFO - 'installer_path': 'installer.exe', 22:49:35 INFO - 'log_level': 'info', 22:49:35 INFO - 'log_name': 'talos', 22:49:35 INFO - 'log_to_console': True, 22:49:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:49:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:49:35 INFO - 'opt_config_files': (), 22:49:35 INFO - 'pip_index': False, 22:49:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:49:35 INFO - 'cmd': ('bash', 22:49:35 INFO - '-c', 22:49:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:49:35 INFO - 'enabled': True, 22:49:35 INFO - 'halt_on_failure': False, 22:49:35 INFO - 'name': 'check_screen_resolution'},), 22:49:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:49:35 INFO - 'cmd': ('bash', 22:49:35 INFO - '-c', 22:49:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:49:35 INFO - 'enabled': True, 22:49:35 INFO - 'halt_on_failure': False, 22:49:35 INFO - 'name': 'check_screen_resolution'},), 22:49:35 INFO - 'run_cmd_checks_enabled': True, 22:49:35 INFO - 'sps_profile': False, 22:49:35 INFO - 'sps_profile_interval': 0, 22:49:35 INFO - 'suite': 'dromaeojs', 22:49:35 INFO - 'system_bits': '32', 22:49:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:49:35 INFO - 'title': 't-yosemite-r7-0277', 22:49:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:49:35 INFO - 'use_talos_json': True, 22:49:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:49:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:49:35 INFO - 'work_dir': 'build'} 22:49:35 INFO - [mozharness: 2016-12-01 06:49:35.459199Z] Running clobber step. 22:49:35 INFO - Running pre-action listener: _resource_record_pre_action 22:49:35 INFO - Running main action method: clobber 22:49:35 INFO - rmtree: /builds/slave/test/build 22:49:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:49:37 INFO - Running post-action listener: _resource_record_post_action 22:49:37 INFO - [mozharness: 2016-12-01 06:49:37.814032Z] Finished clobber step (success) 22:49:37 INFO - [mozharness: 2016-12-01 06:49:37.814159Z] Running read-buildbot-config step. 22:49:37 INFO - Running pre-action listener: _resource_record_pre_action 22:49:37 INFO - Running main action method: read_buildbot_config 22:49:37 INFO - Using buildbot properties: 22:49:37 INFO - { 22:49:37 INFO - "project": "", 22:49:37 INFO - "product": "firefox", 22:49:37 INFO - "script_repo_revision": "default", 22:49:37 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 22:49:37 INFO - "repository": "", 22:49:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 22:49:37 INFO - "buildid": "20161130195843", 22:49:37 INFO - "pgo_build": "False", 22:49:37 INFO - "basedir": "/builds/slave/test", 22:49:37 INFO - "buildnumber": 5, 22:49:37 INFO - "slavename": "t-yosemite-r7-0277", 22:49:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:49:37 INFO - "platform": "yosemite_r7", 22:49:37 INFO - "scheduler": "tests-graphics-macosx64-talos", 22:49:37 INFO - "branch": "graphics", 22:49:37 INFO - "repo_path": "projects/graphics", 22:49:37 INFO - "revision": "2d3e477fd282afeeaf7f849c52aec99f509dbda0", 22:49:37 INFO - "stage_platform": "macosx64", 22:49:37 INFO - "builduid": "47e8b6511f164c04bfaa92d90279950a", 22:49:37 INFO - "slavebuilddir": "test" 22:49:37 INFO - } 22:49:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 22:49:37 INFO - Running post-action listener: _resource_record_post_action 22:49:37 INFO - [mozharness: 2016-12-01 06:49:37.817456Z] Finished read-buildbot-config step (success) 22:49:37 INFO - [mozharness: 2016-12-01 06:49:37.817570Z] Running download-and-extract step. 22:49:37 INFO - Running pre-action listener: _resource_record_pre_action 22:49:37 INFO - Running main action method: download_and_extract 22:49:37 INFO - mkdir: /builds/slave/test/build/tests 22:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:37 INFO - trying https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 22:49:37 INFO - Downloading https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 22:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 22:49:39 INFO - Downloaded 1199 bytes. 22:49:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 22:49:39 INFO - Using the following test package requirements: 22:49:39 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:49:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 22:49:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 22:49:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'jsshell-mac.zip'], 22:49:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 22:49:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:49:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 22:49:39 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 22:49:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 22:49:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:49:39 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 22:49:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:49:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:49:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:49:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:49:39 INFO - Http code: 200 22:49:39 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 22:49:39 INFO - x-amz-cf-id: ea-BXQ5hLf_eZJ1A8NMQKn1zCZ_8R9Nf_zBWvDUVcUXQ66LeQFuWSA== 22:49:39 INFO - x-amz-version-id: yDmT2O78K8mSrmBb85y3.9Sk0PCHOIM2 22:49:40 INFO - Expected file size: 16282648 22:49:40 INFO - Obtained file size: 16282648 22:49:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:49:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:49:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:49:46 INFO - Fetch https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:49:47 INFO - Http code: 200 22:49:47 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 22:49:47 INFO - x-amz-cf-id: ZzgJQJu-0pIcMax7CVcAy3Ad2ieWporPSiGlqh0nTYxDqlGueVbT_w== 22:49:47 INFO - x-amz-version-id: yDmT2O78K8mSrmBb85y3.9Sk0PCHOIM2 22:49:47 INFO - Expected file size: 16282648 22:49:47 INFO - Obtained file size: 16282648 22:49:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 22:49:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:49:54 INFO - Fetch https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 22:49:55 INFO - Http code: 200 22:49:55 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 22:49:55 INFO - x-amz-cf-id: Rrk8LspanouIwsQnNysiFWDIKpKZOGVto8eXs1Y18ElFmFQKLwuLGQ== 22:49:55 INFO - x-amz-version-id: Z5ZruTnIFdw9n966XkY2UBq7fngOEPyc 22:49:55 INFO - Expected file size: 14409702 22:49:55 INFO - Obtained file size: 14409702 22:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:49:55 INFO - trying https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:49:55 INFO - Downloading https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 22:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 22:49:58 INFO - Downloaded 107600375 bytes. 22:49:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:49:58 INFO - mkdir: /builds/slave/test/properties 22:49:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:49:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:49:58 INFO - Contents: 22:49:58 INFO - build_url:https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:49:59 INFO - Running post-action listener: _resource_record_post_action 22:49:59 INFO - Running post-action listener: set_extra_try_arguments 22:49:59 INFO - [mozharness: 2016-12-01 06:49:59.080404Z] Finished download-and-extract step (success) 22:49:59 INFO - [mozharness: 2016-12-01 06:49:59.080550Z] Running populate-webroot step. 22:49:59 INFO - Running pre-action listener: _resource_record_pre_action 22:49:59 INFO - Running main action method: populate_webroot 22:49:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:49:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:49:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:49:59 INFO - '--tppagecycles', 22:49:59 INFO - '7'], 22:49:59 INFO - 'tests': ['tsvgm']}}, 22:49:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:49:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:49:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:49:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:49:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['damp', 'tps']}, 22:49:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'tests': ['damp', 'tps']}, 22:49:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['dromaeo_dom']}, 22:49:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:49:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['basic_compositor_video']}, 22:49:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:49:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'other-e10s': {'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['a11yr', 22:49:59 INFO - 'ts_paint', 22:49:59 INFO - 'tpaint', 22:49:59 INFO - 'sessionrestore', 22:49:59 INFO - 'sessionrestore_no_auto_restore', 22:49:59 INFO - 'tabpaint']}, 22:49:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['tsvgx', 22:49:59 INFO - 'tsvgr_opacity', 22:49:59 INFO - 'tart', 22:49:59 INFO - 'tscrollx', 22:49:59 INFO - 'cart', 22:49:59 INFO - 'tsvg_static']}, 22:49:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:49:59 INFO - 'tsvgr_opacity', 22:49:59 INFO - 'tart', 22:49:59 INFO - 'tscrollx', 22:49:59 INFO - 'cart', 22:49:59 INFO - 'tsvg_static']}, 22:49:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'talos_options': ['--disable-e10s'], 22:49:59 INFO - 'tests': ['tp5o']}, 22:49:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:49:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'talos_options': ['--disable-e10s', 22:49:59 INFO - '--xperf_path', 22:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:59 INFO - 'tests': ['tp5n']}, 22:49:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:49:59 INFO - 'talos_options': ['--xperf_path', 22:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:59 INFO - 'tests': ['tp5n']}}, 22:49:59 INFO - 'talos.zip': {'path': '', 22:49:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:49:59 INFO - Running post-action listener: _resource_record_post_action 22:49:59 INFO - [mozharness: 2016-12-01 06:49:59.099319Z] Finished populate-webroot step (success) 22:49:59 INFO - [mozharness: 2016-12-01 06:49:59.099436Z] Running create-virtualenv step. 22:49:59 INFO - Running pre-action listener: _resource_record_pre_action 22:49:59 INFO - Running main action method: create_virtualenv 22:49:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:49:59 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 22:49:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:49:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:49:59 INFO - Using real prefix '/tools/python27' 22:49:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:49:59 INFO - Installing distribute.............................................................................................................................................................................................done. 22:50:02 INFO - Installing pip.................done. 22:50:02 INFO - Return code: 0 22:50:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:50:03 INFO - Reading from file tmpfile_stdout 22:50:03 INFO - Output received: 22:50:03 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) 22:50:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:50:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:03 INFO - 'HOME': '/Users/cltbld', 22:50:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:03 INFO - 'LOGNAME': 'cltbld', 22:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:03 INFO - 'MOZ_NO_REMOTE': '1', 22:50:03 INFO - 'NO_EM_RESTART': '1', 22:50:03 INFO - 'PAGER': '/bin/cat', 22:50:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:03 INFO - 'PWD': '/builds/slave/test', 22:50:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:03 INFO - 'SHELL': '/bin/bash', 22:50:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:03 INFO - 'USER': 'cltbld', 22:50:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:03 INFO - 'XPC_FLAGS': '0x0', 22:50:03 INFO - 'XPC_SERVICE_NAME': '0', 22:50:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:03 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 22:50:03 INFO - Cleaning up... 22:50:03 INFO - Return code: 0 22:50:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:50:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:03 INFO - 'HOME': '/Users/cltbld', 22:50:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:03 INFO - 'LOGNAME': 'cltbld', 22:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:03 INFO - 'MOZ_NO_REMOTE': '1', 22:50:03 INFO - 'NO_EM_RESTART': '1', 22:50:03 INFO - 'PAGER': '/bin/cat', 22:50:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:03 INFO - 'PWD': '/builds/slave/test', 22:50:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:03 INFO - 'SHELL': '/bin/bash', 22:50:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:03 INFO - 'USER': 'cltbld', 22:50:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:03 INFO - 'XPC_FLAGS': '0x0', 22:50:03 INFO - 'XPC_SERVICE_NAME': '0', 22:50:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:03 INFO - Downloading/unpacking psutil>=3.1.1 22:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:50:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:07 INFO - Installing collected packages: psutil 22:50:07 INFO - Running setup.py install for psutil 22:50:07 INFO - building 'psutil._psutil_osx' extension 22:50:07 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 22:50:07 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 22:50:07 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 22:50:07 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 22:50:07 INFO - building 'psutil._psutil_posix' extension 22:50:07 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 22:50:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:50:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:50:08 INFO - ^ 22:50:08 INFO - 1 warning generated. 22:50:08 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 22:50:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:08 INFO - Successfully installed psutil 22:50:08 INFO - Cleaning up... 22:50:08 INFO - Return code: 0 22:50:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:08 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:08 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 22:50:08 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 22:50:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:08 INFO - 'HOME': '/Users/cltbld', 22:50:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:08 INFO - 'LOGNAME': 'cltbld', 22:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:08 INFO - 'MOZ_NO_REMOTE': '1', 22:50:08 INFO - 'NO_EM_RESTART': '1', 22:50:08 INFO - 'PAGER': '/bin/cat', 22:50:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:08 INFO - 'PWD': '/builds/slave/test', 22:50:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:08 INFO - 'SHELL': '/bin/bash', 22:50:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:08 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:08 INFO - 'USER': 'cltbld', 22:50:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:08 INFO - 'XPC_FLAGS': '0x0', 22:50:08 INFO - 'XPC_SERVICE_NAME': '0', 22:50:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:50:08 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 22:50:08 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 22:50:08 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 22:50:08 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 22:50:08 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 22:50:08 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 22:50:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:50:11 INFO - Installing collected packages: mozsystemmonitor 22:50:11 INFO - Running setup.py install for mozsystemmonitor 22:50:11 INFO - Successfully installed mozsystemmonitor 22:50:11 INFO - Cleaning up... 22:50:11 INFO - Return code: 0 22:50:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:11 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:11 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 22:50:11 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 22:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:11 INFO - 'HOME': '/Users/cltbld', 22:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:11 INFO - 'LOGNAME': 'cltbld', 22:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:11 INFO - 'MOZ_NO_REMOTE': '1', 22:50:11 INFO - 'NO_EM_RESTART': '1', 22:50:11 INFO - 'PAGER': '/bin/cat', 22:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:11 INFO - 'PWD': '/builds/slave/test', 22:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:11 INFO - 'SHELL': '/bin/bash', 22:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:11 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:11 INFO - 'USER': 'cltbld', 22:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:11 INFO - 'XPC_FLAGS': '0x0', 22:50:11 INFO - 'XPC_SERVICE_NAME': '0', 22:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:11 INFO - Downloading/unpacking jsonschema==2.5.1 22:50:11 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 22:50:11 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 22:50:11 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 22:50:11 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 22:50:11 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 22:50:11 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 22:50:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:50:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:50:14 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 22:50:14 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 22:50:14 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 22:50:14 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 22:50:14 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 22:50:14 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 22:50:14 INFO - Downloading functools32-3.2.3-2.tar.gz 22:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:50:14 INFO - warning: no files found matching '*.txt' 22:50:14 INFO - no previously-included directories found matching 'build' 22:50:14 INFO - no previously-included directories found matching 'dist' 22:50:14 INFO - no previously-included directories found matching '.git*' 22:50:14 INFO - Installing collected packages: jsonschema, functools32 22:50:14 INFO - Running setup.py install for functools32 22:50:14 INFO - warning: no files found matching '*.txt' 22:50:14 INFO - no previously-included directories found matching 'build' 22:50:14 INFO - no previously-included directories found matching 'dist' 22:50:14 INFO - no previously-included directories found matching '.git*' 22:50:15 INFO - Successfully installed jsonschema functools32 22:50:15 INFO - Cleaning up... 22:50:15 INFO - Return code: 0 22:50:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:50:15 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')]} 22:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:15 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')]} 22:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:15 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:15 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 22:50:15 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 22:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:15 INFO - 'HOME': '/Users/cltbld', 22:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:15 INFO - 'LOGNAME': 'cltbld', 22:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:15 INFO - 'MOZ_NO_REMOTE': '1', 22:50:15 INFO - 'NO_EM_RESTART': '1', 22:50:15 INFO - 'PAGER': '/bin/cat', 22:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:15 INFO - 'PWD': '/builds/slave/test', 22:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:15 INFO - 'SHELL': '/bin/bash', 22:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:15 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:15 INFO - 'USER': 'cltbld', 22:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:15 INFO - 'XPC_FLAGS': '0x0', 22:50:15 INFO - 'XPC_SERVICE_NAME': '0', 22:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:50:15 INFO - Cleaning up... 22:50:15 INFO - Return code: 0 22:50:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:50:15 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')]} 22:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:15 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')]} 22:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:15 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:15 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 22:50:15 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 22:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:15 INFO - 'HOME': '/Users/cltbld', 22:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:15 INFO - 'LOGNAME': 'cltbld', 22:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:15 INFO - 'MOZ_NO_REMOTE': '1', 22:50:15 INFO - 'NO_EM_RESTART': '1', 22:50:15 INFO - 'PAGER': '/bin/cat', 22:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:15 INFO - 'PWD': '/builds/slave/test', 22:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:15 INFO - 'SHELL': '/bin/bash', 22:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:15 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:15 INFO - 'USER': 'cltbld', 22:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:15 INFO - 'XPC_FLAGS': '0x0', 22:50:15 INFO - 'XPC_SERVICE_NAME': '0', 22:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:18 INFO - Downloading blobuploader-1.2.4.tar.gz 22:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:50:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:50:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:50:19 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 22:50:19 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 22:50:19 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 22:50:19 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 22:50:19 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 22:50:19 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 22:50:19 INFO - Downloading docopt-0.6.1.tar.gz 22:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:50:19 INFO - Installing collected packages: blobuploader, requests, docopt 22:50:19 INFO - Running setup.py install for blobuploader 22:50:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:50:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:50:19 INFO - Running setup.py install for requests 22:50:20 INFO - Running setup.py install for docopt 22:50:20 INFO - Successfully installed blobuploader requests docopt 22:50:20 INFO - Cleaning up... 22:50:20 INFO - Return code: 0 22:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:50:20 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')]} 22:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:20 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')]} 22:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:20 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:20 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 22:50:20 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 22:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:20 INFO - 'HOME': '/Users/cltbld', 22:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:20 INFO - 'LOGNAME': 'cltbld', 22:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:20 INFO - 'MOZ_NO_REMOTE': '1', 22:50:20 INFO - 'NO_EM_RESTART': '1', 22:50:20 INFO - 'PAGER': '/bin/cat', 22:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:20 INFO - 'PWD': '/builds/slave/test', 22:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:20 INFO - 'SHELL': '/bin/bash', 22:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:20 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:20 INFO - 'USER': 'cltbld', 22:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:20 INFO - 'XPC_FLAGS': '0x0', 22:50:20 INFO - 'XPC_SERVICE_NAME': '0', 22:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:50:20 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-e6k5sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:50:20 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4nrgjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:50:20 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Mw2Mvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:50:20 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-CHLIht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5ucaPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xZ0bkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ExH4fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-kgpPp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-2vGKkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-fXsw4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-KAQac0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4kCw91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-TGOBKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:50:21 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-apV2pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:50:22 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3pm7Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:50:22 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ueriNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:50:22 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NNPLgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:50:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:50:22 INFO - Running setup.py install for manifestparser 22:50:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:50:22 INFO - Running setup.py install for mozcrash 22:50:22 INFO - Running setup.py install for mozdebug 22:50:22 INFO - Running setup.py install for mozdevice 22:50:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:50:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:50:22 INFO - Running setup.py install for mozfile 22:50:23 INFO - Running setup.py install for mozhttpd 22:50:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Running setup.py install for mozinfo 22:50:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Running setup.py install for mozInstall 22:50:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Running setup.py install for mozleak 22:50:23 INFO - Running setup.py install for mozlog 22:50:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:50:23 INFO - Running setup.py install for moznetwork 22:50:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Running setup.py install for mozprocess 22:50:24 INFO - Running setup.py install for mozprofile 22:50:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Running setup.py install for mozrunner 22:50:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Running setup.py install for mozscreenshot 22:50:24 INFO - Running setup.py install for moztest 22:50:24 INFO - Running setup.py install for mozversion 22:50:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:50:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:50:24 INFO - Cleaning up... 22:50:24 INFO - Return code: 0 22:50:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:24 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:24 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 22:50:24 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 22:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:24 INFO - 'HOME': '/Users/cltbld', 22:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:24 INFO - 'LOGNAME': 'cltbld', 22:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:24 INFO - 'MOZ_NO_REMOTE': '1', 22:50:24 INFO - 'NO_EM_RESTART': '1', 22:50:24 INFO - 'PAGER': '/bin/cat', 22:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:24 INFO - 'PWD': '/builds/slave/test', 22:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:24 INFO - 'SHELL': '/bin/bash', 22:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:24 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:24 INFO - 'USER': 'cltbld', 22:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:24 INFO - 'XPC_FLAGS': '0x0', 22:50:24 INFO - 'XPC_SERVICE_NAME': '0', 22:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jhrGGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:50:25 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)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-1xxWxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-noRtU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:50:25 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)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-l5iZTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-anKrPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:50:25 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)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jR2Uk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:50:25 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)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6BW0fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:50:25 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)) 22:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:50:25 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-FCyw6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6Ji4cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gtQ__x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-KLju_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-JqA79v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sq4eB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xpyEsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-r9PSxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-2USN6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:50:26 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)) 22:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:50:26 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QNs5iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:50:27 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)) 22:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:27 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)) 22:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:50:27 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 22:50:27 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 22:50:27 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 22:50:27 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 22:50:27 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 22:50:27 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 22:50:29 INFO - Downloading blessings-1.6.tar.gz 22:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:50:29 INFO - Installing collected packages: blessings 22:50:29 INFO - Running setup.py install for blessings 22:50:29 INFO - Successfully installed blessings 22:50:29 INFO - Cleaning up... 22:50:30 INFO - Return code: 0 22:50:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:50:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:50:30 INFO - Reading from file tmpfile_stdout 22:50:30 INFO - Current package versions: 22:50:30 INFO - blessings == 1.6 22:50:30 INFO - blobuploader == 1.2.4 22:50:30 INFO - docopt == 0.6.1 22:50:30 INFO - functools32 == 3.2.3-2 22:50:30 INFO - jsonschema == 2.5.1 22:50:30 INFO - manifestparser == 1.1 22:50:30 INFO - mozInstall == 1.12 22:50:30 INFO - mozcrash == 1.0 22:50:30 INFO - mozdebug == 0.1 22:50:30 INFO - mozdevice == 0.49 22:50:30 INFO - mozfile == 1.2 22:50:30 INFO - mozhttpd == 0.7 22:50:30 INFO - mozinfo == 0.9 22:50:30 INFO - mozleak == 0.1 22:50:30 INFO - mozlog == 3.4 22:50:30 INFO - moznetwork == 0.27 22:50:30 INFO - mozprocess == 0.23 22:50:30 INFO - mozprofile == 0.28 22:50:30 INFO - mozrunner == 6.13 22:50:30 INFO - mozscreenshot == 0.1 22:50:30 INFO - mozsystemmonitor == 0.3 22:50:30 INFO - moztest == 0.7 22:50:30 INFO - mozversion == 1.4 22:50:30 INFO - psutil == 3.1.1 22:50:30 INFO - requests == 1.2.3 22:50:30 INFO - wsgiref == 0.1.2 22:50:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:31 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:31 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 22:50:31 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 22:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:31 INFO - 'HOME': '/Users/cltbld', 22:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:31 INFO - 'LOGNAME': 'cltbld', 22:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:31 INFO - 'MOZ_NO_REMOTE': '1', 22:50:31 INFO - 'NO_EM_RESTART': '1', 22:50:31 INFO - 'PAGER': '/bin/cat', 22:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:31 INFO - 'PWD': '/builds/slave/test', 22:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:31 INFO - 'SHELL': '/bin/bash', 22:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:31 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:31 INFO - 'USER': 'cltbld', 22:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:31 INFO - 'XPC_FLAGS': '0x0', 22:50:31 INFO - 'XPC_SERVICE_NAME': '0', 22:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 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)) 22:50:31 INFO - Cleaning up... 22:50:31 INFO - Return code: 0 22:50:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:50: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')]} 22:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50: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')]} 22:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:31 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 0x10e4833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd001d700e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, '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.nHxGoO5EXb/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.UA08oWVDQf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 22:50:31 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 22:50:31 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 22:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:31 INFO - 'HOME': '/Users/cltbld', 22:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:31 INFO - 'LOGNAME': 'cltbld', 22:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:31 INFO - 'MOZ_NO_REMOTE': '1', 22:50:31 INFO - 'NO_EM_RESTART': '1', 22:50:31 INFO - 'PAGER': '/bin/cat', 22:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:31 INFO - 'PWD': '/builds/slave/test', 22:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:31 INFO - 'SHELL': '/bin/bash', 22:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:50:31 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:31 INFO - 'USER': 'cltbld', 22:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:31 INFO - 'XPC_FLAGS': '0x0', 22:50:31 INFO - 'XPC_SERVICE_NAME': '0', 22:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:50:32 INFO - Cleaning up... 22:50:32 INFO - Return code: 0 22:50:32 INFO - Running post-action listener: _resource_record_post_action 22:50:32 INFO - Running post-action listener: _start_resource_monitoring 22:50:32 INFO - Starting resource monitoring. 22:50:32 INFO - [mozharness: 2016-12-01 06:50:32.225899Z] Finished create-virtualenv step (success) 22:50:32 INFO - [mozharness: 2016-12-01 06:50:32.226850Z] Running install step. 22:50:32 INFO - Running pre-action listener: _resource_record_pre_action 22:50:32 INFO - Running main action method: install 22:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:50:32 INFO - Reading from file tmpfile_stdout 22:50:32 INFO - Detecting whether we're running mozinstall >=1.0... 22:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:50:32 INFO - Reading from file tmpfile_stdout 22:50:32 INFO - Output received: 22:50:32 INFO - Usage: mozinstall [options] installer 22:50:32 INFO - Options: 22:50:32 INFO - -h, --help show this help message and exit 22:50:32 INFO - -d DEST, --destination=DEST 22:50:32 INFO - Directory to install application into. [default: 22:50:32 INFO - "/builds/slave/test"] 22:50:32 INFO - --app=APP Application being installed. [default: firefox] 22:50:32 INFO - mkdir: /builds/slave/test/build/application 22:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:51:06 INFO - Reading from file tmpfile_stdout 22:51:06 INFO - Output received: 22:51:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:51:06 INFO - Running post-action listener: _resource_record_post_action 22:51:06 INFO - [mozharness: 2016-12-01 06:51:06.208753Z] Finished install step (success) 22:51:06 INFO - [mozharness: 2016-12-01 06:51:06.208907Z] Running run-tests step. 22:51:06 INFO - Running pre-action listener: _resource_record_pre_action 22:51:06 INFO - Running main action method: run_tests 22:51:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:51:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:51:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:51:06 INFO - 2016-11-30 22:51:06.223 screenresolution[1621:7740] starting screenresolution argv=screenresolution get 22:51:06 INFO - 2016-11-30 22:51:06.226 screenresolution[1621:7740] Display 0: 1600x1200x32@60 22:51:06 INFO - 2016-11-30 22:51:06.231 screenresolution[1622:7742] starting screenresolution argv=screenresolution list 22:51:06 INFO - Available Modes on Display 0 22:51:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:51:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:51:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:51:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:51:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:51:06 INFO - Intel Iris: 22:51:06 INFO - Chipset Model: Intel Iris 22:51:06 INFO - Type: GPU 22:51:06 INFO - Bus: Built-In 22:51:06 INFO - VRAM (Dynamic, Max): 1536 MB 22:51:06 INFO - Vendor: Intel (0x8086) 22:51:06 INFO - Device ID: 0x0a2e 22:51:06 INFO - Revision ID: 0x0009 22:51:06 INFO - Displays: 22:51:06 INFO - Display: 22:51:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:51:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:51:06 INFO - Display Serial Number: 1600x1200 60 22:51:06 INFO - Main Display: Yes 22:51:06 INFO - Mirror: Off 22:51:06 INFO - Online: Yes 22:51:06 INFO - Rotation: Supported 22:51:06 INFO - Return code: 0 22:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:51:06 INFO - Python 2.7.3 22:51:06 INFO - Return code: 0 22:51:06 INFO - grabbing minidump binary from tooltool 22:51: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')]} 22:51:06 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 0x10e299d30>, '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 0x10e100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e291b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:51:06 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 22:51:06 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 22:51:06 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 22:51:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:51:06 INFO - Return code: 0 22:51:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:51:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:51:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:51:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:51:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 22:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 22:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nHxGoO5EXb/Render', 22:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:51:06 INFO - 'HOME': '/Users/cltbld', 22:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:51:06 INFO - 'LOGNAME': 'cltbld', 22:51:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:51:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:06 INFO - 'MOZ_NO_REMOTE': '1', 22:51:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:51:06 INFO - 'NO_EM_RESTART': '1', 22:51:06 INFO - 'PAGER': '/bin/cat', 22:51:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:06 INFO - 'PWD': '/builds/slave/test', 22:51:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:51:06 INFO - 'SHELL': '/bin/bash', 22:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UA08oWVDQf/Listeners', 22:51:06 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 22:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:51:06 INFO - 'USER': 'cltbld', 22:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:06 INFO - 'XPC_FLAGS': '0x0', 22:51:06 INFO - 'XPC_SERVICE_NAME': '0', 22:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:51:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 22:51:06 INFO - mozversion application_buildid: 20161130195843 22:51:06 INFO - mozversion application_changeset: 2d3e477fd282afeeaf7f849c52aec99f509dbda0 22:51:06 INFO - mozversion application_display_name: Nightly 22:51:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:51:06 INFO - mozversion application_name: Firefox 22:51:06 INFO - mozversion application_remotingname: firefox 22:51:06 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 22:51:06 INFO - mozversion application_vendor: Mozilla 22:51:06 INFO - mozversion application_version: 53.0a1 22:51:06 INFO - mozversion platform_buildid: 20161130195843 22:51:06 INFO - mozversion platform_changeset: 2d3e477fd282afeeaf7f849c52aec99f509dbda0 22:51:06 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 22:51:06 INFO - mozversion platform_version: 53.0a1 22:51:06 INFO - using testdate: 1480575066 22:51:06 INFO - actual date: 1480575066 22:51:06 INFO - starting webserver on 'localhost:49246' 22:51:06 INFO - SUITE-START | Running 2 tests 22:51:06 INFO - TEST-START | dromaeo_css 22:51:06 INFO - operating with platform_type : mac_ 22:51:06 INFO - Initialising browser for dromaeo_css test... 22:51:06 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpm10b0i/profile http://localhost:49246/getInfo.html) 22:51:09 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 22:51:09 INFO - PROCESS | 1632 | colorDepth:24 22:51:09 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 22:51:09 INFO - PROCESS | 1632 | __metrics 22:51:09 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:51:09 INFO - PROCESS | 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:51:10 INFO - TEST-INFO | 1632: exit 0 22:51:10 INFO - Browser initialized. 22:51:10 INFO - Running cycle 1/1 for dromaeo_css test... 22:51:10 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpm10b0i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:51:22 INFO - PROCESS | 1634 | RSS: Main: 244899840 22:51:22 INFO - PROCESS | 1634 | 22:52:14 INFO - PROCESS | 1634 | 1480575134045 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] 22:54:27 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 22:54:29 INFO - PROCESS | 1634 | RSS: Main: 390045696 22:54:29 INFO - PROCESS | 1634 | 22:57:32 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 22:57:32 INFO - PROCESS | 1634 | RSS: Main: 373063680 22:57:32 INFO - PROCESS | 1634 | 23:00:35 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 23:00:36 INFO - PROCESS | 1634 | RSS: Main: 350208000 23:00:36 INFO - PROCESS | 1634 | 23:03:38 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 23:03:39 INFO - PROCESS | 1634 | RSS: Main: 344211456 23:03:39 INFO - PROCESS | 1634 | 23:06:42 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 23:06:43 INFO - PROCESS | 1634 | RSS: Main: 334417920 23:06:43 INFO - PROCESS | 1634 | 23:09:46 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 23:09:47 INFO - PROCESS | 1634 | RSS: Main: 382664704 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | __start_tp_report 23:09:47 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 23:09:47 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 23:09:47 INFO - PROCESS | 1634 | |i|pagename|runs| 23:09:47 INFO - PROCESS | 1634 | |0;dojo.html;3271.1658527075606;3306.5370848081266;3312.3540909522644;3326.3347330533898;3335.182880194351;5553.805616803413;5586.944130558693;5657.632253903504;5663.122216056513;5663.320401551814;5631.7184140793;5636.718164091789;5673.8581535461635;5687.772489100442;5730.398308177644;5071.746412679369;5074.517920797518;5170.715610641413;5178.948210517884;5190.221466779994;5113;5231.764570594332;5235.633505654606;5241.39723931747;5248.501392367719;5221.06020916235;5236.162214045753;5247.921281180786;5256.973715131438;5302.734863256841;5058.873528161788;5094.133997220481;5114.309568208281;5175.741212939376;5187.948120518784;5050.368703912011;5107.157319042353;5116;5126.512981266774;5132.640715149941;5543.695096769676;5628.887422251573;5638.323401191883;5644.717764111778;5686.829395118153;6179.691015449254;6179.907301390483;6188.535859810488;6190.783322583733;6193.597416167935;6241.812745617639;6256.749730010794;6257.812265632038;6264.404881536247;6275.968620156916;5580.748866301026;5582.939241544093;5711.171880077365;5762.250907382014;5788.942110578924;6214.471769899519;6237.220347456568;6243.562950593506;6296.087067375296;6349.873002539924;6051.334353221142;6070.1984909116145;6079.908801367983;6084.421979911901;6116.052011938156;6149.41580549847;6190.690465476709;6216.906746398808;6220.564560480813;6226.377362263737;5967.5524335675;6020.367861374581;6026.337102918763;6037.245344331958;6078.90881636767;6029.6683682397015;6104.755809767559;6110.205673262448;6118.293648225553;6129.693515324216;4823.324734537167;4825.348577942003;4831.73425461596;4843.927341089887;4873.122837889143;4326.091520780608;4330.41539392178;4348.543402942645;4381.978090109529;4420.31485119807;5649.378568357477;5660.915086273709;5671.064274394678;5717.514011309086;5727.541796656257;5223.7910483580235;6187.288461826947;6256.405641464054;6261.7182226799905;6284.528660350401;5709.628874123168;5712.11462223356;5725.8568535786935;5727.284089488814;5746.770129194785;4808.845876989428;5252.264682944391;5283.1546952487415;5294.020606187868;5304.469553044742;6122.418370254819;6264.185655864709;6330.272018717907;6333.429991300805;6338.461230795434;5183.429822719422;6076.33160352352;6261.436470717657;6272.153259310117;6285.622862628257;6204.72078756448;6234.781782637586;6277.591956522811;6277.654728989949;6356.4279214870885;4976.32819569368;6054.788082417094;6106.06632622643;6125.9693701531205;6134.130457564626;6106.297775755845;6195.597286176384;6230.190075290183;6253.718582663882;6254.030625253093;5861.6189947653265;6028.15605815195;6081.878362432815;6083.969580152071;6100.938990610037;4890.217565189552;4952.257161425815;5937.881242375215;5950.375210602824;6117.143599896107;5880.147378629989;5880.764769409176;5884.32330282023;5894.911576326273;5894.941050589439;5180.300659410931;6083.847903802441;6089.756409743561;6097.5731698780655;6099.11562823397;5719.113537401709;5726.226959360433;5774.971125144348;5816.923869084064;5822.796202132905 23:09:47 INFO - PROCESS | 1634 | |1;ext.html;459.6805220371842;480.1884814663221;502.8793089658483;504.19077380803816;510.87352387984475;28023.01919432818;31243.68756312436;31243.84378078109;38716.61283387165;39833;40927.59072409275;41220.793896030555;41317.380239296435;41355.79322103393;41423.58576414235;9221.95389023054;9378;9381.859272110923;9386.20217281532;9390.436573805559;8453.070162282174;8657.26413254874;9256.490893000882;10944.069754070873;11240.550377984871;11225.887741122608;11284.097272218203;11290.491927863224;11291.49188286525;11319.603813866517;9334.346595738301;11205.215634905479;11211.383373914432;11227.101831853432;11241.943790281079;8368.623411946477;8601.526916019617;9368.718938431857;9786.755331116708;10771.407572583505;38847;39157.41263881044;39183.21633567341;39217;39237.80381098105;2861.6566012078474;3251.040942921844;3296;3457.1184347991352;3868;28895.56656650152;28947.276318092005;29021.854890725623;29294.707052929625;29613.077503674624;3122.172624254574;3172.524121381788;3200;3210;3257.088015355704;349819;423968;434596;438304;441264;47601.76199119051;57088;57443.55338679693;57544.71227643835;57627.711861440424;60547.091793623134;60632.69683651553;60652.69673651692;60747;60868.39131608627;15133.092014479167;15335.463258785889;15352.616184595252;15355.462558810388;15408;10774.461276936121;11921.986631136277;11962.222455540363;11964.521419143312;11986.34075125859;14233.85766142346;15486.303116359792;15918.9204053979;16398.590035249214;16432.671346573003;5340.412554618989;6969.1985421676145;7035.50751447404;7039.964800176069;7047.647617619098;820.8932838730926;842.9662813487514;914.6524320758202;992.2310209587628;1048.7116043088213;27777.305567360978;28894.711052889623;29112.563311550344;29385.559216611768;29513.26216844553;1003.5233264199593;1022.3916769522123;1075.8601381820313;1083.4582708645678;1103.696483467053;14451.277436128361;15413.533834586413;15521.301541430663;15768.684626307639;16172.353105875869;592681;598987;606284;606803;612234;56093.71953140208;56321;56402.71798641063;56416;56443.153352699745;1299.6945717756319;1353.350391811916;1363.16165558181;1365.528892532075;1368.2816521326383;23310;23791.286261412184;28494.145175644764;29387;30237.848810755804;39149.80425097857;47800.7609961948;48117.03765924592;48177.03645926992;48197.75901120612;537044;541967.2901635467;542451;545743;545847;24638;24938.251852444457;24978.125765598117;25014.499710005333;25055.87472062628;44227.778861105486;45928;45988.31017534673;47393;48002.27996579984;29327.706722932497;34327.0412816753;35495.64504354924;37876.81061594674;38215.426768597936;36309.27381452409;36730.63269367272;36801.63198367982;37822.243555129295;37959;35397.938061858185;36807.26385472222;37096.25807483781;37320.6267937328;37369.25261494809;26881.82790432713;29523.55714664325;31160.53259201159;31190.908318209662;33585.32829343448;23399.947002385274;23821;24385.39036524101;25000.37499062538;25058.498830023662 23:09:47 INFO - PROCESS | 1634 | |2;jquery.html;328.2696001396892;344.52799664459695;364.9854005839765;370.92766910452457;397.2749731739576;14921.776173357408;15266.160361180131;17294.91352543237;19028.904855475703;20311.796882031176;19419;19514;19526.41420757376;19714.10006497725;19738;5470.261514695505;5511.366192887809;5782.826515204551;5841.737121829507;5905.055191169414;3710.3135919854913;5777.826665200051;5811.564132690044;5817.8836423271505;5834.824955251349;3839.232153569283;5437.238786569884;5663.943360566383;6420.486361091102;6439.22729272488;5715.571332150063;6368.840778980562;6378.84052898679;6421.999999999976;6446.838829029265;3675.081229692577;3878.7478813877005;3879.321118804226;5617.8033768817895;5627.296587926509;25176.748232517624;26376;26521.46957060848;27077.1876843695;27315;2192.6272533669317;2357.976420235793;2367.183321753992;2505.8747062646976;3177.3009937813645;15020.774688379683;15213.771793423108;15354.769678454832;15808.92095539515;16742.24659890308;1894.6873765828623;1906.494778883597;1940.7282980382759;1965.3317871923614;2021.7472815898013;124622;133614;134194;140461.2976935119;140543;18472;19794.70307945382;20146.89926550358;20331.796682033288;20374.28689995843;27346.179614611592;34089.31821363559;34319;34325.97022089341;34384.82807585946;9955.601775929026;10084.647037353658;10256.230782691327;10292.125169360539;10441.269111162146;8387.664493420194;8397.6221070052;8401.95799021001;8541.743747687578;8573.18554737299;7557.773266802004;9052.909470905339;9273.536323183815;9316.580753866092;9349.345545811864;2916.941661166765;3530.7881527107943;3623.873164439232;3653.5615726112505;3730.7015438764834;758.8178837079062;778.6534991928537;810.5055915891302;961.2694352292308;984.8522721591676;20113.698294525595;20360.6585242699;20536.486587835425;21210.36368908935;21306.680399794015;774.2567135549823;884.540039179623;888.2760550151605;892.4888811588415;922.9123233292827;10065.547050382751;10754.354738715545;10846.457677116112;10913.781724365626;10943.83584246237;499123;499357;527522;564019;569731;102602.46096308561;122800.38599807123;124336.75663243432;124567.37716311542;125390;977.5258999385293;991.0881988570533;1015.6902144845745;1018.495844556949;1019.576875596634;15042.473513426978;18279.36022239215;18296.993665348535;18466.076696165408;18782;52969.470305296454;53660.73169634127;54413.72793136009;54437.45562544324;54881;79820.60089699514;80305.19694802977;81569.59215203887;82704.58647706964;82814.17185828305;7607.619619018917;7748.65131069092;7885;7970.2826745593175;8013.799655008438;10055.446950417505;10703.785924281627;12238.143329967173;12437.129400941847;12525.56160534377;10600.25798194119;10635.734106647396;10917.781644366909;11002.669919902415;11013.944930275296;9809.362391444532;10494.527746251284;10568.841467377842;10776.461176941279;11001.22991390595;10825.350478971286;11052.778944421227;11111.00000999914;11198;11206.551737930391;7719.575423351769;7902.723404680809;7903.3677305816545;7954.403419743427;8119.4722343047515;5386.542143917811;6383.297837237993;8087.514749115072;10321.432321222404;10360.689179324632 23:09:47 INFO - PROCESS | 1634 | |3;mootools.html;1354.1536539662711;1465.9413623455061;1493.970120597588;1820.8907465552059;1846.2338129676193;7861.803454913623;8264.33885289177;8270.21432963869;8272.296854767344;8277.83444331113;7254.818629534251;7532.698692052311;7533.9246607533905;7893.644785984645;8066.3546916246705;2246.955060898781;2281.041962375806;2284.8971796269207;2286.8856557172076;2292.988535057322;2298.310506847947;2315.340128063502;2335.544568809083;2335.6730057791924;2344.074090734159;2261.6155253606926;2266.637338025916;2301.079568172736;2302.0446514696464;2306.238941149425;2259.378670865509;2262.3552287597954;2282.3267136194695;2287.0394434337536;2287.9199228027105;2284.303287497313;2303.2859813457712;2304.066852924568;2306.331163962466;2313.1210140146636;8097.392695547857;8117.269445749852;8160.836783264302;8163.0612479564425;8192.836143277102;4166.375043743433;5107.157319042353;5110.6422550421485;5112.565431938289;5116.565091967187;3161.1306890605038;3269.4661637231334;3486.790792552455;3509.3683137035578;3510.701590364822;1035.3735989726258;1035.9326643768131;1062.7502536903899;1080.0549519170725;1085.4138765066855;10501.317414368117;10598.78802423955;10646.733831654194;10655.413952232624;10675.626353077605;4437.600615944516;4494.842680506232;4645.721256724607;4661.86014419568;4674.766261686902;9159.542022898828;9161.954190229006;9173.58718857653;9178.35751497402;9189.356745027784;5111.05445492585;5119.334486516804;5129.076766182048;5137.40919794221;5148.382194136728;4143.772092534879;4213.599708027732;4384.101259241847;4618.584327410549;4654.511276315938;3623.927521449609;3665.706743460517;3732.9813350933073;3770.830312635938;3782.451544526028;1058.51837413978;1122.074288711816;1232.8458942632171;1236.6908272931767;1243.993780031094;766.4366690482491;862.719616124762;871.2681347667989;911.4804561399939;923.132255679659;5497.312835895513;5549.556035517149;5637.182608521742;5757.712114394263;6053.27360716708;890.496869268861;931.5575101826578;960.2414092866696;980.1472718734603;997.7156510394648;3757.5866654667966;3758.398656215047;3831.942520862189;3865.7436333191263;3875.2830726315724;7746.961265193638;9953.153981911619;9971.900280997243;9983.700488985342;10033.247506437046;9279.814403711887;9747.756306092404;9749.512524373895;9918.05778451046;9921.603135874628;7477.401807855358;7701.345385642283;7705.807354816175;7705.961470192725;7775.57234352116;5429.972850135724;5432.891342173055;5459.399466058651;5655.095184770417;5762.337331206965;9177.174054335143;9254.768630784285;9270.072992700676;9278.768030799014;9290.535473226448;8375.581220938806;8933.731988040368;9166.17504424605;9368.625254989724;9470.289728270269;6038.728257228523;6358.268799088164;6790.93209067903;6984.196817366068;7151.177614574182;7714.691412343668;7829.921700782919;7832.177621349676;7837.960810195913;7855.33229675484;6111.266648002268;6906.343897329745;7023.964880175567;7033.120859892513;7187.281271872771;6899;6910.20532638753;6941.062956500808;6959.338862808025;7029.367356937695;6444.162258906312;6511.413972742476;6589.110470086477;6605.702743376463;6609.372109649576;4748.525147485224;4785.066911952275;4791.712497250176;4817.843717507843;4943.30793688891;4764.8332308369045;4771.093492236464;4819.1566475867285;4929.334539837219;5024.773885175103 23:09:47 INFO - PROCESS | 1634 | |4;prototype.html;282.2830011770104;287.42945253671456;300.7864416264452;307.5417627734676;316.7925009119028;4336.132773445315;5181;5248.722291332561;5273.472652734725;5287.339082614673;4091.774952377618;4917.090338287419;5067.417247016594;5074.3657042869645;5158.3552055993005;3980.2835489611857;4012.2376748417782;4047.8178481968234;4053.5541090480024;4058.8579399721016;4002.859185132238;4024.5774193709676;4025.8993525161814;4056.5943405659345;4065.7560546367163;3688.0196720984354;3980.661643760284;3982.661473774718;3989.840406383741;4014.6988975826785;3524.665156810099;3748.306563285774;3954.6272236658065;4017.196560687845;4031.113155105872;3509.596396414394;3512.0517460285837;3517.2262102337445;3517.8944631661093;3529.8411571479346;4339.913201735948;4414.955850441519;4780.928286075712;4926.827561035382;5093.23601459784;3807.3146833569945;4193.937090943638;4501.324801279834;4559.886002849922;4572.862814115582;4345;4926.753662316905;5419.566434685215;5422.6475279106735;5451.563874889999;3254.869805207789;3460.653934606544;3621.420572708354;3817.3701339279264;3823.3500304947947;5123.795048198068;5323.973380133113;5637.605367624268;5661.46216109469;5733.856653583611;3267.8529466174077;3906.882793516199;3909.6285852843935;3910.963594647421;3914.3932690432457;3364.7139993100373;3461.688448039638;3871.632194941476;3957.6635985941516;3984.7011474139554;4158.854440094582;4387.627051700578;4438.646212905031;4576.222042252825;4579.290210017452;5231.869203269949;5499.370415525734;5531.585131115183;5539.335279766373;5541.722913854291;1212.42409855318;1222.8260869565318;1258.641287233134;1283.608499407671;1289.664687181321;720.459655258556;841.54556539468;868.6351732272461;887.1261807119981;902.6073657958809;4332.8985442060575;4802.8799280018275;4918.95081049185;4931.950680493221;4939.641598560424;4483.932741008887;4750.548697873696;4918.458969513351;5345.946540534623;5397.514223719884;4146.688998325138;4347.369736348869;4359.04101097758;4718.811247550128;4820.662553621283;2491.5515207262506;2525.8989640414543;2754.746590301408;2791.7158107270475;2794.8479670653483;4800.871795128142;5036.924446133311;5073.093717837245;5083.72039537829;5506.366767821752;4822.903541929142;5140.331756871583;5151.447826408917;5444.3194600674915;5464.371597266286;5229.581633469237;5501.064818980783;5514.862128446821;5527.613067085265;5539.5014448699;4586.289125185602;4996.351933475264;5050.3434553507805;5287.8149264777085;5302.9659216453965;4253.893987563318;5052.595792336678;5054.924176137434;5228.248536740235;5250.238715386171;4856.1987272099705;5244.737763111905;5357.866053348697;5371.597130215171;5504.9449505504435;3157.8105313681253;3656.884650181614;3658.7255955803953;3685.336639404933;3693.6306369362846;4346.195953748566;4406.339049142654;5075.132550109177;5186.351706036746;5348.384935732285;4742.905141897212;5138.845834624967;5155.896882062263;5168.302279192261;5169.327987361769;4872.3909511311085;5156.819511317086;5158.406783219978;5179.92230116541;5201.396763863932;4522.457305123275;4729.810807567659;4906.386701662293;4989.700617962933;5063.215201643751;4350.9347359789;5304.681719096867;5327.856564626733;5350.545203657733;5468.535174510212;4533.886652833706;5329.813456529003;5348.545373643284;5361.249425080414;5407.2970513834525 23:09:47 INFO - PROCESS | 1634 | |5;yui.html;670.2761018100449;682.9146356705412;708.9012031351406;722.2632914427285;798.4730078148423;14487.927560362197;15063.09621422714;15071.397144114222;15092.924535377322;15123.77314340283;13584.660383490418;14038.508652197175;14648.901332400059;14693.485727999521;14766;707.8053535277814;823.4935514658501;844.6452489954233;846.3905987688854;848.0544193224572;661.3750006244102;684.7363764950505;686.6360828760764;806.2421323955492;818.7830224990382;883.266888482558;886.0342226972599;887.1793590928365;887.4941283468426;887.9556022198897;881.1628952495155;881.8456770065213;882.2280504558511;882.960266787996;883.1654086887894;505.2749304747662;523.808809784426;527.2118183315929;530.3397270398378;653.7875190563038;12475.875241247562;14445.78331325031;14966.326515306728;14968.550943471713;15347.539573812803;12480.126391152622;13725.313734313344;13878.861211387857;13933.512327068605;13942.512012079529;10680.893191068146;11789.882101178964;11816.231944923553;12025.338606376647;12399.194052386567;3623.40213864712;3676.8397870256767;3681.871134510306;3709.0356507308293;3717.498137751396;111659;114122.42938785336;114709;117707;118568;10376.16990640747;10593.947030264953;10637.893621063846;10665.146788256921;10919.836202456969;21099;21408.892955535433;21416.678749818766;21433.67849482259;21687.56624867494;7463.253674632602;7519.436042296849;7535.321821036024;7581.166071732105;7600.391968642495;4200.936985945214;4225.619694227535;4253.106847561985;4277.957220427756;4316.223079845658;3414.6756058174433;3489.180042689966;3553.129483276562;3554.680078792921;3556.5020897074432;628.9716962736687;637.7385272038534;641.1056576076347;647.6891092275735;659.446065305146;575.8387651457599;623.7894214055128;645.6578013652771;649.6329573790794;654.5974225851068;9231.676891308773;9248.815023699488;9354.579043943038;9365;9620.037996200324;567.4722508067537;628.1614045249643;649.8407890066964;650.3009265040101;664.6842749693953;4366.282595512434;4571.47428045779;4586.289125185602;4594.218982772936;4656;76848;78661.60669196617;79576;99493.50253248688;121555;85078.72381914276;87129.56435217784;89726.55136724275;90568.09431905729;95848.10202520735;65811;83702.3038156946;84091.5795421019;84180;86343.56828215944;9585.760355991157;9680.709578712649;9695.806083878142;9708.271879608916;9720.659776907774;50703;52536.73731631317;52681.736591316796;53431;54115.72942135264;68030;72711;73423.63288183525;73688.63155684188;75486.86769698569;12242.877571224173;12516.812247816471;12719;13299.800502992657;13303.667408314483;14222.075565088237;14632.926835365755;14772.33524491379;14828.43933524928;14828.555143345717;13219.66950826237;13481.662958426117;13536.255505946874;13559.525416610371;14261.215633140277;13190.868091319348;13428.93285533566;13542.932285338511;13751.862481375058;13776.517821876187;12807.93596032014;13003;13388.928885689316;13445;13680.65798355049;10988.615398461016;11214.271072380268;11500;11802.645920622395;11819.763604727685;9108.681196158102;10711.785764284827;11078;11363.772724545628;11435.371054592077 23:09:47 INFO - PROCESS | 1634 | __end_tp_report 23:09:47 INFO - PROCESS | 1634 | __start_cc_report 23:09:47 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1644 23:09:47 INFO - PROCESS | 1634 | __end_cc_report 23:09:47 INFO - PROCESS | 1634 | __startTimestamp1480576187101__endTimestamp 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | ------- Summary: start ------- 23:09:47 INFO - PROCESS | 1634 | Number of tests: 6 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5652.76 Median:5774.97 stddev:649.79 (11.3%) stddev-sans-first:624.35 23:09:47 INFO - PROCESS | 1634 | Values: 3271.2 3306.5 3312.4 3326.3 3335.2 5553.8 5586.9 5657.6 5663.1 5663.3 5631.7 5636.7 5673.9 5687.8 5730.4 5071.7 5074.5 5170.7 5178.9 5190.2 5113.0 5231.8 5235.6 5241.4 5248.5 5221.1 5236.2 5247.9 5257.0 5302.7 5058.9 5094.1 5114.3 5175.7 5187.9 5050.4 5107.2 5116.0 5126.5 5132.6 5543.7 5628.9 5638.3 5644.7 5686.8 6179.7 6179.9 6188.5 6190.8 6193.6 6241.8 6256.7 6257.8 6264.4 6276.0 5580.7 5582.9 5711.2 5762.3 5788.9 6214.5 6237.2 6243.6 6296.1 6349.9 6051.3 6070.2 6079.9 6084.4 6116.1 6149.4 6190.7 6216.9 6220.6 6226.4 5967.6 6020.4 6026.3 6037.2 6078.9 6029.7 6104.8 6110.2 6118.3 6129.7 4823.3 4825.3 4831.7 4843.9 4873.1 4326.1 4330.4 4348.5 4382.0 4420.3 5649.4 5660.9 5671.1 5717.5 5727.5 5223.8 6187.3 6256.4 6261.7 6284.5 5709.6 5712.1 5725.9 5727.3 5746.8 4808.8 5252.3 5283.2 5294.0 5304.5 6122.4 6264.2 6330.3 6333.4 6338.5 5183.4 6076.3 6261.4 6272.2 6285.6 6204.7 6234.8 6277.6 6277.7 6356.4 4976.3 6054.8 6106.1 6126.0 6134.1 6106.3 6195.6 6230.2 6253.7 6254.0 5861.6 6028.2 6081.9 6084.0 6100.9 4890.2 4952.3 5937.9 5950.4 6117.1 5880.1 5880.8 5884.3 5894.9 5894.9 5180.3 6083.8 6089.8 6097.6 6099.1 5719.1 5726.2 5775.0 5816.9 5822.8 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:65069.95 Median:36519.95 stddev:140862.14 (385.7%) stddev-sans-first:141173.76 23:09:47 INFO - PROCESS | 1634 | Values: 459.7 480.2 502.9 504.2 510.9 28023.0 31243.7 31243.8 38716.6 39833.0 40927.6 41220.8 41317.4 41355.8 41423.6 9222.0 9378.0 9381.9 9386.2 9390.4 8453.1 8657.3 9256.5 10944.1 11240.6 11225.9 11284.1 11290.5 11291.5 11319.6 9334.3 11205.2 11211.4 11227.1 11241.9 8368.6 8601.5 9368.7 9786.8 10771.4 38847.0 39157.4 39183.2 39217.0 39237.8 2861.7 3251.0 3296.0 3457.1 3868.0 28895.6 28947.3 29021.9 29294.7 29613.1 3122.2 3172.5 3200.0 3210.0 3257.1 349819.0 423968.0 434596.0 438304.0 441264.0 47601.8 57088.0 57443.6 57544.7 57627.7 60547.1 60632.7 60652.7 60747.0 60868.4 15133.1 15335.5 15352.6 15355.5 15408.0 10774.5 11922.0 11962.2 11964.5 11986.3 14233.9 15486.3 15918.9 16398.6 16432.7 5340.4 6969.2 7035.5 7040.0 7047.6 820.9 843.0 914.7 992.2 1048.7 27777.3 28894.7 29112.6 29385.6 29513.3 1003.5 1022.4 1075.9 1083.5 1103.7 14451.3 15413.5 15521.3 15768.7 16172.4 592681.0 598987.0 606284.0 606803.0 612234.0 56093.7 56321.0 56402.7 56416.0 56443.2 1299.7 1353.4 1363.2 1365.5 1368.3 23310.0 23791.3 28494.1 29387.0 30237.8 39149.8 47800.8 48117.0 48177.0 48197.8 537044.0 541967.3 542451.0 545743.0 545847.0 24638.0 24938.3 24978.1 25014.5 25055.9 44227.8 45928.0 45988.3 47393.0 48002.3 29327.7 34327.0 35495.6 37876.8 38215.4 36309.3 36730.6 36801.6 37822.2 37959.0 35397.9 36807.3 37096.3 37320.6 37369.3 26881.8 29523.6 31160.5 31190.9 33585.3 23399.9 23821.0 24385.4 25000.4 25058.5 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:34362.62 Median:17208.79 stddev:89797.71 (521.8%) stddev-sans-first:90013.25 23:09:47 INFO - PROCESS | 1634 | Values: 328.3 344.5 365.0 370.9 397.3 14921.8 15266.2 17294.9 19028.9 20311.8 19419.0 19514.0 19526.4 19714.1 19738.0 5470.3 5511.4 5782.8 5841.7 5905.1 3710.3 5777.8 5811.6 5817.9 5834.8 3839.2 5437.2 5663.9 6420.5 6439.2 5715.6 6368.8 6378.8 6422.0 6446.8 3675.1 3878.7 3879.3 5617.8 5627.3 25176.7 26376.0 26521.5 27077.2 27315.0 2192.6 2358.0 2367.2 2505.9 3177.3 15020.8 15213.8 15354.8 15808.9 16742.2 1894.7 1906.5 1940.7 1965.3 2021.7 124622.0 133614.0 134194.0 140461.3 140543.0 18472.0 19794.7 20146.9 20331.8 20374.3 27346.2 34089.3 34319.0 34326.0 34384.8 9955.6 10084.6 10256.2 10292.1 10441.3 8387.7 8397.6 8402.0 8541.7 8573.2 7557.8 9052.9 9273.5 9316.6 9349.3 2916.9 3530.8 3623.9 3653.6 3730.7 758.8 778.7 810.5 961.3 984.9 20113.7 20360.7 20536.5 21210.4 21306.7 774.3 884.5 888.3 892.5 922.9 10065.5 10754.4 10846.5 10913.8 10943.8 499123.0 499357.0 527522.0 564019.0 569731.0 102602.5 122800.4 124336.8 124567.4 125390.0 977.5 991.1 1015.7 1018.5 1019.6 15042.5 18279.4 18297.0 18466.1 18782.0 52969.5 53660.7 54413.7 54437.5 54881.0 79820.6 80305.2 81569.6 82704.6 82814.2 7607.6 7748.7 7885.0 7970.3 8013.8 10055.4 10703.8 12238.1 12437.1 12525.6 10600.3 10635.7 10917.8 11002.7 11013.9 9809.4 10494.5 10568.8 10776.5 11001.2 10825.4 11052.8 11111.0 11198.0 11206.6 7719.6 7902.7 7903.4 7954.4 8119.5 5386.5 6383.3 8087.5 10321.4 10360.7 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5329.73 Median:5289.18 stddev:2884.05 (54.5%) stddev-sans-first:2876.67 23:09:47 INFO - PROCESS | 1634 | Values: 1354.2 1465.9 1494.0 1820.9 1846.2 7861.8 8264.3 8270.2 8272.3 8277.8 7254.8 7532.7 7533.9 7893.6 8066.4 2247.0 2281.0 2284.9 2286.9 2293.0 2298.3 2315.3 2335.5 2335.7 2344.1 2261.6 2266.6 2301.1 2302.0 2306.2 2259.4 2262.4 2282.3 2287.0 2287.9 2284.3 2303.3 2304.1 2306.3 2313.1 8097.4 8117.3 8160.8 8163.1 8192.8 4166.4 5107.2 5110.6 5112.6 5116.6 3161.1 3269.5 3486.8 3509.4 3510.7 1035.4 1035.9 1062.8 1080.1 1085.4 10501.3 10598.8 10646.7 10655.4 10675.6 4437.6 4494.8 4645.7 4661.9 4674.8 9159.5 9162.0 9173.6 9178.4 9189.4 5111.1 5119.3 5129.1 5137.4 5148.4 4143.8 4213.6 4384.1 4618.6 4654.5 3623.9 3665.7 3733.0 3770.8 3782.5 1058.5 1122.1 1232.8 1236.7 1244.0 766.4 862.7 871.3 911.5 923.1 5497.3 5549.6 5637.2 5757.7 6053.3 890.5 931.6 960.2 980.1 997.7 3757.6 3758.4 3831.9 3865.7 3875.3 7747.0 9953.2 9971.9 9983.7 10033.2 9279.8 9747.8 9749.5 9918.1 9921.6 7477.4 7701.3 7705.8 7706.0 7775.6 5430.0 5432.9 5459.4 5655.1 5762.3 9177.2 9254.8 9270.1 9278.8 9290.5 8375.6 8933.7 9166.2 9368.6 9470.3 6038.7 6358.3 6790.9 6984.2 7151.2 7714.7 7829.9 7832.2 7838.0 7855.3 6111.3 6906.3 7024.0 7033.1 7187.3 6899.0 6910.2 6941.1 6959.3 7029.4 6444.2 6511.4 6589.1 6605.7 6609.4 4748.5 4785.1 4791.7 4817.8 4943.3 4764.8 4771.1 4819.2 4929.3 5024.8 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4281.55 Median:4765.74 stddev:1275.20 (26.8%) stddev-sans-first:1242.94 23:09:47 INFO - PROCESS | 1634 | Values: 282.3 287.4 300.8 307.5 316.8 4336.1 5181.0 5248.7 5273.5 5287.3 4091.8 4917.1 5067.4 5074.4 5158.4 3980.3 4012.2 4047.8 4053.6 4058.9 4002.9 4024.6 4025.9 4056.6 4065.8 3688.0 3980.7 3982.7 3989.8 4014.7 3524.7 3748.3 3954.6 4017.2 4031.1 3509.6 3512.1 3517.2 3517.9 3529.8 4339.9 4415.0 4780.9 4926.8 5093.2 3807.3 4193.9 4501.3 4559.9 4572.9 4345.0 4926.8 5419.6 5422.6 5451.6 3254.9 3460.7 3621.4 3817.4 3823.4 5123.8 5324.0 5637.6 5661.5 5733.9 3267.9 3906.9 3909.6 3911.0 3914.4 3364.7 3461.7 3871.6 3957.7 3984.7 4158.9 4387.6 4438.6 4576.2 4579.3 5231.9 5499.4 5531.6 5539.3 5541.7 1212.4 1222.8 1258.6 1283.6 1289.7 720.5 841.5 868.6 887.1 902.6 4332.9 4802.9 4919.0 4932.0 4939.6 4483.9 4750.5 4918.5 5345.9 5397.5 4146.7 4347.4 4359.0 4718.8 4820.7 2491.6 2525.9 2754.7 2791.7 2794.8 4800.9 5036.9 5073.1 5083.7 5506.4 4822.9 5140.3 5151.4 5444.3 5464.4 5229.6 5501.1 5514.9 5527.6 5539.5 4586.3 4996.4 5050.3 5287.8 5303.0 4253.9 5052.6 5054.9 5228.2 5250.2 4856.2 5244.7 5357.9 5371.6 5504.9 3157.8 3656.9 3658.7 3685.3 3693.6 4346.2 4406.3 5075.1 5186.4 5348.4 4742.9 5138.8 5155.9 5168.3 5169.3 4872.4 5156.8 5158.4 5179.9 5201.4 4522.5 4729.8 4906.4 4989.7 5063.2 4350.9 5304.7 5327.9 5350.5 5468.5 4533.9 5329.8 5348.5 5361.2 5407.3 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20631.63 Median:4468.88 stddev:30051.96 (672.5%) stddev-sans-first:30098.88 23:09:47 INFO - PROCESS | 1634 | Values: 670.3 682.9 708.9 722.3 798.5 14487.9 15063.1 15071.4 15092.9 15123.8 13584.7 14038.5 14648.9 14693.5 14766.0 707.8 823.5 844.6 846.4 848.1 661.4 684.7 686.6 806.2 818.8 883.3 886.0 887.2 887.5 888.0 881.2 881.8 882.2 883.0 883.2 505.3 523.8 527.2 530.3 653.8 12475.9 14445.8 14966.3 14968.6 15347.5 12480.1 13725.3 13878.9 13933.5 13942.5 10680.9 11789.9 11816.2 12025.3 12399.2 3623.4 3676.8 3681.9 3709.0 3717.5 111659.0 114122.4 114709.0 117707.0 118568.0 10376.2 10593.9 10637.9 10665.1 10919.8 21099.0 21408.9 21416.7 21433.7 21687.6 7463.3 7519.4 7535.3 7581.2 7600.4 4200.9 4225.6 4253.1 4278.0 4316.2 3414.7 3489.2 3553.1 3554.7 3556.5 629.0 637.7 641.1 647.7 659.4 575.8 623.8 645.7 649.6 654.6 9231.7 9248.8 9354.6 9365.0 9620.0 567.5 628.2 649.8 650.3 664.7 4366.3 4571.5 4586.3 4594.2 4656.0 76848.0 78661.6 79576.0 99493.5 121555.0 85078.7 87129.6 89726.6 90568.1 95848.1 65811.0 83702.3 84091.6 84180.0 86343.6 9585.8 9680.7 9695.8 9708.3 9720.7 50703.0 52536.7 52681.7 53431.0 54115.7 68030.0 72711.0 73423.6 73688.6 75486.9 12242.9 12516.8 12719.0 13299.8 13303.7 14222.1 14632.9 14772.3 14828.4 14828.6 13219.7 13481.7 13536.3 13559.5 14261.2 13190.9 13428.9 13542.9 13751.9 13776.5 12807.9 13003.0 13388.9 13445.0 13680.7 10988.6 11214.3 11500.0 11802.6 11819.8 9108.7 10711.8 11078.0 11363.8 11435.4 23:09:47 INFO - PROCESS | 1634 | -------- Summary: end -------- 23:09:47 INFO - PROCESS | 1634 | 23:09:47 INFO - TEST-INFO | 1634: exit 0 23:09:47 INFO - TEST-OK | dromaeo_css | took 1121017ms 23:09:47 INFO - TEST-START | kraken 23:09:47 INFO - operating with platform_type : mac_ 23:09:47 INFO - Initialising browser for kraken test... 23:09:47 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpM9Gb7X/profile http://localhost:49246/getInfo.html) 23:09:50 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 23:09:50 INFO - PROCESS | 1643 | colorDepth:24 23:09:50 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 23:09:50 INFO - PROCESS | 1643 | __metrics 23:09:50 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:09:50 INFO - PROCESS | 1643 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:09:51 INFO - TEST-INFO | 1643: exit 0 23:09:51 INFO - Browser initialized. 23:09:51 INFO - Running cycle 1/1 for kraken test... 23:09:51 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpM9Gb7X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:03 INFO - PROCESS | 1644 | RSS: Main: 244994048 23:10:03 INFO - PROCESS | 1644 | 23:10:06 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 23:10:07 INFO - PROCESS | 1644 | RSS: Main: 296751104 23:10:07 INFO - PROCESS | 1644 | 23:10:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 23:10:10 INFO - PROCESS | 1644 | RSS: Main: 297574400 23:10:10 INFO - PROCESS | 1644 | 23:10:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 23:10:14 INFO - PROCESS | 1644 | RSS: Main: 389496832 23:10:14 INFO - PROCESS | 1644 | 23:10:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 23:10:17 INFO - PROCESS | 1644 | RSS: Main: 289087488 23:10:17 INFO - PROCESS | 1644 | 23:10:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:10:19 INFO - PROCESS | 1644 | RSS: Main: 292622336 23:10:19 INFO - PROCESS | 1644 | 23:10:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 23:10:23 INFO - PROCESS | 1644 | RSS: Main: 335122432 23:10:23 INFO - PROCESS | 1644 | 23:10:26 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 23:10:26 INFO - PROCESS | 1644 | RSS: Main: 336723968 23:10:26 INFO - PROCESS | 1644 | 23:10:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 23:10:30 INFO - PROCESS | 1644 | RSS: Main: 332877824 23:10:30 INFO - PROCESS | 1644 | 23:10:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:10:32 INFO - PROCESS | 1644 | RSS: Main: 310181888 23:10:32 INFO - PROCESS | 1644 | 23:10:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:10:35 INFO - PROCESS | 1644 | RSS: Main: 312643584 23:10:35 INFO - PROCESS | 1644 | 23:10:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:10:37 INFO - PROCESS | 1644 | RSS: Main: 314802176 23:10:37 INFO - PROCESS | 1644 | 23:10:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:10:41 INFO - PROCESS | 1644 | RSS: Main: 334544896 23:10:41 INFO - PROCESS | 1644 | 23:10:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:10:45 INFO - PROCESS | 1644 | RSS: Main: 328802304 23:10:45 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 23:10:47 INFO - PROCESS | 1644 | RSS: Main: 373207040 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | __start_tp_report 23:10:47 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 23:10:47 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 23:10:47 INFO - PROCESS | 1644 | |i|pagename|runs| 23:10:47 INFO - PROCESS | 1644 | |0;ai-astar;112;114;114;114;113;113;119;169;161;113 23:10:47 INFO - PROCESS | 1644 | |1;audio-beat-detection;150;137;145;184;146;114;117;114;138;112 23:10:47 INFO - PROCESS | 1644 | |2;audio-dft;183;183;186;186;181;182;186;181;184;184 23:10:47 INFO - PROCESS | 1644 | |3;audio-fft;79;58;63;114;95;76;59;58;74;59 23:10:47 INFO - PROCESS | 1644 | |4;audio-oscillator;85;70;86;70;68;69;81;68;69;82 23:10:47 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;90;87;91;87;90;86;90;87;90;87 23:10:47 INFO - PROCESS | 1644 | |6;imaging-darkroom;95;95;95;96;95;95;95;99;143;150 23:10:47 INFO - PROCESS | 1644 | |7;imaging-desaturate;88;87;86;88;86;87;86;85;87;87 23:10:47 INFO - PROCESS | 1644 | |8;json-parse-financial;58;54;54;54;56;57;56;56;56;56 23:10:47 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;68;73;76;73;72;70;71;72;71;72 23:10:47 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;95;106;88;86;89;89;85;87;88;87 23:10:47 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;150;157;154;149;146;146;149;146;196;148 23:10:47 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;175;174;174;174;174;179;243;239;175;176 23:10:47 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;64;70;70;70;62;63;86;89;87;69 23:10:47 INFO - PROCESS | 1644 | __end_tp_report 23:10:47 INFO - PROCESS | 1644 | __start_cc_report 23:10:47 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1963 23:10:47 INFO - PROCESS | 1644 | __end_cc_report 23:10:47 INFO - PROCESS | 1644 | __startTimestamp1480576247449__endTimestamp 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | ------- Summary: start ------- 23:10:47 INFO - PROCESS | 1644 | Number of tests: 14 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:124.20 Median:114.00 stddev:21.67 (19.0%) stddev-sans-first:22.53 23:10:47 INFO - PROCESS | 1644 | Values: 112.0 114.0 114.0 114.0 113.0 113.0 119.0 169.0 161.0 113.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:141.50 stddev:22.58 (16.0%) stddev-sans-first:23.35 23:10:47 INFO - PROCESS | 1644 | Values: 150.0 137.0 145.0 184.0 146.0 114.0 117.0 114.0 138.0 112.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.96 (1.1%) stddev-sans-first:2.06 23:10:47 INFO - PROCESS | 1644 | Values: 183.0 183.0 186.0 186.0 181.0 182.0 186.0 181.0 184.0 184.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:73.50 Median:68.50 stddev:18.71 (27.3%) stddev-sans-first:19.74 23:10:47 INFO - PROCESS | 1644 | Values: 79.0 58.0 63.0 114.0 95.0 76.0 59.0 58.0 74.0 59.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.50 stddev:7.64 (10.1%) stddev-sans-first:7.16 23:10:47 INFO - PROCESS | 1644 | Values: 85.0 70.0 86.0 70.0 68.0 69.0 81.0 68.0 69.0 82.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:90.00 stddev:1.84 (2.0%) stddev-sans-first:1.87 23:10:47 INFO - PROCESS | 1644 | Values: 90.0 87.0 91.0 87.0 90.0 86.0 90.0 87.0 90.0 87.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:95.00 stddev:21.55 (22.7%) stddev-sans-first:22.50 23:10:47 INFO - PROCESS | 1644 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 99.0 143.0 150.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 23:10:47 INFO - PROCESS | 1644 | Values: 88.0 87.0 86.0 88.0 86.0 87.0 86.0 85.0 87.0 87.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.34 (2.4%) stddev-sans-first:1.13 23:10:47 INFO - PROCESS | 1644 | Values: 58.0 54.0 54.0 54.0 56.0 57.0 56.0 56.0 56.0 56.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:2.10 (2.9%) stddev-sans-first:1.72 23:10:47 INFO - PROCESS | 1644 | Values: 68.0 73.0 76.0 73.0 72.0 70.0 71.0 72.0 71.0 72.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:88.00 stddev:6.24 (7.1%) stddev-sans-first:6.35 23:10:47 INFO - PROCESS | 1644 | Values: 95.0 106.0 88.0 86.0 89.0 89.0 85.0 87.0 88.0 87.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:149.50 stddev:15.15 (10.1%) stddev-sans-first:16.00 23:10:47 INFO - PROCESS | 1644 | Values: 150.0 157.0 154.0 149.0 146.0 146.0 149.0 146.0 196.0 148.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.30 Median:175.50 stddev:27.83 (15.9%) stddev-sans-first:29.10 23:10:47 INFO - PROCESS | 1644 | Values: 175.0 174.0 174.0 174.0 174.0 179.0 243.0 239.0 175.0 176.0 23:10:47 INFO - PROCESS | 1644 | 23:10:47 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:70.00 stddev:10.36 (14.8%) stddev-sans-first:10.46 23:10:47 INFO - PROCESS | 1644 | Values: 64.0 70.0 70.0 70.0 62.0 63.0 86.0 89.0 87.0 69.0 23:10:47 INFO - PROCESS | 1644 | -------- Summary: end -------- 23:10:47 INFO - PROCESS | 1644 | 23:10:48 INFO - TEST-INFO | 1644: exit 0 23:10:48 INFO - TEST-OK | kraken | took 60680ms 23:10:48 INFO - SUITE-END | took 1181s 23:10:48 INFO - Completed test suite (00:19:41) 23:10:48 INFO - javascript benchmark 23:10:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.1658527075606, 3306.5370848081266, 3312.3540909522644, 3326.3347330533898, 3335.182880194351, 5553.805616803413, 5586.944130558693, 5657.632253903504, 5663.122216056513, 5663.320401551814, 5631.7184140793, 5636.718164091789, 5673.8581535461635, 5687.772489100442, 5730.398308177644, 5071.746412679369, 5074.517920797518, 5170.715610641413, 5178.948210517884, 5190.221466779994, 5113.0, 5231.764570594332, 5235.633505654606, 5241.39723931747, 5248.501392367719, 5221.06020916235, 5236.162214045753, 5247.921281180786, 5256.973715131438, 5302.734863256841, 5058.873528161788, 5094.133997220481, 5114.309568208281, 5175.741212939376, 5187.948120518784, 5050.368703912011, 5107.157319042353, 5116.0, 5126.512981266774, 5132.640715149941, 5543.695096769676, 5628.887422251573, 5638.323401191883, 5644.717764111778, 5686.829395118153, 6179.691015449254, 6179.907301390483, 6188.535859810488, 6190.783322583733, 6193.597416167935, 6241.812745617639, 6256.749730010794, 6257.812265632038, 6264.404881536247, 6275.968620156916, 5580.748866301026, 5582.939241544093, 5711.171880077365, 5762.250907382014, 5788.942110578924, 6214.471769899519, 6237.220347456568, 6243.562950593506, 6296.087067375296, 6349.873002539924, 6051.334353221142, 6070.1984909116145, 6079.908801367983, 6084.421979911901, 6116.052011938156, 6149.41580549847, 6190.690465476709, 6216.906746398808, 6220.564560480813, 6226.377362263737, 5967.5524335675, 6020.367861374581, 6026.337102918763, 6037.245344331958, 6078.90881636767, 6029.6683682397015, 6104.755809767559, 6110.205673262448, 6118.293648225553, 6129.693515324216, 4823.324734537167, 4825.348577942003, 4831.73425461596, 4843.927341089887, 4873.122837889143, 4326.091520780608, 4330.41539392178, 4348.543402942645, 4381.978090109529, 4420.31485119807, 5649.378568357477, 5660.915086273709, 5671.064274394678, 5717.514011309086, 5727.541796656257, 5223.7910483580235, 6187.288461826947, 6256.405641464054, 6261.7182226799905, 6284.528660350401, 5709.628874123168, 5712.11462223356, 5725.8568535786935, 5727.284089488814, 5746.770129194785, 4808.845876989428, 5252.264682944391, 5283.1546952487415, 5294.020606187868, 5304.469553044742, 6122.418370254819, 6264.185655864709, 6330.272018717907, 6333.429991300805, 6338.461230795434, 5183.429822719422, 6076.33160352352, 6261.436470717657, 6272.153259310117, 6285.622862628257, 6204.72078756448, 6234.781782637586, 6277.591956522811, 6277.654728989949, 6356.4279214870885, 4976.32819569368, 6054.788082417094, 6106.06632622643, 6125.9693701531205, 6134.130457564626, 6106.297775755845, 6195.597286176384, 6230.190075290183, 6253.718582663882, 6254.030625253093, 5861.6189947653265, 6028.15605815195, 6081.878362432815, 6083.969580152071, 6100.938990610037, 4890.217565189552, 4952.257161425815, 5937.881242375215, 5950.375210602824, 6117.143599896107, 5880.147378629989, 5880.764769409176, 5884.32330282023, 5894.911576326273, 5894.941050589439, 5180.300659410931, 6083.847903802441, 6089.756409743561, 6097.5731698780655, 6099.11562823397, 5719.113537401709, 5726.226959360433, 5774.971125144348, 5816.923869084064, 5822.796202132905], "value": 5611.964967364268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.6805220371842, 480.1884814663221, 502.8793089658483, 504.19077380803816, 510.87352387984475, 28023.01919432818, 31243.68756312436, 31243.84378078109, 38716.61283387165, 39833.0, 40927.59072409275, 41220.793896030555, 41317.380239296435, 41355.79322103393, 41423.58576414235, 9221.95389023054, 9378.0, 9381.859272110923, 9386.20217281532, 9390.436573805559, 8453.070162282174, 8657.26413254874, 9256.490893000882, 10944.069754070873, 11240.550377984871, 11225.887741122608, 11284.097272218203, 11290.491927863224, 11291.49188286525, 11319.603813866517, 9334.346595738301, 11205.215634905479, 11211.383373914432, 11227.101831853432, 11241.943790281079, 8368.623411946477, 8601.526916019617, 9368.718938431857, 9786.755331116708, 10771.407572583505, 38847.0, 39157.41263881044, 39183.21633567341, 39217.0, 39237.80381098105, 2861.6566012078474, 3251.040942921844, 3296.0, 3457.1184347991352, 3868.0, 28895.56656650152, 28947.276318092005, 29021.854890725623, 29294.707052929625, 29613.077503674624, 3122.172624254574, 3172.524121381788, 3200.0, 3210.0, 3257.088015355704, 349819.0, 423968.0, 434596.0, 438304.0, 441264.0, 47601.76199119051, 57088.0, 57443.55338679693, 57544.71227643835, 57627.711861440424, 60547.091793623134, 60632.69683651553, 60652.69673651692, 60747.0, 60868.39131608627, 15133.092014479167, 15335.463258785889, 15352.616184595252, 15355.462558810388, 15408.0, 10774.461276936121, 11921.986631136277, 11962.222455540363, 11964.521419143312, 11986.34075125859, 14233.85766142346, 15486.303116359792, 15918.9204053979, 16398.590035249214, 16432.671346573003, 5340.412554618989, 6969.1985421676145, 7035.50751447404, 7039.964800176069, 7047.647617619098, 820.8932838730926, 842.9662813487514, 914.6524320758202, 992.2310209587628, 1048.7116043088213, 27777.305567360978, 28894.711052889623, 29112.563311550344, 29385.559216611768, 29513.26216844553, 1003.5233264199593, 1022.3916769522123, 1075.8601381820313, 1083.4582708645678, 1103.696483467053, 14451.277436128361, 15413.533834586413, 15521.301541430663, 15768.684626307639, 16172.353105875869, 592681.0, 598987.0, 606284.0, 606803.0, 612234.0, 56093.71953140208, 56321.0, 56402.71798641063, 56416.0, 56443.153352699745, 1299.6945717756319, 1353.350391811916, 1363.16165558181, 1365.528892532075, 1368.2816521326383, 23310.0, 23791.286261412184, 28494.145175644764, 29387.0, 30237.848810755804, 39149.80425097857, 47800.7609961948, 48117.03765924592, 48177.03645926992, 48197.75901120612, 537044.0, 541967.2901635467, 542451.0, 545743.0, 545847.0, 24638.0, 24938.251852444457, 24978.125765598117, 25014.499710005333, 25055.87472062628, 44227.778861105486, 45928.0, 45988.31017534673, 47393.0, 48002.27996579984, 29327.706722932497, 34327.0412816753, 35495.64504354924, 37876.81061594674, 38215.426768597936, 36309.27381452409, 36730.63269367272, 36801.63198367982, 37822.243555129295, 37959.0, 35397.938061858185, 36807.26385472222, 37096.25807483781, 37320.6267937328, 37369.25261494809, 26881.82790432713, 29523.55714664325, 31160.53259201159, 31190.908318209662, 33585.32829343448, 23399.947002385274, 23821.0, 24385.39036524101, 25000.37499062538, 25058.498830023662], "value": 19093.72443582065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.2696001396892, 344.52799664459695, 364.9854005839765, 370.92766910452457, 397.2749731739576, 14921.776173357408, 15266.160361180131, 17294.91352543237, 19028.904855475703, 20311.796882031176, 19419.0, 19514.0, 19526.41420757376, 19714.10006497725, 19738.0, 5470.261514695505, 5511.366192887809, 5782.826515204551, 5841.737121829507, 5905.055191169414, 3710.3135919854913, 5777.826665200051, 5811.564132690044, 5817.8836423271505, 5834.824955251349, 3839.232153569283, 5437.238786569884, 5663.943360566383, 6420.486361091102, 6439.22729272488, 5715.571332150063, 6368.840778980562, 6378.84052898679, 6421.999999999976, 6446.838829029265, 3675.081229692577, 3878.7478813877005, 3879.321118804226, 5617.8033768817895, 5627.296587926509, 25176.748232517624, 26376.0, 26521.46957060848, 27077.1876843695, 27315.0, 2192.6272533669317, 2357.976420235793, 2367.183321753992, 2505.8747062646976, 3177.3009937813645, 15020.774688379683, 15213.771793423108, 15354.769678454832, 15808.92095539515, 16742.24659890308, 1894.6873765828623, 1906.494778883597, 1940.7282980382759, 1965.3317871923614, 2021.7472815898013, 124622.0, 133614.0, 134194.0, 140461.2976935119, 140543.0, 18472.0, 19794.70307945382, 20146.89926550358, 20331.796682033288, 20374.28689995843, 27346.179614611592, 34089.31821363559, 34319.0, 34325.97022089341, 34384.82807585946, 9955.601775929026, 10084.647037353658, 10256.230782691327, 10292.125169360539, 10441.269111162146, 8387.664493420194, 8397.6221070052, 8401.95799021001, 8541.743747687578, 8573.18554737299, 7557.773266802004, 9052.909470905339, 9273.536323183815, 9316.580753866092, 9349.345545811864, 2916.941661166765, 3530.7881527107943, 3623.873164439232, 3653.5615726112505, 3730.7015438764834, 758.8178837079062, 778.6534991928537, 810.5055915891302, 961.2694352292308, 984.8522721591676, 20113.698294525595, 20360.6585242699, 20536.486587835425, 21210.36368908935, 21306.680399794015, 774.2567135549823, 884.540039179623, 888.2760550151605, 892.4888811588415, 922.9123233292827, 10065.547050382751, 10754.354738715545, 10846.457677116112, 10913.781724365626, 10943.83584246237, 499123.0, 499357.0, 527522.0, 564019.0, 569731.0, 102602.46096308561, 122800.38599807123, 124336.75663243432, 124567.37716311542, 125390.0, 977.5258999385293, 991.0881988570533, 1015.6902144845745, 1018.495844556949, 1019.576875596634, 15042.473513426978, 18279.36022239215, 18296.993665348535, 18466.076696165408, 18782.0, 52969.470305296454, 53660.73169634127, 54413.72793136009, 54437.45562544324, 54881.0, 79820.60089699514, 80305.19694802977, 81569.59215203887, 82704.58647706964, 82814.17185828305, 7607.619619018917, 7748.65131069092, 7885.0, 7970.2826745593175, 8013.799655008438, 10055.446950417505, 10703.785924281627, 12238.143329967173, 12437.129400941847, 12525.56160534377, 10600.25798194119, 10635.734106647396, 10917.781644366909, 11002.669919902415, 11013.944930275296, 9809.362391444532, 10494.527746251284, 10568.841467377842, 10776.461176941279, 11001.22991390595, 10825.350478971286, 11052.778944421227, 11111.00000999914, 11198.0, 11206.551737930391, 7719.575423351769, 7902.723404680809, 7903.3677305816545, 7954.403419743427, 8119.4722343047515, 5386.542143917811, 6383.297837237993, 8087.514749115072, 10321.432321222404, 10360.689179324632], "value": 10159.555888393968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.1536539662711, 1465.9413623455061, 1493.970120597588, 1820.8907465552059, 1846.2338129676193, 7861.803454913623, 8264.33885289177, 8270.21432963869, 8272.296854767344, 8277.83444331113, 7254.818629534251, 7532.698692052311, 7533.9246607533905, 7893.644785984645, 8066.3546916246705, 2246.955060898781, 2281.041962375806, 2284.8971796269207, 2286.8856557172076, 2292.988535057322, 2298.310506847947, 2315.340128063502, 2335.544568809083, 2335.6730057791924, 2344.074090734159, 2261.6155253606926, 2266.637338025916, 2301.079568172736, 2302.0446514696464, 2306.238941149425, 2259.378670865509, 2262.3552287597954, 2282.3267136194695, 2287.0394434337536, 2287.9199228027105, 2284.303287497313, 2303.2859813457712, 2304.066852924568, 2306.331163962466, 2313.1210140146636, 8097.392695547857, 8117.269445749852, 8160.836783264302, 8163.0612479564425, 8192.836143277102, 4166.375043743433, 5107.157319042353, 5110.6422550421485, 5112.565431938289, 5116.565091967187, 3161.1306890605038, 3269.4661637231334, 3486.790792552455, 3509.3683137035578, 3510.701590364822, 1035.3735989726258, 1035.9326643768131, 1062.7502536903899, 1080.0549519170725, 1085.4138765066855, 10501.317414368117, 10598.78802423955, 10646.733831654194, 10655.413952232624, 10675.626353077605, 4437.600615944516, 4494.842680506232, 4645.721256724607, 4661.86014419568, 4674.766261686902, 9159.542022898828, 9161.954190229006, 9173.58718857653, 9178.35751497402, 9189.356745027784, 5111.05445492585, 5119.334486516804, 5129.076766182048, 5137.40919794221, 5148.382194136728, 4143.772092534879, 4213.599708027732, 4384.101259241847, 4618.584327410549, 4654.511276315938, 3623.927521449609, 3665.706743460517, 3732.9813350933073, 3770.830312635938, 3782.451544526028, 1058.51837413978, 1122.074288711816, 1232.8458942632171, 1236.6908272931767, 1243.993780031094, 766.4366690482491, 862.719616124762, 871.2681347667989, 911.4804561399939, 923.132255679659, 5497.312835895513, 5549.556035517149, 5637.182608521742, 5757.712114394263, 6053.27360716708, 890.496869268861, 931.5575101826578, 960.2414092866696, 980.1472718734603, 997.7156510394648, 3757.5866654667966, 3758.398656215047, 3831.942520862189, 3865.7436333191263, 3875.2830726315724, 7746.961265193638, 9953.153981911619, 9971.900280997243, 9983.700488985342, 10033.247506437046, 9279.814403711887, 9747.756306092404, 9749.512524373895, 9918.05778451046, 9921.603135874628, 7477.401807855358, 7701.345385642283, 7705.807354816175, 7705.961470192725, 7775.57234352116, 5429.972850135724, 5432.891342173055, 5459.399466058651, 5655.095184770417, 5762.337331206965, 9177.174054335143, 9254.768630784285, 9270.072992700676, 9278.768030799014, 9290.535473226448, 8375.581220938806, 8933.731988040368, 9166.17504424605, 9368.625254989724, 9470.289728270269, 6038.728257228523, 6358.268799088164, 6790.93209067903, 6984.196817366068, 7151.177614574182, 7714.691412343668, 7829.921700782919, 7832.177621349676, 7837.960810195913, 7855.33229675484, 6111.266648002268, 6906.343897329745, 7023.964880175567, 7033.120859892513, 7187.281271872771, 6899.0, 6910.20532638753, 6941.062956500808, 6959.338862808025, 7029.367356937695, 6444.162258906312, 6511.413972742476, 6589.110470086477, 6605.702743376463, 6609.372109649576, 4748.525147485224, 4785.066911952275, 4791.712497250176, 4817.843717507843, 4943.30793688891, 4764.8332308369045, 4771.093492236464, 4819.1566475867285, 4929.334539837219, 5024.773885175103], "value": 4343.471550056997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.2830011770104, 287.42945253671456, 300.7864416264452, 307.5417627734676, 316.7925009119028, 4336.132773445315, 5181.0, 5248.722291332561, 5273.472652734725, 5287.339082614673, 4091.774952377618, 4917.090338287419, 5067.417247016594, 5074.3657042869645, 5158.3552055993005, 3980.2835489611857, 4012.2376748417782, 4047.8178481968234, 4053.5541090480024, 4058.8579399721016, 4002.859185132238, 4024.5774193709676, 4025.8993525161814, 4056.5943405659345, 4065.7560546367163, 3688.0196720984354, 3980.661643760284, 3982.661473774718, 3989.840406383741, 4014.6988975826785, 3524.665156810099, 3748.306563285774, 3954.6272236658065, 4017.196560687845, 4031.113155105872, 3509.596396414394, 3512.0517460285837, 3517.2262102337445, 3517.8944631661093, 3529.8411571479346, 4339.913201735948, 4414.955850441519, 4780.928286075712, 4926.827561035382, 5093.23601459784, 3807.3146833569945, 4193.937090943638, 4501.324801279834, 4559.886002849922, 4572.862814115582, 4345.0, 4926.753662316905, 5419.566434685215, 5422.6475279106735, 5451.563874889999, 3254.869805207789, 3460.653934606544, 3621.420572708354, 3817.3701339279264, 3823.3500304947947, 5123.795048198068, 5323.973380133113, 5637.605367624268, 5661.46216109469, 5733.856653583611, 3267.8529466174077, 3906.882793516199, 3909.6285852843935, 3910.963594647421, 3914.3932690432457, 3364.7139993100373, 3461.688448039638, 3871.632194941476, 3957.6635985941516, 3984.7011474139554, 4158.854440094582, 4387.627051700578, 4438.646212905031, 4576.222042252825, 4579.290210017452, 5231.869203269949, 5499.370415525734, 5531.585131115183, 5539.335279766373, 5541.722913854291, 1212.42409855318, 1222.8260869565318, 1258.641287233134, 1283.608499407671, 1289.664687181321, 720.459655258556, 841.54556539468, 868.6351732272461, 887.1261807119981, 902.6073657958809, 4332.8985442060575, 4802.8799280018275, 4918.95081049185, 4931.950680493221, 4939.641598560424, 4483.932741008887, 4750.548697873696, 4918.458969513351, 5345.946540534623, 5397.514223719884, 4146.688998325138, 4347.369736348869, 4359.04101097758, 4718.811247550128, 4820.662553621283, 2491.5515207262506, 2525.8989640414543, 2754.746590301408, 2791.7158107270475, 2794.8479670653483, 4800.871795128142, 5036.924446133311, 5073.093717837245, 5083.72039537829, 5506.366767821752, 4822.903541929142, 5140.331756871583, 5151.447826408917, 5444.3194600674915, 5464.371597266286, 5229.581633469237, 5501.064818980783, 5514.862128446821, 5527.613067085265, 5539.5014448699, 4586.289125185602, 4996.351933475264, 5050.3434553507805, 5287.8149264777085, 5302.9659216453965, 4253.893987563318, 5052.595792336678, 5054.924176137434, 5228.248536740235, 5250.238715386171, 4856.1987272099705, 5244.737763111905, 5357.866053348697, 5371.597130215171, 5504.9449505504435, 3157.8105313681253, 3656.884650181614, 3658.7255955803953, 3685.336639404933, 3693.6306369362846, 4346.195953748566, 4406.339049142654, 5075.132550109177, 5186.351706036746, 5348.384935732285, 4742.905141897212, 5138.845834624967, 5155.896882062263, 5168.302279192261, 5169.327987361769, 4872.3909511311085, 5156.819511317086, 5158.406783219978, 5179.92230116541, 5201.396763863932, 4522.457305123275, 4729.810807567659, 4906.386701662293, 4989.700617962933, 5063.215201643751, 4350.9347359789, 5304.681719096867, 5327.856564626733, 5350.545203657733, 5468.535174510212, 4533.886652833706, 5329.813456529003, 5348.545373643284, 5361.249425080414, 5407.2970513834525], "value": 3876.339530333523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2761018100449, 682.9146356705412, 708.9012031351406, 722.2632914427285, 798.4730078148423, 14487.927560362197, 15063.09621422714, 15071.397144114222, 15092.924535377322, 15123.77314340283, 13584.660383490418, 14038.508652197175, 14648.901332400059, 14693.485727999521, 14766.0, 707.8053535277814, 823.4935514658501, 844.6452489954233, 846.3905987688854, 848.0544193224572, 661.3750006244102, 684.7363764950505, 686.6360828760764, 806.2421323955492, 818.7830224990382, 883.266888482558, 886.0342226972599, 887.1793590928365, 887.4941283468426, 887.9556022198897, 881.1628952495155, 881.8456770065213, 882.2280504558511, 882.960266787996, 883.1654086887894, 505.2749304747662, 523.808809784426, 527.2118183315929, 530.3397270398378, 653.7875190563038, 12475.875241247562, 14445.78331325031, 14966.326515306728, 14968.550943471713, 15347.539573812803, 12480.126391152622, 13725.313734313344, 13878.861211387857, 13933.512327068605, 13942.512012079529, 10680.893191068146, 11789.882101178964, 11816.231944923553, 12025.338606376647, 12399.194052386567, 3623.40213864712, 3676.8397870256767, 3681.871134510306, 3709.0356507308293, 3717.498137751396, 111659.0, 114122.42938785336, 114709.0, 117707.0, 118568.0, 10376.16990640747, 10593.947030264953, 10637.893621063846, 10665.146788256921, 10919.836202456969, 21099.0, 21408.892955535433, 21416.678749818766, 21433.67849482259, 21687.56624867494, 7463.253674632602, 7519.436042296849, 7535.321821036024, 7581.166071732105, 7600.391968642495, 4200.936985945214, 4225.619694227535, 4253.106847561985, 4277.957220427756, 4316.223079845658, 3414.6756058174433, 3489.180042689966, 3553.129483276562, 3554.680078792921, 3556.5020897074432, 628.9716962736687, 637.7385272038534, 641.1056576076347, 647.6891092275735, 659.446065305146, 575.8387651457599, 623.7894214055128, 645.6578013652771, 649.6329573790794, 654.5974225851068, 9231.676891308773, 9248.815023699488, 9354.579043943038, 9365.0, 9620.037996200324, 567.4722508067537, 628.1614045249643, 649.8407890066964, 650.3009265040101, 664.6842749693953, 4366.282595512434, 4571.47428045779, 4586.289125185602, 4594.218982772936, 4656.0, 76848.0, 78661.60669196617, 79576.0, 99493.50253248688, 121555.0, 85078.72381914276, 87129.56435217784, 89726.55136724275, 90568.09431905729, 95848.10202520735, 65811.0, 83702.3038156946, 84091.5795421019, 84180.0, 86343.56828215944, 9585.760355991157, 9680.709578712649, 9695.806083878142, 9708.271879608916, 9720.659776907774, 50703.0, 52536.73731631317, 52681.736591316796, 53431.0, 54115.72942135264, 68030.0, 72711.0, 73423.63288183525, 73688.63155684188, 75486.86769698569, 12242.877571224173, 12516.812247816471, 12719.0, 13299.800502992657, 13303.667408314483, 14222.075565088237, 14632.926835365755, 14772.33524491379, 14828.43933524928, 14828.555143345717, 13219.66950826237, 13481.662958426117, 13536.255505946874, 13559.525416610371, 14261.215633140277, 13190.868091319348, 13428.93285533566, 13542.932285338511, 13751.862481375058, 13776.517821876187, 12807.93596032014, 13003.0, 13388.928885689316, 13445.0, 13680.65798355049, 10988.615398461016, 11214.271072380268, 11500.0, 11802.645920622395, 11819.763604727685, 9108.681196158102, 10711.785764284827, 11078.0, 11363.772724545628, 11435.371054592077], "value": 7346.364132499416, "unit": "score"}], "name": "dromaeo_css", "value": 7159.40507513638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 114.0, 113.0, 113.0, 119.0, 169.0, 161.0, 113.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 137.0, 145.0, 184.0, 146.0, 114.0, 117.0, 114.0, 138.0, 112.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 186.0, 186.0, 181.0, 182.0, 186.0, 181.0, 184.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 63.0, 114.0, 95.0, 76.0, 59.0, 58.0, 74.0, 59.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 86.0, 70.0, 68.0, 69.0, 81.0, 68.0, 69.0, 82.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 90.0, 86.0, 90.0, 87.0, 90.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 99.0, 143.0, 150.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 88.0, 86.0, 87.0, 86.0, 85.0, 87.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 76.0, 73.0, 72.0, 70.0, 71.0, 72.0, 71.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 88.0, 86.0, 89.0, 89.0, 85.0, 87.0, 88.0, 87.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 157.0, 154.0, 149.0, 146.0, 146.0, 149.0, 146.0, 196.0, 148.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 174.0, 174.0, 174.0, 179.0, 243.0, 239.0, 175.0, 176.0], "value": 188.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 70.0, 70.0, 62.0, 63.0, 86.0, 89.0, 87.0, 69.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1505.6999999999998, "alertThreshold": 2.0}]} 23:10:48 INFO - Return code: 0 23:10:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:10:48 INFO - # TBPL SUCCESS # 23:10:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:10:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:10:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:10:48 INFO - 2016-11-30 23:10:48.772 screenresolution[1648:10141] starting screenresolution argv=screenresolution get 23:10:48 INFO - 2016-11-30 23:10:48.775 screenresolution[1648:10141] Display 0: 1600x1200x32@60 23:10:48 INFO - 2016-11-30 23:10:48.782 screenresolution[1649:10144] starting screenresolution argv=screenresolution list 23:10:48 INFO - Available Modes on Display 0 23:10:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:10:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:10:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:10:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:10:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:10:49 INFO - Intel Iris: 23:10:49 INFO - Chipset Model: Intel Iris 23:10:49 INFO - Type: GPU 23:10:49 INFO - Bus: Built-In 23:10:49 INFO - VRAM (Dynamic, Max): 1536 MB 23:10:49 INFO - Vendor: Intel (0x8086) 23:10:49 INFO - Device ID: 0x0a2e 23:10:49 INFO - Revision ID: 0x0009 23:10:49 INFO - Displays: 23:10:49 INFO - Display: 23:10:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:10:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:10:49 INFO - Display Serial Number: 1600x1200 60 23:10:49 INFO - Main Display: Yes 23:10:49 INFO - Mirror: Off 23:10:49 INFO - Online: Yes 23:10:49 INFO - Rotation: Supported 23:10:49 INFO - Return code: 0 23:10:49 INFO - Running post-action listener: _resource_record_post_action 23:10:49 INFO - [mozharness: 2016-12-01 07:10:49.035048Z] Finished run-tests step (success) 23:10:49 INFO - Running post-run listener: _resource_record_post_run 23:10:49 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 37487616; Write bytes: 695230976; Read time: 239; Write time: 1977 23:10:49 INFO - TinderboxPrint: CPU usage
53.8% 23:10:49 INFO - TinderboxPrint: I/O read bytes / time
37,487,616 / 239 23:10:49 INFO - TinderboxPrint: I/O write bytes / time
695,230,976 / 1,977 23:10:49 INFO - TinderboxPrint: CPU idle
2,247.9 (46.2%) 23:10:49 INFO - TinderboxPrint: CPU system
979.6 (20.1%) 23:10:49 INFO - TinderboxPrint: CPU user
1,638.3 (33.7%) 23:10:49 INFO - TinderboxPrint: Swap in / out
421,376,000 / 0 23:10:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 363188736; Write bytes: 357099520; Read time: 28313; Write time: 730 23:10:49 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 36533248; Write bytes: 308935168; Read time: 227; Write time: 1171 23:10:49 INFO - Running post-run listener: _upload_blobber_files 23:10:49 INFO - Blob upload gear active. 23:10:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:10:49 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 23:10:49 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:10:49 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:10:49 INFO - (blobuploader) - INFO - Open directory for files ... 23:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:10:51 INFO - (blobuploader) - INFO - Done attempting. 23:10:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:10:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:10:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:10:54 INFO - (blobuploader) - INFO - Done attempting. 23:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:10:56 INFO - (blobuploader) - INFO - Done attempting. 23:10:56 INFO - (blobuploader) - INFO - Iteration through files over. 23:10:56 INFO - Return code: 0 23:10:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:10:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:10:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8d0b4f89fb0d88f4537079979e4321156e0935a6be568e70d1383b128a2d955076fa084a49128049fef25694fff4e44578c09c2d9e9d05e2fbe0cd6b83bbc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/63d231556a393e9e1e9c145c513c8ac01bad5c3351ef10549336d7e4be4ec80c4a274175c1a136fdea0db6ddc00cb92e1fd91acb442962de1f18359865ea09ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62a626053f7709070bb881459d899b99a3910657accf4a3dbeda1bae4d8d96d6d5d03ab2c80fae9e29e0520f6064765b684516f1f8c59ef981c694ad2342d787"} 23:10:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:10:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:10:56 INFO - Contents: 23:10:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8d0b4f89fb0d88f4537079979e4321156e0935a6be568e70d1383b128a2d955076fa084a49128049fef25694fff4e44578c09c2d9e9d05e2fbe0cd6b83bbc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/63d231556a393e9e1e9c145c513c8ac01bad5c3351ef10549336d7e4be4ec80c4a274175c1a136fdea0db6ddc00cb92e1fd91acb442962de1f18359865ea09ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62a626053f7709070bb881459d899b99a3910657accf4a3dbeda1bae4d8d96d6d5d03ab2c80fae9e29e0520f6064765b684516f1f8c59ef981c694ad2342d787"} 23:10:56 INFO - Running post-run listener: copy_logs_to_upload_dir 23:10:56 INFO - Copying logs to upload dir... 23:10:56 INFO - mkdir: /builds/slave/test/build/upload/logs 23:10:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.692277 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-30 23:10:56.984140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 23:10:56.987870) ========= 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.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/Graphics/sha512/0a8d0b4f89fb0d88f4537079979e4321156e0935a6be568e70d1383b128a2d955076fa084a49128049fef25694fff4e44578c09c2d9e9d05e2fbe0cd6b83bbc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/63d231556a393e9e1e9c145c513c8ac01bad5c3351ef10549336d7e4be4ec80c4a274175c1a136fdea0db6ddc00cb92e1fd91acb442962de1f18359865ea09ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62a626053f7709070bb881459d899b99a3910657accf4a3dbeda1bae4d8d96d6d5d03ab2c80fae9e29e0520f6064765b684516f1f8c59ef981c694ad2342d787"} build_url:https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/XPUL_RmiT7S0y3ncZqVbsg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8d0b4f89fb0d88f4537079979e4321156e0935a6be568e70d1383b128a2d955076fa084a49128049fef25694fff4e44578c09c2d9e9d05e2fbe0cd6b83bbc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/63d231556a393e9e1e9c145c513c8ac01bad5c3351ef10549336d7e4be4ec80c4a274175c1a136fdea0db6ddc00cb92e1fd91acb442962de1f18359865ea09ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/62a626053f7709070bb881459d899b99a3910657accf4a3dbeda1bae4d8d96d6d5d03ab2c80fae9e29e0520f6064765b684516f1f8c59ef981c694ad2342d787"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 23:10:57.021639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 23:10:57.021957) ========= 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.nHxGoO5EXb/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.UA08oWVDQf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 23:10:57.071833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 23:10:57.072321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 23:10:57.073092) ========= ========= Total master_lag: 0.18 =========