builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1503540999.75 results: success (0) revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:39.750616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:39.751102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:39.751393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:39.768536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:39.768919) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 19:16:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.9K=0.2s 2017-08-23 19:16:40 (47.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.433340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:40.218228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:40.218563) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016034 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:40.268587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:40.268990) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 19:16:40,373 truncating revision to first 12 chars 2017-08-23 19:16:40,373 Setting DEBUG logging. 2017-08-23 19:16:40,373 attempt 1/10 2017-08-23 19:16:40,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1c70c20e7b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 19:16:40,857 unpacking tar archive at: mozilla-central-d1c70c20e7b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:41.123923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:41.124254) ========= script_repo_revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:41.124660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:41.124924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 19:16:41.135895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-23 19:16:41.136348) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:16:41 INFO - MultiFileLogger online at 20170823 19:16:41 in /builds/slave/test 19:16:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:16:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:16:41 INFO - {'append_to_log': False, 19:16:41 INFO - 'base_work_dir': '/builds/slave/test', 19:16:41 INFO - 'blob_upload_branch': 'Firefox', 19:16:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:16:41 INFO - 'branch': 'Firefox', 19:16:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:41 INFO - 'code_coverage': False, 19:16:41 INFO - 'config_files': ('talos/linux_config.py',), 19:16:41 INFO - 'default_actions': ('clobber', 19:16:41 INFO - 'read-buildbot-config', 19:16:41 INFO - 'download-and-extract', 19:16:41 INFO - 'populate-webroot', 19:16:41 INFO - 'create-virtualenv', 19:16:41 INFO - 'install', 19:16:41 INFO - 'setup-mitmproxy', 19:16:41 INFO - 'run-tests'), 19:16:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:41 INFO - 'disable_ccov_upload': False, 19:16:41 INFO - 'download_minidump_stackwalk': True, 19:16:41 INFO - 'download_symbols': 'ondemand', 19:16:41 INFO - 'enable_stylo': False, 19:16:41 INFO - 'enable_webrender': False, 19:16:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 19:16:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:41 INFO - 'gecko_profile': False, 19:16:41 INFO - 'gecko_profile_interval': 0, 19:16:41 INFO - 'installer_path': 'installer.exe', 19:16:41 INFO - 'log_level': 'info', 19:16:41 INFO - 'log_name': 'talos', 19:16:41 INFO - 'log_to_console': True, 19:16:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:16:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:16:41 INFO - 'opt_config_files': (), 19:16:41 INFO - 'pip_index': False, 19:16:41 INFO - 'suite': 'dromaeojs-e10s', 19:16:41 INFO - 'system_bits': '32', 19:16:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:41 INFO - 'title': 'talos-linux64-ix-022', 19:16:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:16:41 INFO - 'use_talos_json': True, 19:16:41 INFO - 'verify': 'False', 19:16:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:16:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:41 INFO - 'work_dir': 'build'} 19:16:41 INFO - [mozharness: 2017-08-24 02:16:41.385718Z] Running clobber step. 19:16:41 INFO - Running pre-action listener: _resource_record_pre_action 19:16:41 INFO - Running main action method: clobber 19:16:41 INFO - rmtree: /builds/slave/test/build 19:16:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:16:42 INFO - Running post-action listener: _resource_record_post_action 19:16:42 INFO - [mozharness: 2017-08-24 02:16:42.423173Z] Finished clobber step (success) 19:16:42 INFO - [mozharness: 2017-08-24 02:16:42.423271Z] Running read-buildbot-config step. 19:16:42 INFO - Running pre-action listener: _resource_record_pre_action 19:16:42 INFO - Running main action method: read_buildbot_config 19:16:42 INFO - Using buildbot properties: 19:16:42 INFO - { 19:16:42 INFO - "project": "", 19:16:42 INFO - "product": "firefox", 19:16:42 INFO - "who": "kwierso@gmail.com", 19:16:42 INFO - "installer_path": "public/build/target.tar.bz2", 19:16:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:16:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:16:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:16:42 INFO - "stage_platform": "linux64-pgo", 19:16:42 INFO - "basedir": "/builds/slave/test", 19:16:42 INFO - "buildnumber": 139, 19:16:42 INFO - "platform": "ubuntu64_hw", 19:16:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:16:42 INFO - "slavebuilddir": "test", 19:16:42 INFO - "taskId": "XNKKT820QGmy68NElcfU3g", 19:16:42 INFO - "branch": "mozilla-central", 19:16:42 INFO - "script_repo_revision": "production", 19:16:42 INFO - "revision": "d1c70c20e7b52f7295411343e4dc5db8ee7c92b9", 19:16:42 INFO - "slavename": "talos-linux64-ix-022", 19:16:42 INFO - "repo_path": "mozilla-central" 19:16:42 INFO - } 19:16:42 INFO - Finding installer, test and symbols from parent task. 19:16:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNKKT820QGmy68NElcfU3g'}, attempt #1 19:16:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNKKT820QGmy68NElcfU3g'}, attempt #1 19:16:43 INFO - Task dependencies: K0CoqHb9Rx6Hb0820ZShhQ 19:16:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ'}, attempt #1 19:16:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 19:16:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.test_packages.json 19:16:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.crashreporter-symbols.zip 19:16:43 INFO - Running post-action listener: _resource_record_post_action 19:16:43 INFO - [mozharness: 2017-08-24 02:16:43.776279Z] Finished read-buildbot-config step (success) 19:16:43 INFO - [mozharness: 2017-08-24 02:16:43.776496Z] Running download-and-extract step. 19:16:43 INFO - Running pre-action listener: _resource_record_pre_action 19:16:43 INFO - Running main action method: download_and_extract 19:16:43 INFO - mkdir: /builds/slave/test/build/tests 19:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:16:43 INFO - trying https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.test_packages.json 19:16:43 INFO - Downloading https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:16:44 INFO - Downloaded 989 bytes. 19:16:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:16:44 INFO - Using the following test package requirements: 19:16:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:16:44 INFO - u'common': [u'target.common.tests.zip'], 19:16:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:16:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:16:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:16:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:16:44 INFO - u'mozbase': [u'target.common.tests.zip'], 19:16:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:16:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:16:44 INFO - u'web-platform': [u'target.common.tests.zip', 19:16:44 INFO - u'target.web-platform.tests.tar.gz'], 19:16:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:16:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:16:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip 19:16:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:16:44 INFO - Fetch https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip into memory 19:16:45 INFO - Content-Length response header: 55704031 19:16:45 INFO - Bytes received: 55704031 19:16:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:16:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip 19:16:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:16:56 INFO - Fetch https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.common.tests.zip into memory 19:16:57 INFO - Content-Length response header: 55704031 19:16:57 INFO - Bytes received: 55704031 19:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.talos.tests.zip 19:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.talos.tests.zip into memory 19:17:12 INFO - Content-Length response header: 14496384 19:17:12 INFO - Bytes received: 14496384 19:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:12 INFO - trying https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 19:17:12 INFO - Downloading https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:17:14 INFO - Downloaded 62342645 bytes. 19:17:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 19:17:14 INFO - mkdir: /builds/slave/test/properties 19:17:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:14 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:14 INFO - Contents: 19:17:14 INFO - build_url:https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 19:17:14 INFO - Running post-action listener: _resource_record_post_action 19:17:14 INFO - Running post-action listener: find_tests_for_verification 19:17:14 INFO - Running post-action listener: set_extra_try_arguments 19:17:14 INFO - [mozharness: 2017-08-24 02:17:14.063606Z] Finished download-and-extract step (success) 19:17:14 INFO - [mozharness: 2017-08-24 02:17:14.063702Z] Running populate-webroot step. 19:17:14 INFO - Running pre-action listener: _resource_record_pre_action 19:17:14 INFO - Running main action method: populate_webroot 19:17:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:14 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:14 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:14 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'tests': ['damp', 'tps']}, 19:17:14 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['damp', 'tps']}, 19:17:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:17:14 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:17:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:17:14 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:17:14 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:14 INFO - 'ts_paint', 19:17:14 INFO - 'tpaint', 19:17:14 INFO - 'sessionrestore', 19:17:14 INFO - 'sessionrestore_many_windows', 19:17:14 INFO - 'sessionrestore_no_auto_restore', 19:17:14 INFO - 'tabpaint']}, 19:17:14 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['a11yr', 19:17:14 INFO - 'ts_paint', 19:17:14 INFO - 'tpaint', 19:17:14 INFO - 'sessionrestore', 19:17:14 INFO - 'sessionrestore_many_windows', 19:17:14 INFO - 'sessionrestore_no_auto_restore', 19:17:14 INFO - 'tabpaint']}, 19:17:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:17:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:17:14 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['bloom_basic_singleton']}, 19:17:14 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['bloom_basic']}, 19:17:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:14 INFO - 'tsvgr_opacity', 19:17:14 INFO - 'tart', 19:17:14 INFO - 'tscrollx', 19:17:14 INFO - 'tsvg_static']}, 19:17:14 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['tsvgx', 19:17:14 INFO - 'tsvgr_opacity', 19:17:14 INFO - 'tart', 19:17:14 INFO - 'tscrollx', 19:17:14 INFO - 'tsvg_static']}, 19:17:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:17:14 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--stylo'], 19:17:14 INFO - 'tests': ['tp5o']}, 19:17:14 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:17:14 INFO - 'talos_options': ['--mitmproxy', 19:17:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:17:14 INFO - '--firstNonBlankPaint'], 19:17:14 INFO - 'tests': ['tp6_google', 19:17:14 INFO - 'tp6_youtube', 19:17:14 INFO - 'tp6_amazon', 19:17:14 INFO - 'tp6_facebook']}, 19:17:14 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:17:14 INFO - 'talos_options': ['--stylo', 19:17:14 INFO - '--mitmproxy', 19:17:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:17:14 INFO - '--firstNonBlankPaint'], 19:17:14 INFO - 'tests': ['tp6_google', 19:17:14 INFO - 'tp6_youtube', 19:17:14 INFO - 'tp6_amazon', 19:17:14 INFO - 'tp6_facebook']}, 19:17:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:17:14 INFO - 'talos_options': ['--stylo', 19:17:14 INFO - '--stylo-threads=1', 19:17:14 INFO - '--mitmproxy', 19:17:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:17:14 INFO - '--firstNonBlankPaint'], 19:17:14 INFO - 'tests': ['tp6_google', 19:17:14 INFO - 'tp6_youtube', 19:17:14 INFO - 'tp6_amazon', 19:17:14 INFO - 'tp6_facebook']}, 19:17:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--xperf_path', 19:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:14 INFO - 'tests': ['tp5n']}, 19:17:14 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:17:14 INFO - 'talos_options': ['--stylo', 19:17:14 INFO - '--xperf_path', 19:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:14 INFO - 'tests': ['tp5n']}}} 19:17:14 INFO - Running post-action listener: _resource_record_post_action 19:17:14 INFO - [mozharness: 2017-08-24 02:17:14.077972Z] Finished populate-webroot step (success) 19:17:14 INFO - [mozharness: 2017-08-24 02:17:14.078061Z] Running create-virtualenv step. 19:17:14 INFO - Running pre-action listener: _resource_record_pre_action 19:17:14 INFO - Running main action method: create_virtualenv 19:17:14 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:14 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:17:14 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 19:17:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:17:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:14 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:14 INFO - Installing pip...............done. 19:17:14 INFO - Return code: 0 19:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:17:15 INFO - Reading from file tmpfile_stdout 19:17:15 INFO - Output received: 19:17:15 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 19:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:17:15 INFO - Using env: {'DISPLAY': ':0', 19:17:15 INFO - 'HOME': '/home/cltbld', 19:17:15 INFO - 'LANG': 'en_US.UTF-8', 19:17:15 INFO - 'LANGUAGE': 'en_US:en', 19:17:15 INFO - 'LOGNAME': 'cltbld', 19:17:15 INFO - 'MAIL': '/var/mail/cltbld', 19:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:15 INFO - 'MOZ_NO_REMOTE': '1', 19:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:15 INFO - 'NO_EM_RESTART': '1', 19:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:15 INFO - 'PWD': '/builds/slave/test', 19:17:15 INFO - 'SHELL': '/bin/bash', 19:17:15 INFO - 'SHLVL': '1', 19:17:15 INFO - 'TERM': 'linux', 19:17:15 INFO - 'TMOUT': '86400', 19:17:15 INFO - 'USER': 'cltbld', 19:17:15 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:15 INFO - '_': '/tools/buildbot/bin/python'} 19:17:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:17:16 INFO - Downloading/unpacking pip>=1.5 19:17:16 INFO - Running setup.py egg_info for package pip 19:17:16 INFO - warning: no files found matching 'pip/cacert.pem' 19:17:16 INFO - warning: no files found matching '*.html' under directory 'docs' 19:17:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:17:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:17:16 INFO - Installing collected packages: pip 19:17:16 INFO - Found existing installation: pip 1.1 19:17:16 INFO - Uninstalling pip: 19:17:16 INFO - Successfully uninstalled pip 19:17:16 INFO - Running setup.py install for pip 19:17:16 INFO - warning: no files found matching 'pip/cacert.pem' 19:17:16 INFO - warning: no files found matching '*.html' under directory 'docs' 19:17:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:17:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:17:16 INFO - Installing pip script to /builds/slave/test/build/venv/bin 19:17:16 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 19:17:16 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 19:17:16 INFO - Successfully installed pip 19:17:16 INFO - Cleaning up... 19:17:16 INFO - Return code: 0 19:17:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:16 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:17:16 INFO - Using env: {'DISPLAY': ':0', 19:17:16 INFO - 'HOME': '/home/cltbld', 19:17:16 INFO - 'LANG': 'en_US.UTF-8', 19:17:16 INFO - 'LANGUAGE': 'en_US:en', 19:17:16 INFO - 'LOGNAME': 'cltbld', 19:17:16 INFO - 'MAIL': '/var/mail/cltbld', 19:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:16 INFO - 'MOZ_NO_REMOTE': '1', 19:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:16 INFO - 'NO_EM_RESTART': '1', 19:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:16 INFO - 'PWD': '/builds/slave/test', 19:17:16 INFO - 'SHELL': '/bin/bash', 19:17:16 INFO - 'SHLVL': '1', 19:17:16 INFO - 'TERM': 'linux', 19:17:16 INFO - 'TMOUT': '86400', 19:17:16 INFO - 'USER': 'cltbld', 19:17:16 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:16 INFO - '_': '/tools/buildbot/bin/python'} 19:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:16 INFO - Downloading/unpacking psutil>=3.1.1 19:17:16 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 19:17:16 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 19:17:16 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 19:17:16 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 19:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:17 INFO - Installing collected packages: psutil 19:17:17 INFO - Running setup.py install for psutil 19:17:17 INFO - building 'psutil._psutil_linux' extension 19:17:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:17:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:17:17 INFO - building 'psutil._psutil_posix' extension 19:17:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:17:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:18 INFO - Successfully installed psutil 19:17:18 INFO - Cleaning up... 19:17:18 INFO - Return code: 0 19:17:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:17:18 INFO - Using env: {'DISPLAY': ':0', 19:17:18 INFO - 'HOME': '/home/cltbld', 19:17:18 INFO - 'LANG': 'en_US.UTF-8', 19:17:18 INFO - 'LANGUAGE': 'en_US:en', 19:17:18 INFO - 'LOGNAME': 'cltbld', 19:17:18 INFO - 'MAIL': '/var/mail/cltbld', 19:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:18 INFO - 'MOZ_NO_REMOTE': '1', 19:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:18 INFO - 'NO_EM_RESTART': '1', 19:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:18 INFO - 'PWD': '/builds/slave/test', 19:17:18 INFO - 'SHELL': '/bin/bash', 19:17:18 INFO - 'SHLVL': '1', 19:17:18 INFO - 'TERM': 'linux', 19:17:18 INFO - 'TMOUT': '86400', 19:17:18 INFO - 'USER': 'cltbld', 19:17:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:18 INFO - '_': '/tools/buildbot/bin/python'} 19:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:19 INFO - Installing collected packages: mozsystemmonitor 19:17:19 INFO - Running setup.py install for mozsystemmonitor 19:17:19 INFO - Successfully installed mozsystemmonitor 19:17:19 INFO - Cleaning up... 19:17:19 INFO - Return code: 0 19:17:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:19 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:17:19 INFO - Using env: {'DISPLAY': ':0', 19:17:19 INFO - 'HOME': '/home/cltbld', 19:17:19 INFO - 'LANG': 'en_US.UTF-8', 19:17:19 INFO - 'LANGUAGE': 'en_US:en', 19:17:19 INFO - 'LOGNAME': 'cltbld', 19:17:19 INFO - 'MAIL': '/var/mail/cltbld', 19:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:19 INFO - 'MOZ_NO_REMOTE': '1', 19:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:19 INFO - 'NO_EM_RESTART': '1', 19:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:19 INFO - 'PWD': '/builds/slave/test', 19:17:19 INFO - 'SHELL': '/bin/bash', 19:17:19 INFO - 'SHLVL': '1', 19:17:19 INFO - 'TERM': 'linux', 19:17:19 INFO - 'TMOUT': '86400', 19:17:19 INFO - 'USER': 'cltbld', 19:17:19 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:19 INFO - '_': '/tools/buildbot/bin/python'} 19:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:19 INFO - Downloading/unpacking jsonschema==2.5.1 19:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17:21 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 19:17:21 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 19:17:21 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 19:17:21 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 19:17:21 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:21 INFO - warning: no files found matching '*.txt' 19:17:21 INFO - no previously-included directories found matching 'build' 19:17:21 INFO - no previously-included directories found matching 'dist' 19:17:21 INFO - no previously-included directories found matching '.git*' 19:17:21 INFO - Installing collected packages: jsonschema, functools32 19:17:21 INFO - Running setup.py install for functools32 19:17:21 INFO - warning: no files found matching '*.txt' 19:17:21 INFO - no previously-included directories found matching 'build' 19:17:21 INFO - no previously-included directories found matching 'dist' 19:17:21 INFO - no previously-included directories found matching '.git*' 19:17:21 INFO - Successfully installed jsonschema functools32 19:17:21 INFO - Cleaning up... 19:17:21 INFO - Return code: 0 19:17:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:17:21 INFO - Using env: {'DISPLAY': ':0', 19:17:21 INFO - 'HOME': '/home/cltbld', 19:17:21 INFO - 'LANG': 'en_US.UTF-8', 19:17:21 INFO - 'LANGUAGE': 'en_US:en', 19:17:21 INFO - 'LOGNAME': 'cltbld', 19:17:21 INFO - 'MAIL': '/var/mail/cltbld', 19:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:21 INFO - 'MOZ_NO_REMOTE': '1', 19:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:21 INFO - 'NO_EM_RESTART': '1', 19:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:21 INFO - 'PWD': '/builds/slave/test', 19:17:21 INFO - 'SHELL': '/bin/bash', 19:17:21 INFO - 'SHLVL': '1', 19:17:21 INFO - 'TERM': 'linux', 19:17:21 INFO - 'TMOUT': '86400', 19:17:21 INFO - 'USER': 'cltbld', 19:17:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:21 INFO - '_': '/tools/buildbot/bin/python'} 19:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:17:21 INFO - Cleaning up... 19:17:21 INFO - Return code: 0 19:17:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:17:21 INFO - Using env: {'DISPLAY': ':0', 19:17:21 INFO - 'HOME': '/home/cltbld', 19:17:21 INFO - 'LANG': 'en_US.UTF-8', 19:17:21 INFO - 'LANGUAGE': 'en_US:en', 19:17:21 INFO - 'LOGNAME': 'cltbld', 19:17:21 INFO - 'MAIL': '/var/mail/cltbld', 19:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:21 INFO - 'MOZ_NO_REMOTE': '1', 19:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:21 INFO - 'NO_EM_RESTART': '1', 19:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:21 INFO - 'PWD': '/builds/slave/test', 19:17:21 INFO - 'SHELL': '/bin/bash', 19:17:21 INFO - 'SHLVL': '1', 19:17:21 INFO - 'TERM': 'linux', 19:17:21 INFO - 'TMOUT': '86400', 19:17:21 INFO - 'USER': 'cltbld', 19:17:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:21 INFO - '_': '/tools/buildbot/bin/python'} 19:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:21 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 19:17:21 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 19:17:21 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 19:17:21 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 19:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:23 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 19:17:23 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 19:17:23 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 19:17:23 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 19:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:23 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 19:17:23 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 19:17:23 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 19:17:23 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 19:17:23 INFO - Downloading docopt-0.6.1.tar.gz 19:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:23 INFO - Running setup.py install for blobuploader 19:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:17:23 INFO - Running setup.py install for requests 19:17:23 INFO - Running setup.py install for docopt 19:17:24 INFO - Successfully installed blobuploader requests docopt 19:17:24 INFO - Cleaning up... 19:17:24 INFO - Return code: 0 19:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:24 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/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:24 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:17:24 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:17:24 INFO - Using env: {'DISPLAY': ':0', 19:17:24 INFO - 'HOME': '/home/cltbld', 19:17:24 INFO - 'LANG': 'en_US.UTF-8', 19:17:24 INFO - 'LANGUAGE': 'en_US:en', 19:17:24 INFO - 'LOGNAME': 'cltbld', 19:17:24 INFO - 'MAIL': '/var/mail/cltbld', 19:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:24 INFO - 'MOZ_NO_REMOTE': '1', 19:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:24 INFO - 'NO_EM_RESTART': '1', 19:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:24 INFO - 'PWD': '/builds/slave/test', 19:17:24 INFO - 'SHELL': '/bin/bash', 19:17:24 INFO - 'SHLVL': '1', 19:17:24 INFO - 'TERM': 'linux', 19:17:24 INFO - 'TMOUT': '86400', 19:17:24 INFO - 'USER': 'cltbld', 19:17:24 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:24 INFO - '_': '/tools/buildbot/bin/python'} 19:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:24 INFO - Running setup.py (path:/tmp/pip-b8d7OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:24 INFO - Running setup.py (path:/tmp/pip-vBTaqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:24 INFO - Running setup.py (path:/tmp/pip-P7oZPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:24 INFO - Running setup.py (path:/tmp/pip-0bycGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:24 INFO - Running setup.py (path:/tmp/pip-8q55WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:24 INFO - Running setup.py (path:/tmp/pip-MJbsWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:24 INFO - Running setup.py (path:/tmp/pip-E0CZuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:24 INFO - Running setup.py (path:/tmp/pip-QBjm7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:24 INFO - Running setup.py (path:/tmp/pip-2gLBCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:24 INFO - Running setup.py (path:/tmp/pip-Khmuhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:25 INFO - Running setup.py (path:/tmp/pip-9U8iW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:25 INFO - Running setup.py (path:/tmp/pip-nPNFhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:25 INFO - Running setup.py (path:/tmp/pip-eSpIgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:25 INFO - Running setup.py (path:/tmp/pip-YDXjsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:25 INFO - Running setup.py (path:/tmp/pip-vlnWAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:25 INFO - Running setup.py (path:/tmp/pip-LiJh7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:25 INFO - Running setup.py (path:/tmp/pip-FUfQmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:25 INFO - Running setup.py install for manifestparser 19:17:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:17:25 INFO - Running setup.py install for mozcrash 19:17:25 INFO - Running setup.py install for mozdebug 19:17:25 INFO - Running setup.py install for mozdevice 19:17:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:17:25 INFO - Running setup.py install for mozfile 19:17:26 INFO - Running setup.py install for mozhttpd 19:17:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozinfo 19:17:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozInstall 19:17:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozleak 19:17:26 INFO - Running setup.py install for mozlog 19:17:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for moznetwork 19:17:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozprocess 19:17:26 INFO - Running setup.py install for mozprofile 19:17:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozrunner 19:17:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:17:26 INFO - Running setup.py install for mozscreenshot 19:17:27 INFO - Running setup.py install for moztest 19:17:27 INFO - Running setup.py install for mozversion 19:17:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:17:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:27 INFO - Cleaning up... 19:17:27 INFO - Return code: 0 19:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:27 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/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:27 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:17:27 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:17:27 INFO - Using env: {'DISPLAY': ':0', 19:17:27 INFO - 'HOME': '/home/cltbld', 19:17:27 INFO - 'LANG': 'en_US.UTF-8', 19:17:27 INFO - 'LANGUAGE': 'en_US:en', 19:17:27 INFO - 'LOGNAME': 'cltbld', 19:17:27 INFO - 'MAIL': '/var/mail/cltbld', 19:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:27 INFO - 'MOZ_NO_REMOTE': '1', 19:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:27 INFO - 'NO_EM_RESTART': '1', 19:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:27 INFO - 'PWD': '/builds/slave/test', 19:17:27 INFO - 'SHELL': '/bin/bash', 19:17:27 INFO - 'SHLVL': '1', 19:17:27 INFO - 'TERM': 'linux', 19:17:27 INFO - 'TMOUT': '86400', 19:17:27 INFO - 'USER': 'cltbld', 19:17:27 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:27 INFO - '_': '/tools/buildbot/bin/python'} 19:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:27 INFO - Running setup.py (path:/tmp/pip-ytnKWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:27 INFO - Running setup.py (path:/tmp/pip-O9RMSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:27 INFO - Running setup.py (path:/tmp/pip-DOZ97E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:27 INFO - Running setup.py (path:/tmp/pip-34jDR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:27 INFO - Running setup.py (path:/tmp/pip-A8zGvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:27 INFO - Running setup.py (path:/tmp/pip-OQOgCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:27 INFO - Running setup.py (path:/tmp/pip-e7zwf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:28 INFO - Running setup.py (path:/tmp/pip-89dcWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:28 INFO - Running setup.py (path:/tmp/pip-ewQkd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:28 INFO - Running setup.py (path:/tmp/pip-TJI7fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:28 INFO - Running setup.py (path:/tmp/pip-rOVJok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:28 INFO - Running setup.py (path:/tmp/pip-D3Z6_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:28 INFO - Running setup.py (path:/tmp/pip-rfYRyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:28 INFO - Running setup.py (path:/tmp/pip-51YdO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:28 INFO - Running setup.py (path:/tmp/pip-fQqIY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:28 INFO - Running setup.py (path:/tmp/pip-e8glpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 19:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:28 INFO - Running setup.py (path:/tmp/pip-MzCkKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:28 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)) 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:17:28 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)) 19:17:28 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:17:28 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:29 INFO - Downloading blessings-1.6.tar.gz 19:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:29 INFO - Installing collected packages: blessings 19:17:29 INFO - Running setup.py install for blessings 19:17:30 INFO - Successfully installed blessings 19:17:30 INFO - Cleaning up... 19:17:30 INFO - Return code: 0 19:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:30 INFO - Reading from file tmpfile_stdout 19:17:30 INFO - Current package versions: 19:17:30 INFO - argparse == 1.2.1 19:17:30 INFO - blessings == 1.6 19:17:30 INFO - blobuploader == 1.2.4 19:17:30 INFO - docopt == 0.6.1 19:17:30 INFO - functools32 == 3.2.3-2 19:17:30 INFO - jsonschema == 2.5.1 19:17:30 INFO - manifestparser == 1.1 19:17:30 INFO - mozInstall == 1.13 19:17:30 INFO - mozcrash == 1.0 19:17:30 INFO - mozdebug == 0.1 19:17:30 INFO - mozdevice == 0.51 19:17:30 INFO - mozfile == 1.2 19:17:30 INFO - mozhttpd == 0.7 19:17:30 INFO - mozinfo == 0.10 19:17:30 INFO - mozleak == 0.1 19:17:30 INFO - mozlog == 3.5 19:17:30 INFO - moznetwork == 0.27 19:17:30 INFO - mozprocess == 0.25 19:17:30 INFO - mozprofile == 0.28 19:17:30 INFO - mozrunner == 6.13 19:17:30 INFO - mozscreenshot == 0.1 19:17:30 INFO - mozsystemmonitor == 0.3 19:17:30 INFO - moztest == 0.8 19:17:30 INFO - mozversion == 1.4 19:17:30 INFO - psutil == 3.1.1 19:17:30 INFO - requests == 1.2.3 19:17:30 INFO - wsgiref == 0.1.2 19:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:30 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/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:30 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:17:30 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:17:30 INFO - Using env: {'DISPLAY': ':0', 19:17:30 INFO - 'HOME': '/home/cltbld', 19:17:30 INFO - 'LANG': 'en_US.UTF-8', 19:17:30 INFO - 'LANGUAGE': 'en_US:en', 19:17:30 INFO - 'LOGNAME': 'cltbld', 19:17:30 INFO - 'MAIL': '/var/mail/cltbld', 19:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:30 INFO - 'MOZ_NO_REMOTE': '1', 19:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:30 INFO - 'NO_EM_RESTART': '1', 19:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:30 INFO - 'PWD': '/builds/slave/test', 19:17:30 INFO - 'SHELL': '/bin/bash', 19:17:30 INFO - 'SHLVL': '1', 19:17:30 INFO - 'TERM': 'linux', 19:17:30 INFO - 'TMOUT': '86400', 19:17:30 INFO - 'USER': 'cltbld', 19:17:30 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:30 INFO - '_': '/tools/buildbot/bin/python'} 19:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:17:30 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 19:17:30 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 19:17:30 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 19:17:30 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 19:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:17:31 INFO - Installing collected packages: simplejson 19:17:31 INFO - Running setup.py install for simplejson 19:17:31 INFO - building 'simplejson._speedups' extension 19:17:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 19:17:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 19:17:32 INFO - Successfully installed simplejson 19:17:32 INFO - Cleaning up... 19:17:32 INFO - Return code: 0 19:17:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:32 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/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 0x1a351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c00a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:17:32 INFO - Using env: {'DISPLAY': ':0', 19:17:32 INFO - 'HOME': '/home/cltbld', 19:17:32 INFO - 'LANG': 'en_US.UTF-8', 19:17:32 INFO - 'LANGUAGE': 'en_US:en', 19:17:32 INFO - 'LOGNAME': 'cltbld', 19:17:32 INFO - 'MAIL': '/var/mail/cltbld', 19:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:32 INFO - 'MOZ_NO_REMOTE': '1', 19:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:32 INFO - 'NO_EM_RESTART': '1', 19:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:32 INFO - 'PWD': '/builds/slave/test', 19:17:32 INFO - 'SHELL': '/bin/bash', 19:17:32 INFO - 'SHLVL': '1', 19:17:32 INFO - 'TERM': 'linux', 19:17:32 INFO - 'TMOUT': '86400', 19:17:32 INFO - 'USER': 'cltbld', 19:17:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:32 INFO - '_': '/tools/buildbot/bin/python'} 19:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:17:32 INFO - Cleaning up... 19:17:32 INFO - Return code: 0 19:17:32 INFO - Running post-action listener: _resource_record_post_action 19:17:32 INFO - Running post-action listener: _start_resource_monitoring 19:17:32 INFO - Starting resource monitoring. 19:17:32 INFO - [mozharness: 2017-08-24 02:17:32.976735Z] Finished create-virtualenv step (success) 19:17:32 INFO - [mozharness: 2017-08-24 02:17:32.977264Z] Running install step. 19:17:32 INFO - Running pre-action listener: _resource_record_pre_action 19:17:32 INFO - Running main action method: install 19:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:33 INFO - Reading from file tmpfile_stdout 19:17:33 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:17:33 INFO - Reading from file tmpfile_stdout 19:17:33 INFO - Output received: 19:17:33 INFO - Usage: mozinstall [options] installer 19:17:33 INFO - Options: 19:17:33 INFO - -h, --help show this help message and exit 19:17:33 INFO - -d DEST, --destination=DEST 19:17:33 INFO - Directory to install application into. [default: 19:17:33 INFO - "/builds/slave/test"] 19:17:33 INFO - --app=APP Application being installed. [default: firefox] 19:17:33 INFO - mkdir: /builds/slave/test/build/application 19:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:17:50 INFO - Reading from file tmpfile_stdout 19:17:50 INFO - Output received: 19:17:50 INFO - /builds/slave/test/build/application/firefox/firefox 19:17:50 INFO - Running post-action listener: _resource_record_post_action 19:17:50 INFO - [mozharness: 2017-08-24 02:17:50.952879Z] Finished install step (success) 19:17:50 INFO - [mozharness: 2017-08-24 02:17:50.953163Z] Running setup-mitmproxy step. 19:17:50 INFO - Running pre-action listener: _resource_record_pre_action 19:17:50 INFO - Running main action method: setup_mitmproxy 19:17:50 INFO - Skipping: mitmproxy is not required 19:17:50 INFO - Running post-action listener: _resource_record_post_action 19:17:50 INFO - [mozharness: 2017-08-24 02:17:50.954298Z] Finished setup-mitmproxy step (success) 19:17:50 INFO - [mozharness: 2017-08-24 02:17:50.954519Z] Running run-tests step. 19:17:50 INFO - Running pre-action listener: _resource_record_pre_action 19:17:50 INFO - Running pre-action listener: _set_gcov_prefix 19:17:50 INFO - Running main action method: run_tests 19:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:17:50 INFO - Python 2.7.3 19:17:50 INFO - Return code: 0 19:17:50 INFO - grabbing minidump binary from tooltool 19:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da1130>, '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 0x1da2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da24c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:17:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:17:50 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:17:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:17:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:17:51 INFO - Return code: 0 19:17:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:17:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:17:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:17:51 INFO - ENV: RUST_BACKTRACE is now full 19:17:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:17:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:17:51 INFO - Using env: {'DISPLAY': ':0', 19:17:51 INFO - 'HOME': '/home/cltbld', 19:17:51 INFO - 'LANG': 'en_US.UTF-8', 19:17:51 INFO - 'LANGUAGE': 'en_US:en', 19:17:51 INFO - 'LOGNAME': 'cltbld', 19:17:51 INFO - 'MAIL': '/var/mail/cltbld', 19:17:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:17:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:51 INFO - 'MOZ_NO_REMOTE': '1', 19:17:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:51 INFO - 'NO_EM_RESTART': '1', 19:17:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:51 INFO - 'PWD': '/builds/slave/test', 19:17:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:17:51 INFO - 'RUST_BACKTRACE': 'full', 19:17:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:17:51 INFO - 'SHELL': '/bin/bash', 19:17:51 INFO - 'SHLVL': '1', 19:17:51 INFO - 'TERM': 'linux', 19:17:51 INFO - 'TMOUT': '86400', 19:17:51 INFO - 'USER': 'cltbld', 19:17:51 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625', 19:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:51 INFO - '_': '/tools/buildbot/bin/python'} 19:17:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:17:51 INFO - mozversion application_buildid: 20170824010741 19:17:51 INFO - mozversion application_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 19:17:51 INFO - mozversion application_display_name: Nightly 19:17:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:17:51 INFO - mozversion application_name: Firefox 19:17:51 INFO - mozversion application_remotingname: firefox 19:17:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:17:51 INFO - mozversion application_vendor: Mozilla 19:17:51 INFO - mozversion application_version: 57.0a1 19:17:51 INFO - mozversion platform_buildid: 20170824010741 19:17:51 INFO - mozversion platform_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 19:17:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:17:51 INFO - mozversion platform_version: 57.0a1 19:17:51 INFO - using testdate: 1503541071 19:17:51 INFO - actual date: 1503541071 19:17:51 INFO - starting webserver on 'localhost:57282' 19:17:51 INFO - SUITE-START | Running 2 tests 19:17:51 INFO - TEST-START | dromaeo_css 19:17:51 INFO - Initialising browser for dromaeo_css test... 19:17:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57282/getInfo.html -profile /tmp/tmpQWScn2/profile 19:17:51 INFO - TEST-INFO | started process 1148 (/builds/slave/test/build/application/firefox/firefox http://localhost:57282/getInfo.html) 19:17:57 INFO - TEST-INFO | 1148: exit 0 19:17:57 INFO - Browser initialized. 19:17:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:17:57 INFO - TEST-INFO | started process 1434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWScn2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:58 INFO - PID 1434 | 19:17:58 INFO - PID 1434 | (/builds/slave/test/build/application/firefox/firefox:1486): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:17:58 INFO - PID 1434 | 19:17:58 INFO - PID 1434 | 19:17:58 INFO - PID 1434 | (/builds/slave/test/build/application/firefox/firefox:1539): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:17:58 INFO - PID 1434 | 19:17:58 INFO - PID 1434 | __metrics Screen width/height:1600/1200 19:17:58 INFO - PID 1434 | colorDepth:24 19:17:58 INFO - PID 1434 | Browser inner width/height: 1024/768 19:17:58 INFO - PID 1434 | __metrics 19:18:08 INFO - PID 1434 | RSS: Main: 166064128 19:18:08 INFO - PID 1434 | 19:21:06 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57282/tests/dromaeo/cssquery-ext.html) 19:21:07 INFO - PID 1434 | RSS: Main: 169664512 19:21:07 INFO - PID 1434 | 19:24:09 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-ext.html (next: http://localhost:57282/tests/dromaeo/cssquery-jquery.html) 19:24:10 INFO - PID 1434 | RSS: Main: 167079936 19:24:10 INFO - PID 1434 | 19:27:11 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57282/tests/dromaeo/cssquery-mootools.html) 19:27:12 INFO - PID 1434 | RSS: Main: 168841216 19:27:12 INFO - PID 1434 | 19:30:13 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57282/tests/dromaeo/cssquery-prototype.html) 19:30:14 INFO - PID 1434 | RSS: Main: 167329792 19:30:14 INFO - PID 1434 | 19:33:17 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57282/tests/dromaeo/cssquery-yui.html) 19:33:18 INFO - PID 1434 | RSS: Main: 168607744 19:33:18 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | Cycle 1(1): loaded http://localhost:57282/tests/dromaeo/cssquery-yui.html (next: http://localhost:57282/tests/dromaeo/cssquery-dojo.html) 19:36:20 INFO - PID 1434 | RSS: Main: 170483712 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | __start_tp_report 19:36:20 INFO - PID 1434 | _x_x_mozilla_page_load 19:36:20 INFO - PID 1434 | _x_x_mozilla_page_load_details 19:36:20 INFO - PID 1434 | |i|pagename|runs| 19:36:20 INFO - PID 1434 | |0;dojo.html;3833.8466461341563;3856.6336198061185;3865.5168103987003;3898.5321761388636;3900.687944964403;6016.669083200422;6092.908606370903;6115.143879856818;6138;6145.508359331254;6026.789062382817;6060.21217241759;6101.35935726749;6102.11519329697;6197.597156184845;5476.726163691809;5512.118061110224;5520.392756796749;5569.832905012836;5595.048841696921;5351.491608297206;5465.180222966567;5491.176323551459;5588.636738611997;5605.607607467479;5514.172874068881;5548.445155484439;5563;5564.527015203713;5594.160875868612;5352.785888564453;5490.313710786152;5514.393416724157;5583.525400340935;5583.720813959286;5422.6475279106735;5423.186522021689;5432.185172224158;5436.157395603648;5442;6042.6978651067275;6099.3900609938655;6125.264968203844;6133.6626485543275;6136.202293701835;6484.254310754276;6492.383223593751;6614.140161778938;6616.470682345449;6665.766698165589;6520.902186467207;6559.737610495575;6564.212294524687;6611.9338806611795;6628.4697224221945;6170.352113028157;6178.474829639486;6204.689765511752;6208.037754148024;6209.503239740855;6715.93284067153;6717.261101278856;6722.058911752359;6722.899156512656;6796.93203067963;6370.980643097082;6510.772122975768;6573.769918052845;6603.867922641521;6605.603663780189;6563.1796025496815;6589.472842172615;6636.004599310142;6661.766838160641;6680.498962577826;6488.708008139645;6569.80290591283;6572.4084832365315;6572.507061970371;6575.736970521221;6441.3880681335195;6483.935160648333;6495.1556297681;6502.447291980235;6523.11937888379;4848.539388758062;4866.124097662455;4869.610431165498;4874.829380971649;4885.413750349981;4424.955750442518;4470.038941627566;4487.955120448819;4569.680122391467;4571.657125715585;6056.9697151513965;6126.019836826175;6130.019196928559;6136.2636483622255;6137.631742095488;6465.353464653497;6549.705263263165;6643.236027856762;6646.501512386591;6648.13574235356;5918.940810591925;5998.1602575639445;5999.400059993965;6035.124906888476;6128.3565225651555;5323.973380133075;5389.326334208224;5393.406725260218;5405.459454054563;5457.481539253765;6810.795676129724;6818.147731533559;6877.346652068046;6899.75850845218;6909.136357955255;6538.869222615616;6542.803715888626;6558.409743123142;6635.8009259722285;6643.833904152435;6799.558028728117;6820.829479262859;6880.827979300558;6896.551724137915;6901.102856628606;6564.081028655896;6572.441342485942;6601.768938087336;6606.141201643755;6607.240167380813;6534.803955881332;6618.271990080991;6695.12963314766;6700.061991321121;6708.127943367331;6342.175517182736;6432.035194720829;6433.839154021187;6434.806955791334;6435.51733619971;6306.684665766602;6376.776812811715;6380.3619638035825;6382.808515744535;6383.265924418565;6318.84202894913;6321.683915804283;6322.968385158045;6337.96831015842;6402.199725034371;6401.327860574573;6424.325445828121;6427.710753016219;6448.709808058742;6493.902591461227;6245.125682404558;6280.183576135073;6338.556301058881;6342.841428964312;6356.491480681442 19:36:20 INFO - PID 1434 | |1;ext.html;867.8326322780608;912.2701838529175;946.1390134977172;963.1379914976096;967.8499832525961;38524.422133667984;39964.80017599915;40239.19521609566;40327.991800204974;40425.3936190957;37601.435978460344;37795.81102094492;37937.430938535945;38167.61832381675;38232.42651360225;7079.539829911065;7173.85652286954;7179.820504487378;7199.1001124859395;7200.747973820918;7066.7173313067415;7147.821304467378;7174.03150574671;7179.605121718303;7180.461465390091;7125.572465652078;7128.322809333105;7129.643517824114;7161.176464706573;7164.749233776819;7108.289171082876;7108.857822843514;7138.785836424916;7138.8572228555395;7141.321574450419;6541.149650545446;6593.406593406568;6593.80218593443;6604.306547812458;6606.174228221473;34720.305593887984;34761.826190869135;35054.47418288728;35108.893466392095;35161.12097197565;3366.2257680733323;3389.2882494676146;3407.795532268072;3424.828758562062;3432.1762776933356;27990.860045699847;27994;28004.29989250285;28075.43849123006;28099;4669.299605059235;4686.133065382915;4686.437627484724;4686.601638860701;4725.173094708447;188702;188724;191395;191834;207631.96184019133;50072;50276.748616256686;50403.495965040616;50434;50466;52485.73757131266;52559;52584.21123683148;52612;52658.473415265355;15581.532554023397;15624.3750249991;15700.136492492795;15722.921385393;15809.367625294859;12884.677883052998;12972.80540791889;12978.480860765652;12984.415701293465;13012.934935325262;13112.672183195305;13133.802992955114;13134.080614356903;13216.339183040809;13220.677932206703;5235.240890070919;5256.789728410898;5339.813106541253;5397.9460205397445;5408.513233808976;1020.9591616335412;1032.8140934631838;1041.2815157541272;1050.753073027838;1055.8944105589533;30025.849870750506;30040.54939175914;30388.392232155675;30465.543016854765;30868.382632347228;1127.334872425273;1129.8587676540433;1138.7437826488974;1146.3122126724065;1148.8965993060497;12504.676906806091;12952.158109723026;13022.023348248918;13037.543685970946;13066.673333166556;265472;265706;266078;266494;266824;51639.48360516422;51810.22284665733;51837;51856.22215666768;51915;1469.0965056490181;1470.191394732914;1491.3512622009462;1492.7238460884555;1510.4939845151998;22668.773312266665;22694.432639184153;22735.65896511587;23009.65485517752;23035;38449.6155038446;38534.42198367083;38540;38545.807270963465;38552.80723596364;164562;165045;165327;165633;165760;32874.342513150084;33080.66919330776;35266.647333526336;35742.46386304156;35986.28027439489;46274.30588541242;46738.766306168254;46951.765241173576;47152.29271560861;47625.285620715025;34567.654323456445;34618.30763384668;34706.132346691535;34817.825910870284;34976.475352870235;34515.48226776651;34549.827250863586;34553.136171595914;34700.47949280712;35329.82335088308;37186.44220336643;38214.23571528609;38324.233515330096;38494.230115396975;38532.80733596314;33721.49417758785;33756.3248735019;33932;34035.319293614484;34110.147246319044;24997.750022499542;25098.874505627355;25176.49647007013;25581.616275756252;25879.0942317018 19:36:20 INFO - PID 1434 | |2;jquery.html;551.3549147497428;569.3509399284814;570.4124751505949;575.6085861614104;588.7350692188514;22155;23207.883960580195;23212.72330021848;23224.071037158537;23225.535489290225;22444.214452494165;22682.54634907305;22839.31482055537;22947.655785163235;22972.65541016882;6452.0321951707265;6575.736970521173;6579.210494740638;6579.671016449182;6600.9339906601035;6225.377462253784;6486.772962946297;6489.643069631168;6493;6545.312742162076;6459.354064593526;6469.967650161742;6471.870562588745;6474.74101035958;6475.125858009179;6471.546991710582;6480.805575832733;6480.870382592322;6484.4164025237715;6485.383888530582;5991.460768530809;6009.969950150265;6021.969890150565;6029.065494848305;6031.1254868044325;29610.25974350637;30601.69398306033;30667.386652267054;30802.38395232105;31172.064838054666;2137.348108826807;2166.599179151862;2167.4906396996694;2169.5227050048966;2173.608750424923;18978.90510547452;19657.606847862964;19691.704624430644;19709.310174143837;19811.702824457643;2340.0639744102323;2341.461463863304;2387;2390.0439824070336;2390.2351247600773;165156;171423;171453;171644;171670;15970.60073498172;16251.918740406223;16335.509934701979;16563.751543726852;16655;24810.751892480843;24907;24909.750902490745;24958.750412496007;24974.625380619305;10139.543720532594;10797.514111864984;10896.727581810359;11004;11008.954149355799;9938.652147174958;10006.048215776218;10066.295359324924;10090.09189172978;10224.64213752515;9901.15840153595;10149.847752283722;10216;10308.278420510493;10346.482675866177;2926.897558585439;2965.1252880400334;2974.940501189964;3008.9247768805517;3095.1797773590015;987.3532835992437;993.2401712689798;997.1474389397106;1022.831232846572;1030.6547306652355;21473.355799326044;21580.244691436037;21585.35243942653;21653.242136525147;21936.670949935764;1066.8186408310605;1072.9141668666489;1083.3012706804225;1086.4296244471716;1088.1947358954317;11867.287962722265;11989.76020479603;11998.280103193836;12063.396830158457;12093.818592721116;595235;601375;605766;622169;623247;132823;137119;140364.29817850844;140564.2971785155;141764;1197.736497970445;1249.4564864283884;1280.0847394113255;1298.8311519502404;1338.5382043194888;22187;22189.445263868532;22518;22598;22837.429064273525;63140.36859631529;63265.36734632595;64019.35980640134;64943;65066;81006.5949670248;83949;84743;86052.56973715092;86473;15360.155191464577;15723.213839308217;15754;15821.683566328378;15821.683566328838;24784.132555361197;24807.62788558137;24904.62643060319;25070;25428.110016149345;19563.217471300988;19691.901540492207;19863.702044469057;19963.800361996775;19964.10161542705;16219.837801621832;16312.918435407748;16425.67148657044;16603.086830224453;16635.83364166343;19390.4182874514;19501.219951201794;20403.897980510003;20454.48863778358;20572.897135514228;15449.382024718885;15478.148701821508;15640.843591563938;15669.373225070869;15715.057096573784;19097.904510477914;19123.713144303125;19167.424977250706;19247.13387897576;19870.801291987475 19:36:20 INFO - PID 1434 | |3;mootools.html;1416.5608661314993;1465.567657541026;1469.8824094072475;1488.4418343121329;1494.9626259343515;15741.763873541906;16359.345626174969;16398.26207820648;16432.342706291747;16433.17834108296;15246.466373676923;16542.83457165428;16553.751693724604;16557.66884662306;16568.088755118464;2692.569188929772;2747.203311039806;2757;2758.0622588319966;2758.0760445250867;2645.642838216835;2650.0857204264594;2735.4939336222765;2737.110439107288;2751.2434080627886;2739.931501712453;2766.4190519990825;2777.5833624956217;2780.5134101532253;2785.4011387551673;2650.112212408845;2651.323912402335;2651.6817981842205;2653.535631264531;2674.826136301154;2515.4843257132425;2528.9747102528922;2547.4905018996274;2549.974500254992;2551;15322;15584.532464025984;16005.039697618064;16005.359785608562;16065.116418596972;7675.424343174229;7890;7936.563489008102;7939.206079392073;7946.404019698488;5077.949220507785;5235.73821308933;5306.177542480922;5340.893182136374;5362.276092727471;1981.1877130376477;2013.9597208055902;2042.2954080842235;2084.4049158797393;2099.9475013124793;26659.73340266592;26683;26705.599416008776;26708.866455667598;27011.45977080467;6643.900341494881;6767.560108592926;6795.286494917962;6944.756933507303;6969.721211151497;17994.730079048826;18001.18994645244;18014.729779053323;18135.818641813676;18143.18355673998;7902.525848449111;7929.881051784228;7956.761297161094;8021.679132834738;8054.355651547862;7247.601381924045;7286.526375785557;7383.556986580715;7421.146568144733;7464.216257293015;4902.509749025069;5065.164247899129;5318.149096144598;5505.752241149158;5512.173174023848;1480.8148981377328;1529.747591647388;1535.9385624574893;1548.5753107141456;1561.1647768444054;963.2486660404895;981.2689546287918;981.3817295104182;1000.7798284377425;1013.2704452793977;9089.727308180632;9139.49732764691;9263;9397.953010234905;9429.575669094907;1042.5725452564411;1051.2010871737382;1058.9523471443804;1064.510325250378;1076.6985244131656;5494.532964697965;5852.912206316909;5867.70661466925;5878.147668588031;6012.128241405059;23285.41786455352;23358.532829343658;23754.524909501713;23942;23996.52006959851;23250.41873953131;23368.415789605056;23395.41511462193;23397;23404.18085367004;11019.669409917715;11390.658280251606;11454.828177577343;11548;11564.42177891102;9107.324567529502;9196.402233855046;9237.861432078658;9268.675596354095;9377.531123443665;19033.524161895508;19583.510412239808;19680.704789427884;20124;20343.4914127148;20703.309604469567;20774.1690332385;20926.68609970821;21199;21723;11671.649850504498;11747.882521174679;11931;11956.641300760992;11957.820632690342;12792.808107878203;13095.476180952655;14591.124532528082;14864.256787160815;14869.033512821632;11905.761884762429;12092.516299347928;12222.327771972627;12358.196717213352;12540.122191446511;11038.779224415628;11057.557697692002;11328.886711132784;11470.369129697612;11715.765684686088;10576.101031412416;10785.191110666574;10795;10795.6221532246;10840.891591083988;8108.432409731262;8199.139090395662;8205.79485512867;8214.876776848472;8276.710315138942;8411.158884111539;8476.533790641573;8525.317974562144;8582.399232053696;8695.913040869511 19:36:20 INFO - PID 1434 | |4;prototype.html;507.0669967260243;540.3866611396064;540.7809837016009;543.1743749500758;550.6943646276316;6015.398460153982;6084.908726369103;6129.295131059929;6172.290186628539;6195.349488303726;6037.305709843369;6053.182820319266;6145.033589251441;6170.413810687977;6173.197484327043;5046.7224302663335;5048.419431765348;5075.873103172432;5115.4884511548735;5115.9488405116035;4695.248760198369;4842.394700662418;4996.125678006352;5034.798608055673;5043.546080852722;4810.158222311099;4845.563899249067;4848.345473361104;4866.610671146317;4866.926996095061;4823;4825.927611085819;4856.902861942759;4861.975690121562;4871.196252618313;4274.508431530352;4351.760653164075;4356.6514678825615;4385.342198670193;4443.688941774077;5866.208061911672;5889.320359236537;5890.617109887887;5949.9702501487645;5995.880082398371;5578.553715702734;5595.552355811526;5600.5799565032785;5659.660420374791;5669.659820410789;6291.213598300213;6337.827501912115;6382.936170638327;6444.323346048644;6457.773977910751;4833.347498087784;4856.781444834991;4863.951360486385;4882.707037577757;4893.339399181101;6444.484441244689;6464.288928217892;6493.805185844432;6570.835729106763;6615.239247486505;4955.1823949048;4962.627802914796;4986.55121039101;5003.3495645565845;5024.371953505812;5028.974855125701;5064.417591976896;5074.213496907912;5079.720615366116;5096.210087436453;5619.297587801525;5620.803271885465;5655.915161272585;5677;5697.800576979786;6357.141785858942;6363.395477429637;6428.19647544057;6428.8071357859335;6442.194725659293;1743.8430541251093;1747.851432628241;1752.1952389039309;1767.6641438126715;1772.7429522719392;1194.898433633151;1227.5212667059855;1242.167747609104;1244.6433387607551;1252.405107573895;5982.414660115073;6000.409891378788;6022.939770602326;6066.4540191382985;6081.726322315506;6458.192725909262;6466.385693359123;6481.708323125471;6587.484878477977;6588.308227636125;5919.437653422918;5944.286685597756;5962.791302304398;6030.366811484819;6101.328853826076;3364.411228035084;3376.062825341919;3429.3141371725756;3479.356319080978;3522.894313170609;6452.967735161388;6641.369069938348;6644.269130395653;6728.730850766013;6789.456843452512;6632.535722499379;6647.002949557508;6653.733850646016;6689.76585819494;6831.726730930806;6664.166979127609;6747.291534388818;6761.72953081881;6857.177138743283;6895.482838787011;6406.199225096863;6451.3226111257645;6475.384838440341;6537.150170477998;6578.473722102125;6338.714757836001;6383.457406120532;6476.319986401549;6511.2512061113575;6555.573887697285;6727.697253623501;6863.416609588241;6877.698704621709;6882.311768823078;6895.34494223048;4958.7024778513405;5000.899982000413;5028.371453568304;5045.369328833895;5059.5952323814745;6266.749330026931;6325.501426936243;6524.836879078061;6536.202544300165;6586.739563915892;6235.407636274728;6274.278457977391;6308.589941653778;6339.651319177489;6347.270063942706;6224.37756224374;6279.623222606659;6279.71741271653;6285.214348206474;6351.174347334817;6273.843153921006;6284.8428789278805;6313.96843015782;6315.842103947438;6319.6208227506495;6363.96818015907;6379.298277189413;6392.232932048184;6417.1657684500715;6418.903716444163;6182.165407669907;6234.906476402948;6235.3452887446165;6264.404881536247;6265.27949285838 19:36:20 INFO - PID 1434 | |5;yui.html;939.7556635274827;942.4863449420066;963.0562049191792;966.3041362408972;967.1247520993495;15617.375304987787;16077.919610401947;16080.356785728556;16109.597260068489;18767.43697689068;19948.900255498702;19972.901490418022;19997.800021999774;20021.099050542725;20032.59934801303;986.3243678080502;1082.2370228988543;1086.3536195963388;1088.6026600290916;1088.7659153282043;1080.2924084724518;1081.5349399758102;1082.112667612558;1082.193765644596;1083.2309060567006;1071.6624263357019;1111.8776934537195;1112.671761830262;1112.9165312601588;1118.0440723181684;1097.8517900083466;1098.906592939601;1099.164634877491;1099.598646494028;1100.944952752359;807.1363640904235;807.386386346381;807.5356669914822;807.6244546286006;807.7657479330987;17298.135093245288;17298.394556190473;17364.305427782874;17376.131193440277;17773.7333939991;19792.60414791696;20204.79795202044;20218.090185941666;20305.898470507702;20605.79394206069;17097.658046838995;17552.473425797245;17578.91210543952;17600.735988960176;17621.207045682975;3779.357509223411;3827.827747751358;3829.7702137871815;3831.1954489557224;3832.559255685604;129441;135943;138586;140117;145293.27353363272;16211.594710132342;16974.830251697324;17020.914895425445;17113.572160695832;17406.303747849943;30724.53913191304;30949.84525077405;30956.69043309538;30985.380292394027;31057.0682879514;8145.5927203639585;8270.875936860952;8678.088800675965;8741.213290803858;8741.956290218508;4564.0871825635;4723.291506274087;4728.101660684528;4730.88172795676;4741.5021422750115;5350.411454739976;5388.110961691277;5396.109641909119;5489.533389661923;5519.613627046068;1085.4464223246202;1093.9781204375868;1094.9835752463719;1104.1994553948323;1107.6400169944638;702.3187508117118;718.0952000479433;721.1778572427437;731.1591669580025;750.782273140794;11857.407129643483;13196.60410187696;13272.270025148517;13806.86193138076;13877;709.8580283943129;712.0138608027816;724.279342054659;724.431321412699;733.1165945036325;6097.176881120992;6122.602030867979;6161.599496032743;6200.255969283715;6313.273973493016;131703;132712.3364383172;133057;133761;134807;113205;115695;115707.67623501453;116305.41847290879;120126;100955.49522252342;103317;105962;106250.46874765577;107337.46331268294;12605.243685378906;12820.679483013;12896.29070401137;12915.483380665044;13039.674008149872;49507;50220;50408;51394;52813.47186528086;87113;87747.12252877645;89993.55003224942;90619.54690226507;92852.53573732088;18736.25054997785;18837.15232814554;18896.52758681044;19093.522661933563;19363.612727745647;20602.381928542167;20814.895925520883;21070.78929210688;21553.03011364461;21653;19035.524111897314;19045.71431428502;19247.32634357847;19294.8070519293;19325.13036913314;18644;19114.713279300544;19254.149170165743;19352.70970935465;19742.70385944241;17161.914190428968;17473.12634368302;17476.650466990333;18919.148638311584;19420.805791942465;13301.201927884358;13338.399772010089;13605.455781768618;13623.114497557626;13963.93018034944;13357.866421336052;13464;13472.932635336761;13481.2585307809;13534.390952406968 19:36:20 INFO - PID 1434 | __end_tp_report 19:36:20 INFO - PID 1434 | __start_cc_report 19:36:20 INFO - PID 1434 | _x_x_mozilla_cycle_collect,344 19:36:20 INFO - PID 1434 | __end_cc_report 19:36:20 INFO - PID 1434 | __startTimestamp1503542180275__endTimestamp 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | ------- Summary: start ------- 19:36:20 INFO - PID 1434 | Number of tests: 6 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#0] dojo.html Cycles:165 Average:6088.04 Median:6338.56 stddev:690.49 (10.9%) stddev-sans-first:669.58 19:36:20 INFO - PID 1434 | Values: 3833.8 3856.6 3865.5 3898.5 3900.7 6016.7 6092.9 6115.1 6138.0 6145.5 6026.8 6060.2 6101.4 6102.1 6197.6 5476.7 5512.1 5520.4 5569.8 5595.0 5351.5 5465.2 5491.2 5588.6 5605.6 5514.2 5548.4 5563.0 5564.5 5594.2 5352.8 5490.3 5514.4 5583.5 5583.7 5422.6 5423.2 5432.2 5436.2 5442.0 6042.7 6099.4 6125.3 6133.7 6136.2 6484.3 6492.4 6614.1 6616.5 6665.8 6520.9 6559.7 6564.2 6611.9 6628.5 6170.4 6178.5 6204.7 6208.0 6209.5 6715.9 6717.3 6722.1 6722.9 6796.9 6371.0 6510.8 6573.8 6603.9 6605.6 6563.2 6589.5 6636.0 6661.8 6680.5 6488.7 6569.8 6572.4 6572.5 6575.7 6441.4 6483.9 6495.2 6502.4 6523.1 4848.5 4866.1 4869.6 4874.8 4885.4 4425.0 4470.0 4488.0 4569.7 4571.7 6057.0 6126.0 6130.0 6136.3 6137.6 6465.4 6549.7 6643.2 6646.5 6648.1 5918.9 5998.2 5999.4 6035.1 6128.4 5324.0 5389.3 5393.4 5405.5 5457.5 6810.8 6818.1 6877.3 6899.8 6909.1 6538.9 6542.8 6558.4 6635.8 6643.8 6799.6 6820.8 6880.8 6896.6 6901.1 6564.1 6572.4 6601.8 6606.1 6607.2 6534.8 6618.3 6695.1 6700.1 6708.1 6342.2 6432.0 6433.8 6434.8 6435.5 6306.7 6376.8 6380.4 6382.8 6383.3 6318.8 6321.7 6323.0 6338.0 6402.2 6401.3 6424.3 6427.7 6448.7 6493.9 6245.1 6280.2 6338.6 6342.8 6356.5 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#1] ext.html Cycles:180 Average:38018.02 Median:34789.83 stddev:55364.11 (159.1%) stddev-sans-first:55449.15 19:36:20 INFO - PID 1434 | Values: 867.8 912.3 946.1 963.1 967.8 38524.4 39964.8 40239.2 40328.0 40425.4 37601.4 37795.8 37937.4 38167.6 38232.4 7079.5 7173.9 7179.8 7199.1 7200.7 7066.7 7147.8 7174.0 7179.6 7180.5 7125.6 7128.3 7129.6 7161.2 7164.7 7108.3 7108.9 7138.8 7138.9 7141.3 6541.1 6593.4 6593.8 6604.3 6606.2 34720.3 34761.8 35054.5 35108.9 35161.1 3366.2 3389.3 3407.8 3424.8 3432.2 27990.9 27994.0 28004.3 28075.4 28099.0 4669.3 4686.1 4686.4 4686.6 4725.2 188702.0 188724.0 191395.0 191834.0 207632.0 50072.0 50276.7 50403.5 50434.0 50466.0 52485.7 52559.0 52584.2 52612.0 52658.5 15581.5 15624.4 15700.1 15722.9 15809.4 12884.7 12972.8 12978.5 12984.4 13012.9 13112.7 13133.8 13134.1 13216.3 13220.7 5235.2 5256.8 5339.8 5397.9 5408.5 1021.0 1032.8 1041.3 1050.8 1055.9 30025.8 30040.5 30388.4 30465.5 30868.4 1127.3 1129.9 1138.7 1146.3 1148.9 12504.7 12952.2 13022.0 13037.5 13066.7 265472.0 265706.0 266078.0 266494.0 266824.0 51639.5 51810.2 51837.0 51856.2 51915.0 1469.1 1470.2 1491.4 1492.7 1510.5 22668.8 22694.4 22735.7 23009.7 23035.0 38449.6 38534.4 38540.0 38545.8 38552.8 164562.0 165045.0 165327.0 165633.0 165760.0 32874.3 33080.7 35266.6 35742.5 35986.3 46274.3 46738.8 46951.8 47152.3 47625.3 34567.7 34618.3 34706.1 34817.8 34976.5 34515.5 34549.8 34553.1 34700.5 35329.8 37186.4 38214.2 38324.2 38494.2 38532.8 33721.5 33756.3 33932.0 34035.3 34110.1 24997.8 25098.9 25176.5 25581.6 25879.1 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#2] jquery.html Cycles:180 Average:40737.22 Median:22171.00 stddev:102872.12 (464.0%) stddev-sans-first:103116.46 19:36:20 INFO - PID 1434 | Values: 551.4 569.4 570.4 575.6 588.7 22155.0 23207.9 23212.7 23224.1 23225.5 22444.2 22682.5 22839.3 22947.7 22972.7 6452.0 6575.7 6579.2 6579.7 6600.9 6225.4 6486.8 6489.6 6493.0 6545.3 6459.4 6470.0 6471.9 6474.7 6475.1 6471.5 6480.8 6480.9 6484.4 6485.4 5991.5 6010.0 6022.0 6029.1 6031.1 29610.3 30601.7 30667.4 30802.4 31172.1 2137.3 2166.6 2167.5 2169.5 2173.6 18978.9 19657.6 19691.7 19709.3 19811.7 2340.1 2341.5 2387.0 2390.0 2390.2 165156.0 171423.0 171453.0 171644.0 171670.0 15970.6 16251.9 16335.5 16563.8 16655.0 24810.8 24907.0 24909.8 24958.8 24974.6 10139.5 10797.5 10896.7 11004.0 11009.0 9938.7 10006.0 10066.3 10090.1 10224.6 9901.2 10149.8 10216.0 10308.3 10346.5 2926.9 2965.1 2974.9 3008.9 3095.2 987.4 993.2 997.1 1022.8 1030.7 21473.4 21580.2 21585.4 21653.2 21936.7 1066.8 1072.9 1083.3 1086.4 1088.2 11867.3 11989.8 11998.3 12063.4 12093.8 595235.0 601375.0 605766.0 622169.0 623247.0 132823.0 137119.0 140364.3 140564.3 141764.0 1197.7 1249.5 1280.1 1298.8 1338.5 22187.0 22189.4 22518.0 22598.0 22837.4 63140.4 63265.4 64019.4 64943.0 65066.0 81006.6 83949.0 84743.0 86052.6 86473.0 15360.2 15723.2 15754.0 15821.7 15821.7 24784.1 24807.6 24904.6 25070.0 25428.1 19563.2 19691.9 19863.7 19963.8 19964.1 16219.8 16312.9 16425.7 16603.1 16635.8 19390.4 19501.2 20403.9 20454.5 20572.9 15449.4 15478.1 15640.8 15669.4 15715.1 19097.9 19123.7 19167.4 19247.1 19870.8 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#3] mootools.html Cycles:180 Average:9853.96 Median:23969.26 stddev:7096.05 (29.6%) stddev-sans-first:7087.64 19:36:20 INFO - PID 1434 | Values: 1416.6 1465.6 1469.9 1488.4 1495.0 15741.8 16359.3 16398.3 16432.3 16433.2 15246.5 16542.8 16553.8 16557.7 16568.1 2692.6 2747.2 2757.0 2758.1 2758.1 2645.6 2650.1 2735.5 2737.1 2751.2 2739.9 2766.4 2777.6 2780.5 2785.4 2650.1 2651.3 2651.7 2653.5 2674.8 2515.5 2529.0 2547.5 2550.0 2551.0 15322.0 15584.5 16005.0 16005.4 16065.1 7675.4 7890.0 7936.6 7939.2 7946.4 5077.9 5235.7 5306.2 5340.9 5362.3 1981.2 2014.0 2042.3 2084.4 2099.9 26659.7 26683.0 26705.6 26708.9 27011.5 6643.9 6767.6 6795.3 6944.8 6969.7 17994.7 18001.2 18014.7 18135.8 18143.2 7902.5 7929.9 7956.8 8021.7 8054.4 7247.6 7286.5 7383.6 7421.1 7464.2 4902.5 5065.2 5318.1 5505.8 5512.2 1480.8 1529.7 1535.9 1548.6 1561.2 963.2 981.3 981.4 1000.8 1013.3 9089.7 9139.5 9263.0 9398.0 9429.6 1042.6 1051.2 1059.0 1064.5 1076.7 5494.5 5852.9 5867.7 5878.1 6012.1 23285.4 23358.5 23754.5 23942.0 23996.5 23250.4 23368.4 23395.4 23397.0 23404.2 11019.7 11390.7 11454.8 11548.0 11564.4 9107.3 9196.4 9237.9 9268.7 9377.5 19033.5 19583.5 19680.7 20124.0 20343.5 20703.3 20774.2 20926.7 21199.0 21723.0 11671.6 11747.9 11931.0 11956.6 11957.8 12792.8 13095.5 14591.1 14864.3 14869.0 11905.8 12092.5 12222.3 12358.2 12540.1 11038.8 11057.6 11328.9 11470.4 11715.8 10576.1 10785.2 10795.0 10795.6 10840.9 8108.4 8199.1 8205.8 8214.9 8276.7 8411.2 8476.5 8525.3 8582.4 8695.9 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#4] prototype.html Cycles:180 Average:5447.70 Median:6074.09 stddev:1516.19 (25.0%) stddev-sans-first:1474.40 19:36:20 INFO - PID 1434 | Values: 507.1 540.4 540.8 543.2 550.7 6015.4 6084.9 6129.3 6172.3 6195.3 6037.3 6053.2 6145.0 6170.4 6173.2 5046.7 5048.4 5075.9 5115.5 5115.9 4695.2 4842.4 4996.1 5034.8 5043.5 4810.2 4845.6 4848.3 4866.6 4866.9 4823.0 4825.9 4856.9 4862.0 4871.2 4274.5 4351.8 4356.7 4385.3 4443.7 5866.2 5889.3 5890.6 5950.0 5995.9 5578.6 5595.6 5600.6 5659.7 5669.7 6291.2 6337.8 6382.9 6444.3 6457.8 4833.3 4856.8 4864.0 4882.7 4893.3 6444.5 6464.3 6493.8 6570.8 6615.2 4955.2 4962.6 4986.6 5003.3 5024.4 5029.0 5064.4 5074.2 5079.7 5096.2 5619.3 5620.8 5655.9 5677.0 5697.8 6357.1 6363.4 6428.2 6428.8 6442.2 1743.8 1747.9 1752.2 1767.7 1772.7 1194.9 1227.5 1242.2 1244.6 1252.4 5982.4 6000.4 6022.9 6066.5 6081.7 6458.2 6466.4 6481.7 6587.5 6588.3 5919.4 5944.3 5962.8 6030.4 6101.3 3364.4 3376.1 3429.3 3479.4 3522.9 6453.0 6641.4 6644.3 6728.7 6789.5 6632.5 6647.0 6653.7 6689.8 6831.7 6664.2 6747.3 6761.7 6857.2 6895.5 6406.2 6451.3 6475.4 6537.2 6578.5 6338.7 6383.5 6476.3 6511.3 6555.6 6727.7 6863.4 6877.7 6882.3 6895.3 4958.7 5000.9 5028.4 5045.4 5059.6 6266.7 6325.5 6524.8 6536.2 6586.7 6235.4 6274.3 6308.6 6339.7 6347.3 6224.4 6279.6 6279.7 6285.2 6351.2 6273.8 6284.8 6314.0 6315.8 6319.6 6364.0 6379.3 6392.2 6417.2 6418.9 6182.2 6234.9 6235.3 6264.4 6265.3 19:36:20 INFO - PID 1434 | 19:36:20 INFO - PID 1434 | [#5] yui.html Cycles:180 Average:26642.92 Median:18907.84 stddev:38131.19 (201.7%) stddev-sans-first:38189.32 19:36:20 INFO - PID 1434 | Values: 939.8 942.5 963.1 966.3 967.1 15617.4 16077.9 16080.4 16109.6 18767.4 19948.9 19972.9 19997.8 20021.1 20032.6 986.3 1082.2 1086.4 1088.6 1088.8 1080.3 1081.5 1082.1 1082.2 1083.2 1071.7 1111.9 1112.7 1112.9 1118.0 1097.9 1098.9 1099.2 1099.6 1100.9 807.1 807.4 807.5 807.6 807.8 17298.1 17298.4 17364.3 17376.1 17773.7 19792.6 20204.8 20218.1 20305.9 20605.8 17097.7 17552.5 17578.9 17600.7 17621.2 3779.4 3827.8 3829.8 3831.2 3832.6 129441.0 135943.0 138586.0 140117.0 145293.3 16211.6 16974.8 17020.9 17113.6 17406.3 30724.5 30949.8 30956.7 30985.4 31057.1 8145.6 8270.9 8678.1 8741.2 8742.0 4564.1 4723.3 4728.1 4730.9 4741.5 5350.4 5388.1 5396.1 5489.5 5519.6 1085.4 1094.0 1095.0 1104.2 1107.6 702.3 718.1 721.2 731.2 750.8 11857.4 13196.6 13272.3 13806.9 13877.0 709.9 712.0 724.3 724.4 733.1 6097.2 6122.6 6161.6 6200.3 6313.3 131703.0 132712.3 133057.0 133761.0 134807.0 113205.0 115695.0 115707.7 116305.4 120126.0 100955.5 103317.0 105962.0 106250.5 107337.5 12605.2 12820.7 12896.3 12915.5 13039.7 49507.0 50220.0 50408.0 51394.0 52813.5 87113.0 87747.1 89993.6 90619.5 92852.5 18736.3 18837.2 18896.5 19093.5 19363.6 20602.4 20814.9 21070.8 21553.0 21653.0 19035.5 19045.7 19247.3 19294.8 19325.1 18644.0 19114.7 19254.1 19352.7 19742.7 17161.9 17473.1 17476.7 18919.1 19420.8 13301.2 13338.4 13605.5 13623.1 13963.9 13357.9 13464.0 13472.9 13481.3 13534.4 19:36:20 INFO - PID 1434 | -------- Summary: end -------- 19:36:20 INFO - PID 1434 | 19:36:20 INFO - TEST-INFO | 1434: exit 0 19:36:21 INFO - TEST-OK | dromaeo_css | took 1109683ms 19:36:21 INFO - TEST-START | kraken 19:36:21 INFO - Initialising browser for kraken test... 19:36:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57282/getInfo.html -profile /tmp/tmpnE3kJ3/profile 19:36:21 INFO - TEST-INFO | started process 1842 (/builds/slave/test/build/application/firefox/firefox http://localhost:57282/getInfo.html) 19:36:26 INFO - TEST-INFO | 1842: exit 0 19:36:26 INFO - Browser initialized. 19:36:26 INFO - Running cycle 1/1 for kraken test... 19:36:26 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnE3kJ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:36:27 INFO - PID 2015 | 19:36:27 INFO - PID 2015 | (/builds/slave/test/build/application/firefox/firefox:2068): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:36:27 INFO - PID 2015 | 19:36:28 INFO - PID 2015 | 19:36:28 INFO - PID 2015 | (/builds/slave/test/build/application/firefox/firefox:2125): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:36:28 INFO - PID 2015 | 19:36:28 INFO - PID 2015 | __metrics Screen width/height:1600/1200 19:36:28 INFO - PID 2015 | colorDepth:24 19:36:28 INFO - PID 2015 | Browser inner width/height: 1024/768 19:36:28 INFO - PID 2015 | __metrics 19:36:37 INFO - PID 2015 | RSS: Main: 166051840 19:36:37 INFO - PID 2015 | 19:36:40 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57282/tests/kraken/driver.html?testName=audio-beat-detection) 19:36:41 INFO - PID 2015 | RSS: Main: 170024960 19:36:41 INFO - PID 2015 | 19:36:43 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57282/tests/kraken/driver.html?testName=audio-dft) 19:36:44 INFO - PID 2015 | RSS: Main: 172744704 19:36:44 INFO - PID 2015 | 19:36:47 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57282/tests/kraken/driver.html?testName=audio-fft) 19:36:47 INFO - PID 2015 | RSS: Main: 166064128 19:36:47 INFO - PID 2015 | 19:36:50 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57282/tests/kraken/driver.html?testName=audio-oscillator) 19:36:50 INFO - PID 2015 | RSS: Main: 166748160 19:36:50 INFO - PID 2015 | 19:36:52 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:36:53 INFO - PID 2015 | RSS: Main: 167075840 19:36:53 INFO - PID 2015 | 19:36:56 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57282/tests/kraken/driver.html?testName=imaging-darkroom) 19:36:57 INFO - PID 2015 | RSS: Main: 167133184 19:36:57 INFO - PID 2015 | 19:37:00 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57282/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:01 INFO - PID 2015 | RSS: Main: 170737664 19:37:01 INFO - PID 2015 | 19:37:03 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57282/tests/kraken/driver.html?testName=json-parse-financial) 19:37:04 INFO - PID 2015 | RSS: Main: 169406464 19:37:04 INFO - PID 2015 | 19:37:05 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:06 INFO - PID 2015 | RSS: Main: 169295872 19:37:06 INFO - PID 2015 | 19:37:08 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:08 INFO - PID 2015 | RSS: Main: 169074688 19:37:08 INFO - PID 2015 | 19:37:10 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:11 INFO - PID 2015 | RSS: Main: 169271296 19:37:11 INFO - PID 2015 | 19:37:14 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:14 INFO - PID 2015 | RSS: Main: 169123840 19:37:14 INFO - PID 2015 | 19:37:17 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:18 INFO - PID 2015 | RSS: Main: 169795584 19:37:18 INFO - PID 2015 | 19:37:19 INFO - PID 2015 | Cycle 1(1): loaded http://localhost:57282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57282/tests/kraken/driver.html?testName=ai-astar) 19:37:20 INFO - PID 2015 | RSS: Main: 171581440 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | __start_tp_report 19:37:20 INFO - PID 2015 | _x_x_mozilla_page_load 19:37:20 INFO - PID 2015 | _x_x_mozilla_page_load_details 19:37:20 INFO - PID 2015 | |i|pagename|runs| 19:37:20 INFO - PID 2015 | |0;ai-astar;100;106;99;106;107;107;108;98;113;109 19:37:20 INFO - PID 2015 | |1;audio-beat-detection;144;112;147;172;115;147;141;115;168;116 19:37:20 INFO - PID 2015 | |2;audio-dft;162;163;163;163;163;162;162;162;166;170 19:37:20 INFO - PID 2015 | |3;audio-fft;76;73;74;157;73;75;73;89;99;73 19:37:20 INFO - PID 2015 | |4;audio-oscillator;79;79;131;79;78;82;135;78;78;127 19:37:20 INFO - PID 2015 | |5;imaging-gaussian-blur;114;117;113;116;115;115;114;113;117;116 19:37:20 INFO - PID 2015 | |6;imaging-darkroom;149;152;149;150;149;152;152;152;150;151 19:37:20 INFO - PID 2015 | |7;imaging-desaturate;99;96;95;95;95;99;94;94;99;95 19:37:20 INFO - PID 2015 | |8;json-parse-financial;48;47;48;45;46;50;55;45;45;45 19:37:20 INFO - PID 2015 | |9;json-stringify-tinderbox;51;51;57;52;52;51;52;55;51;51 19:37:20 INFO - PID 2015 | |10;stanford-crypto-aes;74;73;79;74;72;74;74;72;73;74 19:37:20 INFO - PID 2015 | |11;stanford-crypto-ccm;114;121;112;113;114;116;120;118;123;159 19:37:20 INFO - PID 2015 | |12;stanford-crypto-pbkdf2;166;163;163;164;167;162;166;165;164;173 19:37:20 INFO - PID 2015 | |13;stanford-crypto-sha256-iterative;61;66;64;63;61;64;61;61;60;60 19:37:20 INFO - PID 2015 | __end_tp_report 19:37:20 INFO - PID 2015 | __start_cc_report 19:37:20 INFO - PID 2015 | _x_x_mozilla_cycle_collect,918 19:37:20 INFO - PID 2015 | __end_cc_report 19:37:20 INFO - PID 2015 | __startTimestamp1503542240217__endTimestamp 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | ------- Summary: start ------- 19:37:20 INFO - PID 2015 | Number of tests: 14 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#0] ai-astar Cycles:10 Average:105.30 Median:108.50 stddev:4.81 (4.4%) stddev-sans-first:4.70 19:37:20 INFO - PID 2015 | Values: 100.0 106.0 99.0 106.0 107.0 107.0 108.0 98.0 113.0 109.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:145.50 stddev:22.31 (15.3%) stddev-sans-first:23.55 19:37:20 INFO - PID 2015 | Values: 144.0 112.0 147.0 172.0 115.0 147.0 141.0 115.0 168.0 116.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.55 (1.6%) stddev-sans-first:2.64 19:37:20 INFO - PID 2015 | Values: 162.0 163.0 163.0 163.0 163.0 162.0 162.0 162.0 166.0 170.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#3] audio-fft Cycles:10 Average:86.20 Median:74.50 stddev:26.37 (35.4%) stddev-sans-first:27.71 19:37:20 INFO - PID 2015 | Values: 76.0 73.0 74.0 157.0 73.0 75.0 73.0 89.0 99.0 73.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:78.50 stddev:25.22 (32.1%) stddev-sans-first:26.11 19:37:20 INFO - PID 2015 | Values: 79.0 79.0 131.0 79.0 78.0 82.0 135.0 78.0 78.0 127.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.50 stddev:1.49 (1.3%) stddev-sans-first:1.54 19:37:20 INFO - PID 2015 | Values: 114.0 117.0 113.0 116.0 115.0 115.0 114.0 113.0 117.0 116.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.50 stddev:1.35 (0.9%) stddev-sans-first:1.30 19:37:20 INFO - PID 2015 | Values: 149.0 152.0 149.0 150.0 149.0 152.0 152.0 152.0 150.0 151.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:2.08 (2.2%) stddev-sans-first:1.92 19:37:20 INFO - PID 2015 | Values: 99.0 96.0 95.0 95.0 95.0 99.0 94.0 94.0 99.0 95.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:47.50 stddev:3.17 (6.7%) stddev-sans-first:3.35 19:37:20 INFO - PID 2015 | Values: 48.0 47.0 48.0 45.0 46.0 50.0 55.0 45.0 45.0 45.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#9] json-stringify-tinderbox Cycles:10 Average:52.30 Median:52.00 stddev:2.06 (4.0%) stddev-sans-first:2.13 19:37:20 INFO - PID 2015 | Values: 51.0 51.0 57.0 52.0 52.0 51.0 52.0 55.0 51.0 51.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:1.97 (2.7%) stddev-sans-first:2.09 19:37:20 INFO - PID 2015 | Values: 74.0 73.0 79.0 74.0 72.0 74.0 74.0 72.0 73.0 74.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:119.00 stddev:13.85 (11.6%) stddev-sans-first:14.45 19:37:20 INFO - PID 2015 | Values: 114.0 121.0 112.0 113.0 114.0 116.0 120.0 118.0 123.0 159.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.50 stddev:3.13 (1.9%) stddev-sans-first:3.31 19:37:20 INFO - PID 2015 | Values: 166.0 163.0 163.0 164.0 167.0 162.0 166.0 165.0 164.0 173.0 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.02 (3.3%) stddev-sans-first:2.11 19:37:20 INFO - PID 2015 | Values: 61.0 66.0 64.0 63.0 61.0 64.0 61.0 61.0 60.0 60.0 19:37:20 INFO - PID 2015 | -------- Summary: end -------- 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 19:37:20 INFO - PID 2015 | 19:37:20 INFO - PID 2015 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:37:20 INFO - TEST-INFO | 2015: exit 0 19:37:20 INFO - TEST-OK | kraken | took 59886ms 19:37:20 INFO - SUITE-END | took 1169s 19:37:21 INFO - Completed test suite (00:19:30) 19:37:21 INFO - javascript benchmark 19:37:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8743.903895398375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3833.8466461341563, 3856.6336198061185, 3865.5168103987003, 3898.5321761388636, 3900.687944964403, 6016.669083200422, 6092.908606370903, 6115.143879856818, 6138.0, 6145.508359331254, 6026.789062382817, 6060.21217241759, 6101.35935726749, 6102.11519329697, 6197.597156184845, 5476.726163691809, 5512.118061110224, 5520.392756796749, 5569.832905012836, 5595.048841696921, 5351.491608297206, 5465.180222966567, 5491.176323551459, 5588.636738611997, 5605.607607467479, 5514.172874068881, 5548.445155484439, 5563.0, 5564.527015203713, 5594.160875868612, 5352.785888564453, 5490.313710786152, 5514.393416724157, 5583.525400340935, 5583.720813959286, 5422.6475279106735, 5423.186522021689, 5432.185172224158, 5436.157395603648, 5442.0, 6042.6978651067275, 6099.3900609938655, 6125.264968203844, 6133.6626485543275, 6136.202293701835, 6484.254310754276, 6492.383223593751, 6614.140161778938, 6616.470682345449, 6665.766698165589, 6520.902186467207, 6559.737610495575, 6564.212294524687, 6611.9338806611795, 6628.4697224221945, 6170.352113028157, 6178.474829639486, 6204.689765511752, 6208.037754148024, 6209.503239740855, 6715.93284067153, 6717.261101278856, 6722.058911752359, 6722.899156512656, 6796.93203067963, 6370.980643097082, 6510.772122975768, 6573.769918052845, 6603.867922641521, 6605.603663780189, 6563.1796025496815, 6589.472842172615, 6636.004599310142, 6661.766838160641, 6680.498962577826, 6488.708008139645, 6569.80290591283, 6572.4084832365315, 6572.507061970371, 6575.736970521221, 6441.3880681335195, 6483.935160648333, 6495.1556297681, 6502.447291980235, 6523.11937888379, 4848.539388758062, 4866.124097662455, 4869.610431165498, 4874.829380971649, 4885.413750349981, 4424.955750442518, 4470.038941627566, 4487.955120448819, 4569.680122391467, 4571.657125715585, 6056.9697151513965, 6126.019836826175, 6130.019196928559, 6136.2636483622255, 6137.631742095488, 6465.353464653497, 6549.705263263165, 6643.236027856762, 6646.501512386591, 6648.13574235356, 5918.940810591925, 5998.1602575639445, 5999.400059993965, 6035.124906888476, 6128.3565225651555, 5323.973380133075, 5389.326334208224, 5393.406725260218, 5405.459454054563, 5457.481539253765, 6810.795676129724, 6818.147731533559, 6877.346652068046, 6899.75850845218, 6909.136357955255, 6538.869222615616, 6542.803715888626, 6558.409743123142, 6635.8009259722285, 6643.833904152435, 6799.558028728117, 6820.829479262859, 6880.827979300558, 6896.551724137915, 6901.102856628606, 6564.081028655896, 6572.441342485942, 6601.768938087336, 6606.141201643755, 6607.240167380813, 6534.803955881332, 6618.271990080991, 6695.12963314766, 6700.061991321121, 6708.127943367331, 6342.175517182736, 6432.035194720829, 6433.839154021187, 6434.806955791334, 6435.51733619971, 6306.684665766602, 6376.776812811715, 6380.3619638035825, 6382.808515744535, 6383.265924418565, 6318.84202894913, 6321.683915804283, 6322.968385158045, 6337.96831015842, 6402.199725034371, 6401.327860574573, 6424.325445828121, 6427.710753016219, 6448.709808058742, 6493.902591461227, 6245.125682404558, 6280.183576135073, 6338.556301058881, 6342.841428964312, 6356.491480681442], "value": 6043.679042837881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.8326322780608, 912.2701838529175, 946.1390134977172, 963.1379914976096, 967.8499832525961, 38524.422133667984, 39964.80017599915, 40239.19521609566, 40327.991800204974, 40425.3936190957, 37601.435978460344, 37795.81102094492, 37937.430938535945, 38167.61832381675, 38232.42651360225, 7079.539829911065, 7173.85652286954, 7179.820504487378, 7199.1001124859395, 7200.747973820918, 7066.7173313067415, 7147.821304467378, 7174.03150574671, 7179.605121718303, 7180.461465390091, 7125.572465652078, 7128.322809333105, 7129.643517824114, 7161.176464706573, 7164.749233776819, 7108.289171082876, 7108.857822843514, 7138.785836424916, 7138.8572228555395, 7141.321574450419, 6541.149650545446, 6593.406593406568, 6593.80218593443, 6604.306547812458, 6606.174228221473, 34720.305593887984, 34761.826190869135, 35054.47418288728, 35108.893466392095, 35161.12097197565, 3366.2257680733323, 3389.2882494676146, 3407.795532268072, 3424.828758562062, 3432.1762776933356, 27990.860045699847, 27994.0, 28004.29989250285, 28075.43849123006, 28099.0, 4669.299605059235, 4686.133065382915, 4686.437627484724, 4686.601638860701, 4725.173094708447, 188702.0, 188724.0, 191395.0, 191834.0, 207631.96184019133, 50072.0, 50276.748616256686, 50403.495965040616, 50434.0, 50466.0, 52485.73757131266, 52559.0, 52584.21123683148, 52612.0, 52658.473415265355, 15581.532554023397, 15624.3750249991, 15700.136492492795, 15722.921385393, 15809.367625294859, 12884.677883052998, 12972.80540791889, 12978.480860765652, 12984.415701293465, 13012.934935325262, 13112.672183195305, 13133.802992955114, 13134.080614356903, 13216.339183040809, 13220.677932206703, 5235.240890070919, 5256.789728410898, 5339.813106541253, 5397.9460205397445, 5408.513233808976, 1020.9591616335412, 1032.8140934631838, 1041.2815157541272, 1050.753073027838, 1055.8944105589533, 30025.849870750506, 30040.54939175914, 30388.392232155675, 30465.543016854765, 30868.382632347228, 1127.334872425273, 1129.8587676540433, 1138.7437826488974, 1146.3122126724065, 1148.8965993060497, 12504.676906806091, 12952.158109723026, 13022.023348248918, 13037.543685970946, 13066.673333166556, 265472.0, 265706.0, 266078.0, 266494.0, 266824.0, 51639.48360516422, 51810.22284665733, 51837.0, 51856.22215666768, 51915.0, 1469.0965056490181, 1470.191394732914, 1491.3512622009462, 1492.7238460884555, 1510.4939845151998, 22668.773312266665, 22694.432639184153, 22735.65896511587, 23009.65485517752, 23035.0, 38449.6155038446, 38534.42198367083, 38540.0, 38545.807270963465, 38552.80723596364, 164562.0, 165045.0, 165327.0, 165633.0, 165760.0, 32874.342513150084, 33080.66919330776, 35266.647333526336, 35742.46386304156, 35986.28027439489, 46274.30588541242, 46738.766306168254, 46951.765241173576, 47152.29271560861, 47625.285620715025, 34567.654323456445, 34618.30763384668, 34706.132346691535, 34817.825910870284, 34976.475352870235, 34515.48226776651, 34549.827250863586, 34553.136171595914, 34700.47949280712, 35329.82335088308, 37186.44220336643, 38214.23571528609, 38324.233515330096, 38494.230115396975, 38532.80733596314, 33721.49417758785, 33756.3248735019, 33932.0, 34035.319293614484, 34110.147246319044, 24997.750022499542, 25098.874505627355, 25176.49647007013, 25581.616275756252, 25879.0942317018], "value": 17105.849252710024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3549147497428, 569.3509399284814, 570.4124751505949, 575.6085861614104, 588.7350692188514, 22155.0, 23207.883960580195, 23212.72330021848, 23224.071037158537, 23225.535489290225, 22444.214452494165, 22682.54634907305, 22839.31482055537, 22947.655785163235, 22972.65541016882, 6452.0321951707265, 6575.736970521173, 6579.210494740638, 6579.671016449182, 6600.9339906601035, 6225.377462253784, 6486.772962946297, 6489.643069631168, 6493.0, 6545.312742162076, 6459.354064593526, 6469.967650161742, 6471.870562588745, 6474.74101035958, 6475.125858009179, 6471.546991710582, 6480.805575832733, 6480.870382592322, 6484.4164025237715, 6485.383888530582, 5991.460768530809, 6009.969950150265, 6021.969890150565, 6029.065494848305, 6031.1254868044325, 29610.25974350637, 30601.69398306033, 30667.386652267054, 30802.38395232105, 31172.064838054666, 2137.348108826807, 2166.599179151862, 2167.4906396996694, 2169.5227050048966, 2173.608750424923, 18978.90510547452, 19657.606847862964, 19691.704624430644, 19709.310174143837, 19811.702824457643, 2340.0639744102323, 2341.461463863304, 2387.0, 2390.0439824070336, 2390.2351247600773, 165156.0, 171423.0, 171453.0, 171644.0, 171670.0, 15970.60073498172, 16251.918740406223, 16335.509934701979, 16563.751543726852, 16655.0, 24810.751892480843, 24907.0, 24909.750902490745, 24958.750412496007, 24974.625380619305, 10139.543720532594, 10797.514111864984, 10896.727581810359, 11004.0, 11008.954149355799, 9938.652147174958, 10006.048215776218, 10066.295359324924, 10090.09189172978, 10224.64213752515, 9901.15840153595, 10149.847752283722, 10216.0, 10308.278420510493, 10346.482675866177, 2926.897558585439, 2965.1252880400334, 2974.940501189964, 3008.9247768805517, 3095.1797773590015, 987.3532835992437, 993.2401712689798, 997.1474389397106, 1022.831232846572, 1030.6547306652355, 21473.355799326044, 21580.244691436037, 21585.35243942653, 21653.242136525147, 21936.670949935764, 1066.8186408310605, 1072.9141668666489, 1083.3012706804225, 1086.4296244471716, 1088.1947358954317, 11867.287962722265, 11989.76020479603, 11998.280103193836, 12063.396830158457, 12093.818592721116, 595235.0, 601375.0, 605766.0, 622169.0, 623247.0, 132823.0, 137119.0, 140364.29817850844, 140564.2971785155, 141764.0, 1197.736497970445, 1249.4564864283884, 1280.0847394113255, 1298.8311519502404, 1338.5382043194888, 22187.0, 22189.445263868532, 22518.0, 22598.0, 22837.429064273525, 63140.36859631529, 63265.36734632595, 64019.35980640134, 64943.0, 65066.0, 81006.5949670248, 83949.0, 84743.0, 86052.56973715092, 86473.0, 15360.155191464577, 15723.213839308217, 15754.0, 15821.683566328378, 15821.683566328838, 24784.132555361197, 24807.62788558137, 24904.62643060319, 25070.0, 25428.110016149345, 19563.217471300988, 19691.901540492207, 19863.702044469057, 19963.800361996775, 19964.10161542705, 16219.837801621832, 16312.918435407748, 16425.67148657044, 16603.086830224453, 16635.83364166343, 19390.4182874514, 19501.219951201794, 20403.897980510003, 20454.48863778358, 20572.897135514228, 15449.382024718885, 15478.148701821508, 15640.843591563938, 15669.373225070869, 15715.057096573784, 19097.904510477914, 19123.713144303125, 19167.424977250706, 19247.13387897576, 19870.801291987475], "value": 12757.36954555929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.5608661314993, 1465.567657541026, 1469.8824094072475, 1488.4418343121329, 1494.9626259343515, 15741.763873541906, 16359.345626174969, 16398.26207820648, 16432.342706291747, 16433.17834108296, 15246.466373676923, 16542.83457165428, 16553.751693724604, 16557.66884662306, 16568.088755118464, 2692.569188929772, 2747.203311039806, 2757.0, 2758.0622588319966, 2758.0760445250867, 2645.642838216835, 2650.0857204264594, 2735.4939336222765, 2737.110439107288, 2751.2434080627886, 2739.931501712453, 2766.4190519990825, 2777.5833624956217, 2780.5134101532253, 2785.4011387551673, 2650.112212408845, 2651.323912402335, 2651.6817981842205, 2653.535631264531, 2674.826136301154, 2515.4843257132425, 2528.9747102528922, 2547.4905018996274, 2549.974500254992, 2551.0, 15322.0, 15584.532464025984, 16005.039697618064, 16005.359785608562, 16065.116418596972, 7675.424343174229, 7890.0, 7936.563489008102, 7939.206079392073, 7946.404019698488, 5077.949220507785, 5235.73821308933, 5306.177542480922, 5340.893182136374, 5362.276092727471, 1981.1877130376477, 2013.9597208055902, 2042.2954080842235, 2084.4049158797393, 2099.9475013124793, 26659.73340266592, 26683.0, 26705.599416008776, 26708.866455667598, 27011.45977080467, 6643.900341494881, 6767.560108592926, 6795.286494917962, 6944.756933507303, 6969.721211151497, 17994.730079048826, 18001.18994645244, 18014.729779053323, 18135.818641813676, 18143.18355673998, 7902.525848449111, 7929.881051784228, 7956.761297161094, 8021.679132834738, 8054.355651547862, 7247.601381924045, 7286.526375785557, 7383.556986580715, 7421.146568144733, 7464.216257293015, 4902.509749025069, 5065.164247899129, 5318.149096144598, 5505.752241149158, 5512.173174023848, 1480.8148981377328, 1529.747591647388, 1535.9385624574893, 1548.5753107141456, 1561.1647768444054, 963.2486660404895, 981.2689546287918, 981.3817295104182, 1000.7798284377425, 1013.2704452793977, 9089.727308180632, 9139.49732764691, 9263.0, 9397.953010234905, 9429.575669094907, 1042.5725452564411, 1051.2010871737382, 1058.9523471443804, 1064.510325250378, 1076.6985244131656, 5494.532964697965, 5852.912206316909, 5867.70661466925, 5878.147668588031, 6012.128241405059, 23285.41786455352, 23358.532829343658, 23754.524909501713, 23942.0, 23996.52006959851, 23250.41873953131, 23368.415789605056, 23395.41511462193, 23397.0, 23404.18085367004, 11019.669409917715, 11390.658280251606, 11454.828177577343, 11548.0, 11564.42177891102, 9107.324567529502, 9196.402233855046, 9237.861432078658, 9268.675596354095, 9377.531123443665, 19033.524161895508, 19583.510412239808, 19680.704789427884, 20124.0, 20343.4914127148, 20703.309604469567, 20774.1690332385, 20926.68609970821, 21199.0, 21723.0, 11671.649850504498, 11747.882521174679, 11931.0, 11956.641300760992, 11957.820632690342, 12792.808107878203, 13095.476180952655, 14591.124532528082, 14864.256787160815, 14869.033512821632, 11905.761884762429, 12092.516299347928, 12222.327771972627, 12358.196717213352, 12540.122191446511, 11038.779224415628, 11057.557697692002, 11328.886711132784, 11470.369129697612, 11715.765684686088, 10576.101031412416, 10785.191110666574, 10795.0, 10795.6221532246, 10840.891591083988, 8108.432409731262, 8199.139090395662, 8205.79485512867, 8214.876776848472, 8276.710315138942, 8411.158884111539, 8476.533790641573, 8525.317974562144, 8582.399232053696, 8695.913040869511], "value": 7001.68548374216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.0669967260243, 540.3866611396064, 540.7809837016009, 543.1743749500758, 550.6943646276316, 6015.398460153982, 6084.908726369103, 6129.295131059929, 6172.290186628539, 6195.349488303726, 6037.305709843369, 6053.182820319266, 6145.033589251441, 6170.413810687977, 6173.197484327043, 5046.7224302663335, 5048.419431765348, 5075.873103172432, 5115.4884511548735, 5115.9488405116035, 4695.248760198369, 4842.394700662418, 4996.125678006352, 5034.798608055673, 5043.546080852722, 4810.158222311099, 4845.563899249067, 4848.345473361104, 4866.610671146317, 4866.926996095061, 4823.0, 4825.927611085819, 4856.902861942759, 4861.975690121562, 4871.196252618313, 4274.508431530352, 4351.760653164075, 4356.6514678825615, 4385.342198670193, 4443.688941774077, 5866.208061911672, 5889.320359236537, 5890.617109887887, 5949.9702501487645, 5995.880082398371, 5578.553715702734, 5595.552355811526, 5600.5799565032785, 5659.660420374791, 5669.659820410789, 6291.213598300213, 6337.827501912115, 6382.936170638327, 6444.323346048644, 6457.773977910751, 4833.347498087784, 4856.781444834991, 4863.951360486385, 4882.707037577757, 4893.339399181101, 6444.484441244689, 6464.288928217892, 6493.805185844432, 6570.835729106763, 6615.239247486505, 4955.1823949048, 4962.627802914796, 4986.55121039101, 5003.3495645565845, 5024.371953505812, 5028.974855125701, 5064.417591976896, 5074.213496907912, 5079.720615366116, 5096.210087436453, 5619.297587801525, 5620.803271885465, 5655.915161272585, 5677.0, 5697.800576979786, 6357.141785858942, 6363.395477429637, 6428.19647544057, 6428.8071357859335, 6442.194725659293, 1743.8430541251093, 1747.851432628241, 1752.1952389039309, 1767.6641438126715, 1772.7429522719392, 1194.898433633151, 1227.5212667059855, 1242.167747609104, 1244.6433387607551, 1252.405107573895, 5982.414660115073, 6000.409891378788, 6022.939770602326, 6066.4540191382985, 6081.726322315506, 6458.192725909262, 6466.385693359123, 6481.708323125471, 6587.484878477977, 6588.308227636125, 5919.437653422918, 5944.286685597756, 5962.791302304398, 6030.366811484819, 6101.328853826076, 3364.411228035084, 3376.062825341919, 3429.3141371725756, 3479.356319080978, 3522.894313170609, 6452.967735161388, 6641.369069938348, 6644.269130395653, 6728.730850766013, 6789.456843452512, 6632.535722499379, 6647.002949557508, 6653.733850646016, 6689.76585819494, 6831.726730930806, 6664.166979127609, 6747.291534388818, 6761.72953081881, 6857.177138743283, 6895.482838787011, 6406.199225096863, 6451.3226111257645, 6475.384838440341, 6537.150170477998, 6578.473722102125, 6338.714757836001, 6383.457406120532, 6476.319986401549, 6511.2512061113575, 6555.573887697285, 6727.697253623501, 6863.416609588241, 6877.698704621709, 6882.311768823078, 6895.34494223048, 4958.7024778513405, 5000.899982000413, 5028.371453568304, 5045.369328833895, 5059.5952323814745, 6266.749330026931, 6325.501426936243, 6524.836879078061, 6536.202544300165, 6586.739563915892, 6235.407636274728, 6274.278457977391, 6308.589941653778, 6339.651319177489, 6347.270063942706, 6224.37756224374, 6279.623222606659, 6279.71741271653, 6285.214348206474, 6351.174347334817, 6273.843153921006, 6284.8428789278805, 6313.96843015782, 6315.842103947438, 6319.6208227506495, 6363.96818015907, 6379.298277189413, 6392.232932048184, 6417.1657684500715, 6418.903716444163, 6182.165407669907, 6234.906476402948, 6235.3452887446165, 6264.404881536247, 6265.27949285838], "value": 5008.9282421946045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [939.7556635274827, 942.4863449420066, 963.0562049191792, 966.3041362408972, 967.1247520993495, 15617.375304987787, 16077.919610401947, 16080.356785728556, 16109.597260068489, 18767.43697689068, 19948.900255498702, 19972.901490418022, 19997.800021999774, 20021.099050542725, 20032.59934801303, 986.3243678080502, 1082.2370228988543, 1086.3536195963388, 1088.6026600290916, 1088.7659153282043, 1080.2924084724518, 1081.5349399758102, 1082.112667612558, 1082.193765644596, 1083.2309060567006, 1071.6624263357019, 1111.8776934537195, 1112.671761830262, 1112.9165312601588, 1118.0440723181684, 1097.8517900083466, 1098.906592939601, 1099.164634877491, 1099.598646494028, 1100.944952752359, 807.1363640904235, 807.386386346381, 807.5356669914822, 807.6244546286006, 807.7657479330987, 17298.135093245288, 17298.394556190473, 17364.305427782874, 17376.131193440277, 17773.7333939991, 19792.60414791696, 20204.79795202044, 20218.090185941666, 20305.898470507702, 20605.79394206069, 17097.658046838995, 17552.473425797245, 17578.91210543952, 17600.735988960176, 17621.207045682975, 3779.357509223411, 3827.827747751358, 3829.7702137871815, 3831.1954489557224, 3832.559255685604, 129441.0, 135943.0, 138586.0, 140117.0, 145293.27353363272, 16211.594710132342, 16974.830251697324, 17020.914895425445, 17113.572160695832, 17406.303747849943, 30724.53913191304, 30949.84525077405, 30956.69043309538, 30985.380292394027, 31057.0682879514, 8145.5927203639585, 8270.875936860952, 8678.088800675965, 8741.213290803858, 8741.956290218508, 4564.0871825635, 4723.291506274087, 4728.101660684528, 4730.88172795676, 4741.5021422750115, 5350.411454739976, 5388.110961691277, 5396.109641909119, 5489.533389661923, 5519.613627046068, 1085.4464223246202, 1093.9781204375868, 1094.9835752463719, 1104.1994553948323, 1107.6400169944638, 702.3187508117118, 718.0952000479433, 721.1778572427437, 731.1591669580025, 750.782273140794, 11857.407129643483, 13196.60410187696, 13272.270025148517, 13806.86193138076, 13877.0, 709.8580283943129, 712.0138608027816, 724.279342054659, 724.431321412699, 733.1165945036325, 6097.176881120992, 6122.602030867979, 6161.599496032743, 6200.255969283715, 6313.273973493016, 131703.0, 132712.3364383172, 133057.0, 133761.0, 134807.0, 113205.0, 115695.0, 115707.67623501453, 116305.41847290879, 120126.0, 100955.49522252342, 103317.0, 105962.0, 106250.46874765577, 107337.46331268294, 12605.243685378906, 12820.679483013, 12896.29070401137, 12915.483380665044, 13039.674008149872, 49507.0, 50220.0, 50408.0, 51394.0, 52813.47186528086, 87113.0, 87747.12252877645, 89993.55003224942, 90619.54690226507, 92852.53573732088, 18736.25054997785, 18837.15232814554, 18896.52758681044, 19093.522661933563, 19363.612727745647, 20602.381928542167, 20814.895925520883, 21070.78929210688, 21553.03011364461, 21653.0, 19035.524111897314, 19045.71431428502, 19247.32634357847, 19294.8070519293, 19325.13036913314, 18644.0, 19114.713279300544, 19254.149170165743, 19352.70970935465, 19742.70385944241, 17161.914190428968, 17473.12634368302, 17476.650466990333, 18919.148638311584, 19420.805791942465, 13301.201927884358, 13338.399772010089, 13605.455781768618, 13623.114497557626, 13963.93018034944, 13357.866421336052, 13464.0, 13472.932635336761, 13481.2585307809, 13534.390952406968], "value": 9661.637081578472, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 99.0, 106.0, 107.0, 107.0, 108.0, 98.0, 113.0, 109.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 147.0, 172.0, 115.0, 147.0, 141.0, 115.0, 168.0, 116.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 166.0, 170.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 157.0, 73.0, 75.0, 73.0, 89.0, 99.0, 73.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 79.0, 78.0, 82.0, 135.0, 78.0, 78.0, 127.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 113.0, 116.0, 115.0, 115.0, 114.0, 113.0, 117.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 149.0, 150.0, 149.0, 152.0, 152.0, 152.0, 150.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 95.0, 95.0, 95.0, 99.0, 94.0, 94.0, 99.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 45.0, 46.0, 50.0, 55.0, 45.0, 45.0, 45.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 57.0, 52.0, 52.0, 51.0, 52.0, 55.0, 51.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 79.0, 74.0, 72.0, 74.0, 74.0, 72.0, 73.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 112.0, 113.0, 114.0, 116.0, 120.0, 118.0, 123.0, 159.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 164.0, 167.0, 162.0, 166.0, 165.0, 164.0, 173.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 64.0, 63.0, 61.0, 64.0, 61.0, 61.0, 60.0, 60.0], "value": 62.1, "unit": "score"}]}]} 19:37:21 INFO - Return code: 0 19:37:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:37:21 INFO - # TBPL SUCCESS # 19:37:21 INFO - Running post-action listener: _package_coverage_data 19:37:21 INFO - Running post-action listener: _resource_record_post_action 19:37:21 INFO - [mozharness: 2017-08-24 02:37:21.539544Z] Finished run-tests step (success) 19:37:21 INFO - Running post-run listener: _resource_record_post_run 19:37:21 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 425635840; Read time: 0; Write time: 401844 19:37:21 INFO - TinderboxPrint: CPU usage
13.1% 19:37:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:37:21 INFO - TinderboxPrint: I/O write bytes / time
425,635,840 / 401,844 19:37:21 INFO - TinderboxPrint: CPU idle
8,231.8 (86.9%) 19:37:21 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 19:37:21 INFO - TinderboxPrint: Swap in / out
0 / 0 19:37:21 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 108011520; Read time: 0; Write time: 149044 19:37:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:37:21 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 317624320; Read time: 0; Write time: 252800 19:37:22 INFO - Running post-run listener: _upload_blobber_files 19:37:22 INFO - Blob upload gear active. 19:37:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:37:22 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 19:37:22 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'] 19:37:22 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 19:37:22 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:23 INFO - (blobuploader) - INFO - Done attempting. 19:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:30 INFO - (blobuploader) - INFO - Done attempting. 19:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:31 INFO - (blobuploader) - INFO - Done attempting. 19:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:32 INFO - (blobuploader) - INFO - Done attempting. 19:37:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:37:32 INFO - Return code: 0 19:37:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:37:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:37:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f66620cf69030945f30e95fea1b1421214687134f16ec340d6b7104266ee4dda65bea69f1856b61ef886ef7559e511fa0360957a8c52414fa76a0c9979b0439", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cc822f86339758f8f8443e8d5b75850982a3912572cb61ea12739dd3e7ded9227536004163cef7f67d68beb0146df57cd905c6974481bce7231d5b4f4d0f64e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229ae407aa34e6a109914d189285032826e616fe3b40f106231f55e7211f977fbd6cd5bf8a8d4e22459b8447736be1f8a4e4fffe788b800713beec56578f6193", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883ee1baae348d55ffedb583590ca714729e4153ade243ccd57ee4f19bb59e766691babc38a9eb84858af87a988beea5aadffc0ee4007fe4c5688e2f073faec8"} 19:37:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:37:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:37:32 INFO - Contents: 19:37:32 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f66620cf69030945f30e95fea1b1421214687134f16ec340d6b7104266ee4dda65bea69f1856b61ef886ef7559e511fa0360957a8c52414fa76a0c9979b0439", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cc822f86339758f8f8443e8d5b75850982a3912572cb61ea12739dd3e7ded9227536004163cef7f67d68beb0146df57cd905c6974481bce7231d5b4f4d0f64e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229ae407aa34e6a109914d189285032826e616fe3b40f106231f55e7211f977fbd6cd5bf8a8d4e22459b8447736be1f8a4e4fffe788b800713beec56578f6193", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883ee1baae348d55ffedb583590ca714729e4153ade243ccd57ee4f19bb59e766691babc38a9eb84858af87a988beea5aadffc0ee4007fe4c5688e2f073faec8"} 19:37:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:37:32 INFO - Copying logs to upload dir... 19:37:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:37:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.000745 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-23 19:37:32.154865) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:37:32.158741) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f66620cf69030945f30e95fea1b1421214687134f16ec340d6b7104266ee4dda65bea69f1856b61ef886ef7559e511fa0360957a8c52414fa76a0c9979b0439", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cc822f86339758f8f8443e8d5b75850982a3912572cb61ea12739dd3e7ded9227536004163cef7f67d68beb0146df57cd905c6974481bce7231d5b4f4d0f64e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229ae407aa34e6a109914d189285032826e616fe3b40f106231f55e7211f977fbd6cd5bf8a8d4e22459b8447736be1f8a4e4fffe788b800713beec56578f6193", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883ee1baae348d55ffedb583590ca714729e4153ade243ccd57ee4f19bb59e766691babc38a9eb84858af87a988beea5aadffc0ee4007fe4c5688e2f073faec8"} build_url:https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/K0CoqHb9Rx6Hb0820ZShhQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f66620cf69030945f30e95fea1b1421214687134f16ec340d6b7104266ee4dda65bea69f1856b61ef886ef7559e511fa0360957a8c52414fa76a0c9979b0439", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cc822f86339758f8f8443e8d5b75850982a3912572cb61ea12739dd3e7ded9227536004163cef7f67d68beb0146df57cd905c6974481bce7231d5b4f4d0f64e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229ae407aa34e6a109914d189285032826e616fe3b40f106231f55e7211f977fbd6cd5bf8a8d4e22459b8447736be1f8a4e4fffe788b800713beec56578f6193", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883ee1baae348d55ffedb583590ca714729e4153ade243ccd57ee4f19bb59e766691babc38a9eb84858af87a988beea5aadffc0ee4007fe4c5688e2f073faec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:37:32.185849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:37:32.186185) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1503540998.733084-945632625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:37:32.268184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:37:32.268503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:37:32.268800) ========= ========= Total master_lag: 0.18 =========