builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1460029344.51 results: success (0) buildid: 20160407043446 builduid: 0792d2782011433daa62c8eeff464aa0 revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.513577) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.514126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.514486) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005681 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.543501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.544268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.563456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.564240) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005442 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.618650) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.619445) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.620399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.621151) ========= 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.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-04-07 04:42:24-- 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% 16.4M=0.001s 2016-04-07 04:42:24 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.816749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.817574) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.026472 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.870022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:24.870844) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-04-07 04:42:24,949 truncating revision to first 12 chars 2016-04-07 04:42:24,949 Setting DEBUG logging. 2016-04-07 04:42:24,949 attempt 1/10 2016-04-07 04:42:24,949 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68c0b7d6f16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 04:42:25,233 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:25.419217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:25.420102) ========= echo 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 program finished with exit code 0 elapsedTime=0.005020 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:25.474767) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:25.475237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:25.488388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-07 04:42:25.488856) ========= /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.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:25 INFO - MultiFileLogger online at 20160407 04:42:25 in /builds/slave/test 04:42:25 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 04:42:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:25 INFO - {'append_to_log': False, 04:42:25 INFO - 'base_work_dir': '/builds/slave/test', 04:42:25 INFO - 'blob_upload_branch': 'Firefox', 04:42:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:25 INFO - 'branch': 'Firefox', 04:42:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:25 INFO - 'config_files': ('talos/mac_config.py',), 04:42:25 INFO - 'default_actions': ('clobber', 04:42:25 INFO - 'read-buildbot-config', 04:42:25 INFO - 'download-and-extract', 04:42:25 INFO - 'populate-webroot', 04:42:25 INFO - 'create-virtualenv', 04:42:25 INFO - 'install', 04:42:25 INFO - 'run-tests'), 04:42:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:25 INFO - 'download_minidump_stackwalk': True, 04:42:25 INFO - 'download_symbols': 'ondemand', 04:42:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:25 INFO - 'installer_path': 'installer.exe', 04:42:25 INFO - 'log_level': 'info', 04:42:25 INFO - 'log_name': 'talos', 04:42:25 INFO - 'log_to_console': True, 04:42:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:25 INFO - 'opt_config_files': (), 04:42:25 INFO - 'pip_index': False, 04:42:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:25 INFO - 'cmd': ('bash', 04:42:25 INFO - '-c', 04:42:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:25 INFO - 'enabled': True, 04:42:25 INFO - 'halt_on_failure': False, 04:42:25 INFO - 'name': 'check_screen_resolution'},), 04:42:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:25 INFO - 'cmd': ('bash', 04:42:25 INFO - '-c', 04:42:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:25 INFO - 'enabled': True, 04:42:25 INFO - 'halt_on_failure': False, 04:42:25 INFO - 'name': 'check_screen_resolution'},), 04:42:25 INFO - 'run_cmd_checks_enabled': True, 04:42:25 INFO - 'sps_profile': False, 04:42:25 INFO - 'sps_profile_interval': 0, 04:42:25 INFO - 'suite': 'dromaeojs', 04:42:25 INFO - 'system_bits': '32', 04:42:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:25 INFO - 'title': 't-yosemite-r7-0150', 04:42:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:25 INFO - 'use_talos_json': True, 04:42:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:25 INFO - 'work_dir': 'build'} 04:42:25 INFO - ##### 04:42:25 INFO - ##### Running clobber step. 04:42:25 INFO - ##### 04:42:25 INFO - Running pre-action listener: _resource_record_pre_action 04:42:25 INFO - Running main action method: clobber 04:42:25 INFO - rmtree: /builds/slave/test/build 04:42:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:28 INFO - Running post-action listener: _resource_record_post_action 04:42:28 INFO - ##### 04:42:28 INFO - ##### Running read-buildbot-config step. 04:42:28 INFO - ##### 04:42:28 INFO - Running pre-action listener: _resource_record_pre_action 04:42:28 INFO - Running main action method: read_buildbot_config 04:42:28 INFO - Using buildbot properties: 04:42:28 INFO - { 04:42:28 INFO - "project": "", 04:42:28 INFO - "product": "firefox", 04:42:28 INFO - "script_repo_revision": "production", 04:42:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:28 INFO - "repository": "", 04:42:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:28 INFO - "buildid": "20160407043446", 04:42:28 INFO - "stage_platform": "macosx64", 04:42:28 INFO - "basedir": "/builds/slave/test", 04:42:28 INFO - "buildnumber": 195, 04:42:28 INFO - "platform": "yosemite_r7", 04:42:28 INFO - "mozci_request": { 04:42:28 INFO - "priority": -1, 04:42:28 INFO - "type": "trigger_all_talos_jobs", 04:42:28 INFO - "times": 6 04:42:28 INFO - }, 04:42:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:42:28 INFO - "slavebuilddir": "test", 04:42:28 INFO - "branch": "mozilla-central", 04:42:28 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:42:28 INFO - "slavename": "t-yosemite-r7-0150", 04:42:28 INFO - "builduid": "0792d2782011433daa62c8eeff464aa0", 04:42:28 INFO - "repo_path": "mozilla-central" 04:42:28 INFO - } 04:42:28 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg. 04:42:28 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json. 04:42:28 INFO - Running post-action listener: _resource_record_post_action 04:42:28 INFO - ##### 04:42:28 INFO - ##### Running download-and-extract step. 04:42:28 INFO - ##### 04:42:28 INFO - Running pre-action listener: _resource_record_pre_action 04:42:28 INFO - Running main action method: download_and_extract 04:42:28 INFO - mkdir: /builds/slave/test/build/tests 04:42:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json 04:42:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:28 INFO - Downloaded 1199 bytes. 04:42:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:28 INFO - Using the following test package requirements: 04:42:28 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:42:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'jsshell-mac.zip'], 04:42:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:42:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:42:28 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:42:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:42:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:28 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:28 INFO - Downloaded 17964225 bytes. 04:42:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:42:31 INFO - Return code: 0 04:42:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:32 INFO - Downloaded 17964225 bytes. 04:42:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:42:35 INFO - Return code: 0 04:42: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:35 INFO - Downloaded 10847617 bytes. 04:42:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:42:36 INFO - Return code: 0 04:42:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:42:38 INFO - Downloaded 108925595 bytes. 04:42:38 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:38 INFO - mkdir: /builds/slave/test/properties 04:42:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:38 INFO - Contents: 04:42:38 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:39 INFO - Running post-action listener: _resource_record_post_action 04:42:39 INFO - Running post-action listener: set_extra_try_arguments 04:42:39 INFO - ##### 04:42:39 INFO - ##### Running populate-webroot step. 04:42:39 INFO - ##### 04:42:39 INFO - Running pre-action listener: _resource_record_pre_action 04:42:39 INFO - Running main action method: populate_webroot 04:42:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:39 INFO - '--tppagecycles', 04:42:39 INFO - '7'], 04:42:39 INFO - 'tests': ['tsvgm']}}, 04:42:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['damp', 'tps']}, 04:42:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'tests': ['damp', 'tps']}, 04:42:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['dromaeo_dom']}, 04:42:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['a11yr', 04:42:39 INFO - 'ts_paint', 04:42:39 INFO - 'tpaint', 04:42:39 INFO - 'sessionrestore', 04:42:39 INFO - 'sessionrestore_no_auto_restore', 04:42:39 INFO - 'tabpaint']}, 04:42:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['tsvgx', 04:42:39 INFO - 'tsvgr_opacity', 04:42:39 INFO - 'tart', 04:42:39 INFO - 'tscrollx', 04:42:39 INFO - 'cart']}, 04:42:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:39 INFO - 'tsvgr_opacity', 04:42:39 INFO - 'tart', 04:42:39 INFO - 'tscrollx', 04:42:39 INFO - 'cart']}, 04:42:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'talos_options': ['--disable-e10s'], 04:42:39 INFO - 'tests': ['tp5o']}, 04:42:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'tests': ['tp5o']}, 04:42:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'talos_options': ['--disable-e10s', 04:42:39 INFO - '--xperf_path', 04:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:39 INFO - 'tests': ['tp5n']}, 04:42:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:39 INFO - 'talos_options': ['--xperf_path', 04:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:39 INFO - 'tests': ['tp5n']}}, 04:42:39 INFO - 'talos.zip': {'path': '', 04:42:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:39 INFO - Running post-action listener: _resource_record_post_action 04:42:39 INFO - ##### 04:42:39 INFO - ##### Running create-virtualenv step. 04:42:39 INFO - ##### 04:42:39 INFO - Running pre-action listener: _resource_record_pre_action 04:42:39 INFO - Running main action method: create_virtualenv 04:42:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:39 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 04:42:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:39 INFO - Using real prefix '/tools/python27' 04:42:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:42 INFO - Installing pip.................done. 04:42:42 INFO - Return code: 0 04:42:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:42 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 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:42 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 04:42:42 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 04:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:42 INFO - 'HOME': '/Users/cltbld', 04:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:42 INFO - 'LOGNAME': 'cltbld', 04:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:42 INFO - 'MOZ_NO_REMOTE': '1', 04:42:42 INFO - 'NO_EM_RESTART': '1', 04:42:42 INFO - 'PAGER': '/bin/cat', 04:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:42 INFO - 'PWD': '/builds/slave/test', 04:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:42 INFO - 'SHELL': '/bin/bash', 04:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:42:42 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:42 INFO - 'USER': 'cltbld', 04:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:42 INFO - 'XPC_FLAGS': '0x0', 04:42:42 INFO - 'XPC_SERVICE_NAME': '0', 04:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:43 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 04:42:43 INFO - Cleaning up... 04:42:43 INFO - Return code: 0 04:42:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:42:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:43 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:43 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>=0.7.1'] in /builds/slave/test/build 04:42:43 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>=0.7.1 04:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:43 INFO - 'HOME': '/Users/cltbld', 04:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:43 INFO - 'LOGNAME': 'cltbld', 04:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:43 INFO - 'MOZ_NO_REMOTE': '1', 04:42:43 INFO - 'NO_EM_RESTART': '1', 04:42:43 INFO - 'PAGER': '/bin/cat', 04:42:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:43 INFO - 'PWD': '/builds/slave/test', 04:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:43 INFO - 'SHELL': '/bin/bash', 04:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:42:43 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:43 INFO - 'USER': 'cltbld', 04:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:43 INFO - 'XPC_FLAGS': '0x0', 04:42:43 INFO - 'XPC_SERVICE_NAME': '0', 04:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:43 INFO - Downloading/unpacking psutil>=0.7.1 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 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 04:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:46 INFO - Installing collected packages: psutil 04:42:46 INFO - Running setup.py install for psutil 04:42:46 INFO - building 'psutil._psutil_osx' extension 04:42:46 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 INFO - building 'psutil._psutil_posix' extension 04:42:47 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 04:42:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:47 INFO - ^ 04:42:47 INFO - 1 warning generated. 04:42:47 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 04:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:47 INFO - Successfully installed psutil 04:42:47 INFO - Cleaning up... 04:42:47 INFO - Return code: 0 04:42:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:47 INFO - 'HOME': '/Users/cltbld', 04:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:47 INFO - 'LOGNAME': 'cltbld', 04:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:47 INFO - 'MOZ_NO_REMOTE': '1', 04:42:47 INFO - 'NO_EM_RESTART': '1', 04:42:47 INFO - 'PAGER': '/bin/cat', 04:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:47 INFO - 'PWD': '/builds/slave/test', 04:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:47 INFO - 'SHELL': '/bin/bash', 04:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:42:47 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:47 INFO - 'USER': 'cltbld', 04:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:47 INFO - 'XPC_FLAGS': '0x0', 04:42:47 INFO - 'XPC_SERVICE_NAME': '0', 04:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:42:48 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 04:42:48 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 04:42:48 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 04:42:48 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 04:42:48 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 04:42:48 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 04:42:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:42:50 INFO - Installing collected packages: mozsystemmonitor 04:42:50 INFO - Running setup.py install for mozsystemmonitor 04:42:50 INFO - Successfully installed mozsystemmonitor 04:42:50 INFO - Cleaning up... 04:42:50 INFO - Return code: 0 04:42:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:50 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 04:42:50 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 04:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:50 INFO - 'HOME': '/Users/cltbld', 04:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:50 INFO - 'LOGNAME': 'cltbld', 04:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:50 INFO - 'MOZ_NO_REMOTE': '1', 04:42:50 INFO - 'NO_EM_RESTART': '1', 04:42:50 INFO - 'PAGER': '/bin/cat', 04:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:50 INFO - 'PWD': '/builds/slave/test', 04:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:50 INFO - 'SHELL': '/bin/bash', 04:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:42:50 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:50 INFO - 'USER': 'cltbld', 04:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:50 INFO - 'XPC_FLAGS': '0x0', 04:42:50 INFO - 'XPC_SERVICE_NAME': '0', 04:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:53 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 04:42:53 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 04:42:53 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 04:42:53 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 04:42:53 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 04:42:53 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 04:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:54 INFO - Downloading docopt-0.6.1.tar.gz 04:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:54 INFO - Running setup.py install for blobuploader 04:42:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:54 INFO - Running setup.py install for requests 04:42:55 INFO - Running setup.py install for docopt 04:42:55 INFO - Successfully installed blobuploader requests docopt 04:42:55 INFO - Cleaning up... 04:42:55 INFO - Return code: 0 04:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:55 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 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:42:55 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 04:42:55 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 04:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:55 INFO - 'HOME': '/Users/cltbld', 04:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:55 INFO - 'LOGNAME': 'cltbld', 04:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:55 INFO - 'MOZ_NO_REMOTE': '1', 04:42:55 INFO - 'NO_EM_RESTART': '1', 04:42:55 INFO - 'PAGER': '/bin/cat', 04:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:55 INFO - 'PWD': '/builds/slave/test', 04:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:55 INFO - 'SHELL': '/bin/bash', 04:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:42:55 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:55 INFO - 'USER': 'cltbld', 04:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:55 INFO - 'XPC_FLAGS': '0x0', 04:42:55 INFO - 'XPC_SERVICE_NAME': '0', 04:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Ig7LLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7qWp8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-q8bz9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-bCtxML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Xop24V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Ho9P6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-27z90P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yeHVWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Fkn0T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-E4ZsUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0XUTnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-1KHRfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4y7PDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-zT85lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pnbopi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4I500P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:57 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-JYyKf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:57 INFO - Running setup.py install for manifestparser 04:42:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:57 INFO - Running setup.py install for mozcrash 04:42:57 INFO - Running setup.py install for mozdebug 04:42:58 INFO - Running setup.py install for mozdevice 04:42:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Running setup.py install for mozfile 04:42:58 INFO - Running setup.py install for mozhttpd 04:42:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Running setup.py install for mozinfo 04:42:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Running setup.py install for mozInstall 04:42:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Running setup.py install for mozleak 04:42:58 INFO - Running setup.py install for mozlog 04:42:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Running setup.py install for moznetwork 04:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Running setup.py install for mozprocess 04:42:59 INFO - Running setup.py install for mozprofile 04:42:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Running setup.py install for mozrunner 04:42:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:59 INFO - Running setup.py install for mozscreenshot 04:42:59 INFO - Running setup.py install for moztest 04:43:00 INFO - Running setup.py install for mozversion 04:43:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:00 INFO - Cleaning up... 04:43:00 INFO - Return code: 0 04:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:43:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:00 INFO - 'HOME': '/Users/cltbld', 04:43:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:00 INFO - 'LOGNAME': 'cltbld', 04:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:00 INFO - 'MOZ_NO_REMOTE': '1', 04:43:00 INFO - 'NO_EM_RESTART': '1', 04:43:00 INFO - 'PAGER': '/bin/cat', 04:43:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:00 INFO - 'PWD': '/builds/slave/test', 04:43:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:00 INFO - 'SHELL': '/bin/bash', 04:43:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:43:00 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:43:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:00 INFO - 'USER': 'cltbld', 04:43:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:00 INFO - 'XPC_FLAGS': '0x0', 04:43:00 INFO - 'XPC_SERVICE_NAME': '0', 04:43:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:00 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-8BxoCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:00 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)) 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:00 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-2cWpKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:00 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)) 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:00 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7T4Otf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:00 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)) 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:00 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0bn9oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:00 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)) 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:00 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-L7RLnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-CEnHPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-egwGzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nqjkUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-liuEhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:01 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-P47fso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6Qa_dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:01 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-oIsqDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-LC62So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:01 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:01 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-MXDFRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:02 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-izhgOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:02 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-sN2TCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:02 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-t8liKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:04 INFO - Downloading blessings-1.6.tar.gz 04:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:04 INFO - Installing collected packages: blessings 04:43:04 INFO - Running setup.py install for blessings 04:43:04 INFO - Successfully installed blessings 04:43:04 INFO - Cleaning up... 04:43:05 INFO - Return code: 0 04:43:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:05 INFO - Reading from file tmpfile_stdout 04:43:05 INFO - Current package versions: 04:43:05 INFO - blessings == 1.6 04:43:05 INFO - blobuploader == 1.2.4 04:43:05 INFO - docopt == 0.6.1 04:43:05 INFO - manifestparser == 1.1 04:43:05 INFO - mozInstall == 1.12 04:43:05 INFO - mozcrash == 0.17 04:43:05 INFO - mozdebug == 0.1 04:43:05 INFO - mozdevice == 0.48 04:43:05 INFO - mozfile == 1.2 04:43:05 INFO - mozhttpd == 0.7 04:43:05 INFO - mozinfo == 0.9 04:43:05 INFO - mozleak == 0.1 04:43:05 INFO - mozlog == 3.1 04:43:05 INFO - moznetwork == 0.27 04:43:05 INFO - mozprocess == 0.22 04:43:05 INFO - mozprofile == 0.28 04:43:05 INFO - mozrunner == 6.11 04:43:05 INFO - mozscreenshot == 0.1 04:43:05 INFO - mozsystemmonitor == 0.0 04:43:05 INFO - moztest == 0.7 04:43:05 INFO - mozversion == 1.4 04:43:05 INFO - psutil == 3.1.1 04:43:05 INFO - requests == 1.2.3 04:43:05 INFO - wsgiref == 0.1.2 04:43:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 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)) 04:43:05 INFO - Cleaning up... 04:43:05 INFO - Return code: 0 04:43:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 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 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:43:05 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 04:43:05 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 04:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 INFO - Downloading/unpacking jsonschema 04:43:05 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 04:43:05 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 04:43:05 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 04:43:05 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 04:43:05 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 04:43:05 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 04:43:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:08 INFO - Downloading/unpacking functools32 (from jsonschema) 04:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:08 INFO - warning: no files found matching '*.txt' 04:43:08 INFO - no previously-included directories found matching 'build' 04:43:08 INFO - no previously-included directories found matching 'dist' 04:43:08 INFO - no previously-included directories found matching '.git*' 04:43:08 INFO - Installing collected packages: jsonschema, functools32 04:43:08 INFO - Running setup.py install for functools32 04:43:08 INFO - warning: no files found matching '*.txt' 04:43:08 INFO - no previously-included directories found matching 'build' 04:43:08 INFO - no previously-included directories found matching 'dist' 04:43:08 INFO - no previously-included directories found matching '.git*' 04:43:08 INFO - Successfully installed jsonschema functools32 04:43:08 INFO - Cleaning up... 04:43:09 INFO - Return code: 0 04:43:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed4da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed5d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf034ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, '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.WJDRsw3qRg/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.mXfinFrIOu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:43:09 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', 'flake8'] in /builds/slave/test/build 04:43:09 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 flake8 04:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:09 INFO - 'HOME': '/Users/cltbld', 04:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:09 INFO - 'LOGNAME': 'cltbld', 04:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:09 INFO - 'MOZ_NO_REMOTE': '1', 04:43:09 INFO - 'NO_EM_RESTART': '1', 04:43:09 INFO - 'PAGER': '/bin/cat', 04:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:09 INFO - 'PWD': '/builds/slave/test', 04:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:09 INFO - 'SHELL': '/bin/bash', 04:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:43:09 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:09 INFO - 'USER': 'cltbld', 04:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:09 INFO - 'XPC_FLAGS': '0x0', 04:43:09 INFO - 'XPC_SERVICE_NAME': '0', 04:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:09 INFO - Downloading/unpacking flake8 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:43:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:43:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 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 04:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:12 INFO - no previously-included directories found matching 'docs/_build' 04:43:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:43:13 INFO - Running setup.py install for pep8 04:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:13 INFO - no previously-included directories found matching 'docs/_build' 04:43:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:43:13 INFO - Cleaning up... 04:43:13 INFO - Return code: 0 04:43:13 INFO - Running post-action listener: _resource_record_post_action 04:43:13 INFO - Running post-action listener: _start_resource_monitoring 04:43:13 INFO - Starting resource monitoring. 04:43:13 INFO - ##### 04:43:13 INFO - ##### Running install step. 04:43:13 INFO - ##### 04:43:13 INFO - Running pre-action listener: _resource_record_pre_action 04:43:13 INFO - Running main action method: install 04:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:13 INFO - Reading from file tmpfile_stdout 04:43:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:13 INFO - Reading from file tmpfile_stdout 04:43:13 INFO - Output received: 04:43:13 INFO - Usage: mozinstall [options] installer 04:43:13 INFO - Options: 04:43:13 INFO - -h, --help show this help message and exit 04:43:13 INFO - -d DEST, --destination=DEST 04:43:13 INFO - Directory to install application into. [default: 04:43:13 INFO - "/builds/slave/test"] 04:43:13 INFO - --app=APP Application being installed. [default: firefox] 04:43:13 INFO - mkdir: /builds/slave/test/build/application 04:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:47 INFO - Reading from file tmpfile_stdout 04:43:47 INFO - Output received: 04:43:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:43:47 INFO - Running post-action listener: _resource_record_post_action 04:43:47 INFO - ##### 04:43:47 INFO - ##### Running run-tests step. 04:43:47 INFO - ##### 04:43:47 INFO - Running pre-action listener: _resource_record_pre_action 04:43:47 INFO - Running main action method: run_tests 04:43:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:47 INFO - 2016-04-07 04:43:47.791 screenresolution[1672:7842] starting screenresolution argv=screenresolution get 04:43:47 INFO - 2016-04-07 04:43:47.794 screenresolution[1672:7842] Display 0: 1600x1200x32@60 04:43:47 INFO - 2016-04-07 04:43:47.799 screenresolution[1673:7844] starting screenresolution argv=screenresolution list 04:43:47 INFO - Available Modes on Display 0 04:43:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:48 INFO - Intel Iris: 04:43:48 INFO - Chipset Model: Intel Iris 04:43:48 INFO - Type: GPU 04:43:48 INFO - Bus: Built-In 04:43:48 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:48 INFO - Vendor: Intel (0x8086) 04:43:48 INFO - Device ID: 0x0a2e 04:43:48 INFO - Revision ID: 0x0009 04:43:48 INFO - Displays: 04:43:48 INFO - Display: 04:43:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:48 INFO - Display Serial Number: 1600x1200 60 04:43:48 INFO - Main Display: Yes 04:43:48 INFO - Mirror: Off 04:43:48 INFO - Online: Yes 04:43:48 INFO - Rotation: Supported 04:43:48 INFO - Return code: 0 04:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:48 INFO - Python 2.7.3 04:43:48 INFO - Return code: 0 04:43:48 INFO - grabbing minidump binary from tooltool 04:43:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:48 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebece00>, '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 0x10ea15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:48 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 04:43:48 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 04:43:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:48 INFO - Return code: 0 04:43:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:43:49 INFO - Return code: 0 04:43:49 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 04:43:49 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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 04:43:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WJDRsw3qRg/Render', 04:43:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:49 INFO - 'HOME': '/Users/cltbld', 04:43:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:49 INFO - 'LOGNAME': 'cltbld', 04:43:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:49 INFO - 'MOZ_NO_REMOTE': '1', 04:43:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:49 INFO - 'NO_EM_RESTART': '1', 04:43:49 INFO - 'PAGER': '/bin/cat', 04:43:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:49 INFO - 'PWD': '/builds/slave/test', 04:43:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:49 INFO - 'SHELL': '/bin/bash', 04:43:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXfinFrIOu/Listeners', 04:43:49 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:43:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:49 INFO - 'USER': 'cltbld', 04:43:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:49 INFO - 'XPC_FLAGS': '0x0', 04:43:49 INFO - 'XPC_SERVICE_NAME': '0', 04:43:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:49 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 04:43:49 INFO - mozversion application_buildid: 20160406030021 04:43:49 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:43:49 INFO - mozversion application_display_name: Nightly 04:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:49 INFO - mozversion application_name: Firefox 04:43:49 INFO - mozversion application_remotingname: firefox 04:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:49 INFO - mozversion application_vendor: Mozilla 04:43:49 INFO - mozversion application_version: 48.0a1 04:43:49 INFO - mozversion platform_buildid: 20160406030021 04:43:49 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:49 INFO - mozversion platform_version: 48.0a1 04:43:49 INFO - using testdate: 1460029429 04:43:49 INFO - actual date: 1460029429 04:43:49 INFO - starting webserver on 'localhost:49270' 04:43:49 INFO - SUITE-START | Running 2 tests 04:43:49 INFO - TEST-START | dromaeo_css 04:43:49 INFO - operating with platform_type : mac_ 04:43:49 INFO - Initialising browser for dromaeo_css test... 04:43:49 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpF8ymkP/profile http://localhost:49270/getInfo.html) 04:43:51 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 04:43:51 INFO - PROCESS | 1691 | colorDepth:24 04:43:51 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 04:43:51 INFO - PROCESS | 1691 | __metrics 04:43:51 INFO - PROCESS | 1691 | 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" 04:43:51 ERROR - PROCESS | 1691 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:43:52 INFO - TEST-INFO | 1691: exit 0 04:43:52 INFO - Browser initialized. 04:43:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:52 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpF8ymkP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:04 INFO - PROCESS | 1693 | RSS: Main: 236339200 04:44:04 INFO - PROCESS | 1693 | 04:44:55 INFO - PROCESS | 1693 | 1460029495335 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] 04:47:06 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 04:47:07 INFO - PROCESS | 1693 | RSS: Main: 369246208 04:47:07 INFO - PROCESS | 1693 | 04:50:10 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 04:50:11 INFO - PROCESS | 1693 | RSS: Main: 367403008 04:50:11 INFO - PROCESS | 1693 | 04:53:13 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 04:53:13 INFO - PROCESS | 1693 | RSS: Main: 365203456 04:53:13 INFO - PROCESS | 1693 | 04:56:15 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 04:56:16 INFO - PROCESS | 1693 | RSS: Main: 323559424 04:56:16 INFO - PROCESS | 1693 | 04:59:19 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 04:59:20 INFO - PROCESS | 1693 | RSS: Main: 320262144 04:59:20 INFO - PROCESS | 1693 | 05:02:22 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:02:23 INFO - PROCESS | 1693 | RSS: Main: 384815104 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | __start_tp_report 05:02:23 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 05:02:23 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 05:02:23 INFO - PROCESS | 1693 | |i|pagename|runs| 05:02:23 INFO - PROCESS | 1693 | |0;dojo.html;3395.3209358128374;3432.8455219515117;3441.7590768646205;3463.3592785334713;3497.492863534786;5492.725363731817;5525.226468294442;5557.3886872444;5583.748731307091;5598.244237028;5557.3886872444;5568;5683.914741278884;5699.629524080942;5728.198052272674;5024.7738851751665;5024.799008039674;5038.168702164138;5068.873278168038;5162.638615296931;5134.25553294772;5172.224166375055;5186.611004174683;5199.740012999354;5227.555657769094;4989.900201995976;5000.074986127578;5087.923681144785;5107.259447380127;5116.155834287338;5083.262926875583;5086.491350864884;5092.26162206478;5092.745362731848;5115.411727651331;5034.270030845507;5063.063333283318;5065.772040258197;5078.339815823956;5110.488951104897;5398.379186393576;5476.7535460904355;5508.834734957958;5536.723163841792;5594.524465420444;6143.784967526115;6149.907751383733;6153.077038444225;6157.846053848645;6170.259568851721;6160.291566469824;6216.658083805389;6233.563650544464;6234.937650623481;6241.65670888101;5609.467100625434;5685.317761868602;5708.97145514274;5716.542676585905;5778.508826749689;6248.375162483806;6266.342034086447;6267.091271765568;6274.215723034621;6280.591761535486;5996.820095397145;6009.699515024318;6054.122152287893;6057.485113765291;6057.848553786191;5965.343812180657;6007.219061522062;6118.071005858243;6121.6358891611635;6216.2540495140875;5174.275601415805;6098.250697042149;6114.449699527064;6114.877702445926;6371.076193951943;6146.416090471398;6170.876582468325;6172.660503672341;6188.257409110935;6206.937930620727;4724.244120940633;4778.283257511401;4829.517048295143;4839.443464001685;4840.34655321527;4365.301551751768;4399.318105693623;4401.6698747594055;4404.735715856995;4405.9559404405545;5458.836234912959;5533.529649979716;5540.612157148961;5541.9168712469345;5542.889142217133;6101.359357267512;6121.938780612226;6133;6133.693315334215;6186.536009799283;5556.833295001156;5570.86072848182;5595.720213989284;5595.804146854841;5603.971980140073;5278.656887302313;5287.894242115136;5294.57643388528;5302.390225124083;5331;5327.174287985368;6171.382861713882;6206.503479721521;6278.654673992883;6286.874262514632;6180.072989051679;6184.6598437086395;6188.783392581238;6193.783217587363;6206.162168107247;5886.205362276038;5888.61617519891;6227.813165605039;6262.436380725757;6264.749410023548;5954.285485741739;6080.48315893154;6104.822969073627;6124.696630669495;6144.603604594301;6161;6164.753409863555;6170.568060235741;6171.413715697002;6184.226971628546;4671.252599584051;5632.802851900164;5818.359980402237;5984.670843103497;6004.819855404345;5166.715830629351;5874.765009399576;5920.3783602722815;5980.37206093354;6028.849278768066;4893.559579637849;5774.307083150049;5782.681952492653;5821.359650438533;5837.503812176013;5903.144044113494;5949.940500594938;5974.103884417372;5983.401659833982;6017.007193812972;5948.910766338422;5950.375210602824;5953.821385358447;5958.5828991971875;6021.578489505868 05:02:23 INFO - PROCESS | 1693 | |1;ext.html;493.4103746023503;574.3481148896004;582.2169182449604;644.9742010319586;645.3901063494998;38081.23837523251;38405.80797096011;38436.615633843656;38477;38609.22781544367;41993.37009944853;42608.786956065174;42653.36019959703;42703.5053773118;42781.57218427822;9445.669401570929;9637.807243855119;9642.61429542821;9665.130138287554;9667.323287369887;8020.839583208362;9551.617935282615;9574.04259574044;9578.52107394631;9579.41939579972;9672.129508344247;9742.805143897118;9746.46394448305;9759.609615615367;9762.121409073183;8318.750437486886;9617.56720947559;9696;9703;9704.951475242613;8493.320534357237;9570.856437153448;9709.271804614611;9717.46553939533;9717.951410242975;40723;40939.77180684584;40946.181076378605;40986.79506602478;40991.18017639631;3163.8576264068174;3248.2366643838677;3251.3822373748912;3426.201064954254;3665.706743460517;28170.15489535317;28950.42099158026;29664;29677.703222967924;29786;2691.4078902641386;2698.136596289188;2794.18968499135;2796.2310364649884;2852.443773464175;478036;480683;481555;482610;483175.58412208065;71725.64137179386;72601.37685543047;73392.2660773396;73560;73590.95249761315;78732.81900771493;79132.20867791363;79280.20719792844;79331;79363.60318198372;17506.562335941704;17658.470245892644;17737.37919172823;17791.644167116585;17791.911040444975;13287.933560332136;13397.330133493286;13413;13426.395812188279;13464.124831885896;21878.89060554687;22854;23145.84270786454;23342.299731008097;23410.06359745591;7436.3679087277105;9083.318751093562;9300.8604870927;9682.951585242028;9830.459324737209;999.615148167946;1004.9799004020025;1024.687470321559;1041.068243921701;1046.9790604188026;27515.31211719723;29172.562411563842;29295;29624.555631665542;29704.2573935649;1027.3527677563088;1164.598213616301;1191.4995701805262;1245.21551422605;1260.1179174577833;14856.331465084097;14915.776263356058;15096.773548396563;15112.395504179709;15177.468788592347;528589;534604;537929;538271;539014;57358.42641573531;58189.70905145447;58315.416845831;58367;58427;1339.7186590815843;1362.9591112266648;1449.2101804516565;1459.4308219794077;1478.6451251699514;24295;27881;28176.577351339336;28588.14235572936;28897.42205155843;44671.55328446804;45057.32414013858;45115.54884451113;45148.32277515905;45246.54753452555;308486;309126;309987;310225;310397;24008.39979000539;29262.561061583667;31945.361092777548;32469;32580.34839303248;39502.01244968899;40344.1606744359;40932.97667558335;41809;42331.1533769329;29127.563086553295;33560.1609959753;33874.8306258477;34885.65114348824;36101.277974439836;35651;35682.46476302806;35810.74662386804;36482.27035459329;36562.26875462422;30826.845865770527;31168.064958051295;31843.044708658777;32047.839760801045;36239.45640815337;29068.854655726587;31306.68693313038;31599.526007109453;31675.683243167274;31741.365172695954;23555.88222058879;24030.9186086623;24068.037278508662;24614.261572152864;24662 05:02:23 INFO - PROCESS | 1693 | |2;jquery.html;357.6870238541278;361.5607037449498;364.99817500912496;367.2929610499787;372.62923391225735;18993.99999999998;19040.90479547602;20008.29970951017;20051.09770060347;20060.799392006076;12111.27332360059;19415.22339106434;20151.798482015176;20195.293164739236;20212.292569760062;5182.11903976324;5328.120860058086;5384.91922621161;5385.165299378603;5409;3930.233604447134;4104.712670113093;5325.281087053237;5727.770889164429;6003.879922401549;5965.821025369246;6002.039673652216;6009.75960961561;6014.308354539218;6020.879582408349;5798.362180160179;6431.48548116152;6482.57863238888;6502.512311576604;6508.93491065088;3753.7372383933134;5353.170258609883;5576.7211639417865;5605.607607467479;5700.828975130753;13156.473741050442;13374.13068150567;13402.463901444027;15066.472673456487;24663;2093.4766308422895;2124.6706760452153;2142.1110239250693;2188.059134572133;2212.2920665387082;9293.72118836436;9810.313278070538;13882.583522494342;14120.576382708536;14426;1680.7562903379064;1681.1930273468804;1689.983100168995;1703.9233234504477;1754.429810311641;101538;108896;108972.99999999921;109602;109693.90306096997;10716.839247411295;10925.781484370427;11073.114150867912;11135.888641113646;11182.993530582287;12222.755544889053;13471.98960077998;13887.44450222;13916.721665566633;13933.372998215105;7138.714451421989;8263.710770123016;8414.158584141536;8444.45111067791;8524.275436587835;8489.235968762841;8523;8530.317574594017;8637.352198585006;8653.048164702004;3721.2557488502407;4292.828286868553;4364.934525982113;4392.604665580113;4408.360787685768;1704.1905095079737;1767.4609244180392;1777.7688900442859;1789.9821001789815;1792.453301742981;903.823754367892;946.1531928923575;974.6539978307741;983.8032393521181;991.9900800992042;18816;19188.232470701016;19333.419997400102;19398.4180474586;19760.40718778439;871.4509858789049;938.2447130060231;995.66147509847;1049.1606714628267;1094.8029354716227;10379.221558383151;10759.623413180658;10793.352398856094;10863.891361086287;11021.83467247992;584312;601102;606445;616531;617660;69609;85165;98080.50959745156;102943;109070.45464772625;1033.9224558158019;1038.325088692356;1050.9474526273655;1052.8789189243182;1055.9683209503728;17672.911635442255;17733.733993990358;17806.37677681275;17977.460676179737;18082.457526274233;48412.5158748408;48639;48854.75572622256;49424;50280.49719502904;66216.66891665703;68230.66489797815;68843.31156688569;69206.65396672985;69214;7609.467337286337;7615.7334493292465;7668.298714637674;7722.768316950501;7792.766217013499;9114.908850911406;11604.94197529007;12152.392380381123;12517.93597544219;12614.936925315315;10094.495275236062;10843.1867609928;10889.455527223448;10889.78220435571;10942.507587158438;10493.842592361274;10510.474476276002;10702.946485267525;10846.24076314682;10883.020528152505;10382.688519344432;10968.670939871816;11129.054030407182;11243.49404276826;11292.943535282271;7666.578338191453;7718.652660630173;7746.457747957589;7875.921240787748;8089.676412943416;9405.153536181777;10789.946050269698;10790.73023174427;11080.501377437873;11084.16868734832 05:02:23 INFO - PROCESS | 1693 | |3;mootools.html;1363.3115276785222;1377.393946663468;1412.3432603839212;1468.8531146885314;1706.1980868991577;8013.8397232055395;8699.434536755114;8866.911330886689;8876.201141897229;8881.200691937724;8533.018702849175;8812.735617931472;8821.941367035965;8825.823483530325;8860.158284962934;2177.2706143441965;2229.442639340165;2236.206146817881;2475.7524247575234;2508.4732206236713;2479.47930934504;2545.4654522550286;2546.9745302547017;2547.1339744486872;2549.400890790672;2450.4976479821594;2481.925542233727;2496.6629505016863;2500.9124680636182;2504.7119581248116;2453.460238747473;2464.753524647539;2490.887910044043;2502.074232533956;2508.9623655645273;2401.447667036591;2406.278116565041;2408.3136306152837;2410.7950824179966;2416.5770990076667;8881.866771998426;8927.018028016977;8947.64209431622;8950.373473856833;8960.775980600538;5437.429069947638;5600.243967064475;5600.803971860965;5607.495325420691;5611.270534830487;3036.891534589881;3550.3254381667402;3627.8548858045647;3702.2965636529243;3703.2963736889906;1044.1125043712784;1060.4061725433705;1066.4827558634056;1067.092970974673;1075.9892401076045;10178.440185789852;11846.644600661994;11868.109891758153;11883.821742673867;11901.464434100486;4414.9558504414545;4848.0546293472435;4870.318155458239;4895.118878601886;4969.130402179604;10157.238207134495;10180.490975451197;10191.184705223712;10205.540750666238;10221.080102790636;5526.944730552643;5538.501534861882;5543.1408131739645;5558.194061861089;5562.805301814498;4475.641948644101;4639.652026098056;4858.271259311132;5039.067772462106;5043.672161309503;3868.2650296443585;3893.299206142865;3914.099757055893;3931.253061918226;3968.523777146761;1324.311358093805;1333.7193399287135;1335.5525898824003;1346.7373862096993;1353.911995720275;1104.6244276945877;1114.242315225638;1137.0164807441504;1359.0622470495327;1393.4983405973842;8102;8297.917020829835;8307.335413166933;8328.33373330132;8353.707620233263;512.1114865707993;524.1168630857018;524.593440083938;525.3774277481197;532.379777559147;6195.876082478415;6200.81397558074;6242.625442473375;6271.811845644638;6275.5920865144535;10542.156627469783;10790.73023174427;10873;10900.454977251105;10903.509342079467;10486.685399438029;10611.151107911348;10646;10680.98530639588;10765.03114719679;8232.094469608339;8279.62741676614;8315.792105197297;8333.499990000619;8334.041585217656;7616.466847320635;7828.412869034732;7905.960470197842;7959.164287749702;7983.5209887406945;9270;9557.426554406758;9589.664361747306;9722.805543889224;9794.314397992071;9677.177439917687;9917.30578859473;10013.198944084601;10070.748231293983;10077.294589378966;5568.610197286151;6812.318768123347;6966.407855332353;7543.73596924105;7591.3547348475995;8158.673653054048;8266.958665206635;8276.462029968034;8280.83438331218;8289.83420331602;7238.963805180941;7335.77992660221;7355.080614923135;7472.439567032603;7530.8493830122;7192.029076074663;7229.927700723136;7321.743738969323;7323;7421.369183619453;7617.771466856003;7775.455718099679;7805.843883122192;7821;7831.177726338652;6114.510839132769;7023.086998690138;7034.331738484836;7091;7116.181639111568;6868.484863635347;7097.148342198969;7108.537945033556;7120.928790712027;7129.82175445618 05:02:23 INFO - PROCESS | 1693 | |4;prototype.html;321.5867610120995;324.2752448278098;327.79185217386953;331.6650183314851;332.98002119872825;6106.053561697933;6195.504359651229;6211.689415529217;6224.533160012995;6226.533010024244;5531.723413829312;5641.041023026085;6068.27180738312;6163.938360616393;6175.104609831583;4353.695241333108;4436.4676238851225;4450.132224216279;4545.2954792007295;4583.587477127049;4554.43069616298;4556.977215113936;4566.566176213254;4594.931076033862;4616.030633566955;4544.454665440152;4558.4529856417275;4565.360849481075;4566.6575006874455;4572.954270457302;3671.229041901204;4339.500957389893;4372.781360931941;4453.4433195850515;4458.821647134111;3937.212557488485;3944.881653550398;3951.960480395188;3952.288588054149;3960.663343615767;5862.12068189775;5898.233229680157;5908.556858235606;5909.704514774244;5926.78500907313;5261.657992230493;5294.126469132589;5300.323336714973;5308.283381743492;5308.964751873386;6434.806955791334;6491.675416229217;6492.513061520358;6496.740130394778;6498.805035848932;4094.9181016379803;4262.808173632163;4264.296391095466;4316.892077698051;4375.453068366454;6808.6936087876165;6853.862922741518;6867.416269617089;6893.862122757517;6896.655167241618;4334.32817913224;4341.8480353188115;4346.217680817484;4348.9997300621035;4350.60844523988;4405.801738921757;4409.669274804402;4424.048829501673;4430;4432.911341773147;5206.505381988705;5206.71363075027;5207.6875387476875;5218.556422704112;5224.138017227191;5744.937186620488;6257.74969001244;6312.652804095819;6563.212414510289;6597.967010164918;1513.6291608555755;1528.5414375687249;1539.8383169767237;1540.7212014028553;1545.2351086212173;932.3287233192091;959.2757468111671;985.9252720221364;991.7520619845038;1009.6365308488938;5149.433562308143;5168.095583272988;5866.266716660418;5914.467697907209;6044.607100538451;5522.8678120985105;6364.586301890362;6781.8643627127185;6784.21981472137;6887.345702158287;6080.327909824833;6085.4523092921845;6096.9390306096375;6108.1143234230785;6118.969405152946;3557.092941299952;3630.691391231775;3636.5272514572935;3637.7635453695425;3639.8180090995875;6908.661706800372;7050;7141.14306283239;7163.785086447415;7177.641117944187;7008.684609192496;7066.611336376549;7075.575465472089;7081.327273908971;7091.574505529685;6784.676987987295;7116.110486189226;7127.434123715459;7137.785866424016;7147.106611673541;6058.12198218536;6867.450603951772;6870.553414028072;6874.931250687429;6889.104416425833;6434.967825160844;6698.631575263407;6717.261101278953;6746.9325306746305;6796.76211332601;5799.82600521985;7095.119793254688;7099.183593886769;7166.2475440080125;7177.533460325062;4358.9564104359815;4420.646348292064;4426.800793964344;4429.114177164644;4443.066955939289;6864.107666003388;6876.346747059021;6877.277885822116;6879.277675843964;6889.621070840952;5977.163197152489;6312.4634406076;6677.532572719863;6682.131322927989;6696.062551242732;6452.22573291208;6493.545451818327;6552.737890484327;6553.4101930826455;6678.165229346332;6476.12572302752;6500.479961603155;6502.6748662567625;6528.086067950586;6534.967325163344;5581.665100094007;6519.8044058678315;6586.1438013058;6648.434883034803;6697.196336439659;6219.40915613016;6391.6804159792755;6531.640759758259;6534.901976470262;6567.9014814778775 05:02:23 INFO - PROCESS | 1693 | |5;yui.html;687.5359132585505;750.2235186581889;752.3116348541085;765.8315170662453;802.0575823407496;14599.635009124764;14764.926175369135;14806.777898331507;14818.110913345206;14845.62885927851;15265.465708700198;15705;15736.97709648872;15758.76361854573;15765;731.7950973727364;743.9442041846856;908.0873721909488;920.9079092090805;928.5078908178676;896.1397058823537;914.8399030169727;916.9174774270315;917.3670167584379;921.0007142250666;964.3635200767495;970.5826494607317;971.8396464583335;971.8736564246637;973.8928717841031;760.4752720622753;772.6716145638137;774.8876412920094;964.7346979580636;966.0629189685993;704.5279662626053;715.5492040014809;717.4726575966713;717.7559629725866;719.1298528780183;15104.848951510454;15229.61925951849;15238.161901095435;15246.847531524654;15279.770803437847;12354.38228088601;12400.689982750413;12447.190932589352;12680.936595316964;12756.170848894792;9988.95005524975;10005.59977600895;10063.843751864579;10412.010858968386;10896.673099807018;4052.9392059119136;4060.9847538115473;4187.45563076798;4205.222033923734;4218.810153543098;71332.3701300323;79710.40579188384;79817.40365192664;80000.19999799985;80252.59873700653;9202.355835091614;9280.90719092814;9334.71995840126;9363.62545498186;9654;20591;20794.376168714964;20811.79188208129;20816.95915204264;20861.269855554983;7401.59291238987;7421.220771818989;7450.403967682572;7586.962065189638;7693.653785579662;3940.271049855786;4060.26915155269;4142.689298302639;4195.97902010488;4327.59353210208;3614.6566076222716;3673.412254039341;3675.00774790805;3679.1721862580707;3681.042928838521;581.9796307129315;591.8520369907524;596.3916804859019;650.4601181019742;654.649762377126;550.6640949021094;584.2959234122872;613.8680183760424;617.6479406738116;620.2061361457341;7332.79008963515;8010.919890801134;8130.512169269863;8206.967823995894;8253.009638843378;508.2427829027511;556.5186114011351;559.6502186133666;577.656294504769;579.5161040531203;3777.4481749491797;3830.6552410283207;3871.2257548490416;3979.5622481527007;4050.0707044554047;85034.25784639301;87384;87768;87909.68135477974;88097;75254.11864703317;76475;76829.61585192039;77359;77934.61032694801;64916.67541662262;65714.6857062856;65787.4740041591;65913.67043164754;68071;7659.502132361378;7687.730929417444;7965.243301886311;8089.635966381409;8132.634031468479;48089.03821923612;48789.75605122094;49875.501244987085;50383.87285053635;50949;68260;68541.65729171323;68978;69782.25544361431;70477.9428308586;9959.850602240827;10031.047050530187;10243.641472548425;10721.30311529748;10912;11982.58060967862;11997.76004479923;12222.816657749963;12269.141160118706;12932.870671293167;11372.886271137513;11468.885311147116;11498.19512634141;11555.191136620357;11613;11506.252093613888;11618.767624647291;11652.708682283012;11666.183367164216;11713.824292635447;11098.167637427065;11283.492242849255;11321;11562.132840037199;11576.768464630828;9038.322125840457;9352.719418417459;9495.287853410884;9904.158146557334;9936.105750482202;8991.865122023306;9196.402233854778;9665.76781858535;9713.174380177481;9758.56086476096 05:02:23 INFO - PROCESS | 1693 | __end_tp_report 05:02:23 INFO - PROCESS | 1693 | __start_cc_report 05:02:23 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,1275 05:02:23 INFO - PROCESS | 1693 | __end_cc_report 05:02:23 INFO - PROCESS | 1693 | __startTimestamp1460030543071__endTimestamp 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | ------- Summary: start ------- 05:02:23 INFO - PROCESS | 1693 | Number of tests: 6 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#0] dojo.html Cycles:165 Average:5622.62 Median:5782.68 stddev:628.89 (10.9%) stddev-sans-first:606.06 05:02:23 INFO - PROCESS | 1693 | Values: 3395.3 3432.8 3441.8 3463.4 3497.5 5492.7 5525.2 5557.4 5583.7 5598.2 5557.4 5568.0 5683.9 5699.6 5728.2 5024.8 5024.8 5038.2 5068.9 5162.6 5134.3 5172.2 5186.6 5199.7 5227.6 4989.9 5000.1 5087.9 5107.3 5116.2 5083.3 5086.5 5092.3 5092.7 5115.4 5034.3 5063.1 5065.8 5078.3 5110.5 5398.4 5476.8 5508.8 5536.7 5594.5 6143.8 6149.9 6153.1 6157.8 6170.3 6160.3 6216.7 6233.6 6234.9 6241.7 5609.5 5685.3 5709.0 5716.5 5778.5 6248.4 6266.3 6267.1 6274.2 6280.6 5996.8 6009.7 6054.1 6057.5 6057.8 5965.3 6007.2 6118.1 6121.6 6216.3 5174.3 6098.3 6114.4 6114.9 6371.1 6146.4 6170.9 6172.7 6188.3 6206.9 4724.2 4778.3 4829.5 4839.4 4840.3 4365.3 4399.3 4401.7 4404.7 4406.0 5458.8 5533.5 5540.6 5541.9 5542.9 6101.4 6121.9 6133.0 6133.7 6186.5 5556.8 5570.9 5595.7 5595.8 5604.0 5278.7 5287.9 5294.6 5302.4 5331.0 5327.2 6171.4 6206.5 6278.7 6286.9 6180.1 6184.7 6188.8 6193.8 6206.2 5886.2 5888.6 6227.8 6262.4 6264.7 5954.3 6080.5 6104.8 6124.7 6144.6 6161.0 6164.8 6170.6 6171.4 6184.2 4671.3 5632.8 5818.4 5984.7 6004.8 5166.7 5874.8 5920.4 5980.4 6028.8 4893.6 5774.3 5782.7 5821.4 5837.5 5903.1 5949.9 5974.1 5983.4 6017.0 5948.9 5950.4 5953.8 5958.6 6021.6 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#1] ext.html Cycles:180 Average:59827.33 Median:36360.86 stddev:120453.04 (331.3%) stddev-sans-first:120708.57 05:02:23 INFO - PROCESS | 1693 | Values: 493.4 574.3 582.2 645.0 645.4 38081.2 38405.8 38436.6 38477.0 38609.2 41993.4 42608.8 42653.4 42703.5 42781.6 9445.7 9637.8 9642.6 9665.1 9667.3 8020.8 9551.6 9574.0 9578.5 9579.4 9672.1 9742.8 9746.5 9759.6 9762.1 8318.8 9617.6 9696.0 9703.0 9705.0 8493.3 9570.9 9709.3 9717.5 9718.0 40723.0 40939.8 40946.2 40986.8 40991.2 3163.9 3248.2 3251.4 3426.2 3665.7 28170.2 28950.4 29664.0 29677.7 29786.0 2691.4 2698.1 2794.2 2796.2 2852.4 478036.0 480683.0 481555.0 482610.0 483175.6 71725.6 72601.4 73392.3 73560.0 73591.0 78732.8 79132.2 79280.2 79331.0 79363.6 17506.6 17658.5 17737.4 17791.6 17791.9 13287.9 13397.3 13413.0 13426.4 13464.1 21878.9 22854.0 23145.8 23342.3 23410.1 7436.4 9083.3 9300.9 9683.0 9830.5 999.6 1005.0 1024.7 1041.1 1047.0 27515.3 29172.6 29295.0 29624.6 29704.3 1027.4 1164.6 1191.5 1245.2 1260.1 14856.3 14915.8 15096.8 15112.4 15177.5 528589.0 534604.0 537929.0 538271.0 539014.0 57358.4 58189.7 58315.4 58367.0 58427.0 1339.7 1363.0 1449.2 1459.4 1478.6 24295.0 27881.0 28176.6 28588.1 28897.4 44671.6 45057.3 45115.5 45148.3 45246.5 308486.0 309126.0 309987.0 310225.0 310397.0 24008.4 29262.6 31945.4 32469.0 32580.3 39502.0 40344.2 40933.0 41809.0 42331.2 29127.6 33560.2 33874.8 34885.7 36101.3 35651.0 35682.5 35810.7 36482.3 36562.3 30826.8 31168.1 31843.0 32047.8 36239.5 29068.9 31306.7 31599.5 31675.7 31741.4 23555.9 24030.9 24068.0 24614.3 24662.0 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#2] jquery.html Cycles:180 Average:33057.91 Median:2133.39 stddev:99993.99 (4687.1%) stddev-sans-first:100244.35 05:02:23 INFO - PROCESS | 1693 | Values: 357.7 361.6 365.0 367.3 372.6 18994.0 19040.9 20008.3 20051.1 20060.8 12111.3 19415.2 20151.8 20195.3 20212.3 5182.1 5328.1 5384.9 5385.2 5409.0 3930.2 4104.7 5325.3 5727.8 6003.9 5965.8 6002.0 6009.8 6014.3 6020.9 5798.4 6431.5 6482.6 6502.5 6508.9 3753.7 5353.2 5576.7 5605.6 5700.8 13156.5 13374.1 13402.5 15066.5 24663.0 2093.5 2124.7 2142.1 2188.1 2212.3 9293.7 9810.3 13882.6 14120.6 14426.0 1680.8 1681.2 1690.0 1703.9 1754.4 101538.0 108896.0 108973.0 109602.0 109693.9 10716.8 10925.8 11073.1 11135.9 11183.0 12222.8 13472.0 13887.4 13916.7 13933.4 7138.7 8263.7 8414.2 8444.5 8524.3 8489.2 8523.0 8530.3 8637.4 8653.0 3721.3 4292.8 4364.9 4392.6 4408.4 1704.2 1767.5 1777.8 1790.0 1792.5 903.8 946.2 974.7 983.8 992.0 18816.0 19188.2 19333.4 19398.4 19760.4 871.5 938.2 995.7 1049.2 1094.8 10379.2 10759.6 10793.4 10863.9 11021.8 584312.0 601102.0 606445.0 616531.0 617660.0 69609.0 85165.0 98080.5 102943.0 109070.5 1033.9 1038.3 1050.9 1052.9 1056.0 17672.9 17733.7 17806.4 17977.5 18082.5 48412.5 48639.0 48854.8 49424.0 50280.5 66216.7 68230.7 68843.3 69206.7 69214.0 7609.5 7615.7 7668.3 7722.8 7792.8 9114.9 11604.9 12152.4 12517.9 12614.9 10094.5 10843.2 10889.5 10889.8 10942.5 10493.8 10510.5 10702.9 10846.2 10883.0 10382.7 10968.7 11129.1 11243.5 11292.9 7666.6 7718.7 7746.5 7875.9 8089.7 9405.2 10789.9 10790.7 11080.5 11084.2 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#3] mootools.html Cycles:180 Average:6036.52 Median:524.99 stddev:3219.48 (613.3%) stddev-sans-first:3209.35 05:02:23 INFO - PROCESS | 1693 | Values: 1363.3 1377.4 1412.3 1468.9 1706.2 8013.8 8699.4 8866.9 8876.2 8881.2 8533.0 8812.7 8821.9 8825.8 8860.2 2177.3 2229.4 2236.2 2475.8 2508.5 2479.5 2545.5 2547.0 2547.1 2549.4 2450.5 2481.9 2496.7 2500.9 2504.7 2453.5 2464.8 2490.9 2502.1 2509.0 2401.4 2406.3 2408.3 2410.8 2416.6 8881.9 8927.0 8947.6 8950.4 8960.8 5437.4 5600.2 5600.8 5607.5 5611.3 3036.9 3550.3 3627.9 3702.3 3703.3 1044.1 1060.4 1066.5 1067.1 1076.0 10178.4 11846.6 11868.1 11883.8 11901.5 4415.0 4848.1 4870.3 4895.1 4969.1 10157.2 10180.5 10191.2 10205.5 10221.1 5526.9 5538.5 5543.1 5558.2 5562.8 4475.6 4639.7 4858.3 5039.1 5043.7 3868.3 3893.3 3914.1 3931.3 3968.5 1324.3 1333.7 1335.6 1346.7 1353.9 1104.6 1114.2 1137.0 1359.1 1393.5 8102.0 8297.9 8307.3 8328.3 8353.7 512.1 524.1 524.6 525.4 532.4 6195.9 6200.8 6242.6 6271.8 6275.6 10542.2 10790.7 10873.0 10900.5 10903.5 10486.7 10611.2 10646.0 10681.0 10765.0 8232.1 8279.6 8315.8 8333.5 8334.0 7616.5 7828.4 7906.0 7959.2 7983.5 9270.0 9557.4 9589.7 9722.8 9794.3 9677.2 9917.3 10013.2 10070.7 10077.3 5568.6 6812.3 6966.4 7543.7 7591.4 8158.7 8267.0 8276.5 8280.8 8289.8 7239.0 7335.8 7355.1 7472.4 7530.8 7192.0 7229.9 7321.7 7323.0 7421.4 7617.8 7775.5 7805.8 7821.0 7831.2 6114.5 7023.1 7034.3 7091.0 7116.2 6868.5 7097.1 7108.5 7120.9 7129.8 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#4] prototype.html Cycles:180 Average:5355.77 Median:6082.89 stddev:1701.13 (28.0%) stddev-sans-first:1663.41 05:02:23 INFO - PROCESS | 1693 | Values: 321.6 324.3 327.8 331.7 333.0 6106.1 6195.5 6211.7 6224.5 6226.5 5531.7 5641.0 6068.3 6163.9 6175.1 4353.7 4436.5 4450.1 4545.3 4583.6 4554.4 4557.0 4566.6 4594.9 4616.0 4544.5 4558.5 4565.4 4566.7 4573.0 3671.2 4339.5 4372.8 4453.4 4458.8 3937.2 3944.9 3952.0 3952.3 3960.7 5862.1 5898.2 5908.6 5909.7 5926.8 5261.7 5294.1 5300.3 5308.3 5309.0 6434.8 6491.7 6492.5 6496.7 6498.8 4094.9 4262.8 4264.3 4316.9 4375.5 6808.7 6853.9 6867.4 6893.9 6896.7 4334.3 4341.8 4346.2 4349.0 4350.6 4405.8 4409.7 4424.0 4430.0 4432.9 5206.5 5206.7 5207.7 5218.6 5224.1 5744.9 6257.7 6312.7 6563.2 6598.0 1513.6 1528.5 1539.8 1540.7 1545.2 932.3 959.3 985.9 991.8 1009.6 5149.4 5168.1 5866.3 5914.5 6044.6 5522.9 6364.6 6781.9 6784.2 6887.3 6080.3 6085.5 6096.9 6108.1 6119.0 3557.1 3630.7 3636.5 3637.8 3639.8 6908.7 7050.0 7141.1 7163.8 7177.6 7008.7 7066.6 7075.6 7081.3 7091.6 6784.7 7116.1 7127.4 7137.8 7147.1 6058.1 6867.5 6870.6 6874.9 6889.1 6435.0 6698.6 6717.3 6746.9 6796.8 5799.8 7095.1 7099.2 7166.2 7177.5 4359.0 4420.6 4426.8 4429.1 4443.1 6864.1 6876.3 6877.3 6879.3 6889.6 5977.2 6312.5 6677.5 6682.1 6696.1 6452.2 6493.5 6552.7 6553.4 6678.2 6476.1 6500.5 6502.7 6528.1 6535.0 5581.7 6519.8 6586.1 6648.4 6697.2 6219.4 6391.7 6531.6 6534.9 6567.9 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - PROCESS | 1693 | [#5] yui.html Cycles:180 Average:17998.44 Median:32768.44 stddev:24879.86 (75.9%) stddev-sans-first:24915.70 05:02:23 INFO - PROCESS | 1693 | Values: 687.5 750.2 752.3 765.8 802.1 14599.6 14764.9 14806.8 14818.1 14845.6 15265.5 15705.0 15737.0 15758.8 15765.0 731.8 743.9 908.1 920.9 928.5 896.1 914.8 916.9 917.4 921.0 964.4 970.6 971.8 971.9 973.9 760.5 772.7 774.9 964.7 966.1 704.5 715.5 717.5 717.8 719.1 15104.8 15229.6 15238.2 15246.8 15279.8 12354.4 12400.7 12447.2 12680.9 12756.2 9989.0 10005.6 10063.8 10412.0 10896.7 4052.9 4061.0 4187.5 4205.2 4218.8 71332.4 79710.4 79817.4 80000.2 80252.6 9202.4 9280.9 9334.7 9363.6 9654.0 20591.0 20794.4 20811.8 20817.0 20861.3 7401.6 7421.2 7450.4 7587.0 7693.7 3940.3 4060.3 4142.7 4196.0 4327.6 3614.7 3673.4 3675.0 3679.2 3681.0 582.0 591.9 596.4 650.5 654.6 550.7 584.3 613.9 617.6 620.2 7332.8 8010.9 8130.5 8207.0 8253.0 508.2 556.5 559.7 577.7 579.5 3777.4 3830.7 3871.2 3979.6 4050.1 85034.3 87384.0 87768.0 87909.7 88097.0 75254.1 76475.0 76829.6 77359.0 77934.6 64916.7 65714.7 65787.5 65913.7 68071.0 7659.5 7687.7 7965.2 8089.6 8132.6 48089.0 48789.8 49875.5 50383.9 50949.0 68260.0 68541.7 68978.0 69782.3 70477.9 9959.9 10031.0 10243.6 10721.3 10912.0 11982.6 11997.8 12222.8 12269.1 12932.9 11372.9 11468.9 11498.2 11555.2 11613.0 11506.3 11618.8 11652.7 11666.2 11713.8 11098.2 11283.5 11321.0 11562.1 11576.8 9038.3 9352.7 9495.3 9904.2 9936.1 8991.9 9196.4 9665.8 9713.2 9758.6 05:02:23 INFO - PROCESS | 1693 | -------- Summary: end -------- 05:02:23 INFO - PROCESS | 1693 | 05:02:23 INFO - TEST-INFO | 1693: exit 0 05:02:23 INFO - TEST-OK | dromaeo_css | took 1113984ms 05:02:23 INFO - TEST-START | kraken 05:02:23 INFO - operating with platform_type : mac_ 05:02:23 INFO - Initialising browser for kraken test... 05:02:23 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpcUASWE/profile http://localhost:49270/getInfo.html) 05:02:25 INFO - PROCESS | 1702 | __metrics Screen width/height:1600/1200 05:02:25 INFO - PROCESS | 1702 | colorDepth:24 05:02:25 INFO - PROCESS | 1702 | Browser inner width/height: 1024/689 05:02:25 INFO - PROCESS | 1702 | __metrics 05:02:25 INFO - PROCESS | 1702 | 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" 05:02:25 ERROR - PROCESS | 1702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:26 INFO - TEST-INFO | 1702: exit 0 05:02:26 INFO - Browser initialized. 05:02:26 INFO - Running cycle 1/1 for kraken test... 05:02:26 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpcUASWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:38 INFO - PROCESS | 1704 | RSS: Main: 236679168 05:02:38 INFO - PROCESS | 1704 | 05:02:40 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:41 INFO - PROCESS | 1704 | RSS: Main: 282832896 05:02:41 INFO - PROCESS | 1704 | 05:02:44 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:02:44 INFO - PROCESS | 1704 | RSS: Main: 293310464 05:02:44 INFO - PROCESS | 1704 | 05:02:48 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:02:48 INFO - PROCESS | 1704 | RSS: Main: 279474176 05:02:48 INFO - PROCESS | 1704 | 05:02:50 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:02:51 INFO - PROCESS | 1704 | RSS: Main: 281440256 05:02:51 INFO - PROCESS | 1704 | 05:02:53 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:54 INFO - PROCESS | 1704 | RSS: Main: 282386432 05:02:54 INFO - PROCESS | 1704 | 05:02:56 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:57 INFO - PROCESS | 1704 | RSS: Main: 284774400 05:02:57 INFO - PROCESS | 1704 | 05:03:00 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:00 INFO - PROCESS | 1704 | RSS: Main: 283852800 05:03:00 INFO - PROCESS | 1704 | 05:03:03 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:03:04 INFO - PROCESS | 1704 | RSS: Main: 284098560 05:03:04 INFO - PROCESS | 1704 | 05:03:05 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:06 INFO - PROCESS | 1704 | RSS: Main: 316653568 05:03:06 INFO - PROCESS | 1704 | 05:03:08 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:08 INFO - PROCESS | 1704 | RSS: Main: 316092416 05:03:08 INFO - PROCESS | 1704 | 05:03:10 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:11 INFO - PROCESS | 1704 | RSS: Main: 323428352 05:03:11 INFO - PROCESS | 1704 | 05:03:14 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:14 INFO - PROCESS | 1704 | RSS: Main: 324780032 05:03:14 INFO - PROCESS | 1704 | 05:03:17 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:17 INFO - PROCESS | 1704 | RSS: Main: 325091328 05:03:17 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:03:19 INFO - PROCESS | 1704 | RSS: Main: 387829760 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | __start_tp_report 05:03:19 INFO - PROCESS | 1704 | _x_x_mozilla_page_load 05:03:19 INFO - PROCESS | 1704 | _x_x_mozilla_page_load_details 05:03:19 INFO - PROCESS | 1704 | |i|pagename|runs| 05:03:19 INFO - PROCESS | 1704 | |0;ai-astar;112;108;111;110;111;113;117;111;110;110 05:03:19 INFO - PROCESS | 1704 | |1;audio-beat-detection;157;124;141;161;122;142;138;117;162;117 05:03:19 INFO - PROCESS | 1704 | |2;audio-dft;183;184;183;186;185;185;183;182;182;182 05:03:19 INFO - PROCESS | 1704 | |3;audio-fft;76;73;83;86;80;82;81;113;95;57 05:03:19 INFO - PROCESS | 1704 | |4;audio-oscillator;93;97;164;115;102;77;113;79;75;117 05:03:19 INFO - PROCESS | 1704 | |5;imaging-gaussian-blur;88;84;87;85;88;84;89;82;103;84 05:03:19 INFO - PROCESS | 1704 | |6;imaging-darkroom;93;93;95;94;94;94;94;94;104;147 05:03:19 INFO - PROCESS | 1704 | |7;imaging-desaturate;88;88;86;87;84;85;84;82;88;85 05:03:19 INFO - PROCESS | 1704 | |8;json-parse-financial;52;54;53;53;53;53;53;63;54;52 05:03:19 INFO - PROCESS | 1704 | |9;json-stringify-tinderbox;66;63;70;77;70;72;68;68;68;69 05:03:19 INFO - PROCESS | 1704 | |10;stanford-crypto-aes;84;82;83;82;82;82;96;106;109;103 05:03:19 INFO - PROCESS | 1704 | |11;stanford-crypto-ccm;123;132;131;133;122;124;124;108;117;146 05:03:19 INFO - PROCESS | 1704 | |12;stanford-crypto-pbkdf2;139;127;141;135;135;128;139;138;136;137 05:03:19 INFO - PROCESS | 1704 | |13;stanford-crypto-sha256-iterative;67;66;68;69;67;66;66;66;67;66 05:03:19 INFO - PROCESS | 1704 | __end_tp_report 05:03:19 INFO - PROCESS | 1704 | __start_cc_report 05:03:19 INFO - PROCESS | 1704 | _x_x_mozilla_cycle_collect,1305 05:03:19 INFO - PROCESS | 1704 | __end_cc_report 05:03:19 INFO - PROCESS | 1704 | __startTimestamp1460030599760__endTimestamp 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | ------- Summary: start ------- 05:03:19 INFO - PROCESS | 1704 | Number of tests: 14 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.41 (2.2%) stddev-sans-first:2.54 05:03:19 INFO - PROCESS | 1704 | Values: 112.0 108.0 111.0 110.0 111.0 113.0 117.0 111.0 110.0 110.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:141.50 stddev:17.72 (12.5%) stddev-sans-first:17.42 05:03:19 INFO - PROCESS | 1704 | Values: 157.0 124.0 141.0 161.0 122.0 142.0 138.0 117.0 162.0 117.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.43 (0.8%) stddev-sans-first:1.51 05:03:19 INFO - PROCESS | 1704 | Values: 183.0 184.0 183.0 186.0 185.0 185.0 183.0 182.0 182.0 182.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#3] audio-fft Cycles:10 Average:82.60 Median:81.50 stddev:14.49 (17.8%) stddev-sans-first:15.17 05:03:19 INFO - PROCESS | 1704 | Values: 76.0 73.0 83.0 86.0 80.0 82.0 81.0 113.0 95.0 57.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:76.00 stddev:26.53 (34.9%) stddev-sans-first:27.88 05:03:19 INFO - PROCESS | 1704 | Values: 93.0 97.0 164.0 115.0 102.0 77.0 113.0 79.0 75.0 117.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:86.00 stddev:5.93 (6.9%) stddev-sans-first:6.28 05:03:19 INFO - PROCESS | 1704 | Values: 88.0 84.0 87.0 85.0 88.0 84.0 89.0 82.0 103.0 84.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:94.00 stddev:16.76 (17.8%) stddev-sans-first:17.57 05:03:19 INFO - PROCESS | 1704 | Values: 93.0 93.0 95.0 94.0 94.0 94.0 94.0 94.0 104.0 147.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.50 stddev:2.06 (2.4%) stddev-sans-first:2.01 05:03:19 INFO - PROCESS | 1704 | Values: 88.0 88.0 86.0 87.0 84.0 85.0 84.0 82.0 88.0 85.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:3.23 (6.1%) stddev-sans-first:3.35 05:03:19 INFO - PROCESS | 1704 | Values: 52.0 54.0 53.0 53.0 53.0 53.0 53.0 63.0 54.0 52.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:3.70 (5.3%) stddev-sans-first:3.75 05:03:19 INFO - PROCESS | 1704 | Values: 66.0 63.0 70.0 77.0 70.0 72.0 68.0 68.0 68.0 69.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.00 stddev:11.33 (13.8%) stddev-sans-first:11.74 05:03:19 INFO - PROCESS | 1704 | Values: 84.0 82.0 83.0 82.0 82.0 82.0 96.0 106.0 109.0 103.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:10.26 (8.0%) stddev-sans-first:10.83 05:03:19 INFO - PROCESS | 1704 | Values: 123.0 132.0 131.0 133.0 122.0 124.0 124.0 108.0 117.0 146.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:137.50 stddev:4.62 (3.4%) stddev-sans-first:4.73 05:03:19 INFO - PROCESS | 1704 | Values: 139.0 127.0 141.0 135.0 135.0 128.0 139.0 138.0 136.0 137.0 05:03:19 INFO - PROCESS | 1704 | 05:03:19 INFO - PROCESS | 1704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 05:03:19 INFO - PROCESS | 1704 | Values: 67.0 66.0 68.0 69.0 67.0 66.0 66.0 66.0 67.0 66.0 05:03:19 INFO - PROCESS | 1704 | -------- Summary: end -------- 05:03:19 INFO - PROCESS | 1704 | 05:03:20 INFO - TEST-INFO | 1704: exit 0 05:03:20 INFO - TEST-OK | kraken | took 56836ms 05:03:20 INFO - SUITE-END | took 1170s 05:03:20 INFO - Completed test suite (00:19:30) 05:03:20 INFO - javascript benchmark 05:03:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3395.3209358128374, 3432.8455219515117, 3441.7590768646205, 3463.3592785334713, 3497.492863534786, 5492.725363731817, 5525.226468294442, 5557.3886872444, 5583.748731307091, 5598.244237028, 5557.3886872444, 5568.0, 5683.914741278884, 5699.629524080942, 5728.198052272674, 5024.7738851751665, 5024.799008039674, 5038.168702164138, 5068.873278168038, 5162.638615296931, 5134.25553294772, 5172.224166375055, 5186.611004174683, 5199.740012999354, 5227.555657769094, 4989.900201995976, 5000.074986127578, 5087.923681144785, 5107.259447380127, 5116.155834287338, 5083.262926875583, 5086.491350864884, 5092.26162206478, 5092.745362731848, 5115.411727651331, 5034.270030845507, 5063.063333283318, 5065.772040258197, 5078.339815823956, 5110.488951104897, 5398.379186393576, 5476.7535460904355, 5508.834734957958, 5536.723163841792, 5594.524465420444, 6143.784967526115, 6149.907751383733, 6153.077038444225, 6157.846053848645, 6170.259568851721, 6160.291566469824, 6216.658083805389, 6233.563650544464, 6234.937650623481, 6241.65670888101, 5609.467100625434, 5685.317761868602, 5708.97145514274, 5716.542676585905, 5778.508826749689, 6248.375162483806, 6266.342034086447, 6267.091271765568, 6274.215723034621, 6280.591761535486, 5996.820095397145, 6009.699515024318, 6054.122152287893, 6057.485113765291, 6057.848553786191, 5965.343812180657, 6007.219061522062, 6118.071005858243, 6121.6358891611635, 6216.2540495140875, 5174.275601415805, 6098.250697042149, 6114.449699527064, 6114.877702445926, 6371.076193951943, 6146.416090471398, 6170.876582468325, 6172.660503672341, 6188.257409110935, 6206.937930620727, 4724.244120940633, 4778.283257511401, 4829.517048295143, 4839.443464001685, 4840.34655321527, 4365.301551751768, 4399.318105693623, 4401.6698747594055, 4404.735715856995, 4405.9559404405545, 5458.836234912959, 5533.529649979716, 5540.612157148961, 5541.9168712469345, 5542.889142217133, 6101.359357267512, 6121.938780612226, 6133.0, 6133.693315334215, 6186.536009799283, 5556.833295001156, 5570.86072848182, 5595.720213989284, 5595.804146854841, 5603.971980140073, 5278.656887302313, 5287.894242115136, 5294.57643388528, 5302.390225124083, 5331.0, 5327.174287985368, 6171.382861713882, 6206.503479721521, 6278.654673992883, 6286.874262514632, 6180.072989051679, 6184.6598437086395, 6188.783392581238, 6193.783217587363, 6206.162168107247, 5886.205362276038, 5888.61617519891, 6227.813165605039, 6262.436380725757, 6264.749410023548, 5954.285485741739, 6080.48315893154, 6104.822969073627, 6124.696630669495, 6144.603604594301, 6161.0, 6164.753409863555, 6170.568060235741, 6171.413715697002, 6184.226971628546, 4671.252599584051, 5632.802851900164, 5818.359980402237, 5984.670843103497, 6004.819855404345, 5166.715830629351, 5874.765009399576, 5920.3783602722815, 5980.37206093354, 6028.849278768066, 4893.559579637849, 5774.307083150049, 5782.681952492653, 5821.359650438533, 5837.503812176013, 5903.144044113494, 5949.940500594938, 5974.103884417372, 5983.401659833982, 6017.007193812972, 5948.910766338422, 5950.375210602824, 5953.821385358447, 5958.5828991971875, 6021.578489505868], "unit": "score", "name": "dojo.html", "value": 5584.8044964294295}, {"lowerIsBetter": false, "replicates": [493.4103746023503, 574.3481148896004, 582.2169182449604, 644.9742010319586, 645.3901063494998, 38081.23837523251, 38405.80797096011, 38436.615633843656, 38477.0, 38609.22781544367, 41993.37009944853, 42608.786956065174, 42653.36019959703, 42703.5053773118, 42781.57218427822, 9445.669401570929, 9637.807243855119, 9642.61429542821, 9665.130138287554, 9667.323287369887, 8020.839583208362, 9551.617935282615, 9574.04259574044, 9578.52107394631, 9579.41939579972, 9672.129508344247, 9742.805143897118, 9746.46394448305, 9759.609615615367, 9762.121409073183, 8318.750437486886, 9617.56720947559, 9696.0, 9703.0, 9704.951475242613, 8493.320534357237, 9570.856437153448, 9709.271804614611, 9717.46553939533, 9717.951410242975, 40723.0, 40939.77180684584, 40946.181076378605, 40986.79506602478, 40991.18017639631, 3163.8576264068174, 3248.2366643838677, 3251.3822373748912, 3426.201064954254, 3665.706743460517, 28170.15489535317, 28950.42099158026, 29664.0, 29677.703222967924, 29786.0, 2691.4078902641386, 2698.136596289188, 2794.18968499135, 2796.2310364649884, 2852.443773464175, 478036.0, 480683.0, 481555.0, 482610.0, 483175.58412208065, 71725.64137179386, 72601.37685543047, 73392.2660773396, 73560.0, 73590.95249761315, 78732.81900771493, 79132.20867791363, 79280.20719792844, 79331.0, 79363.60318198372, 17506.562335941704, 17658.470245892644, 17737.37919172823, 17791.644167116585, 17791.911040444975, 13287.933560332136, 13397.330133493286, 13413.0, 13426.395812188279, 13464.124831885896, 21878.89060554687, 22854.0, 23145.84270786454, 23342.299731008097, 23410.06359745591, 7436.3679087277105, 9083.318751093562, 9300.8604870927, 9682.951585242028, 9830.459324737209, 999.615148167946, 1004.9799004020025, 1024.687470321559, 1041.068243921701, 1046.9790604188026, 27515.31211719723, 29172.562411563842, 29295.0, 29624.555631665542, 29704.2573935649, 1027.3527677563088, 1164.598213616301, 1191.4995701805262, 1245.21551422605, 1260.1179174577833, 14856.331465084097, 14915.776263356058, 15096.773548396563, 15112.395504179709, 15177.468788592347, 528589.0, 534604.0, 537929.0, 538271.0, 539014.0, 57358.42641573531, 58189.70905145447, 58315.416845831, 58367.0, 58427.0, 1339.7186590815843, 1362.9591112266648, 1449.2101804516565, 1459.4308219794077, 1478.6451251699514, 24295.0, 27881.0, 28176.577351339336, 28588.14235572936, 28897.42205155843, 44671.55328446804, 45057.32414013858, 45115.54884451113, 45148.32277515905, 45246.54753452555, 308486.0, 309126.0, 309987.0, 310225.0, 310397.0, 24008.39979000539, 29262.561061583667, 31945.361092777548, 32469.0, 32580.34839303248, 39502.01244968899, 40344.1606744359, 40932.97667558335, 41809.0, 42331.1533769329, 29127.563086553295, 33560.1609959753, 33874.8306258477, 34885.65114348824, 36101.277974439836, 35651.0, 35682.46476302806, 35810.74662386804, 36482.27035459329, 36562.26875462422, 30826.845865770527, 31168.064958051295, 31843.044708658777, 32047.839760801045, 36239.45640815337, 29068.854655726587, 31306.68693313038, 31599.526007109453, 31675.683243167274, 31741.365172695954, 23555.88222058879, 24030.9186086623, 24068.037278508662, 24614.261572152864, 24662.0], "unit": "score", "name": "ext.html", "value": 19653.261929399017}, {"lowerIsBetter": false, "replicates": [357.6870238541278, 361.5607037449498, 364.99817500912496, 367.2929610499787, 372.62923391225735, 18993.99999999998, 19040.90479547602, 20008.29970951017, 20051.09770060347, 20060.799392006076, 12111.27332360059, 19415.22339106434, 20151.798482015176, 20195.293164739236, 20212.292569760062, 5182.11903976324, 5328.120860058086, 5384.91922621161, 5385.165299378603, 5409.0, 3930.233604447134, 4104.712670113093, 5325.281087053237, 5727.770889164429, 6003.879922401549, 5965.821025369246, 6002.039673652216, 6009.75960961561, 6014.308354539218, 6020.879582408349, 5798.362180160179, 6431.48548116152, 6482.57863238888, 6502.512311576604, 6508.93491065088, 3753.7372383933134, 5353.170258609883, 5576.7211639417865, 5605.607607467479, 5700.828975130753, 13156.473741050442, 13374.13068150567, 13402.463901444027, 15066.472673456487, 24663.0, 2093.4766308422895, 2124.6706760452153, 2142.1110239250693, 2188.059134572133, 2212.2920665387082, 9293.72118836436, 9810.313278070538, 13882.583522494342, 14120.576382708536, 14426.0, 1680.7562903379064, 1681.1930273468804, 1689.983100168995, 1703.9233234504477, 1754.429810311641, 101538.0, 108896.0, 108972.99999999921, 109602.0, 109693.90306096997, 10716.839247411295, 10925.781484370427, 11073.114150867912, 11135.888641113646, 11182.993530582287, 12222.755544889053, 13471.98960077998, 13887.44450222, 13916.721665566633, 13933.372998215105, 7138.714451421989, 8263.710770123016, 8414.158584141536, 8444.45111067791, 8524.275436587835, 8489.235968762841, 8523.0, 8530.317574594017, 8637.352198585006, 8653.048164702004, 3721.2557488502407, 4292.828286868553, 4364.934525982113, 4392.604665580113, 4408.360787685768, 1704.1905095079737, 1767.4609244180392, 1777.7688900442859, 1789.9821001789815, 1792.453301742981, 903.823754367892, 946.1531928923575, 974.6539978307741, 983.8032393521181, 991.9900800992042, 18816.0, 19188.232470701016, 19333.419997400102, 19398.4180474586, 19760.40718778439, 871.4509858789049, 938.2447130060231, 995.66147509847, 1049.1606714628267, 1094.8029354716227, 10379.221558383151, 10759.623413180658, 10793.352398856094, 10863.891361086287, 11021.83467247992, 584312.0, 601102.0, 606445.0, 616531.0, 617660.0, 69609.0, 85165.0, 98080.50959745156, 102943.0, 109070.45464772625, 1033.9224558158019, 1038.325088692356, 1050.9474526273655, 1052.8789189243182, 1055.9683209503728, 17672.911635442255, 17733.733993990358, 17806.37677681275, 17977.460676179737, 18082.457526274233, 48412.5158748408, 48639.0, 48854.75572622256, 49424.0, 50280.49719502904, 66216.66891665703, 68230.66489797815, 68843.31156688569, 69206.65396672985, 69214.0, 7609.467337286337, 7615.7334493292465, 7668.298714637674, 7722.768316950501, 7792.766217013499, 9114.908850911406, 11604.94197529007, 12152.392380381123, 12517.93597544219, 12614.936925315315, 10094.495275236062, 10843.1867609928, 10889.455527223448, 10889.78220435571, 10942.507587158438, 10493.842592361274, 10510.474476276002, 10702.946485267525, 10846.24076314682, 10883.020528152505, 10382.688519344432, 10968.670939871816, 11129.054030407182, 11243.49404276826, 11292.943535282271, 7666.578338191453, 7718.652660630173, 7746.457747957589, 7875.921240787748, 8089.676412943416, 9405.153536181777, 10789.946050269698, 10790.73023174427, 11080.501377437873, 11084.16868734832], "unit": "score", "name": "jquery.html", "value": 9050.290231405439}, {"lowerIsBetter": false, "replicates": [1363.3115276785222, 1377.393946663468, 1412.3432603839212, 1468.8531146885314, 1706.1980868991577, 8013.8397232055395, 8699.434536755114, 8866.911330886689, 8876.201141897229, 8881.200691937724, 8533.018702849175, 8812.735617931472, 8821.941367035965, 8825.823483530325, 8860.158284962934, 2177.2706143441965, 2229.442639340165, 2236.206146817881, 2475.7524247575234, 2508.4732206236713, 2479.47930934504, 2545.4654522550286, 2546.9745302547017, 2547.1339744486872, 2549.400890790672, 2450.4976479821594, 2481.925542233727, 2496.6629505016863, 2500.9124680636182, 2504.7119581248116, 2453.460238747473, 2464.753524647539, 2490.887910044043, 2502.074232533956, 2508.9623655645273, 2401.447667036591, 2406.278116565041, 2408.3136306152837, 2410.7950824179966, 2416.5770990076667, 8881.866771998426, 8927.018028016977, 8947.64209431622, 8950.373473856833, 8960.775980600538, 5437.429069947638, 5600.243967064475, 5600.803971860965, 5607.495325420691, 5611.270534830487, 3036.891534589881, 3550.3254381667402, 3627.8548858045647, 3702.2965636529243, 3703.2963736889906, 1044.1125043712784, 1060.4061725433705, 1066.4827558634056, 1067.092970974673, 1075.9892401076045, 10178.440185789852, 11846.644600661994, 11868.109891758153, 11883.821742673867, 11901.464434100486, 4414.9558504414545, 4848.0546293472435, 4870.318155458239, 4895.118878601886, 4969.130402179604, 10157.238207134495, 10180.490975451197, 10191.184705223712, 10205.540750666238, 10221.080102790636, 5526.944730552643, 5538.501534861882, 5543.1408131739645, 5558.194061861089, 5562.805301814498, 4475.641948644101, 4639.652026098056, 4858.271259311132, 5039.067772462106, 5043.672161309503, 3868.2650296443585, 3893.299206142865, 3914.099757055893, 3931.253061918226, 3968.523777146761, 1324.311358093805, 1333.7193399287135, 1335.5525898824003, 1346.7373862096993, 1353.911995720275, 1104.6244276945877, 1114.242315225638, 1137.0164807441504, 1359.0622470495327, 1393.4983405973842, 8102.0, 8297.917020829835, 8307.335413166933, 8328.33373330132, 8353.707620233263, 512.1114865707993, 524.1168630857018, 524.593440083938, 525.3774277481197, 532.379777559147, 6195.876082478415, 6200.81397558074, 6242.625442473375, 6271.811845644638, 6275.5920865144535, 10542.156627469783, 10790.73023174427, 10873.0, 10900.454977251105, 10903.509342079467, 10486.685399438029, 10611.151107911348, 10646.0, 10680.98530639588, 10765.03114719679, 8232.094469608339, 8279.62741676614, 8315.792105197297, 8333.499990000619, 8334.041585217656, 7616.466847320635, 7828.412869034732, 7905.960470197842, 7959.164287749702, 7983.5209887406945, 9270.0, 9557.426554406758, 9589.664361747306, 9722.805543889224, 9794.314397992071, 9677.177439917687, 9917.30578859473, 10013.198944084601, 10070.748231293983, 10077.294589378966, 5568.610197286151, 6812.318768123347, 6966.407855332353, 7543.73596924105, 7591.3547348475995, 8158.673653054048, 8266.958665206635, 8276.462029968034, 8280.83438331218, 8289.83420331602, 7238.963805180941, 7335.77992660221, 7355.080614923135, 7472.439567032603, 7530.8493830122, 7192.029076074663, 7229.927700723136, 7321.743738969323, 7323.0, 7421.369183619453, 7617.771466856003, 7775.455718099679, 7805.843883122192, 7821.0, 7831.177726338652, 6114.510839132769, 7023.086998690138, 7034.331738484836, 7091.0, 7116.181639111568, 6868.484863635347, 7097.148342198969, 7108.537945033556, 7120.928790712027, 7129.82175445618], "unit": "score", "name": "mootools.html", "value": 4821.9547064828275}, {"lowerIsBetter": false, "replicates": [321.5867610120995, 324.2752448278098, 327.79185217386953, 331.6650183314851, 332.98002119872825, 6106.053561697933, 6195.504359651229, 6211.689415529217, 6224.533160012995, 6226.533010024244, 5531.723413829312, 5641.041023026085, 6068.27180738312, 6163.938360616393, 6175.104609831583, 4353.695241333108, 4436.4676238851225, 4450.132224216279, 4545.2954792007295, 4583.587477127049, 4554.43069616298, 4556.977215113936, 4566.566176213254, 4594.931076033862, 4616.030633566955, 4544.454665440152, 4558.4529856417275, 4565.360849481075, 4566.6575006874455, 4572.954270457302, 3671.229041901204, 4339.500957389893, 4372.781360931941, 4453.4433195850515, 4458.821647134111, 3937.212557488485, 3944.881653550398, 3951.960480395188, 3952.288588054149, 3960.663343615767, 5862.12068189775, 5898.233229680157, 5908.556858235606, 5909.704514774244, 5926.78500907313, 5261.657992230493, 5294.126469132589, 5300.323336714973, 5308.283381743492, 5308.964751873386, 6434.806955791334, 6491.675416229217, 6492.513061520358, 6496.740130394778, 6498.805035848932, 4094.9181016379803, 4262.808173632163, 4264.296391095466, 4316.892077698051, 4375.453068366454, 6808.6936087876165, 6853.862922741518, 6867.416269617089, 6893.862122757517, 6896.655167241618, 4334.32817913224, 4341.8480353188115, 4346.217680817484, 4348.9997300621035, 4350.60844523988, 4405.801738921757, 4409.669274804402, 4424.048829501673, 4430.0, 4432.911341773147, 5206.505381988705, 5206.71363075027, 5207.6875387476875, 5218.556422704112, 5224.138017227191, 5744.937186620488, 6257.74969001244, 6312.652804095819, 6563.212414510289, 6597.967010164918, 1513.6291608555755, 1528.5414375687249, 1539.8383169767237, 1540.7212014028553, 1545.2351086212173, 932.3287233192091, 959.2757468111671, 985.9252720221364, 991.7520619845038, 1009.6365308488938, 5149.433562308143, 5168.095583272988, 5866.266716660418, 5914.467697907209, 6044.607100538451, 5522.8678120985105, 6364.586301890362, 6781.8643627127185, 6784.21981472137, 6887.345702158287, 6080.327909824833, 6085.4523092921845, 6096.9390306096375, 6108.1143234230785, 6118.969405152946, 3557.092941299952, 3630.691391231775, 3636.5272514572935, 3637.7635453695425, 3639.8180090995875, 6908.661706800372, 7050.0, 7141.14306283239, 7163.785086447415, 7177.641117944187, 7008.684609192496, 7066.611336376549, 7075.575465472089, 7081.327273908971, 7091.574505529685, 6784.676987987295, 7116.110486189226, 7127.434123715459, 7137.785866424016, 7147.106611673541, 6058.12198218536, 6867.450603951772, 6870.553414028072, 6874.931250687429, 6889.104416425833, 6434.967825160844, 6698.631575263407, 6717.261101278953, 6746.9325306746305, 6796.76211332601, 5799.82600521985, 7095.119793254688, 7099.183593886769, 7166.2475440080125, 7177.533460325062, 4358.9564104359815, 4420.646348292064, 4426.800793964344, 4429.114177164644, 4443.066955939289, 6864.107666003388, 6876.346747059021, 6877.277885822116, 6879.277675843964, 6889.621070840952, 5977.163197152489, 6312.4634406076, 6677.532572719863, 6682.131322927989, 6696.062551242732, 6452.22573291208, 6493.545451818327, 6552.737890484327, 6553.4101930826455, 6678.165229346332, 6476.12572302752, 6500.479961603155, 6502.6748662567625, 6528.086067950586, 6534.967325163344, 5581.665100094007, 6519.8044058678315, 6586.1438013058, 6648.434883034803, 6697.196336439659, 6219.40915613016, 6391.6804159792755, 6531.640759758259, 6534.901976470262, 6567.9014814778775], "unit": "score", "name": "prototype.html", "value": 4794.062889266122}, {"lowerIsBetter": false, "replicates": [687.5359132585505, 750.2235186581889, 752.3116348541085, 765.8315170662453, 802.0575823407496, 14599.635009124764, 14764.926175369135, 14806.777898331507, 14818.110913345206, 14845.62885927851, 15265.465708700198, 15705.0, 15736.97709648872, 15758.76361854573, 15765.0, 731.7950973727364, 743.9442041846856, 908.0873721909488, 920.9079092090805, 928.5078908178676, 896.1397058823537, 914.8399030169727, 916.9174774270315, 917.3670167584379, 921.0007142250666, 964.3635200767495, 970.5826494607317, 971.8396464583335, 971.8736564246637, 973.8928717841031, 760.4752720622753, 772.6716145638137, 774.8876412920094, 964.7346979580636, 966.0629189685993, 704.5279662626053, 715.5492040014809, 717.4726575966713, 717.7559629725866, 719.1298528780183, 15104.848951510454, 15229.61925951849, 15238.161901095435, 15246.847531524654, 15279.770803437847, 12354.38228088601, 12400.689982750413, 12447.190932589352, 12680.936595316964, 12756.170848894792, 9988.95005524975, 10005.59977600895, 10063.843751864579, 10412.010858968386, 10896.673099807018, 4052.9392059119136, 4060.9847538115473, 4187.45563076798, 4205.222033923734, 4218.810153543098, 71332.3701300323, 79710.40579188384, 79817.40365192664, 80000.19999799985, 80252.59873700653, 9202.355835091614, 9280.90719092814, 9334.71995840126, 9363.62545498186, 9654.0, 20591.0, 20794.376168714964, 20811.79188208129, 20816.95915204264, 20861.269855554983, 7401.59291238987, 7421.220771818989, 7450.403967682572, 7586.962065189638, 7693.653785579662, 3940.271049855786, 4060.26915155269, 4142.689298302639, 4195.97902010488, 4327.59353210208, 3614.6566076222716, 3673.412254039341, 3675.00774790805, 3679.1721862580707, 3681.042928838521, 581.9796307129315, 591.8520369907524, 596.3916804859019, 650.4601181019742, 654.649762377126, 550.6640949021094, 584.2959234122872, 613.8680183760424, 617.6479406738116, 620.2061361457341, 7332.79008963515, 8010.919890801134, 8130.512169269863, 8206.967823995894, 8253.009638843378, 508.2427829027511, 556.5186114011351, 559.6502186133666, 577.656294504769, 579.5161040531203, 3777.4481749491797, 3830.6552410283207, 3871.2257548490416, 3979.5622481527007, 4050.0707044554047, 85034.25784639301, 87384.0, 87768.0, 87909.68135477974, 88097.0, 75254.11864703317, 76475.0, 76829.61585192039, 77359.0, 77934.61032694801, 64916.67541662262, 65714.6857062856, 65787.4740041591, 65913.67043164754, 68071.0, 7659.502132361378, 7687.730929417444, 7965.243301886311, 8089.635966381409, 8132.634031468479, 48089.03821923612, 48789.75605122094, 49875.501244987085, 50383.87285053635, 50949.0, 68260.0, 68541.65729171323, 68978.0, 69782.25544361431, 70477.9428308586, 9959.850602240827, 10031.047050530187, 10243.641472548425, 10721.30311529748, 10912.0, 11982.58060967862, 11997.76004479923, 12222.816657749963, 12269.141160118706, 12932.870671293167, 11372.886271137513, 11468.885311147116, 11498.19512634141, 11555.191136620357, 11613.0, 11506.252093613888, 11618.767624647291, 11652.708682283012, 11666.183367164216, 11713.824292635447, 11098.167637427065, 11283.492242849255, 11321.0, 11562.132840037199, 11576.768464630828, 9038.322125840457, 9352.719418417459, 9495.287853410884, 9904.158146557334, 9936.105750482202, 8991.865122023306, 9196.402233854778, 9665.76781858535, 9713.174380177481, 9758.56086476096], "unit": "score", "name": "yui.html", "value": 6890.406990023691}], "name": "dromaeo_css", "value": 7354.486317202618}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 110.0, 111.0, 113.0, 117.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [157.0, 124.0, 141.0, 161.0, 122.0, 142.0, 138.0, 117.0, 162.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 138.1}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 183.0, 186.0, 185.0, 185.0, 183.0, 182.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 83.0, 86.0, 80.0, 82.0, 81.0, 113.0, 95.0, 57.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [93.0, 97.0, 164.0, 115.0, 102.0, 77.0, 113.0, 79.0, 75.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 85.0, 88.0, 84.0, 89.0, 82.0, 103.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 104.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 100.2}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 86.0, 87.0, 84.0, 85.0, 84.0, 82.0, 88.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 63.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 70.0, 77.0, 70.0, 72.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 82.0, 82.0, 82.0, 96.0, 106.0, 109.0, 103.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.9}, {"lowerIsBetter": true, "replicates": [123.0, 132.0, 131.0, 133.0, 122.0, 124.0, 124.0, 108.0, 117.0, 146.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 141.0, 135.0, 135.0, 128.0, 139.0, 138.0, 136.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 69.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1434.3000000000002}]} 05:03:20 INFO - Return code: 0 05:03:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:03:20 ERROR - # TBPL SUCCESS # 05:03:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:20 INFO - 2016-04-07 05:03:20.569 screenresolution[1708:10256] starting screenresolution argv=screenresolution get 05:03:20 INFO - 2016-04-07 05:03:20.571 screenresolution[1708:10256] Display 0: 1600x1200x32@60 05:03:20 INFO - 2016-04-07 05:03:20.578 screenresolution[1709:10259] starting screenresolution argv=screenresolution list 05:03:20 INFO - Available Modes on Display 0 05:03:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:20 INFO - Intel Iris: 05:03:20 INFO - Chipset Model: Intel Iris 05:03:20 INFO - Type: GPU 05:03:20 INFO - Bus: Built-In 05:03:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:20 INFO - Vendor: Intel (0x8086) 05:03:20 INFO - Device ID: 0x0a2e 05:03:20 INFO - Revision ID: 0x0009 05:03:20 INFO - Displays: 05:03:20 INFO - Display: 05:03:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:20 INFO - Display Serial Number: 1600x1200 60 05:03:20 INFO - Main Display: Yes 05:03:20 INFO - Mirror: Off 05:03:20 INFO - Online: Yes 05:03:20 INFO - Rotation: Supported 05:03:20 INFO - Return code: 0 05:03:20 INFO - Running post-action listener: _resource_record_post_action 05:03:20 INFO - Running post-run listener: _resource_record_post_run 05:03:21 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 37037568; Write bytes: 691654144; Read time: 415; Write time: 1836 05:03:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 383791616; Write bytes: 377435648; Read time: 29015; Write time: 673 05:03:21 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35804672; Write bytes: 296757248; Read time: 403; Write time: 1123 05:03:21 INFO - Running post-run listener: _upload_blobber_files 05:03:21 INFO - Blob upload gear active. 05:03:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:21 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 05:03:21 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'] 05:03:21 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 05:03:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:24 INFO - (blobuploader) - INFO - Done attempting. 05:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:26 INFO - (blobuploader) - INFO - Done attempting. 05:03:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:26 INFO - Return code: 0 05:03:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cdd2a89f48fc9e9887c300060ebde60bce3148b0dce8ff92ce482c2d483176969e51f2bc92b3dc7fdc4bc41d64b182cc695923114ff1ddb6290ef8e9b5d924c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ba8c0ffead498e295fea8d5ef51aaa1ab4105a46665a86bd7a047b5b1727ceafe8b9d7724afae4c8dc02eaccca1b12cec090c07718a11a752b2f4956877232"} 05:03:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:26 INFO - Contents: 05:03:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cdd2a89f48fc9e9887c300060ebde60bce3148b0dce8ff92ce482c2d483176969e51f2bc92b3dc7fdc4bc41d64b182cc695923114ff1ddb6290ef8e9b5d924c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ba8c0ffead498e295fea8d5ef51aaa1ab4105a46665a86bd7a047b5b1727ceafe8b9d7724afae4c8dc02eaccca1b12cec090c07718a11a752b2f4956877232"} 05:03:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:26 INFO - Copying logs to upload dir... 05:03:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.314150 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-07 05:03:26.842191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:26.845360) ========= 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.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/2cdd2a89f48fc9e9887c300060ebde60bce3148b0dce8ff92ce482c2d483176969e51f2bc92b3dc7fdc4bc41d64b182cc695923114ff1ddb6290ef8e9b5d924c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ba8c0ffead498e295fea8d5ef51aaa1ab4105a46665a86bd7a047b5b1727ceafe8b9d7724afae4c8dc02eaccca1b12cec090c07718a11a752b2f4956877232"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010872 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cdd2a89f48fc9e9887c300060ebde60bce3148b0dce8ff92ce482c2d483176969e51f2bc92b3dc7fdc4bc41d64b182cc695923114ff1ddb6290ef8e9b5d924c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ba8c0ffead498e295fea8d5ef51aaa1ab4105a46665a86bd7a047b5b1727ceafe8b9d7724afae4c8dc02eaccca1b12cec090c07718a11a752b2f4956877232"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:26.874778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:26.875323) ========= 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.WJDRsw3qRg/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.mXfinFrIOu/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.004559 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:26.924772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:26.925122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:26.925548) ========= ========= Total master_lag: 0.29 =========