builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1475476962.99 results: success (0) buildid: 20161002223356 builduid: 65c899af787f4ac4b2b9800c3b9c0f1f revision: 955840bfd3c20eb24dd5a01be27bdc55c489a285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:42.988314) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:42.988687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:42.988952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:43.317255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-02 23:42:43.317508) ========= 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.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-02 23:42:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-10-02 23:42:44 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.980850 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-02 23:42:44.324624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.324954) ========= 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.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.029309 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.376173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.376565) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 955840bfd3c20eb24dd5a01be27bdc55c489a285 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 955840bfd3c20eb24dd5a01be27bdc55c489a285 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-02 23:42:44,457 truncating revision to first 12 chars 2016-10-02 23:42:44,457 Setting DEBUG logging. 2016-10-02 23:42:44,457 attempt 1/10 2016-10-02 23:42:44,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/955840bfd3c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-02 23:42:44,757 unpacking tar archive at: mozilla-central-955840bfd3c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.968111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.971162) ========= script_repo_revision: 955840bfd3c20eb24dd5a01be27bdc55c489a285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.971570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.971838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 23:42:44.990184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-10-02 23:42:44.990493) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:42:45 INFO - MultiFileLogger online at 20161002 23:42:45 in /builds/slave/test 23:42:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:42:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:42:45 INFO - {'append_to_log': False, 23:42:45 INFO - 'base_work_dir': '/builds/slave/test', 23:42:45 INFO - 'blob_upload_branch': 'Firefox', 23:42:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:42:45 INFO - 'branch': 'Firefox', 23:42:45 INFO - 'buildbot_json_path': 'buildprops.json', 23:42:45 INFO - 'config_files': ('talos/mac_config.py',), 23:42:45 INFO - 'default_actions': ('clobber', 23:42:45 INFO - 'read-buildbot-config', 23:42:45 INFO - 'download-and-extract', 23:42:45 INFO - 'populate-webroot', 23:42:45 INFO - 'create-virtualenv', 23:42:45 INFO - 'install', 23:42:45 INFO - 'run-tests'), 23:42:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:42:45 INFO - 'download_minidump_stackwalk': True, 23:42:45 INFO - 'download_symbols': 'ondemand', 23:42:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:42:45 INFO - 'tooltool.py': '/tools/tooltool.py', 23:42:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:42:45 INFO - '/tools/misc-python/virtualenv.py')}, 23:42:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:42:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:42:45 INFO - 'installer_path': 'installer.exe', 23:42:45 INFO - 'log_level': 'info', 23:42:45 INFO - 'log_name': 'talos', 23:42:45 INFO - 'log_to_console': True, 23:42:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:42:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:42:45 INFO - 'opt_config_files': (), 23:42:45 INFO - 'pip_index': False, 23:42:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:42:45 INFO - 'cmd': ('bash', 23:42:45 INFO - '-c', 23:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:42:45 INFO - 'enabled': True, 23:42:45 INFO - 'halt_on_failure': False, 23:42:45 INFO - 'name': 'check_screen_resolution'},), 23:42:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:42:45 INFO - 'cmd': ('bash', 23:42:45 INFO - '-c', 23:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:42:45 INFO - 'enabled': True, 23:42:45 INFO - 'halt_on_failure': False, 23:42:45 INFO - 'name': 'check_screen_resolution'},), 23:42:45 INFO - 'run_cmd_checks_enabled': True, 23:42:45 INFO - 'sps_profile': False, 23:42:45 INFO - 'sps_profile_interval': 0, 23:42:45 INFO - 'suite': 'dromaeojs', 23:42:45 INFO - 'system_bits': '32', 23:42:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:42:45 INFO - 'title': 't-yosemite-r7-0370', 23:42:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:42:45 INFO - 'use_talos_json': True, 23:42:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:42:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:42:45 INFO - 'work_dir': 'build'} 23:42:45 INFO - [mozharness: 2016-10-03 06:42:45.204024Z] Running clobber step. 23:42:45 INFO - Running pre-action listener: _resource_record_pre_action 23:42:45 INFO - Running main action method: clobber 23:42:45 INFO - rmtree: /builds/slave/test/build 23:42:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:42:47 INFO - Running post-action listener: _resource_record_post_action 23:42:47 INFO - [mozharness: 2016-10-03 06:42:47.329270Z] Finished clobber step (success) 23:42:47 INFO - [mozharness: 2016-10-03 06:42:47.329423Z] Running read-buildbot-config step. 23:42:47 INFO - Running pre-action listener: _resource_record_pre_action 23:42:47 INFO - Running main action method: read_buildbot_config 23:42:47 INFO - Using buildbot properties: 23:42:47 INFO - { 23:42:47 INFO - "project": "", 23:42:47 INFO - "product": "firefox", 23:42:47 INFO - "script_repo_revision": "production", 23:42:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:42:47 INFO - "repository": "", 23:42:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:42:47 INFO - "buildid": "20161002223356", 23:42:47 INFO - "pgo_build": "False", 23:42:47 INFO - "basedir": "/builds/slave/test", 23:42:47 INFO - "buildnumber": 3, 23:42:47 INFO - "slavename": "t-yosemite-r7-0370", 23:42:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:42:47 INFO - "platform": "yosemite_r7", 23:42:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:42:47 INFO - "branch": "mozilla-central", 23:42:47 INFO - "repo_path": "mozilla-central", 23:42:47 INFO - "revision": "955840bfd3c20eb24dd5a01be27bdc55c489a285", 23:42:47 INFO - "stage_platform": "macosx64", 23:42:47 INFO - "builduid": "65c899af787f4ac4b2b9800c3b9c0f1f", 23:42:47 INFO - "slavebuilddir": "test" 23:42:47 INFO - } 23:42:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 23:42:47 INFO - Running post-action listener: _resource_record_post_action 23:42:47 INFO - [mozharness: 2016-10-03 06:42:47.332806Z] Finished read-buildbot-config step (success) 23:42:47 INFO - [mozharness: 2016-10-03 06:42:47.332939Z] Running download-and-extract step. 23:42:47 INFO - Running pre-action listener: _resource_record_pre_action 23:42:47 INFO - Running main action method: download_and_extract 23:42:47 INFO - mkdir: /builds/slave/test/build/tests 23:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:47 INFO - trying https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 23:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 23:42:48 INFO - Downloaded 1199 bytes. 23:42:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:42:48 INFO - Using the following test package requirements: 23:42:48 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:42:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 23:42:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 23:42:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'jsshell-mac.zip'], 23:42:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 23:42:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:42:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 23:42:48 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 23:42:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 23:42:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:42:48 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 23:42:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:42:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:42:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:42:48 INFO - Fetch https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:42:49 INFO - Http code: 200 23:42:49 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 23:42:49 INFO - x-amz-cf-id: LoE6mJVPbQbvqTrzXh61a7oPxcFMU9QkdNhrvgF7dh-CfmKhm-qcMw== 23:42:49 INFO - x-amz-version-id: AUCBc9.P3u_kSaorlgvAFt3xkb9ODUvV 23:42:49 INFO - Expected file size: 16476345 23:42:49 INFO - Obtained file size: 16476345 23:42:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:42:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:42:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:42:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:42:57 INFO - Http code: 200 23:42:57 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 23:42:57 INFO - x-amz-cf-id: GsCegfCYhgWwlaQrAj1KFMPOHaBIy0f1kGDw3bC9wNP57XuN6BoeSg== 23:42:57 INFO - x-amz-version-id: AUCBc9.P3u_kSaorlgvAFt3xkb9ODUvV 23:42:58 INFO - Expected file size: 16476345 23:42:58 INFO - Obtained file size: 16476345 23:43:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 23:43:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:43:04 INFO - Fetch https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 23:43:05 INFO - Http code: 200 23:43:05 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 23:43:05 INFO - x-amz-cf-id: AHE1u8brO0ME_VFpZJoAhyzgFX9HBEwBKXg6zwnhA_e7H1pZnVWUUA== 23:43:05 INFO - x-amz-version-id: uVSNyYAiMqaJpbtRLfuiPPbVndr_fWpW 23:43:05 INFO - Expected file size: 14408522 23:43:05 INFO - Obtained file size: 14408522 23:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:05 INFO - trying https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:43:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 23:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 23:43:08 INFO - Downloaded 111735068 bytes. 23:43:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:43:08 INFO - mkdir: /builds/slave/test/properties 23:43:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:43:08 INFO - Writing to file /builds/slave/test/properties/build_url 23:43:08 INFO - Contents: 23:43:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:43:09 INFO - Running post-action listener: _resource_record_post_action 23:43:09 INFO - Running post-action listener: set_extra_try_arguments 23:43:09 INFO - [mozharness: 2016-10-03 06:43:09.144817Z] Finished download-and-extract step (success) 23:43:09 INFO - [mozharness: 2016-10-03 06:43:09.144963Z] Running populate-webroot step. 23:43:09 INFO - Running pre-action listener: _resource_record_pre_action 23:43:09 INFO - Running main action method: populate_webroot 23:43:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:43:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:43:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:43:09 INFO - '--tppagecycles', 23:43:09 INFO - '7'], 23:43:09 INFO - 'tests': ['tsvgm']}}, 23:43:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:43:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:43:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:43:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:43:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:43:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:43:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['damp', 'tps']}, 23:43:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'tests': ['damp', 'tps']}, 23:43:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['dromaeo_dom']}, 23:43:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:43:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['basic_compositor_video']}, 23:43:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:43:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'other-e10s': {'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['a11yr', 23:43:09 INFO - 'ts_paint', 23:43:09 INFO - 'tpaint', 23:43:09 INFO - 'sessionrestore', 23:43:09 INFO - 'sessionrestore_no_auto_restore', 23:43:09 INFO - 'tabpaint']}, 23:43:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['tsvgx', 23:43:09 INFO - 'tsvgr_opacity', 23:43:09 INFO - 'tart', 23:43:09 INFO - 'tscrollx', 23:43:09 INFO - 'cart']}, 23:43:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:43:09 INFO - 'tsvgr_opacity', 23:43:09 INFO - 'tart', 23:43:09 INFO - 'tscrollx', 23:43:09 INFO - 'cart']}, 23:43:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'talos_options': ['--disable-e10s'], 23:43:09 INFO - 'tests': ['tp5o']}, 23:43:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'tests': ['tp5o']}, 23:43:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'talos_options': ['--disable-e10s', 23:43:09 INFO - '--xperf_path', 23:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:43:09 INFO - 'tests': ['tp5n']}, 23:43:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:43:09 INFO - 'talos_options': ['--xperf_path', 23:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:43:09 INFO - 'tests': ['tp5n']}}, 23:43:09 INFO - 'talos.zip': {'path': '', 23:43:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:43:09 INFO - Running post-action listener: _resource_record_post_action 23:43:09 INFO - [mozharness: 2016-10-03 06:43:09.163915Z] Finished populate-webroot step (success) 23:43:09 INFO - [mozharness: 2016-10-03 06:43:09.164044Z] Running create-virtualenv step. 23:43:09 INFO - Running pre-action listener: _resource_record_pre_action 23:43:09 INFO - Running main action method: create_virtualenv 23:43:09 INFO - Creating virtualenv /builds/slave/test/build/venv 23:43:09 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 23:43:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:43:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:43:09 INFO - Using real prefix '/tools/python27' 23:43:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 23:43:12 INFO - Installing pip.................done. 23:43:12 INFO - Return code: 0 23:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:43:13 INFO - Reading from file tmpfile_stdout 23:43:13 INFO - Output received: 23:43:13 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) 23:43:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:13 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:13 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 23:43:13 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 23:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:13 INFO - 'HOME': '/Users/cltbld', 23:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:13 INFO - 'LOGNAME': 'cltbld', 23:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:13 INFO - 'MOZ_NO_REMOTE': '1', 23:43:13 INFO - 'NO_EM_RESTART': '1', 23:43:13 INFO - 'PAGER': '/bin/cat', 23:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:13 INFO - 'PWD': '/builds/slave/test', 23:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:13 INFO - 'SHELL': '/bin/bash', 23:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:13 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:13 INFO - 'USER': 'cltbld', 23:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:13 INFO - 'XPC_FLAGS': '0x0', 23:43:13 INFO - 'XPC_SERVICE_NAME': '0', 23:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:13 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 23:43:13 INFO - Cleaning up... 23:43:13 INFO - Return code: 0 23:43:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:13 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:13 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 23:43:13 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 23:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:13 INFO - 'HOME': '/Users/cltbld', 23:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:13 INFO - 'LOGNAME': 'cltbld', 23:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:13 INFO - 'MOZ_NO_REMOTE': '1', 23:43:13 INFO - 'NO_EM_RESTART': '1', 23:43:13 INFO - 'PAGER': '/bin/cat', 23:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:13 INFO - 'PWD': '/builds/slave/test', 23:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:13 INFO - 'SHELL': '/bin/bash', 23:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:13 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:13 INFO - 'USER': 'cltbld', 23:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:13 INFO - 'XPC_FLAGS': '0x0', 23:43:13 INFO - 'XPC_SERVICE_NAME': '0', 23:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:13 INFO - Downloading/unpacking psutil>=3.1.1 23:43:13 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 23:43:13 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 23:43:13 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 23:43:13 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 23:43:13 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 23:43:13 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 23:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:17 INFO - Installing collected packages: psutil 23:43:17 INFO - Running setup.py install for psutil 23:43:17 INFO - building 'psutil._psutil_osx' extension 23:43:17 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 23:43:18 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 23:43:18 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 23:43:18 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 23:43:18 INFO - building 'psutil._psutil_posix' extension 23:43:18 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 23:43:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:43:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:43:18 INFO - ^ 23:43:18 INFO - 1 warning generated. 23:43:18 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 23:43:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:18 INFO - Successfully installed psutil 23:43:18 INFO - Cleaning up... 23:43:18 INFO - Return code: 0 23:43:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:18 INFO - 'HOME': '/Users/cltbld', 23:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:18 INFO - 'LOGNAME': 'cltbld', 23:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:18 INFO - 'MOZ_NO_REMOTE': '1', 23:43:18 INFO - 'NO_EM_RESTART': '1', 23:43:18 INFO - 'PAGER': '/bin/cat', 23:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:18 INFO - 'PWD': '/builds/slave/test', 23:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:18 INFO - 'SHELL': '/bin/bash', 23:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:18 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:18 INFO - 'USER': 'cltbld', 23:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:18 INFO - 'XPC_FLAGS': '0x0', 23:43:18 INFO - 'XPC_SERVICE_NAME': '0', 23:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:43:21 INFO - Installing collected packages: mozsystemmonitor 23:43:21 INFO - Running setup.py install for mozsystemmonitor 23:43:21 INFO - Successfully installed mozsystemmonitor 23:43:21 INFO - Cleaning up... 23:43:21 INFO - Return code: 0 23:43:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:21 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:21 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 23:43:21 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 23:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:21 INFO - 'HOME': '/Users/cltbld', 23:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:21 INFO - 'LOGNAME': 'cltbld', 23:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:21 INFO - 'MOZ_NO_REMOTE': '1', 23:43:21 INFO - 'NO_EM_RESTART': '1', 23:43:21 INFO - 'PAGER': '/bin/cat', 23:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:21 INFO - 'PWD': '/builds/slave/test', 23:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:21 INFO - 'SHELL': '/bin/bash', 23:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:21 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:21 INFO - 'USER': 'cltbld', 23:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:21 INFO - 'XPC_FLAGS': '0x0', 23:43:21 INFO - 'XPC_SERVICE_NAME': '0', 23:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:22 INFO - Downloading/unpacking jsonschema==2.5.1 23:43:22 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 23:43:22 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 23:43:22 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 23:43:22 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 23:43:22 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 23:43:22 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 23:43:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:43:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:43:24 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 23:43:24 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 23:43:24 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 23:43:24 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 23:43:24 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 23:43:24 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 23:43:25 INFO - Downloading functools32-3.2.3-2.tar.gz 23:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:43:25 INFO - warning: no files found matching '*.txt' 23:43:25 INFO - no previously-included directories found matching 'build' 23:43:25 INFO - no previously-included directories found matching 'dist' 23:43:25 INFO - no previously-included directories found matching '.git*' 23:43:25 INFO - Installing collected packages: jsonschema, functools32 23:43:25 INFO - Running setup.py install for functools32 23:43:25 INFO - warning: no files found matching '*.txt' 23:43:25 INFO - no previously-included directories found matching 'build' 23:43:25 INFO - no previously-included directories found matching 'dist' 23:43:25 INFO - no previously-included directories found matching '.git*' 23:43:25 INFO - Successfully installed jsonschema functools32 23:43:25 INFO - Cleaning up... 23:43:25 INFO - Return code: 0 23:43:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:43:25 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')]} 23:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:25 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')]} 23:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:25 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:25 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 23:43:25 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 23:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:25 INFO - 'HOME': '/Users/cltbld', 23:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:25 INFO - 'LOGNAME': 'cltbld', 23:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:25 INFO - 'MOZ_NO_REMOTE': '1', 23:43:25 INFO - 'NO_EM_RESTART': '1', 23:43:25 INFO - 'PAGER': '/bin/cat', 23:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:25 INFO - 'PWD': '/builds/slave/test', 23:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:25 INFO - 'SHELL': '/bin/bash', 23:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:25 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:25 INFO - 'USER': 'cltbld', 23:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:25 INFO - 'XPC_FLAGS': '0x0', 23:43:25 INFO - 'XPC_SERVICE_NAME': '0', 23:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:43:25 INFO - Cleaning up... 23:43:25 INFO - Return code: 0 23:43:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:43:25 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')]} 23:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:25 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')]} 23:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:25 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:25 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 23:43:25 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 23:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:25 INFO - 'HOME': '/Users/cltbld', 23:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:25 INFO - 'LOGNAME': 'cltbld', 23:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:25 INFO - 'MOZ_NO_REMOTE': '1', 23:43:25 INFO - 'NO_EM_RESTART': '1', 23:43:25 INFO - 'PAGER': '/bin/cat', 23:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:25 INFO - 'PWD': '/builds/slave/test', 23:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:25 INFO - 'SHELL': '/bin/bash', 23:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:25 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:25 INFO - 'USER': 'cltbld', 23:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:25 INFO - 'XPC_FLAGS': '0x0', 23:43:25 INFO - 'XPC_SERVICE_NAME': '0', 23:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:25 INFO - Downloading/unpacking blobuploader==1.2.4 23:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:28 INFO - Downloading blobuploader-1.2.4.tar.gz 23:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:43:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:43:28 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 23:43:28 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 23:43:28 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 23:43:28 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 23:43:28 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 23:43:28 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 23:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:43:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:43:29 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 23:43:29 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 23:43:29 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 23:43:29 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 23:43:29 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 23:43:29 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 23:43:29 INFO - Downloading docopt-0.6.1.tar.gz 23:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:43:29 INFO - Installing collected packages: blobuploader, requests, docopt 23:43:29 INFO - Running setup.py install for blobuploader 23:43:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:43:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:43:29 INFO - Running setup.py install for requests 23:43:30 INFO - Running setup.py install for docopt 23:43:30 INFO - Successfully installed blobuploader requests docopt 23:43:30 INFO - Cleaning up... 23:43:30 INFO - Return code: 0 23:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43: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')]} 23:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43: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')]} 23:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:30 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:30 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 23:43:30 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 23:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:30 INFO - 'HOME': '/Users/cltbld', 23:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:30 INFO - 'LOGNAME': 'cltbld', 23:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:30 INFO - 'MOZ_NO_REMOTE': '1', 23:43:30 INFO - 'NO_EM_RESTART': '1', 23:43:30 INFO - 'PAGER': '/bin/cat', 23:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:30 INFO - 'PWD': '/builds/slave/test', 23:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:30 INFO - 'SHELL': '/bin/bash', 23:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:30 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:30 INFO - 'USER': 'cltbld', 23:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:30 INFO - 'XPC_FLAGS': '0x0', 23:43:30 INFO - 'XPC_SERVICE_NAME': '0', 23:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-KfywY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-fCQmhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-IusSS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3S7o7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-GWF41T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-jMwg4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-v_kkaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-prreSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-TLWAbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-LYvdx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:31 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-_Nx0FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-pdXDhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-c2vCWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ZjVzFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-f4Mqc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ks9yic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:32 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-zeVdFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:43:32 INFO - Running setup.py install for manifestparser 23:43:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:43:32 INFO - Running setup.py install for mozcrash 23:43:32 INFO - Running setup.py install for mozdebug 23:43:33 INFO - Running setup.py install for mozdevice 23:43:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Running setup.py install for mozfile 23:43:33 INFO - Running setup.py install for mozhttpd 23:43:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Running setup.py install for mozinfo 23:43:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Running setup.py install for mozInstall 23:43:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:43:33 INFO - Running setup.py install for mozleak 23:43:33 INFO - Running setup.py install for mozlog 23:43:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Running setup.py install for moznetwork 23:43:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Running setup.py install for mozprocess 23:43:34 INFO - Running setup.py install for mozprofile 23:43:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Running setup.py install for mozrunner 23:43:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:43:34 INFO - Running setup.py install for mozscreenshot 23:43:34 INFO - Running setup.py install for moztest 23:43:35 INFO - Running setup.py install for mozversion 23:43:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:43:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:43:35 INFO - Cleaning up... 23:43:35 INFO - Return code: 0 23:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:35 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')]} 23:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:35 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')]} 23:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:35 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:35 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 23:43:35 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 23:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:35 INFO - 'HOME': '/Users/cltbld', 23:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:35 INFO - 'LOGNAME': 'cltbld', 23:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:35 INFO - 'MOZ_NO_REMOTE': '1', 23:43:35 INFO - 'NO_EM_RESTART': '1', 23:43:35 INFO - 'PAGER': '/bin/cat', 23:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:35 INFO - 'PWD': '/builds/slave/test', 23:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:35 INFO - 'SHELL': '/bin/bash', 23:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:35 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:35 INFO - 'USER': 'cltbld', 23:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:35 INFO - 'XPC_FLAGS': '0x0', 23:43:35 INFO - 'XPC_SERVICE_NAME': '0', 23:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-AHpPze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:35 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)) 23:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3BOovF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-uRXMAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:35 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)) 23:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-HmAPt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-HqCGyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ZIQAXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-B2ZV2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iEw9_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-dRuN7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2NTwIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-uqtHrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iWmtSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7xNQoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:36 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)) 23:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ypvC3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-j9ePzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:37 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)) 23:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ltTNTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:37 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)) 23:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-W7bF5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:37 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)) 23:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:43:37 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)) 23:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:43:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:39 INFO - Downloading blessings-1.6.tar.gz 23:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:43:40 INFO - Installing collected packages: blessings 23:43:40 INFO - Running setup.py install for blessings 23:43:40 INFO - Successfully installed blessings 23:43:40 INFO - Cleaning up... 23:43:40 INFO - Return code: 0 23:43:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:40 INFO - Reading from file tmpfile_stdout 23:43:40 INFO - Current package versions: 23:43:40 INFO - blessings == 1.6 23:43:40 INFO - blobuploader == 1.2.4 23:43:40 INFO - docopt == 0.6.1 23:43:40 INFO - functools32 == 3.2.3-2 23:43:40 INFO - jsonschema == 2.5.1 23:43:40 INFO - manifestparser == 1.1 23:43:40 INFO - mozInstall == 1.12 23:43:40 INFO - mozcrash == 0.17 23:43:40 INFO - mozdebug == 0.1 23:43:40 INFO - mozdevice == 0.48 23:43:40 INFO - mozfile == 1.2 23:43:40 INFO - mozhttpd == 0.7 23:43:40 INFO - mozinfo == 0.9 23:43:40 INFO - mozleak == 0.1 23:43:40 INFO - mozlog == 3.4 23:43:40 INFO - moznetwork == 0.27 23:43:40 INFO - mozprocess == 0.23 23:43:40 INFO - mozprofile == 0.28 23:43:40 INFO - mozrunner == 6.12 23:43:40 INFO - mozscreenshot == 0.1 23:43:40 INFO - mozsystemmonitor == 0.3 23:43:40 INFO - moztest == 0.7 23:43:40 INFO - mozversion == 1.4 23:43:40 INFO - psutil == 3.1.1 23:43:40 INFO - requests == 1.2.3 23:43:40 INFO - wsgiref == 0.1.2 23:43:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:40 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:40 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 23:43:40 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 23:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:40 INFO - 'HOME': '/Users/cltbld', 23:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:40 INFO - 'LOGNAME': 'cltbld', 23:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:40 INFO - 'MOZ_NO_REMOTE': '1', 23:43:40 INFO - 'NO_EM_RESTART': '1', 23:43:40 INFO - 'PAGER': '/bin/cat', 23:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:40 INFO - 'PWD': '/builds/slave/test', 23:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:40 INFO - 'SHELL': '/bin/bash', 23:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:40 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:40 INFO - 'USER': 'cltbld', 23:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:40 INFO - 'XPC_FLAGS': '0x0', 23:43:40 INFO - 'XPC_SERVICE_NAME': '0', 23:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 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)) 23:43:40 INFO - Cleaning up... 23:43:40 INFO - Return code: 0 23:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:40 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 0x10c536490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ac570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7848e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, '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.pTdzXQek60/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.KPqLZdt7vM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 23:43:40 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 23:43:40 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 23:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:40 INFO - 'HOME': '/Users/cltbld', 23:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:40 INFO - 'LOGNAME': 'cltbld', 23:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:40 INFO - 'MOZ_NO_REMOTE': '1', 23:43:40 INFO - 'NO_EM_RESTART': '1', 23:43:40 INFO - 'PAGER': '/bin/cat', 23:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:40 INFO - 'PWD': '/builds/slave/test', 23:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:40 INFO - 'SHELL': '/bin/bash', 23:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:43:40 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:40 INFO - 'USER': 'cltbld', 23:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:40 INFO - 'XPC_FLAGS': '0x0', 23:43:40 INFO - 'XPC_SERVICE_NAME': '0', 23:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:43:41 INFO - Cleaning up... 23:43:41 INFO - Return code: 0 23:43:41 INFO - Running post-action listener: _resource_record_post_action 23:43:41 INFO - Running post-action listener: _start_resource_monitoring 23:43:41 INFO - Starting resource monitoring. 23:43:41 INFO - [mozharness: 2016-10-03 06:43:41.131172Z] Finished create-virtualenv step (success) 23:43:41 INFO - [mozharness: 2016-10-03 06:43:41.132207Z] Running install step. 23:43:41 INFO - Running pre-action listener: _resource_record_pre_action 23:43:41 INFO - Running main action method: install 23:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:41 INFO - Reading from file tmpfile_stdout 23:43:41 INFO - Detecting whether we're running mozinstall >=1.0... 23:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:43:41 INFO - Reading from file tmpfile_stdout 23:43:41 INFO - Output received: 23:43:41 INFO - Usage: mozinstall [options] installer 23:43:41 INFO - Options: 23:43:41 INFO - -h, --help show this help message and exit 23:43:41 INFO - -d DEST, --destination=DEST 23:43:41 INFO - Directory to install application into. [default: 23:43:41 INFO - "/builds/slave/test"] 23:43:41 INFO - --app=APP Application being installed. [default: firefox] 23:43:41 INFO - mkdir: /builds/slave/test/build/application 23:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:44:16 INFO - Reading from file tmpfile_stdout 23:44:16 INFO - Output received: 23:44:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:44:16 INFO - Running post-action listener: _resource_record_post_action 23:44:16 INFO - [mozharness: 2016-10-03 06:44:16.277262Z] Finished install step (success) 23:44:16 INFO - [mozharness: 2016-10-03 06:44:16.277420Z] Running run-tests step. 23:44:16 INFO - Running pre-action listener: _resource_record_pre_action 23:44:16 INFO - Running main action method: run_tests 23:44:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:44:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:44:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:44:16 INFO - 2016-10-02 23:44:16.292 screenresolution[1663:8584] starting screenresolution argv=screenresolution get 23:44:16 INFO - 2016-10-02 23:44:16.294 screenresolution[1663:8584] Display 0: 1600x1200x32@60 23:44:16 INFO - 2016-10-02 23:44:16.300 screenresolution[1664:8586] starting screenresolution argv=screenresolution list 23:44:16 INFO - Available Modes on Display 0 23:44:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:44:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:44:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:44:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:44:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:44:16 INFO - Intel Iris: 23:44:16 INFO - Chipset Model: Intel Iris 23:44:16 INFO - Type: GPU 23:44:16 INFO - Bus: Built-In 23:44:16 INFO - VRAM (Dynamic, Max): 1536 MB 23:44:16 INFO - Vendor: Intel (0x8086) 23:44:16 INFO - Device ID: 0x0a2e 23:44:16 INFO - Revision ID: 0x0009 23:44:16 INFO - Displays: 23:44:16 INFO - Display: 23:44:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:44:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:44:16 INFO - Display Serial Number: 1600x1200 60 23:44:16 INFO - Main Display: Yes 23:44:16 INFO - Mirror: Off 23:44:16 INFO - Online: Yes 23:44:16 INFO - Rotation: Supported 23:44:16 INFO - Return code: 0 23:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:44:16 INFO - Python 2.7.3 23:44:16 INFO - Return code: 0 23:44:16 INFO - grabbing minidump binary from tooltool 23:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:44:16 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 0x10c34ad30>, '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 0x10c170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c342b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:44:16 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 23:44:16 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 23:44:16 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 23:44:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:44:16 INFO - Return code: 0 23:44:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:44:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:44:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:44:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:44:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 23:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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 23:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pTdzXQek60/Render', 23:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:44:16 INFO - 'HOME': '/Users/cltbld', 23:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:44:16 INFO - 'LOGNAME': 'cltbld', 23:44:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:44:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:16 INFO - 'MOZ_NO_REMOTE': '1', 23:44:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:44:16 INFO - 'NO_EM_RESTART': '1', 23:44:16 INFO - 'PAGER': '/bin/cat', 23:44:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:16 INFO - 'PWD': '/builds/slave/test', 23:44:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:44:16 INFO - 'SHELL': '/bin/bash', 23:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KPqLZdt7vM/Listeners', 23:44:16 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 23:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:44:16 INFO - 'USER': 'cltbld', 23:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:16 INFO - 'XPC_FLAGS': '0x0', 23:44:16 INFO - 'XPC_SERVICE_NAME': '0', 23:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:44:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 23:44:16 INFO - mozversion application_buildid: 20161002223356 23:44:16 INFO - mozversion application_changeset: 955840bfd3c20eb24dd5a01be27bdc55c489a285 23:44:16 INFO - mozversion application_display_name: Nightly 23:44:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:44:16 INFO - mozversion application_name: Firefox 23:44:16 INFO - mozversion application_remotingname: firefox 23:44:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:44:16 INFO - mozversion application_vendor: Mozilla 23:44:16 INFO - mozversion application_version: 52.0a1 23:44:16 INFO - mozversion platform_buildid: 20161002223356 23:44:16 INFO - mozversion platform_changeset: 955840bfd3c20eb24dd5a01be27bdc55c489a285 23:44:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:44:16 INFO - mozversion platform_version: 52.0a1 23:44:16 INFO - using testdate: 1475477056 23:44:16 INFO - actual date: 1475477056 23:44:16 INFO - starting webserver on 'localhost:49279' 23:44:16 INFO - SUITE-START | Running 2 tests 23:44:16 INFO - TEST-START | dromaeo_css 23:44:16 INFO - operating with platform_type : mac_ 23:44:16 INFO - Initialising browser for dromaeo_css test... 23:44:16 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpcGcQaF/profile http://localhost:49279/getInfo.html) 23:44:19 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 23:44:19 INFO - PROCESS | 1674 | colorDepth:24 23:44:19 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 23:44:19 INFO - PROCESS | 1674 | __metrics 23:44:19 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:44:19 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:44:20 INFO - TEST-INFO | 1674: exit 0 23:44:20 INFO - Browser initialized. 23:44:20 INFO - Running cycle 1/1 for dromaeo_css test... 23:44:20 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpcGcQaF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:32 INFO - PROCESS | 1676 | RSS: Main: 236060672 23:44:32 INFO - PROCESS | 1676 | 23:45:23 INFO - PROCESS | 1676 | 1475477123379 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] 23:47:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 23:47:38 INFO - PROCESS | 1676 | RSS: Main: 353366016 23:47:38 INFO - PROCESS | 1676 | 23:50:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 23:50:41 INFO - PROCESS | 1676 | RSS: Main: 376897536 23:50:41 INFO - PROCESS | 1676 | 23:53:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 23:53:44 INFO - PROCESS | 1676 | RSS: Main: 337395712 23:53:44 INFO - PROCESS | 1676 | 23:56:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 23:56:47 INFO - PROCESS | 1676 | RSS: Main: 357928960 23:56:47 INFO - PROCESS | 1676 | 23:59:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 23:59:51 INFO - PROCESS | 1676 | RSS: Main: 328003584 23:59:51 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 00:02:55 INFO - PROCESS | 1676 | RSS: Main: 416780288 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | __start_tp_report 00:02:55 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 00:02:55 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 00:02:55 INFO - PROCESS | 1676 | |i|pagename|runs| 00:02:55 INFO - PROCESS | 1676 | |0;dojo.html;2670.813043086984;3319.9170020749484;3348.3972884880727;3362.9495557566643;3384.813835239061;5541.168824676301;5610.130429783385;5645.15322701594;5703;5723.599348045634;5640.266765320503;5655.632383895044;5693.629914055594;5735.397783232763;5772.855678608026;5203.2975548300965;5251.55361794248;5257.395399529065;5261.605379596526;5273.920891186635;5217.739113044351;5249.790008399678;5265.210218467241;5286.10136276832;5307.655002424849;5127.48725127488;5255.421903590602;5275.788968441258;5282.366116066059;5291.3385826771655;5079.847604571832;5215.452377500384;5232.424433312332;5267.183586544092;5310.362756469229;5121.385433747937;5128.948710512922;5153.046686362997;5176.870578235536;5202.219667049935;5551.555875529948;5592.972035139839;5600.215969764236;5602.971985140089;5626.324841019104;6212;6228.22147231596;6238.407351301619;6242.531810114214;6249.937500625027;6097.766665674493;6108.008189064015;6154.415330543591;6181.6600086995195;6241.531885108589;4671.065786842645;5768.509676677488;5787.855303617359;5799.18811366409;5839.620424672383;5815.185873977646;6156.846078848064;6231.844203894939;6236.064590311489;6258.030005349178;5449.209864569694;5947.762089516457;6011.458968692838;6106.969465152734;6123.84690382744;6125.449118208347;6140.723667434976;6165.352637973038;6191.876162476815;6247.156633854372;6115;6166.075088736726;6178.6601736904;6186.4741496973265;6190.845228869314;6152;6196.132541444202;6202.81391558254;6206.596571222856;6207.099970504251;4786.827227329327;4849.2726091086615;4855.198892182821;4860.270959356125;4870.196417591058;4355.520892701864;4372;4413.470383553994;4430.446194225722;4462.933056004163;5695.088785794253;5712.11462223356;5712.400197979236;5713.714314284269;5718.685472299064;6066.059760737093;6170.691465426711;6171.413715697002;6266.686665666698;6301.495880329563;5644.379118296984;5685.971570142206;5692.260006199251;5724.084146536534;5762.366139724627;5366.168243922199;5374;5378.757955891994;5393.78424863009;5403.081476149064;6235.438810507076;6267.655278959701;6276.309605943251;6281.089242059876;6282.120503129566;5198.922016169836;6109.070667813169;6174.012158054689;6241.656708881055;6291.905621415591;6249.187605611241;6279.434850863444;6289.937100628935;6291.245050593958;6300.338464461165;6140.232470941132;6149.692515374124;6170.259568851587;6178.969105154445;6199.845003874939;6126.724297406538;6140.350877192904;6159.938400615936;6164.445199932027;6175.166352542349;6110.923300256407;6118.07100585842;6125.199680511147;6143.911070236141;6155.891939450942;6112.022076467744;6113.572049956639;6121.632702037892;6125.11336343068;6143.109249158758;5765.682887441231;5834.27071616048;5883.970580147072;5925.288965324189;5960.582759206987;6099.763790468328;6100.399513635539;6104.4505994460715;6119.969400152971;6125.17440701618;5748.281464816898;5922.940770592411;5928.822135335947;5953.077273022688;5987.161797348462 00:02:55 INFO - PROCESS | 1676 | |1;ext.html;492.00123748789946;495.7372592525961;504.98485045448604;507.6091409614597;518.2226660009985;31041;40391.39412908809;41392;41502.16995660085;41542.37686434706;43628.345574816325;43927.78036109815;43982.78008609961;44024.779876100656;44068.55931440685;9786.02139786021;9980.20158387331;9988.800223995515;9994.850077248811;9998;9760.560774765152;9853.458059806708;9857.359271647356;9865.112139907407;9867.60529578816;9845;9896.950515247414;9919.206463482904;9926.503674816266;9954.203663706887;9806.705798826046;9839.45882976436;9876.654317098866;9888.555015024305;9900.702978910644;9252.519596864537;9706.369086009387;9786.510674466319;9799.951000244953;9822.705318840446;36733.44899826505;41463.92680366;41562.58437415618;41658.583414165776;41688.79155604233;3277.082416923265;3445.2248244145117;3539.2213712983103;3572.214112895159;3732.682721968636;31479.527807082683;32005.359892802247;32655.346893062007;32789.508157377655;32992.505112423336;3193.3613277344625;3229.1765599771907;3232.337370838972;3299.6205436374885;3393.745469089828;482825;486210;489447;491689;506778;60971.69514152401;61194.694026529585;61297;61400.69299653473;61408.692956534935;35177.296454071286;35391.646083538835;35428.645713543054;37151.6996905107;37157.25685486275;15760.448384306494;16036.198190090448;16267;16487.92828466146;16521.421750238685;12499.18755280922;12604;12605.558805441766;12622.684432889251;12632.873671263353;18657.720134197996;18664.906675466536;18847.832499262488;19258.413013783684;19491.66873911962;7240.529365591325;7384.815379615553;7414.851702965911;7427.925720742832;7487.7004919803685;816.510093943629;967.57426732239;983.6065573770549;984.7538115471132;1013.5591017907234;26231.213063608124;28608.427831443256;29831.254218644273;31022.22444438907;31067.378652426825;972.6838777397375;988.1156365053237;1044.0342683018177;1052.8631277933819;1053.199568328076;15718.371265149495;15806.841931580537;16125.95181313211;16292.837071629368;16648.25082871274;657543;659809;661969.9015049228;662083;664842;60067;60549.69725151346;60622.393776062556;60636.39363606396;60675.69662151749;1319.8284223050941;1341.3896677011935;1355.7424089422977;1359.8436179839248;1365.5561942368968;25527.234182974542;30433.391332173676;31371.84314078415;32201.677983220805;33597.99206023823;53348.4665153359;54080.72959635177;54134;54234.7288263572;54348;617585;623561;624692;625975;627333;25768.226953191435;26232.213033609023;26319.34201644974;26479;26554.601680974414;48101.27848082212;48160.55518334456;48931.266031008854;49147;49335;39876.8006159979;39921.20157596774;40058;40413.230973367405;40616;39361.70212765944;39373.80313098531;39886.800565996986;40115.79942100271;40187.79906100568;37642.623573765006;37840.243195135394;38446.42330365103;38475.42286865755;39000;33394.666053339155;33952.320953581286;34851.825740871136;34853.47719784256;35498.29003419969;22648.094076236765;23839.451649647817;25422.872885635454;25909.481810364065;26066 00:02:55 INFO - PROCESS | 1676 | |2;jquery.html;353.68168648216584;372.1125116596916;373.99626003739957;382.5275784406258;401.7167896632874;13346.599602011944;13453.932730336346;14259.3583288752;20423.28518501853;20902.47743806402;18659;18933.52666183346;19202.519937001583;19422.863485016638;20440.897795511002;5768.740406681699;6123.601965872226;6131.570790044699;6143.508519318466;6144.938550614504;4674.298855171717;6087.2086628738425;6119.66341851198;6154.292256390528;6159.661218632973;5777.19119323295;6096.298925623543;6096.390360963913;6097.8170654880205;6104.877902441948;5969.343372229051;6073.544484163684;6076.908846367264;6081.604695694766;6084.117802918597;4983;5153.56194723449;5229.973850130725;5254.238135470336;5270.49930256625;24637.137700180407;24692.506149876903;25043;25269.62095568568;25559.361015974562;2031.654618714822;2291.5187810559637;2416.0094361311776;2562.6027965665353;2643.960340594893;10052.24608154384;10147.64483243083;10515.73710657232;10562.471876406149;10566.841497377469;1833.5507800588941;1859.6001859600115;1869.364416098533;1903;1973.6480510850113;109593.9705323766;112747.23516588949;118743.40628296803;122756;124200;9284.95357523208;9859.901400986042;9884.258680598983;9965.80068398628;10020.248481363928;12312.569060083033;12386.194897331645;12394.008479321632;12401.317927513894;12401.875981240253;7823.2567906048835;7995;8006.679732810739;8141.470804397695;8183.590820458953;8351.8329633407;8354.45696029756;8361.665533378718;8528.65885364591;8529.872051919227;3334.233126380946;3828.444875493038;3910.7066969976795;3913.745606535566;3985.8405663773706;1879.1919474625768;1924.162989099746;1926.1717461491694;1931.6909294512811;1933.4296382567177;379.250979315849;382.28131113506987;401.78303715993036;813.6257321632115;906.1165363770403;10838.837417438745;11351.94324028391;11511.30932144074;11650.825237621273;11903.940480297717;422.528880298465;435.81477871904315;438.4541246148502;443.5010613060307;446.2792589967244;5924.7037648118285;5944.970275148683;6059.515238780887;6107.29766076898;6236.251649802053;545836;587432;599740;623628;623905;85902.95407051271;107209;118498;119792;137929.00029495868;430.700663039191;447.6754353093981;449.5459585818347;449.85604606526255;451.17660270007366;11477.311361318347;11568.248063876157;11690;11832.822507662564;11869.821952670889;52057.7397113012;53078.73460632672;55151.44848551463;56561.434385655615;57761.71119144378;75126;81049.59475202586;81229;81642;84119;6971.407430368476;7918.3665306776475;7970;8184.631691573774;8213.38399620019;9253.86119208199;12312.384380780746;12841.422136004088;13072.542461013818;13596.93201533986;11148.498317575566;11356.034737047443;11359.636843578823;11469.483873225892;11572.826407604061;10795.460226988776;10869.347839129678;11234.213605047567;11258.986691197832;11540.769184616429;11399.316041037564;11488.885111149117;11700.35648039366;11861.644150675493;11924.403779811148;8199.22107399796;8359.707410240613;8366.87449688243;8379.790505237417;8463.57682115904;10840.824435063323;11246.1565382595;11294;11670.649880503599;11671.066314694634 00:02:55 INFO - PROCESS | 1676 | |3;mootools.html;1298.9285589292588;1493.4101030093111;1637.983620163798;1847.7690288713911;1877.7183422486617;8442.831143377129;8988.77528061797;9006.729798106051;9011.95494022529;9014.053524379944;7668.616569171547;7929.326007289373;7934.880976785353;8465.746027619165;8756.649734010647;2343.964840527398;2385.42749740062;2386.212549858551;2387.462820865309;2400.7119145702454;2343.16817529777;2343.5664402085586;2395.053953688292;2403.110848985869;2411.05968672218;2373.371056669975;2379.393254720044;2389.7729715676983;2397.892094855727;2402.8798560072014;2355.2934119764172;2363.5745565798147;2376.1920946878145;2383.725871524771;2390.1873363056643;2349.1777877742825;2365.8343915925893;2370.2296753554992;2370.8458950168356;2372.608519594265;8774.956125219333;8959.462432254086;8963.955180224122;8970.596323165408;8997.595108220146;5225;5374.435684253175;5413.02565538203;5417.322834645669;5428.538574221196;3591.8024508652275;3600.567931848169;3663.56037275526;3670.1925576373424;3682.0794801299676;1065.3820783945293;1069.096613361708;1074.2050882347085;1086.4676308608805;1095.2442814457997;11774.64676059711;11839.644810655695;11845.5854045108;11870.34713090771;11875.34685592292;4512.503624601291;4618.815247390066;4799.208130658402;4821.9035619288115;4824.782884770194;10049.949750251202;10052.949735251277;10071.992800719869;10074.143697785623;10083.747906302255;5376.731163441812;5391.649542779707;5392.379876314196;5394.244805727201;5397.8110766123;4359.04101097758;4508.436445444319;4531.410916580823;4905.70565766048;4911.066897289575;3347.5313456116164;3680.9877283747182;3859.324618191861;3925;4019.477467929209;995.4773743784571;1209.516193522598;1266.2782214138037;1281.35932033983;1281.6859869332072;805.428146016335;874.4097734029505;904.6426661468814;919.5494207838111;926.6941909170092;5803.332616749043;5954.761809527657;5964.373740757158;6135.447809697149;6352.936470635234;882.2853488674194;906.6600024990629;917.1974522292994;954.9877130241965;968.4237878462303;3759.567649720317;3978.1645854370327;3981.904926705019;4006.6794656427414;4088.34586466164;10511.316764410441;10683.358998460117;10926.562937482571;10935;10949.781004379867;10649.574017039387;10776.892231077589;10873.565057397775;10886.965738255012;10893.782124357469;8223.95888020556;8320.791980200544;8323.66705331792;8335.124811894784;8341.708040218684;4915.1644220481885;5573.749181286771;5920.082387229986;5941.881162376641;6000.759969601167;9967.302288839712;10082.69751907444;10111.54498047575;10196.286259961731;10285.74285642865;9874.703758887244;10221.897781022391;10232.744181395525;10457.738556536147;10471.42407167613;7350.375218106521;7648.541087534766;7807.219278072147;7964.721234756756;8076.798080048045;8249.917500824915;8373.120822313813;8410.495370277802;8428.199321064489;8456.069832318562;7364.631768411451;7381.261873812576;7500.13748418917;7566.432517561095;7619.238076192337;7214.71141154348;7285.052943117361;7299.160596531467;7316.012338334257;7433.442491813244;5769.249997500298;6988.475864310095;7048.224695283618;7048.823779405556;7058.188308344606;4824.204006338915;4979.3526841510375;5000.949990500194;5059.443461219189;5121.257417674491;4872.634552408513;4957.504249575158;5028.170351891897;5155.407128180157;5257.369115705987 00:02:55 INFO - PROCESS | 1676 | |4;prototype.html;243.64427935214587;290.76883877317533;305.7401208972373;311.7739638761898;313.140429520965;4696.365990591277;5098.158803797369;5201.800892451139;5261.474492243726;5262.447443018481;3805.448210009547;4848.490908454614;5051.595872330214;5083.567896728782;5100.464451232613;3965.583613720561;3973.384125460558;3974.7416417932886;3984.7409918355215;3992.920141597166;3977.0711205065522;3978.582248863871;3991.6407523322896;3998.2403343364667;4004.379321205218;3617.9095522611883;3693.741438099334;3693.873368622569;3733.9066523336996;3896.1428485733095;3283.5567198428143;3950.0052473500987;3953;3973.324534829057;3982.661473774718;2855.8714857831446;3330.20075181957;3439.2949445363643;3456.2050728332374;3471.8784842530645;3962.821673024721;4634.490206077328;4986.376702912136;5009.67243680425;5042.974785126087;3871.264459752638;4021.055052062763;4283.807228674717;4449.887528117971;4507.819687212507;5463.836084917459;5466.004908208515;5474.138792810463;5514.779408823642;5611.7474713637985;3100.2714362124884;3763.379042457991;3774.0753515388906;3784.2431513697097;3791.3175628387157;4732.751942827164;5608.663480191201;5615.546438940063;5673.319201695823;5700.831329577468;3525.206828463575;3793.430985352219;3796.8101594920145;3797.715171362159;3813.7711737295294;3244.6268679102204;3870.4000879863665;3887.455756194135;3888.941665875014;3896.1623251000606;3629.283256395342;4278.465191851019;4434.600885920283;4486.528914463935;4525.728456292633;4746.169420351424;5398.163284690879;5484.506394424521;5493.258410114663;5501.257330260363;1055.9102476289602;1096.4791723931228;1285.415136113085;1311.895048396126;1329.654289884637;788.7081779741533;826.4215049465398;849.3078141314809;878.1789027259533;881.7963479850087;4766.571008609242;5080.644354895196;5097.64316497849;5120.948790512121;5129.307543481582;5525.668459892419;5560.805371811967;5577.466196795914;5606.860158311359;5612;4824.131656301899;4898;4906.11689895815;5216.426193118754;5239.449857764956;2467.4324905271887;2559.462512872318;2921.7516511096796;2942.9264268393035;2950.542665886791;4892.290617860391;5631.8592035199445;5754.88490230193;5812.953668339739;5825.621334613236;4860.6111511079025;5086.287919691246;5652.954203472288;5688.317401911797;5748.655080695172;5386.192071189353;5798.594098413155;5805.593608447368;5817.883642327214;5836.445537673914;5260.342457192851;5396;5561.914282144196;5576.403219923046;5597.860053498695;5531.474509921551;5533.889322213614;5560.694161820977;5565.332160140809;5574.554035677217;5362;5798.913016304843;5802.912956305743;5841.211436456024;5859.882802344015;3727.881635509282;3752.1370084881178;3757.398816189506;3771.6039815818945;3825.6365645263654;5305.867353316198;5537.390887002507;5547.4175211603815;5585.385607583082;5593.272874526286;5100.923486147636;5373.865653358541;5403.621746477709;5421.132618780976;5433.994710978482;5032.572231360376;5139.434662187231;5190.584753219809;5333.253344531846;5413.891722165614;4997.775100120431;5047.924281135859;5180.093483640272;5214.687118772886;5283.365996080495;4782.641301902441;4983.152864013054;5296.424913183662;5455.863603409946;5476.91784623223;4459.620932220798;5293.629445938901;5322.866928326823;5326.869252298957;5344.198370244494 00:02:55 INFO - PROCESS | 1676 | |5;yui.html;700.2717174138896;723.797336745711;763.3358977689411;764.2128607534239;807.4630370803418;14612.561623151296;14704.632384190387;15278.618034549141;15334.38662453502;15342.386304547805;14124.646883827883;14235.217063061527;14275;14278.571642850706;14294.285285735723;676.4453148418299;701.7894631610521;702.9718811247544;813.4549851599413;839.5256679975794;835.9623816928253;861.1904809479101;863.4560227056977;866.8656358264479;875.8905136857893;912.2246090822781;915.6520522201554;917.2066162769223;917.7384445433053;917.9678711245108;708.4261747984149;912.0879120879154;912.1334732004622;913.0458670689112;916.0564618443015;549.3846891481526;662.3575132121834;676.1109141478939;682.474494639125;686.7287421468542;14669.26653667323;14733;14741.189234592093;14754.188519631416;14791.260436978107;13408.731825363535;13834.377453014638;13941.163530188222;14053;14110.117026800393;12646;12667.239965602093;12723.42744576487;13193.340332983313;13388.665283367896;4505.662075344329;4544.5228251033495;4580.541945805426;4734.124187025377;4748.7863046163;117044;118855.2171717425;119348;119639.4018029913;122598.38700806438;11107.888921110685;11131.998120169224;11162.218644694793;11174.27367221128;11570.884291157148;21818.89090554537;22297.888510557666;22375.328740137822;22386.44033899133;22388.664170037464;7593.354564862048;7668.616569171519;7881.251281128284;7895.447318687637;7966.28303452692;4253;4300.6129448349175;4349.891252718708;4448.421705178306;4503.662225333113;3418.2821607462215;3532;3532.5584301962253;3535.7524973251625;3536.345776031391;628.8585068359674;638.285120664849;646.2697152217963;647;647.3397134922353;585.1749033862234;613.6502193749609;615.1848800339568;618.1809102938624;643.7746788623945;8497.235248827636;8849.20357167858;8895.332850036273;9026.954865225633;9186.58660360272;505.98988020239386;557.4759725857681;606.2391698418456;629.0941044895336;630.8990561510136;4362.694611377173;4367.67242456817;4675.602573781199;4720.291956206596;4781;135098;138830;141350.29324853516;141643.29178354042;146067;98026;124228;124675;128044;128771;99921.50039249758;109180;109857;110944.4452777747;111080.88919110705;8468.872966905625;8812.823743524965;8912;8918.73243802687;9095.681651142442;47405.52594474011;52116.73941630268;59769.701151493966;61739.38260617336;63838.3616163851;61474.38525614687;85050;89836;92114;92831.14337713073;11635.360055197045;11711.355875426592;11782.116341274268;11952.58165964187;12213.572524961584;13069.738605228033;13155.408006639533;13510.594682159552;13777.966652500902;13793.310334483436;11994.700132496408;12225.938870305592;12363.62909112728;12513.874861251272;12923.612291631267;11620.186586938833;12069.155159138776;12085.214461060003;12095.274283543016;12171.756564868476;11816.291022538675;11826.881731182923;11911.106666999836;12185.147039707135;12255.75488490243;9839.803203935739;10149.49252537385;10534.315269507457;10707.625233117114;10758.408287543947;8812.339074569305;10310.639127630497;10396.87534338281;10577.153827693612;10581.947090264499 00:02:55 INFO - PROCESS | 1676 | __end_tp_report 00:02:55 INFO - PROCESS | 1676 | __start_cc_report 00:02:55 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1570 00:02:55 INFO - PROCESS | 1676 | __end_cc_report 00:02:55 INFO - PROCESS | 1676 | __startTimestamp1475478175707__endTimestamp 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | ------- Summary: start ------- 00:02:55 INFO - PROCESS | 1676 | Number of tests: 6 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5700.72 Median:5922.94 stddev:650.03 (11.0%) stddev-sans-first:607.01 00:02:55 INFO - PROCESS | 1676 | Values: 2670.8 3319.9 3348.4 3362.9 3384.8 5541.2 5610.1 5645.2 5703.0 5723.6 5640.3 5655.6 5693.6 5735.4 5772.9 5203.3 5251.6 5257.4 5261.6 5273.9 5217.7 5249.8 5265.2 5286.1 5307.7 5127.5 5255.4 5275.8 5282.4 5291.3 5079.8 5215.5 5232.4 5267.2 5310.4 5121.4 5128.9 5153.0 5176.9 5202.2 5551.6 5593.0 5600.2 5603.0 5626.3 6212.0 6228.2 6238.4 6242.5 6249.9 6097.8 6108.0 6154.4 6181.7 6241.5 4671.1 5768.5 5787.9 5799.2 5839.6 5815.2 6156.8 6231.8 6236.1 6258.0 5449.2 5947.8 6011.5 6107.0 6123.8 6125.4 6140.7 6165.4 6191.9 6247.2 6115.0 6166.1 6178.7 6186.5 6190.8 6152.0 6196.1 6202.8 6206.6 6207.1 4786.8 4849.3 4855.2 4860.3 4870.2 4355.5 4372.0 4413.5 4430.4 4462.9 5695.1 5712.1 5712.4 5713.7 5718.7 6066.1 6170.7 6171.4 6266.7 6301.5 5644.4 5686.0 5692.3 5724.1 5762.4 5366.2 5374.0 5378.8 5393.8 5403.1 6235.4 6267.7 6276.3 6281.1 6282.1 5198.9 6109.1 6174.0 6241.7 6291.9 6249.2 6279.4 6289.9 6291.2 6300.3 6140.2 6149.7 6170.3 6179.0 6199.8 6126.7 6140.4 6159.9 6164.4 6175.2 6110.9 6118.1 6125.2 6143.9 6155.9 6112.0 6113.6 6121.6 6125.1 6143.1 5765.7 5834.3 5884.0 5925.3 5960.6 6099.8 6100.4 6104.5 6120.0 6125.2 5748.3 5922.9 5928.8 5953.1 5987.2 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:71891.42 Median:40514.62 stddev:159667.44 (394.1%) stddev-sans-first:160025.36 00:02:55 INFO - PROCESS | 1676 | Values: 492.0 495.7 505.0 507.6 518.2 31041.0 40391.4 41392.0 41502.2 41542.4 43628.3 43927.8 43982.8 44024.8 44068.6 9786.0 9980.2 9988.8 9994.9 9998.0 9760.6 9853.5 9857.4 9865.1 9867.6 9845.0 9897.0 9919.2 9926.5 9954.2 9806.7 9839.5 9876.7 9888.6 9900.7 9252.5 9706.4 9786.5 9800.0 9822.7 36733.4 41463.9 41562.6 41658.6 41688.8 3277.1 3445.2 3539.2 3572.2 3732.7 31479.5 32005.4 32655.3 32789.5 32992.5 3193.4 3229.2 3232.3 3299.6 3393.7 482825.0 486210.0 489447.0 491689.0 506778.0 60971.7 61194.7 61297.0 61400.7 61408.7 35177.3 35391.6 35428.6 37151.7 37157.3 15760.4 16036.2 16267.0 16487.9 16521.4 12499.2 12604.0 12605.6 12622.7 12632.9 18657.7 18664.9 18847.8 19258.4 19491.7 7240.5 7384.8 7414.9 7427.9 7487.7 816.5 967.6 983.6 984.8 1013.6 26231.2 28608.4 29831.3 31022.2 31067.4 972.7 988.1 1044.0 1052.9 1053.2 15718.4 15806.8 16126.0 16292.8 16648.3 657543.0 659809.0 661969.9 662083.0 664842.0 60067.0 60549.7 60622.4 60636.4 60675.7 1319.8 1341.4 1355.7 1359.8 1365.6 25527.2 30433.4 31371.8 32201.7 33598.0 53348.5 54080.7 54134.0 54234.7 54348.0 617585.0 623561.0 624692.0 625975.0 627333.0 25768.2 26232.2 26319.3 26479.0 26554.6 48101.3 48160.6 48931.3 49147.0 49335.0 39876.8 39921.2 40058.0 40413.2 40616.0 39361.7 39373.8 39886.8 40115.8 40187.8 37642.6 37840.2 38446.4 38475.4 39000.0 33394.7 33952.3 34851.8 34853.5 35498.3 22648.1 23839.5 25422.9 25909.5 26066.0 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:33809.64 Median:2105.49 stddev:99546.29 (4727.9%) stddev-sans-first:99793.85 00:02:55 INFO - PROCESS | 1676 | Values: 353.7 372.1 374.0 382.5 401.7 13346.6 13453.9 14259.4 20423.3 20902.5 18659.0 18933.5 19202.5 19422.9 20440.9 5768.7 6123.6 6131.6 6143.5 6144.9 4674.3 6087.2 6119.7 6154.3 6159.7 5777.2 6096.3 6096.4 6097.8 6104.9 5969.3 6073.5 6076.9 6081.6 6084.1 4983.0 5153.6 5230.0 5254.2 5270.5 24637.1 24692.5 25043.0 25269.6 25559.4 2031.7 2291.5 2416.0 2562.6 2644.0 10052.2 10147.6 10515.7 10562.5 10566.8 1833.6 1859.6 1869.4 1903.0 1973.6 109594.0 112747.2 118743.4 122756.0 124200.0 9285.0 9859.9 9884.3 9965.8 10020.2 12312.6 12386.2 12394.0 12401.3 12401.9 7823.3 7995.0 8006.7 8141.5 8183.6 8351.8 8354.5 8361.7 8528.7 8529.9 3334.2 3828.4 3910.7 3913.7 3985.8 1879.2 1924.2 1926.2 1931.7 1933.4 379.3 382.3 401.8 813.6 906.1 10838.8 11351.9 11511.3 11650.8 11903.9 422.5 435.8 438.5 443.5 446.3 5924.7 5945.0 6059.5 6107.3 6236.3 545836.0 587432.0 599740.0 623628.0 623905.0 85903.0 107209.0 118498.0 119792.0 137929.0 430.7 447.7 449.5 449.9 451.2 11477.3 11568.2 11690.0 11832.8 11869.8 52057.7 53078.7 55151.4 56561.4 57761.7 75126.0 81049.6 81229.0 81642.0 84119.0 6971.4 7918.4 7970.0 8184.6 8213.4 9253.9 12312.4 12841.4 13072.5 13596.9 11148.5 11356.0 11359.6 11469.5 11572.8 10795.5 10869.3 11234.2 11259.0 11540.8 11399.3 11488.9 11700.4 11861.6 11924.4 8199.2 8359.7 8366.9 8379.8 8463.6 10840.8 11246.2 11294.0 11670.6 11671.1 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5744.31 Median:4848.71 stddev:3239.98 (66.8%) stddev-sans-first:3231.84 00:02:55 INFO - PROCESS | 1676 | Values: 1298.9 1493.4 1638.0 1847.8 1877.7 8442.8 8988.8 9006.7 9012.0 9014.1 7668.6 7929.3 7934.9 8465.7 8756.6 2344.0 2385.4 2386.2 2387.5 2400.7 2343.2 2343.6 2395.1 2403.1 2411.1 2373.4 2379.4 2389.8 2397.9 2402.9 2355.3 2363.6 2376.2 2383.7 2390.2 2349.2 2365.8 2370.2 2370.8 2372.6 8775.0 8959.5 8964.0 8970.6 8997.6 5225.0 5374.4 5413.0 5417.3 5428.5 3591.8 3600.6 3663.6 3670.2 3682.1 1065.4 1069.1 1074.2 1086.5 1095.2 11774.6 11839.6 11845.6 11870.3 11875.3 4512.5 4618.8 4799.2 4821.9 4824.8 10049.9 10052.9 10072.0 10074.1 10083.7 5376.7 5391.6 5392.4 5394.2 5397.8 4359.0 4508.4 4531.4 4905.7 4911.1 3347.5 3681.0 3859.3 3925.0 4019.5 995.5 1209.5 1266.3 1281.4 1281.7 805.4 874.4 904.6 919.5 926.7 5803.3 5954.8 5964.4 6135.4 6352.9 882.3 906.7 917.2 955.0 968.4 3759.6 3978.2 3981.9 4006.7 4088.3 10511.3 10683.4 10926.6 10935.0 10949.8 10649.6 10776.9 10873.6 10887.0 10893.8 8224.0 8320.8 8323.7 8335.1 8341.7 4915.2 5573.7 5920.1 5941.9 6000.8 9967.3 10082.7 10111.5 10196.3 10285.7 9874.7 10221.9 10232.7 10457.7 10471.4 7350.4 7648.5 7807.2 7964.7 8076.8 8249.9 8373.1 8410.5 8428.2 8456.1 7364.6 7381.3 7500.1 7566.4 7619.2 7214.7 7285.1 7299.2 7316.0 7433.4 5769.2 6988.5 7048.2 7048.8 7058.2 4824.2 4979.4 5000.9 5059.4 5121.3 4872.6 4957.5 5028.2 5155.4 5257.4 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:4415.72 Median:5045.45 stddev:1372.77 (27.2%) stddev-sans-first:1340.43 00:02:55 INFO - PROCESS | 1676 | Values: 243.6 290.8 305.7 311.8 313.1 4696.4 5098.2 5201.8 5261.5 5262.4 3805.4 4848.5 5051.6 5083.6 5100.5 3965.6 3973.4 3974.7 3984.7 3992.9 3977.1 3978.6 3991.6 3998.2 4004.4 3617.9 3693.7 3693.9 3733.9 3896.1 3283.6 3950.0 3953.0 3973.3 3982.7 2855.9 3330.2 3439.3 3456.2 3471.9 3962.8 4634.5 4986.4 5009.7 5043.0 3871.3 4021.1 4283.8 4449.9 4507.8 5463.8 5466.0 5474.1 5514.8 5611.7 3100.3 3763.4 3774.1 3784.2 3791.3 4732.8 5608.7 5615.5 5673.3 5700.8 3525.2 3793.4 3796.8 3797.7 3813.8 3244.6 3870.4 3887.5 3888.9 3896.2 3629.3 4278.5 4434.6 4486.5 4525.7 4746.2 5398.2 5484.5 5493.3 5501.3 1055.9 1096.5 1285.4 1311.9 1329.7 788.7 826.4 849.3 878.2 881.8 4766.6 5080.6 5097.6 5120.9 5129.3 5525.7 5560.8 5577.5 5606.9 5612.0 4824.1 4898.0 4906.1 5216.4 5239.4 2467.4 2559.5 2921.8 2942.9 2950.5 4892.3 5631.9 5754.9 5813.0 5825.6 4860.6 5086.3 5653.0 5688.3 5748.7 5386.2 5798.6 5805.6 5817.9 5836.4 5260.3 5396.0 5561.9 5576.4 5597.9 5531.5 5533.9 5560.7 5565.3 5574.6 5362.0 5798.9 5802.9 5841.2 5859.9 3727.9 3752.1 3757.4 3771.6 3825.6 5305.9 5537.4 5547.4 5585.4 5593.3 5100.9 5373.9 5403.6 5421.1 5434.0 5032.6 5139.4 5190.6 5333.3 5413.9 4997.8 5047.9 5180.1 5214.7 5283.4 4782.6 4983.2 5296.4 5455.9 5476.9 4459.6 5293.6 5322.9 5326.9 5344.2 00:02:55 INFO - PROCESS | 1676 | 00:02:55 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:24058.69 Median:3894.67 stddev:38507.33 (988.7%) stddev-sans-first:38575.42 00:02:55 INFO - PROCESS | 1676 | Values: 700.3 723.8 763.3 764.2 807.5 14612.6 14704.6 15278.6 15334.4 15342.4 14124.6 14235.2 14275.0 14278.6 14294.3 676.4 701.8 703.0 813.5 839.5 836.0 861.2 863.5 866.9 875.9 912.2 915.7 917.2 917.7 918.0 708.4 912.1 912.1 913.0 916.1 549.4 662.4 676.1 682.5 686.7 14669.3 14733.0 14741.2 14754.2 14791.3 13408.7 13834.4 13941.2 14053.0 14110.1 12646.0 12667.2 12723.4 13193.3 13388.7 4505.7 4544.5 4580.5 4734.1 4748.8 117044.0 118855.2 119348.0 119639.4 122598.4 11107.9 11132.0 11162.2 11174.3 11570.9 21818.9 22297.9 22375.3 22386.4 22388.7 7593.4 7668.6 7881.3 7895.4 7966.3 4253.0 4300.6 4349.9 4448.4 4503.7 3418.3 3532.0 3532.6 3535.8 3536.3 628.9 638.3 646.3 647.0 647.3 585.2 613.7 615.2 618.2 643.8 8497.2 8849.2 8895.3 9027.0 9186.6 506.0 557.5 606.2 629.1 630.9 4362.7 4367.7 4675.6 4720.3 4781.0 135098.0 138830.0 141350.3 141643.3 146067.0 98026.0 124228.0 124675.0 128044.0 128771.0 99921.5 109180.0 109857.0 110944.4 111080.9 8468.9 8812.8 8912.0 8918.7 9095.7 47405.5 52116.7 59769.7 61739.4 63838.4 61474.4 85050.0 89836.0 92114.0 92831.1 11635.4 11711.4 11782.1 11952.6 12213.6 13069.7 13155.4 13510.6 13778.0 13793.3 11994.7 12225.9 12363.6 12513.9 12923.6 11620.2 12069.2 12085.2 12095.3 12171.8 11816.3 11826.9 11911.1 12185.1 12255.8 9839.8 10149.5 10534.3 10707.6 10758.4 8812.3 10310.6 10396.9 10577.2 10581.9 00:02:55 INFO - PROCESS | 1676 | -------- Summary: end -------- 00:02:55 INFO - PROCESS | 1676 | 00:02:56 INFO - TEST-INFO | 1676: exit 0 00:02:56 INFO - TEST-OK | dromaeo_css | took 1119517ms 00:02:56 INFO - TEST-START | kraken 00:02:56 INFO - operating with platform_type : mac_ 00:02:56 INFO - Initialising browser for kraken test... 00:02:56 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpaeugKg/profile http://localhost:49279/getInfo.html) 00:02:58 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 00:02:58 INFO - PROCESS | 1683 | colorDepth:24 00:02:58 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 00:02:58 INFO - PROCESS | 1683 | __metrics 00:02:58 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:02:58 INFO - PROCESS | 1683 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:02:59 INFO - TEST-INFO | 1683: exit 0 00:02:59 INFO - Browser initialized. 00:02:59 INFO - Running cycle 1/1 for kraken test... 00:02:59 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpaeugKg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:03:11 INFO - PROCESS | 1684 | RSS: Main: 236052480 00:03:11 INFO - PROCESS | 1684 | 00:03:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 00:03:15 INFO - PROCESS | 1684 | RSS: Main: 294432768 00:03:15 INFO - PROCESS | 1684 | 00:03:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 00:03:18 INFO - PROCESS | 1684 | RSS: Main: 293441536 00:03:18 INFO - PROCESS | 1684 | 00:03:22 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 00:03:22 INFO - PROCESS | 1684 | RSS: Main: 382881792 00:03:22 INFO - PROCESS | 1684 | 00:03:24 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 00:03:25 INFO - PROCESS | 1684 | RSS: Main: 288972800 00:03:25 INFO - PROCESS | 1684 | 00:03:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:03:28 INFO - PROCESS | 1684 | RSS: Main: 290488320 00:03:28 INFO - PROCESS | 1684 | 00:03:30 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 00:03:31 INFO - PROCESS | 1684 | RSS: Main: 328232960 00:03:31 INFO - PROCESS | 1684 | 00:03:34 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 00:03:34 INFO - PROCESS | 1684 | RSS: Main: 329478144 00:03:34 INFO - PROCESS | 1684 | 00:03:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 00:03:38 INFO - PROCESS | 1684 | RSS: Main: 327151616 00:03:38 INFO - PROCESS | 1684 | 00:03:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:03:40 INFO - PROCESS | 1684 | RSS: Main: 302133248 00:03:40 INFO - PROCESS | 1684 | 00:03:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:03:42 INFO - PROCESS | 1684 | RSS: Main: 304951296 00:03:42 INFO - PROCESS | 1684 | 00:03:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:03:45 INFO - PROCESS | 1684 | RSS: Main: 311906304 00:03:45 INFO - PROCESS | 1684 | 00:03:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:03:49 INFO - PROCESS | 1684 | RSS: Main: 321421312 00:03:49 INFO - PROCESS | 1684 | 00:03:52 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:03:53 INFO - PROCESS | 1684 | RSS: Main: 321306624 00:03:53 INFO - PROCESS | 1684 | 00:03:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 00:03:55 INFO - PROCESS | 1684 | RSS: Main: 365875200 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | __start_tp_report 00:03:55 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 00:03:55 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 00:03:55 INFO - PROCESS | 1684 | |i|pagename|runs| 00:03:55 INFO - PROCESS | 1684 | |0;ai-astar;113;113;114;113;114;115;114;113;114;114 00:03:55 INFO - PROCESS | 1684 | |1;audio-beat-detection;149;112;113;149;117;109;115;112;142;111 00:03:55 INFO - PROCESS | 1684 | |2;audio-dft;183;182;183;189;184;182;183;182;181;182 00:03:55 INFO - PROCESS | 1684 | |3;audio-fft;81;59;59;87;61;59;59;58;82;57 00:03:55 INFO - PROCESS | 1684 | |4;audio-oscillator;83;71;94;71;67;69;90;67;69;90 00:03:55 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;86;87;89;90;87;90;88;89;86 00:03:55 INFO - PROCESS | 1684 | |6;imaging-darkroom;93;95;94;95;95;95;95;95;94;94 00:03:55 INFO - PROCESS | 1684 | |7;imaging-desaturate;87;86;85;85;86;84;84;84;84;88 00:03:55 INFO - PROCESS | 1684 | |8;json-parse-financial;57;55;53;52;53;54;52;54;53;54 00:03:55 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;65;72;69;76;71;68;68;71;69;71 00:03:55 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;85;85;89;87;88;89;84;90;88;87 00:03:55 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;147;141;145;146;145;144;145;145;205;150 00:03:55 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;169;169;171;183;238;217;172;171;170;171 00:03:55 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;68;69;69;69;68;71;71;68;68;68 00:03:55 INFO - PROCESS | 1684 | __end_tp_report 00:03:55 INFO - PROCESS | 1684 | __start_cc_report 00:03:55 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1992 00:03:55 INFO - PROCESS | 1684 | __end_cc_report 00:03:55 INFO - PROCESS | 1684 | __startTimestamp1475478235022__endTimestamp 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | ------- Summary: start ------- 00:03:55 INFO - PROCESS | 1684 | Number of tests: 14 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:03:55 INFO - PROCESS | 1684 | Values: 113.0 113.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:116.00 stddev:16.65 (14.4%) stddev-sans-first:14.74 00:03:55 INFO - PROCESS | 1684 | Values: 149.0 112.0 113.0 149.0 117.0 109.0 115.0 112.0 142.0 111.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:2.23 (1.2%) stddev-sans-first:2.37 00:03:55 INFO - PROCESS | 1684 | Values: 183.0 182.0 183.0 189.0 184.0 182.0 183.0 182.0 181.0 182.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:11.96 (19.9%) stddev-sans-first:11.42 00:03:55 INFO - PROCESS | 1684 | Values: 81.0 59.0 59.0 87.0 61.0 59.0 59.0 58.0 82.0 57.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:10.87 (14.1%) stddev-sans-first:11.31 00:03:55 INFO - PROCESS | 1684 | Values: 83.0 71.0 94.0 71.0 67.0 69.0 90.0 67.0 69.0 90.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:1.52 (1.7%) stddev-sans-first:1.58 00:03:55 INFO - PROCESS | 1684 | Values: 89.0 86.0 87.0 89.0 90.0 87.0 90.0 88.0 89.0 86.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.71 (0.7%) stddev-sans-first:0.50 00:03:55 INFO - PROCESS | 1684 | Values: 93.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.42 (1.7%) stddev-sans-first:1.36 00:03:55 INFO - PROCESS | 1684 | Values: 87.0 86.0 85.0 85.0 86.0 84.0 84.0 84.0 84.0 88.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.49 (2.8%) stddev-sans-first:1.00 00:03:55 INFO - PROCESS | 1684 | Values: 57.0 55.0 53.0 52.0 53.0 54.0 52.0 54.0 53.0 54.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:71.00 stddev:2.94 (4.1%) stddev-sans-first:2.51 00:03:55 INFO - PROCESS | 1684 | Values: 65.0 72.0 69.0 76.0 71.0 68.0 68.0 71.0 69.0 71.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.00 stddev:1.99 (2.3%) stddev-sans-first:1.94 00:03:55 INFO - PROCESS | 1684 | Values: 85.0 85.0 89.0 87.0 88.0 89.0 84.0 90.0 88.0 87.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:145.50 stddev:19.00 (13.1%) stddev-sans-first:20.09 00:03:55 INFO - PROCESS | 1684 | Values: 147.0 141.0 145.0 146.0 145.0 144.0 145.0 145.0 205.0 150.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:171.50 stddev:24.26 (14.1%) stddev-sans-first:25.18 00:03:55 INFO - PROCESS | 1684 | Values: 169.0 169.0 171.0 183.0 238.0 217.0 172.0 171.0 170.0 171.0 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.22 00:03:55 INFO - PROCESS | 1684 | Values: 68.0 69.0 69.0 69.0 68.0 71.0 71.0 68.0 68.0 68.0 00:03:55 INFO - PROCESS | 1684 | -------- Summary: end -------- 00:03:55 INFO - PROCESS | 1684 | 00:03:55 INFO - TEST-INFO | 1684: exit 0 00:03:55 INFO - TEST-OK | kraken | took 59453ms 00:03:55 INFO - SUITE-END | took 1178s 00:03:56 INFO - Completed test suite (00:19:39) 00:03:56 INFO - javascript benchmark 00:03:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.813043086984, 3319.9170020749484, 3348.3972884880727, 3362.9495557566643, 3384.813835239061, 5541.168824676301, 5610.130429783385, 5645.15322701594, 5703.0, 5723.599348045634, 5640.266765320503, 5655.632383895044, 5693.629914055594, 5735.397783232763, 5772.855678608026, 5203.2975548300965, 5251.55361794248, 5257.395399529065, 5261.605379596526, 5273.920891186635, 5217.739113044351, 5249.790008399678, 5265.210218467241, 5286.10136276832, 5307.655002424849, 5127.48725127488, 5255.421903590602, 5275.788968441258, 5282.366116066059, 5291.3385826771655, 5079.847604571832, 5215.452377500384, 5232.424433312332, 5267.183586544092, 5310.362756469229, 5121.385433747937, 5128.948710512922, 5153.046686362997, 5176.870578235536, 5202.219667049935, 5551.555875529948, 5592.972035139839, 5600.215969764236, 5602.971985140089, 5626.324841019104, 6212.0, 6228.22147231596, 6238.407351301619, 6242.531810114214, 6249.937500625027, 6097.766665674493, 6108.008189064015, 6154.415330543591, 6181.6600086995195, 6241.531885108589, 4671.065786842645, 5768.509676677488, 5787.855303617359, 5799.18811366409, 5839.620424672383, 5815.185873977646, 6156.846078848064, 6231.844203894939, 6236.064590311489, 6258.030005349178, 5449.209864569694, 5947.762089516457, 6011.458968692838, 6106.969465152734, 6123.84690382744, 6125.449118208347, 6140.723667434976, 6165.352637973038, 6191.876162476815, 6247.156633854372, 6115.0, 6166.075088736726, 6178.6601736904, 6186.4741496973265, 6190.845228869314, 6152.0, 6196.132541444202, 6202.81391558254, 6206.596571222856, 6207.099970504251, 4786.827227329327, 4849.2726091086615, 4855.198892182821, 4860.270959356125, 4870.196417591058, 4355.520892701864, 4372.0, 4413.470383553994, 4430.446194225722, 4462.933056004163, 5695.088785794253, 5712.11462223356, 5712.400197979236, 5713.714314284269, 5718.685472299064, 6066.059760737093, 6170.691465426711, 6171.413715697002, 6266.686665666698, 6301.495880329563, 5644.379118296984, 5685.971570142206, 5692.260006199251, 5724.084146536534, 5762.366139724627, 5366.168243922199, 5374.0, 5378.757955891994, 5393.78424863009, 5403.081476149064, 6235.438810507076, 6267.655278959701, 6276.309605943251, 6281.089242059876, 6282.120503129566, 5198.922016169836, 6109.070667813169, 6174.012158054689, 6241.656708881055, 6291.905621415591, 6249.187605611241, 6279.434850863444, 6289.937100628935, 6291.245050593958, 6300.338464461165, 6140.232470941132, 6149.692515374124, 6170.259568851587, 6178.969105154445, 6199.845003874939, 6126.724297406538, 6140.350877192904, 6159.938400615936, 6164.445199932027, 6175.166352542349, 6110.923300256407, 6118.07100585842, 6125.199680511147, 6143.911070236141, 6155.891939450942, 6112.022076467744, 6113.572049956639, 6121.632702037892, 6125.11336343068, 6143.109249158758, 5765.682887441231, 5834.27071616048, 5883.970580147072, 5925.288965324189, 5960.582759206987, 6099.763790468328, 6100.399513635539, 6104.4505994460715, 6119.969400152971, 6125.17440701618, 5748.281464816898, 5922.940770592411, 5928.822135335947, 5953.077273022688, 5987.161797348462], "value": 5657.687722914655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.00123748789946, 495.7372592525961, 504.98485045448604, 507.6091409614597, 518.2226660009985, 31041.0, 40391.39412908809, 41392.0, 41502.16995660085, 41542.37686434706, 43628.345574816325, 43927.78036109815, 43982.78008609961, 44024.779876100656, 44068.55931440685, 9786.02139786021, 9980.20158387331, 9988.800223995515, 9994.850077248811, 9998.0, 9760.560774765152, 9853.458059806708, 9857.359271647356, 9865.112139907407, 9867.60529578816, 9845.0, 9896.950515247414, 9919.206463482904, 9926.503674816266, 9954.203663706887, 9806.705798826046, 9839.45882976436, 9876.654317098866, 9888.555015024305, 9900.702978910644, 9252.519596864537, 9706.369086009387, 9786.510674466319, 9799.951000244953, 9822.705318840446, 36733.44899826505, 41463.92680366, 41562.58437415618, 41658.583414165776, 41688.79155604233, 3277.082416923265, 3445.2248244145117, 3539.2213712983103, 3572.214112895159, 3732.682721968636, 31479.527807082683, 32005.359892802247, 32655.346893062007, 32789.508157377655, 32992.505112423336, 3193.3613277344625, 3229.1765599771907, 3232.337370838972, 3299.6205436374885, 3393.745469089828, 482825.0, 486210.0, 489447.0, 491689.0, 506778.0, 60971.69514152401, 61194.694026529585, 61297.0, 61400.69299653473, 61408.692956534935, 35177.296454071286, 35391.646083538835, 35428.645713543054, 37151.6996905107, 37157.25685486275, 15760.448384306494, 16036.198190090448, 16267.0, 16487.92828466146, 16521.421750238685, 12499.18755280922, 12604.0, 12605.558805441766, 12622.684432889251, 12632.873671263353, 18657.720134197996, 18664.906675466536, 18847.832499262488, 19258.413013783684, 19491.66873911962, 7240.529365591325, 7384.815379615553, 7414.851702965911, 7427.925720742832, 7487.7004919803685, 816.510093943629, 967.57426732239, 983.6065573770549, 984.7538115471132, 1013.5591017907234, 26231.213063608124, 28608.427831443256, 29831.254218644273, 31022.22444438907, 31067.378652426825, 972.6838777397375, 988.1156365053237, 1044.0342683018177, 1052.8631277933819, 1053.199568328076, 15718.371265149495, 15806.841931580537, 16125.95181313211, 16292.837071629368, 16648.25082871274, 657543.0, 659809.0, 661969.9015049228, 662083.0, 664842.0, 60067.0, 60549.69725151346, 60622.393776062556, 60636.39363606396, 60675.69662151749, 1319.8284223050941, 1341.3896677011935, 1355.7424089422977, 1359.8436179839248, 1365.5561942368968, 25527.234182974542, 30433.391332173676, 31371.84314078415, 32201.677983220805, 33597.99206023823, 53348.4665153359, 54080.72959635177, 54134.0, 54234.7288263572, 54348.0, 617585.0, 623561.0, 624692.0, 625975.0, 627333.0, 25768.226953191435, 26232.213033609023, 26319.34201644974, 26479.0, 26554.601680974414, 48101.27848082212, 48160.55518334456, 48931.266031008854, 49147.0, 49335.0, 39876.8006159979, 39921.20157596774, 40058.0, 40413.230973367405, 40616.0, 39361.70212765944, 39373.80313098531, 39886.800565996986, 40115.79942100271, 40187.79906100568, 37642.623573765006, 37840.243195135394, 38446.42330365103, 38475.42286865755, 39000.0, 33394.666053339155, 33952.320953581286, 34851.825740871136, 34853.47719784256, 35498.29003419969, 22648.094076236765, 23839.451649647817, 25422.872885635454, 25909.481810364065, 26066.0], "value": 19970.47095710312, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.68168648216584, 372.1125116596916, 373.99626003739957, 382.5275784406258, 401.7167896632874, 13346.599602011944, 13453.932730336346, 14259.3583288752, 20423.28518501853, 20902.47743806402, 18659.0, 18933.52666183346, 19202.519937001583, 19422.863485016638, 20440.897795511002, 5768.740406681699, 6123.601965872226, 6131.570790044699, 6143.508519318466, 6144.938550614504, 4674.298855171717, 6087.2086628738425, 6119.66341851198, 6154.292256390528, 6159.661218632973, 5777.19119323295, 6096.298925623543, 6096.390360963913, 6097.8170654880205, 6104.877902441948, 5969.343372229051, 6073.544484163684, 6076.908846367264, 6081.604695694766, 6084.117802918597, 4983.0, 5153.56194723449, 5229.973850130725, 5254.238135470336, 5270.49930256625, 24637.137700180407, 24692.506149876903, 25043.0, 25269.62095568568, 25559.361015974562, 2031.654618714822, 2291.5187810559637, 2416.0094361311776, 2562.6027965665353, 2643.960340594893, 10052.24608154384, 10147.64483243083, 10515.73710657232, 10562.471876406149, 10566.841497377469, 1833.5507800588941, 1859.6001859600115, 1869.364416098533, 1903.0, 1973.6480510850113, 109593.9705323766, 112747.23516588949, 118743.40628296803, 122756.0, 124200.0, 9284.95357523208, 9859.901400986042, 9884.258680598983, 9965.80068398628, 10020.248481363928, 12312.569060083033, 12386.194897331645, 12394.008479321632, 12401.317927513894, 12401.875981240253, 7823.2567906048835, 7995.0, 8006.679732810739, 8141.470804397695, 8183.590820458953, 8351.8329633407, 8354.45696029756, 8361.665533378718, 8528.65885364591, 8529.872051919227, 3334.233126380946, 3828.444875493038, 3910.7066969976795, 3913.745606535566, 3985.8405663773706, 1879.1919474625768, 1924.162989099746, 1926.1717461491694, 1931.6909294512811, 1933.4296382567177, 379.250979315849, 382.28131113506987, 401.78303715993036, 813.6257321632115, 906.1165363770403, 10838.837417438745, 11351.94324028391, 11511.30932144074, 11650.825237621273, 11903.940480297717, 422.528880298465, 435.81477871904315, 438.4541246148502, 443.5010613060307, 446.2792589967244, 5924.7037648118285, 5944.970275148683, 6059.515238780887, 6107.29766076898, 6236.251649802053, 545836.0, 587432.0, 599740.0, 623628.0, 623905.0, 85902.95407051271, 107209.0, 118498.0, 119792.0, 137929.00029495868, 430.700663039191, 447.6754353093981, 449.5459585818347, 449.85604606526255, 451.17660270007366, 11477.311361318347, 11568.248063876157, 11690.0, 11832.822507662564, 11869.821952670889, 52057.7397113012, 53078.73460632672, 55151.44848551463, 56561.434385655615, 57761.71119144378, 75126.0, 81049.59475202586, 81229.0, 81642.0, 84119.0, 6971.407430368476, 7918.3665306776475, 7970.0, 8184.631691573774, 8213.38399620019, 9253.86119208199, 12312.384380780746, 12841.422136004088, 13072.542461013818, 13596.93201533986, 11148.498317575566, 11356.034737047443, 11359.636843578823, 11469.483873225892, 11572.826407604061, 10795.460226988776, 10869.347839129678, 11234.213605047567, 11258.986691197832, 11540.769184616429, 11399.316041037564, 11488.885111149117, 11700.35648039366, 11861.644150675493, 11924.403779811148, 8199.22107399796, 8359.707410240613, 8366.87449688243, 8379.790505237417, 8463.57682115904, 10840.824435063323, 11246.1565382595, 11294.0, 11670.649880503599, 11671.066314694634], "value": 8463.15947708493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.9285589292588, 1493.4101030093111, 1637.983620163798, 1847.7690288713911, 1877.7183422486617, 8442.831143377129, 8988.77528061797, 9006.729798106051, 9011.95494022529, 9014.053524379944, 7668.616569171547, 7929.326007289373, 7934.880976785353, 8465.746027619165, 8756.649734010647, 2343.964840527398, 2385.42749740062, 2386.212549858551, 2387.462820865309, 2400.7119145702454, 2343.16817529777, 2343.5664402085586, 2395.053953688292, 2403.110848985869, 2411.05968672218, 2373.371056669975, 2379.393254720044, 2389.7729715676983, 2397.892094855727, 2402.8798560072014, 2355.2934119764172, 2363.5745565798147, 2376.1920946878145, 2383.725871524771, 2390.1873363056643, 2349.1777877742825, 2365.8343915925893, 2370.2296753554992, 2370.8458950168356, 2372.608519594265, 8774.956125219333, 8959.462432254086, 8963.955180224122, 8970.596323165408, 8997.595108220146, 5225.0, 5374.435684253175, 5413.02565538203, 5417.322834645669, 5428.538574221196, 3591.8024508652275, 3600.567931848169, 3663.56037275526, 3670.1925576373424, 3682.0794801299676, 1065.3820783945293, 1069.096613361708, 1074.2050882347085, 1086.4676308608805, 1095.2442814457997, 11774.64676059711, 11839.644810655695, 11845.5854045108, 11870.34713090771, 11875.34685592292, 4512.503624601291, 4618.815247390066, 4799.208130658402, 4821.9035619288115, 4824.782884770194, 10049.949750251202, 10052.949735251277, 10071.992800719869, 10074.143697785623, 10083.747906302255, 5376.731163441812, 5391.649542779707, 5392.379876314196, 5394.244805727201, 5397.8110766123, 4359.04101097758, 4508.436445444319, 4531.410916580823, 4905.70565766048, 4911.066897289575, 3347.5313456116164, 3680.9877283747182, 3859.324618191861, 3925.0, 4019.477467929209, 995.4773743784571, 1209.516193522598, 1266.2782214138037, 1281.35932033983, 1281.6859869332072, 805.428146016335, 874.4097734029505, 904.6426661468814, 919.5494207838111, 926.6941909170092, 5803.332616749043, 5954.761809527657, 5964.373740757158, 6135.447809697149, 6352.936470635234, 882.2853488674194, 906.6600024990629, 917.1974522292994, 954.9877130241965, 968.4237878462303, 3759.567649720317, 3978.1645854370327, 3981.904926705019, 4006.6794656427414, 4088.34586466164, 10511.316764410441, 10683.358998460117, 10926.562937482571, 10935.0, 10949.781004379867, 10649.574017039387, 10776.892231077589, 10873.565057397775, 10886.965738255012, 10893.782124357469, 8223.95888020556, 8320.791980200544, 8323.66705331792, 8335.124811894784, 8341.708040218684, 4915.1644220481885, 5573.749181286771, 5920.082387229986, 5941.881162376641, 6000.759969601167, 9967.302288839712, 10082.69751907444, 10111.54498047575, 10196.286259961731, 10285.74285642865, 9874.703758887244, 10221.897781022391, 10232.744181395525, 10457.738556536147, 10471.42407167613, 7350.375218106521, 7648.541087534766, 7807.219278072147, 7964.721234756756, 8076.798080048045, 8249.917500824915, 8373.120822313813, 8410.495370277802, 8428.199321064489, 8456.069832318562, 7364.631768411451, 7381.261873812576, 7500.13748418917, 7566.432517561095, 7619.238076192337, 7214.71141154348, 7285.052943117361, 7299.160596531467, 7316.012338334257, 7433.442491813244, 5769.249997500298, 6988.475864310095, 7048.224695283618, 7048.823779405556, 7058.188308344606, 4824.204006338915, 4979.3526841510375, 5000.949990500194, 5059.443461219189, 5121.257417674491, 4872.634552408513, 4957.504249575158, 5028.170351891897, 5155.407128180157, 5257.369115705987], "value": 4603.658027594838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [243.64427935214587, 290.76883877317533, 305.7401208972373, 311.7739638761898, 313.140429520965, 4696.365990591277, 5098.158803797369, 5201.800892451139, 5261.474492243726, 5262.447443018481, 3805.448210009547, 4848.490908454614, 5051.595872330214, 5083.567896728782, 5100.464451232613, 3965.583613720561, 3973.384125460558, 3974.7416417932886, 3984.7409918355215, 3992.920141597166, 3977.0711205065522, 3978.582248863871, 3991.6407523322896, 3998.2403343364667, 4004.379321205218, 3617.9095522611883, 3693.741438099334, 3693.873368622569, 3733.9066523336996, 3896.1428485733095, 3283.5567198428143, 3950.0052473500987, 3953.0, 3973.324534829057, 3982.661473774718, 2855.8714857831446, 3330.20075181957, 3439.2949445363643, 3456.2050728332374, 3471.8784842530645, 3962.821673024721, 4634.490206077328, 4986.376702912136, 5009.67243680425, 5042.974785126087, 3871.264459752638, 4021.055052062763, 4283.807228674717, 4449.887528117971, 4507.819687212507, 5463.836084917459, 5466.004908208515, 5474.138792810463, 5514.779408823642, 5611.7474713637985, 3100.2714362124884, 3763.379042457991, 3774.0753515388906, 3784.2431513697097, 3791.3175628387157, 4732.751942827164, 5608.663480191201, 5615.546438940063, 5673.319201695823, 5700.831329577468, 3525.206828463575, 3793.430985352219, 3796.8101594920145, 3797.715171362159, 3813.7711737295294, 3244.6268679102204, 3870.4000879863665, 3887.455756194135, 3888.941665875014, 3896.1623251000606, 3629.283256395342, 4278.465191851019, 4434.600885920283, 4486.528914463935, 4525.728456292633, 4746.169420351424, 5398.163284690879, 5484.506394424521, 5493.258410114663, 5501.257330260363, 1055.9102476289602, 1096.4791723931228, 1285.415136113085, 1311.895048396126, 1329.654289884637, 788.7081779741533, 826.4215049465398, 849.3078141314809, 878.1789027259533, 881.7963479850087, 4766.571008609242, 5080.644354895196, 5097.64316497849, 5120.948790512121, 5129.307543481582, 5525.668459892419, 5560.805371811967, 5577.466196795914, 5606.860158311359, 5612.0, 4824.131656301899, 4898.0, 4906.11689895815, 5216.426193118754, 5239.449857764956, 2467.4324905271887, 2559.462512872318, 2921.7516511096796, 2942.9264268393035, 2950.542665886791, 4892.290617860391, 5631.8592035199445, 5754.88490230193, 5812.953668339739, 5825.621334613236, 4860.6111511079025, 5086.287919691246, 5652.954203472288, 5688.317401911797, 5748.655080695172, 5386.192071189353, 5798.594098413155, 5805.593608447368, 5817.883642327214, 5836.445537673914, 5260.342457192851, 5396.0, 5561.914282144196, 5576.403219923046, 5597.860053498695, 5531.474509921551, 5533.889322213614, 5560.694161820977, 5565.332160140809, 5574.554035677217, 5362.0, 5798.913016304843, 5802.912956305743, 5841.211436456024, 5859.882802344015, 3727.881635509282, 3752.1370084881178, 3757.398816189506, 3771.6039815818945, 3825.6365645263654, 5305.867353316198, 5537.390887002507, 5547.4175211603815, 5585.385607583082, 5593.272874526286, 5100.923486147636, 5373.865653358541, 5403.621746477709, 5421.132618780976, 5433.994710978482, 5032.572231360376, 5139.434662187231, 5190.584753219809, 5333.253344531846, 5413.891722165614, 4997.775100120431, 5047.924281135859, 5180.093483640272, 5214.687118772886, 5283.365996080495, 4782.641301902441, 4983.152864013054, 5296.424913183662, 5455.863603409946, 5476.91784623223, 4459.620932220798, 5293.629445938901, 5322.866928326823, 5326.869252298957, 5344.198370244494], "value": 3971.247087808379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.2717174138896, 723.797336745711, 763.3358977689411, 764.2128607534239, 807.4630370803418, 14612.561623151296, 14704.632384190387, 15278.618034549141, 15334.38662453502, 15342.386304547805, 14124.646883827883, 14235.217063061527, 14275.0, 14278.571642850706, 14294.285285735723, 676.4453148418299, 701.7894631610521, 702.9718811247544, 813.4549851599413, 839.5256679975794, 835.9623816928253, 861.1904809479101, 863.4560227056977, 866.8656358264479, 875.8905136857893, 912.2246090822781, 915.6520522201554, 917.2066162769223, 917.7384445433053, 917.9678711245108, 708.4261747984149, 912.0879120879154, 912.1334732004622, 913.0458670689112, 916.0564618443015, 549.3846891481526, 662.3575132121834, 676.1109141478939, 682.474494639125, 686.7287421468542, 14669.26653667323, 14733.0, 14741.189234592093, 14754.188519631416, 14791.260436978107, 13408.731825363535, 13834.377453014638, 13941.163530188222, 14053.0, 14110.117026800393, 12646.0, 12667.239965602093, 12723.42744576487, 13193.340332983313, 13388.665283367896, 4505.662075344329, 4544.5228251033495, 4580.541945805426, 4734.124187025377, 4748.7863046163, 117044.0, 118855.2171717425, 119348.0, 119639.4018029913, 122598.38700806438, 11107.888921110685, 11131.998120169224, 11162.218644694793, 11174.27367221128, 11570.884291157148, 21818.89090554537, 22297.888510557666, 22375.328740137822, 22386.44033899133, 22388.664170037464, 7593.354564862048, 7668.616569171519, 7881.251281128284, 7895.447318687637, 7966.28303452692, 4253.0, 4300.6129448349175, 4349.891252718708, 4448.421705178306, 4503.662225333113, 3418.2821607462215, 3532.0, 3532.5584301962253, 3535.7524973251625, 3536.345776031391, 628.8585068359674, 638.285120664849, 646.2697152217963, 647.0, 647.3397134922353, 585.1749033862234, 613.6502193749609, 615.1848800339568, 618.1809102938624, 643.7746788623945, 8497.235248827636, 8849.20357167858, 8895.332850036273, 9026.954865225633, 9186.58660360272, 505.98988020239386, 557.4759725857681, 606.2391698418456, 629.0941044895336, 630.8990561510136, 4362.694611377173, 4367.67242456817, 4675.602573781199, 4720.291956206596, 4781.0, 135098.0, 138830.0, 141350.29324853516, 141643.29178354042, 146067.0, 98026.0, 124228.0, 124675.0, 128044.0, 128771.0, 99921.50039249758, 109180.0, 109857.0, 110944.4452777747, 111080.88919110705, 8468.872966905625, 8812.823743524965, 8912.0, 8918.73243802687, 9095.681651142442, 47405.52594474011, 52116.73941630268, 59769.701151493966, 61739.38260617336, 63838.3616163851, 61474.38525614687, 85050.0, 89836.0, 92114.0, 92831.14337713073, 11635.360055197045, 11711.355875426592, 11782.116341274268, 11952.58165964187, 12213.572524961584, 13069.738605228033, 13155.408006639533, 13510.594682159552, 13777.966652500902, 13793.310334483436, 11994.700132496408, 12225.938870305592, 12363.62909112728, 12513.874861251272, 12923.612291631267, 11620.186586938833, 12069.155159138776, 12085.214461060003, 12095.274283543016, 12171.756564868476, 11816.291022538675, 11826.881731182923, 11911.106666999836, 12185.147039707135, 12255.75488490243, 9839.803203935739, 10149.49252537385, 10534.315269507457, 10707.625233117114, 10758.408287543947, 8812.339074569305, 10310.639127630497, 10396.87534338281, 10577.153827693612, 10581.947090264499], "value": 7605.461019300648, "unit": "score"}], "name": "dromaeo_css", "value": 7144.30848431617, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 112.0, 113.0, 149.0, 117.0, 109.0, 115.0, 112.0, 142.0, 111.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 189.0, 184.0, 182.0, 183.0, 182.0, 181.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 87.0, 61.0, 59.0, 59.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 94.0, 71.0, 67.0, 69.0, 90.0, 67.0, 69.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 89.0, 90.0, 87.0, 90.0, 88.0, 89.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 85.0, 86.0, 84.0, 84.0, 84.0, 84.0, 88.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 52.0, 53.0, 54.0, 52.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 69.0, 76.0, 71.0, 68.0, 68.0, 71.0, 69.0, 71.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 87.0, 88.0, 89.0, 84.0, 90.0, 88.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 145.0, 146.0, 145.0, 144.0, 145.0, 145.0, 205.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 171.0, 183.0, 238.0, 217.0, 172.0, 171.0, 170.0, 171.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 71.0, 71.0, 68.0, 68.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1445.1, "alertThreshold": 2.0}]} 00:03:56 INFO - Return code: 0 00:03:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:03:56 INFO - # TBPL SUCCESS # 00:03:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:03:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:03:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:03:56 INFO - 2016-10-03 00:03:56.354 screenresolution[1688:11051] starting screenresolution argv=screenresolution get 00:03:56 INFO - 2016-10-03 00:03:56.357 screenresolution[1688:11051] Display 0: 1600x1200x32@60 00:03:56 INFO - 2016-10-03 00:03:56.363 screenresolution[1689:11054] starting screenresolution argv=screenresolution list 00:03:56 INFO - Available Modes on Display 0 00:03:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:03:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:03:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:03:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:03:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:03:56 INFO - Intel Iris: 00:03:56 INFO - Chipset Model: Intel Iris 00:03:56 INFO - Type: GPU 00:03:56 INFO - Bus: Built-In 00:03:56 INFO - VRAM (Dynamic, Max): 1536 MB 00:03:56 INFO - Vendor: Intel (0x8086) 00:03:56 INFO - Device ID: 0x0a2e 00:03:56 INFO - Revision ID: 0x0009 00:03:56 INFO - Displays: 00:03:56 INFO - Display: 00:03:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:03:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:03:56 INFO - Display Serial Number: 1600x1200 60 00:03:56 INFO - Main Display: Yes 00:03:56 INFO - Mirror: Off 00:03:56 INFO - Online: Yes 00:03:56 INFO - Rotation: Supported 00:03:56 INFO - Return code: 0 00:03:56 INFO - Running post-action listener: _resource_record_post_action 00:03:56 INFO - [mozharness: 2016-10-03 07:03:56.599764Z] Finished run-tests step (success) 00:03:56 INFO - Running post-run listener: _resource_record_post_run 00:03:56 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 34741248; Write bytes: 714172416; Read time: 250; Write time: 1967 00:03:56 INFO - TinderboxPrint: CPU usage
53.7% 00:03:56 INFO - TinderboxPrint: I/O read bytes / time
34,741,248 / 250 00:03:56 INFO - TinderboxPrint: I/O write bytes / time
714,172,416 / 1,967 00:03:56 INFO - TinderboxPrint: CPU idle
2,249.3 (46.3%) 00:03:56 INFO - TinderboxPrint: CPU system
977.6 (20.1%) 00:03:56 INFO - TinderboxPrint: CPU user
1,634.7 (33.6%) 00:03:56 INFO - TinderboxPrint: Swap in / out
437,649,408 / 0 00:03:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408556032; Write bytes: 411183104; Read time: 31020; Write time: 809 00:03:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31886336; Write bytes: 301551616; Read time: 227; Write time: 1152 00:03:57 INFO - Running post-run listener: _upload_blobber_files 00:03:57 INFO - Blob upload gear active. 00:03:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:03:57 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 00:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:03:57 INFO - (blobuploader) - INFO - Open directory for files ... 00:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:03:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:58 INFO - (blobuploader) - INFO - Done attempting. 00:03:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:03:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:03:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:59 INFO - (blobuploader) - INFO - Done attempting. 00:03:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:03:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:01 INFO - (blobuploader) - INFO - Done attempting. 00:04:01 INFO - (blobuploader) - INFO - Iteration through files over. 00:04:01 INFO - Return code: 0 00:04:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:04:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:04:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8151b5cec241425c469b15ab04910b0dceac84f06aab95a3e3db163972b1565211699e2a5c4b2403cf9d8c7c013e0a18f3e538bcf0fbc69f7e783710da565482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82b2bc23d0c8ab909c0efa8ca1852f4fe99d7af9c14337ddcd298535bcf331f8e67555e0f28a700f3b3b9e4a829f6b068ce516a20d42165a80b78533cf8ae4e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894d20dd0ef8dad2c1613df91e566a47d09cd24d2090f66841caa0167d2992f5b0ecd64e5a4ec8cace5b84d779e4262348f53c077de9a95b3a31ad5ddffca0fe"} 00:04:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:04:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:04:01 INFO - Contents: 00:04:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8151b5cec241425c469b15ab04910b0dceac84f06aab95a3e3db163972b1565211699e2a5c4b2403cf9d8c7c013e0a18f3e538bcf0fbc69f7e783710da565482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82b2bc23d0c8ab909c0efa8ca1852f4fe99d7af9c14337ddcd298535bcf331f8e67555e0f28a700f3b3b9e4a829f6b068ce516a20d42165a80b78533cf8ae4e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894d20dd0ef8dad2c1613df91e566a47d09cd24d2090f66841caa0167d2992f5b0ecd64e5a4ec8cace5b84d779e4262348f53c077de9a95b3a31ad5ddffca0fe"} 00:04:01 INFO - Running post-run listener: copy_logs_to_upload_dir 00:04:01 INFO - Copying logs to upload dir... 00:04:01 INFO - mkdir: /builds/slave/test/build/upload/logs 00:04:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.948744 ========= master_lag: 18.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-10-03 00:04:20.141426) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 00:04:20.144702) ========= 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.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/Firefox/sha512/8151b5cec241425c469b15ab04910b0dceac84f06aab95a3e3db163972b1565211699e2a5c4b2403cf9d8c7c013e0a18f3e538bcf0fbc69f7e783710da565482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82b2bc23d0c8ab909c0efa8ca1852f4fe99d7af9c14337ddcd298535bcf331f8e67555e0f28a700f3b3b9e4a829f6b068ce516a20d42165a80b78533cf8ae4e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894d20dd0ef8dad2c1613df91e566a47d09cd24d2090f66841caa0167d2992f5b0ecd64e5a4ec8cace5b84d779e4262348f53c077de9a95b3a31ad5ddffca0fe"} build_url:https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/MuGVE50MRTe_N9909nEtgw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8151b5cec241425c469b15ab04910b0dceac84f06aab95a3e3db163972b1565211699e2a5c4b2403cf9d8c7c013e0a18f3e538bcf0fbc69f7e783710da565482", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82b2bc23d0c8ab909c0efa8ca1852f4fe99d7af9c14337ddcd298535bcf331f8e67555e0f28a700f3b3b9e4a829f6b068ce516a20d42165a80b78533cf8ae4e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894d20dd0ef8dad2c1613df91e566a47d09cd24d2090f66841caa0167d2992f5b0ecd64e5a4ec8cace5b84d779e4262348f53c077de9a95b3a31ad5ddffca0fe"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 00:04:20.406685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 00:04:20.406978) ========= 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.pTdzXQek60/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.KPqLZdt7vM/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.005204 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 00:04:20.524853) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-10-03 00:04:20.525126) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-10-03 00:04:22.858270) ========= ========= Total master_lag: 18.64 =========