builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1499728031.84 results: success (0) revision: 5d794bf4c4653153e602631f1b8818acd559d8f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.838945) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.839443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.839744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.858313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.858715) ========= 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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-10 16:07:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2017-07-10 16:07:12 (40.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:11.997357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:12.000774) ========= 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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015924 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:12.050347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 16:07:12.053766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5d794bf4c4653153e602631f1b8818acd559d8f5 --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 5d794bf4c4653153e602631f1b8818acd559d8f5 --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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-10 16:07:12,215 truncating revision to first 12 chars 2017-07-10 16:07:12,215 Setting DEBUG logging. 2017-07-10 16:07:12,215 attempt 1/10 2017-07-10 16:07:12,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d794bf4c465?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-10 16:07:13,133 unpacking tar archive at: mozilla-central-5d794bf4c465/testing/mozharness/ program finished with exit code 0 elapsedTime=1.235796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 16:07:13.304721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:13.305045) ========= script_repo_revision: 5d794bf4c4653153e602631f1b8818acd559d8f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:13.305411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:13.305682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 16:07:13.314119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-10 16:07:13.314378) ========= /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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:13 INFO - MultiFileLogger online at 20170710 16:07:13 in /builds/slave/test 16:07:13 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 16:07:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:13 INFO - {'append_to_log': False, 16:07:13 INFO - 'base_work_dir': '/builds/slave/test', 16:07:13 INFO - 'blob_upload_branch': 'Firefox', 16:07:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:13 INFO - 'branch': 'Firefox', 16:07:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:13 INFO - 'code_coverage': False, 16:07:13 INFO - 'config_files': ('talos/linux_config.py',), 16:07:13 INFO - 'default_actions': ('clobber', 16:07:13 INFO - 'read-buildbot-config', 16:07:13 INFO - 'download-and-extract', 16:07:13 INFO - 'populate-webroot', 16:07:13 INFO - 'create-virtualenv', 16:07:13 INFO - 'install', 16:07:13 INFO - 'setup-mitmproxy', 16:07:13 INFO - 'run-tests'), 16:07:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:13 INFO - 'disable_ccov_upload': False, 16:07:13 INFO - 'download_minidump_stackwalk': True, 16:07:13 INFO - 'download_symbols': 'ondemand', 16:07:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:13 INFO - 'gecko_profile': False, 16:07:13 INFO - 'gecko_profile_interval': 0, 16:07:13 INFO - 'installer_path': 'installer.exe', 16:07:13 INFO - 'log_level': 'info', 16:07:13 INFO - 'log_name': 'talos', 16:07:13 INFO - 'log_to_console': True, 16:07:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:13 INFO - 'opt_config_files': (), 16:07:13 INFO - 'pip_index': False, 16:07:13 INFO - 'suite': 'dromaeojs-e10s', 16:07:13 INFO - 'system_bits': '32', 16:07:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:13 INFO - 'title': 'talos-linux64-ix-059', 16:07:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:13 INFO - 'use_talos_json': True, 16:07:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:13 INFO - 'work_dir': 'build'} 16:07:13 INFO - [mozharness: 2017-07-10 23:07:13.577946Z] Running clobber step. 16:07:13 INFO - Running pre-action listener: _resource_record_pre_action 16:07:13 INFO - Running main action method: clobber 16:07:13 INFO - rmtree: /builds/slave/test/build 16:07:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:14 INFO - Running post-action listener: _resource_record_post_action 16:07:14 INFO - [mozharness: 2017-07-10 23:07:14.818289Z] Finished clobber step (success) 16:07:14 INFO - [mozharness: 2017-07-10 23:07:14.818391Z] Running read-buildbot-config step. 16:07:14 INFO - Running pre-action listener: _resource_record_pre_action 16:07:14 INFO - Running main action method: read_buildbot_config 16:07:14 INFO - Using buildbot properties: 16:07:14 INFO - { 16:07:14 INFO - "project": "", 16:07:14 INFO - "product": "firefox", 16:07:14 INFO - "who": "kwierso@gmail.com", 16:07:14 INFO - "installer_path": "public/build/target.tar.bz2", 16:07:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:07:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:07:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:07:14 INFO - "stage_platform": "linux64-pgo", 16:07:14 INFO - "basedir": "/builds/slave/test", 16:07:14 INFO - "buildnumber": 55, 16:07:14 INFO - "platform": "ubuntu64_hw", 16:07:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:07:14 INFO - "slavebuilddir": "test", 16:07:14 INFO - "taskId": "Ct3g8QJDRumQwg7KQyvl8A", 16:07:14 INFO - "branch": "mozilla-central", 16:07:14 INFO - "script_repo_revision": "production", 16:07:14 INFO - "revision": "5d794bf4c4653153e602631f1b8818acd559d8f5", 16:07:14 INFO - "slavename": "talos-linux64-ix-059", 16:07:14 INFO - "repo_path": "mozilla-central" 16:07:14 INFO - } 16:07:14 INFO - Finding installer, test and symbols from parent task. 16:07:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ct3g8QJDRumQwg7KQyvl8A'}, attempt #1 16:07:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ct3g8QJDRumQwg7KQyvl8A'}, attempt #1 16:07:15 INFO - Task dependencies: VjGQ5cTWQT-QsDUTO1_FFQ 16:07:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ'}, attempt #1 16:07:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 16:07:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/test_packages.json 16:07:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.crashreporter-symbols.zip 16:07:16 INFO - Running post-action listener: _resource_record_post_action 16:07:16 INFO - [mozharness: 2017-07-10 23:07:16.166456Z] Finished read-buildbot-config step (success) 16:07:16 INFO - [mozharness: 2017-07-10 23:07:16.166678Z] Running download-and-extract step. 16:07:16 INFO - Running pre-action listener: _resource_record_pre_action 16:07:16 INFO - Running main action method: download_and_extract 16:07:16 INFO - mkdir: /builds/slave/test/build/tests 16:07: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')]} 16:07:16 INFO - trying https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.test_packages.json 16:07:16 INFO - Downloading https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:07:16 INFO - Downloaded 989 bytes. 16:07:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:07:16 INFO - Using the following test package requirements: 16:07:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:07:16 INFO - u'common': [u'target.common.tests.zip'], 16:07:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:07:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:07:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:07:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:07:16 INFO - u'mozbase': [u'target.common.tests.zip'], 16:07:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:07:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:07:16 INFO - u'web-platform': [u'target.common.tests.zip', 16:07:16 INFO - u'target.web-platform.tests.tar.gz'], 16:07:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:07:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip 16:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip into memory 16:07:17 INFO - Content-Length response header: 68034424 16:07:17 INFO - Bytes received: 68034424 16:07:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:07:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip 16:07:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.common.tests.zip into memory 16:07:29 INFO - Content-Length response header: 68034424 16:07:29 INFO - Bytes received: 68034424 16:07:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.talos.tests.zip 16:07:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:07:41 INFO - Fetch https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.talos.tests.zip into memory 16:07:42 INFO - Content-Length response header: 14474423 16:07:42 INFO - Bytes received: 14474423 16:07:42 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')]} 16:07:42 INFO - trying https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 16:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:07:44 INFO - Downloaded 62986755 bytes. 16:07:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 16:07:44 INFO - mkdir: /builds/slave/test/properties 16:07:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:44 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:44 INFO - Contents: 16:07:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - Running post-action listener: set_extra_try_arguments 16:07:44 INFO - [mozharness: 2017-07-10 23:07:44.039237Z] Finished download-and-extract step (success) 16:07:44 INFO - [mozharness: 2017-07-10 23:07:44.039334Z] Running populate-webroot step. 16:07:44 INFO - Running pre-action listener: _resource_record_pre_action 16:07:44 INFO - Running main action method: populate_webroot 16:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:44 INFO - '--tppagecycles', 16:07:44 INFO - '7'], 16:07:44 INFO - 'tests': ['tsvgm']}}, 16:07:44 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:07:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['damp', 'tps']}, 16:07:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'tests': ['damp', 'tps']}, 16:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['dromaeo_dom']}, 16:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:07:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:07:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_many_windows', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_many_windows', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_many_windows', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 16:07:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:07:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:07:44 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:07:44 INFO - 'talos_options': ['--mitmproxy', 16:07:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:07:44 INFO - '--firstNonBlankPaint'], 16:07:44 INFO - 'tests': ['quantum_pageload_google', 16:07:44 INFO - 'quantum_pageload_youtube', 16:07:44 INFO - 'quantum_pageload_amazon', 16:07:44 INFO - 'quantum_pageload_facebook']}, 16:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tsvgx', 16:07:44 INFO - 'tsvgr_opacity', 16:07:44 INFO - 'tart', 16:07:44 INFO - 'tscrollx', 16:07:44 INFO - 'cart', 16:07:44 INFO - 'tsvg_static']}, 16:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:07:44 INFO - 'tsvgr_opacity', 16:07:44 INFO - 'tart', 16:07:44 INFO - 'tscrollx', 16:07:44 INFO - 'cart', 16:07:44 INFO - 'tsvg_static']}, 16:07:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tp5o']}, 16:07:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:07:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s', 16:07:44 INFO - '--xperf_path', 16:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:44 INFO - 'tests': ['tp5n']}, 16:07:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:07:44 INFO - 'talos_options': ['--xperf_path', 16:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:44 INFO - 'tests': ['tp5n']}}, 16:07:44 INFO - 'talos.zip': {'path': '', 16:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - [mozharness: 2017-07-10 23:07:44.054530Z] Finished populate-webroot step (success) 16:07:44 INFO - [mozharness: 2017-07-10 23:07:44.054620Z] Running create-virtualenv step. 16:07:44 INFO - Running pre-action listener: _resource_record_pre_action 16:07:44 INFO - Running main action method: create_virtualenv 16:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:44 INFO - Using real prefix '/usr' 16:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:46 INFO - Installing pip.................done. 16:07:46 INFO - Return code: 0 16:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:07:46 INFO - Reading from file tmpfile_stdout 16:07:46 INFO - Output received: 16:07:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07:46 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')]} 16:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:46 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')]} 16:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:46 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:46 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 16:07:46 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 16:07:46 INFO - Using env: {'DISPLAY': ':0', 16:07:46 INFO - 'HOME': '/home/cltbld', 16:07:46 INFO - 'LANG': 'en_US.UTF-8', 16:07:46 INFO - 'LANGUAGE': 'en_US:en', 16:07:46 INFO - 'LOGNAME': 'cltbld', 16:07:46 INFO - 'MAIL': '/var/mail/cltbld', 16:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:46 INFO - 'MOZ_NO_REMOTE': '1', 16:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:46 INFO - 'NO_EM_RESTART': '1', 16:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:46 INFO - 'PWD': '/builds/slave/test', 16:07:46 INFO - 'SHELL': '/bin/bash', 16:07:46 INFO - 'SHLVL': '1', 16:07:46 INFO - 'TERM': 'linux', 16:07:46 INFO - 'TMOUT': '86400', 16:07:46 INFO - 'USER': 'cltbld', 16:07:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:46 INFO - '_': '/tools/buildbot/bin/python'} 16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:07:47 INFO - Cleaning up... 16:07:47 INFO - Return code: 0 16:07:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:07:47 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')]} 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:47 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')]} 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:47 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 16:07:47 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 16:07:47 INFO - Using env: {'DISPLAY': ':0', 16:07:47 INFO - 'HOME': '/home/cltbld', 16:07:47 INFO - 'LANG': 'en_US.UTF-8', 16:07:47 INFO - 'LANGUAGE': 'en_US:en', 16:07:47 INFO - 'LOGNAME': 'cltbld', 16:07:47 INFO - 'MAIL': '/var/mail/cltbld', 16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:47 INFO - 'MOZ_NO_REMOTE': '1', 16:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:47 INFO - 'NO_EM_RESTART': '1', 16:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:47 INFO - 'PWD': '/builds/slave/test', 16:07:47 INFO - 'SHELL': '/bin/bash', 16:07:47 INFO - 'SHLVL': '1', 16:07:47 INFO - 'TERM': 'linux', 16:07:47 INFO - 'TMOUT': '86400', 16:07:47 INFO - 'USER': 'cltbld', 16:07:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:47 INFO - '_': '/tools/buildbot/bin/python'} 16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:47 INFO - Downloading/unpacking psutil>=3.1.1 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:48 INFO - Installing collected packages: psutil 16:07:48 INFO - Running setup.py install for psutil 16:07:48 INFO - building 'psutil._psutil_linux' extension 16:07:48 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 16:07:48 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 16:07:48 INFO - building 'psutil._psutil_posix' extension 16:07:48 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 16:07:48 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 16:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:48 INFO - Successfully installed psutil 16:07:48 INFO - Cleaning up... 16:07:49 INFO - Return code: 0 16:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:07:49 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')]} 16:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:49 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')]} 16:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:49 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:49 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 16:07:49 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 16:07:49 INFO - Using env: {'DISPLAY': ':0', 16:07:49 INFO - 'HOME': '/home/cltbld', 16:07:49 INFO - 'LANG': 'en_US.UTF-8', 16:07:49 INFO - 'LANGUAGE': 'en_US:en', 16:07:49 INFO - 'LOGNAME': 'cltbld', 16:07:49 INFO - 'MAIL': '/var/mail/cltbld', 16:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:49 INFO - 'MOZ_NO_REMOTE': '1', 16:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:49 INFO - 'NO_EM_RESTART': '1', 16:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:49 INFO - 'PWD': '/builds/slave/test', 16:07:49 INFO - 'SHELL': '/bin/bash', 16:07:49 INFO - 'SHLVL': '1', 16:07:49 INFO - 'TERM': 'linux', 16:07:49 INFO - 'TMOUT': '86400', 16:07:49 INFO - 'USER': 'cltbld', 16:07:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:49 INFO - '_': '/tools/buildbot/bin/python'} 16:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:07:49 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 16:07:49 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 16:07:49 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 16:07:49 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 16:07:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:07:50 INFO - Installing collected packages: mozsystemmonitor 16:07:50 INFO - Running setup.py install for mozsystemmonitor 16:07:50 INFO - Successfully installed mozsystemmonitor 16:07:50 INFO - Cleaning up... 16:07:50 INFO - Return code: 0 16:07:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07: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')]} 16:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:50 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 16:07:50 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 16:07:50 INFO - Using env: {'DISPLAY': ':0', 16:07:50 INFO - 'HOME': '/home/cltbld', 16:07:50 INFO - 'LANG': 'en_US.UTF-8', 16:07:50 INFO - 'LANGUAGE': 'en_US:en', 16:07:50 INFO - 'LOGNAME': 'cltbld', 16:07:50 INFO - 'MAIL': '/var/mail/cltbld', 16:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:50 INFO - 'MOZ_NO_REMOTE': '1', 16:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:50 INFO - 'NO_EM_RESTART': '1', 16:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:50 INFO - 'PWD': '/builds/slave/test', 16:07:50 INFO - 'SHELL': '/bin/bash', 16:07:50 INFO - 'SHLVL': '1', 16:07:50 INFO - 'TERM': 'linux', 16:07:50 INFO - 'TMOUT': '86400', 16:07:50 INFO - 'USER': 'cltbld', 16:07:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:50 INFO - '_': '/tools/buildbot/bin/python'} 16:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:50 INFO - Downloading/unpacking jsonschema==2.5.1 16:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:51 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:51 INFO - warning: no files found matching '*.txt' 16:07:51 INFO - no previously-included directories found matching 'build' 16:07:51 INFO - no previously-included directories found matching 'dist' 16:07:51 INFO - no previously-included directories found matching '.git*' 16:07:51 INFO - Installing collected packages: jsonschema, functools32 16:07:52 INFO - Running setup.py install for functools32 16:07:52 INFO - warning: no files found matching '*.txt' 16:07:52 INFO - no previously-included directories found matching 'build' 16:07:52 INFO - no previously-included directories found matching 'dist' 16:07:52 INFO - no previously-included directories found matching '.git*' 16:07:52 INFO - Successfully installed jsonschema functools32 16:07:52 INFO - Cleaning up... 16:07:52 INFO - Return code: 0 16:07:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:07:52 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')]} 16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:52 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')]} 16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:52 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:52 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 16:07:52 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 16:07:52 INFO - Using env: {'DISPLAY': ':0', 16:07:52 INFO - 'HOME': '/home/cltbld', 16:07:52 INFO - 'LANG': 'en_US.UTF-8', 16:07:52 INFO - 'LANGUAGE': 'en_US:en', 16:07:52 INFO - 'LOGNAME': 'cltbld', 16:07:52 INFO - 'MAIL': '/var/mail/cltbld', 16:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:52 INFO - 'MOZ_NO_REMOTE': '1', 16:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:52 INFO - 'NO_EM_RESTART': '1', 16:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:52 INFO - 'PWD': '/builds/slave/test', 16:07:52 INFO - 'SHELL': '/bin/bash', 16:07:52 INFO - 'SHLVL': '1', 16:07:52 INFO - 'TERM': 'linux', 16:07:52 INFO - 'TMOUT': '86400', 16:07:52 INFO - 'USER': 'cltbld', 16:07:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:52 INFO - '_': '/tools/buildbot/bin/python'} 16:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:07:52 INFO - Cleaning up... 16:07:52 INFO - Return code: 0 16:07:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07:52 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')]} 16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:52 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')]} 16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:52 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:52 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 16:07:52 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 16:07:52 INFO - Using env: {'DISPLAY': ':0', 16:07:52 INFO - 'HOME': '/home/cltbld', 16:07:52 INFO - 'LANG': 'en_US.UTF-8', 16:07:52 INFO - 'LANGUAGE': 'en_US:en', 16:07:52 INFO - 'LOGNAME': 'cltbld', 16:07:52 INFO - 'MAIL': '/var/mail/cltbld', 16:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:52 INFO - 'MOZ_NO_REMOTE': '1', 16:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:52 INFO - 'NO_EM_RESTART': '1', 16:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:52 INFO - 'PWD': '/builds/slave/test', 16:07:52 INFO - 'SHELL': '/bin/bash', 16:07:52 INFO - 'SHLVL': '1', 16:07:52 INFO - 'TERM': 'linux', 16:07:52 INFO - 'TMOUT': '86400', 16:07:52 INFO - 'USER': 'cltbld', 16:07:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:52 INFO - '_': '/tools/buildbot/bin/python'} 16:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:52 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 16:07:52 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 16:07:52 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 16:07:52 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 16:07:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:54 INFO - Downloading docopt-0.6.1.tar.gz 16:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:54 INFO - Running setup.py install for blobuploader 16:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:54 INFO - Running setup.py install for requests 16:07:54 INFO - Running setup.py install for docopt 16:07:54 INFO - Successfully installed blobuploader requests docopt 16:07:54 INFO - Cleaning up... 16:07:54 INFO - Return code: 0 16:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:54 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')]} 16:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:54 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')]} 16:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:54 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:54 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 16:07:54 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 16:07:54 INFO - Using env: {'DISPLAY': ':0', 16:07:54 INFO - 'HOME': '/home/cltbld', 16:07:54 INFO - 'LANG': 'en_US.UTF-8', 16:07:54 INFO - 'LANGUAGE': 'en_US:en', 16:07:54 INFO - 'LOGNAME': 'cltbld', 16:07:54 INFO - 'MAIL': '/var/mail/cltbld', 16:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:54 INFO - 'MOZ_NO_REMOTE': '1', 16:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:54 INFO - 'NO_EM_RESTART': '1', 16:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:54 INFO - 'PWD': '/builds/slave/test', 16:07:54 INFO - 'SHELL': '/bin/bash', 16:07:54 INFO - 'SHLVL': '1', 16:07:54 INFO - 'TERM': 'linux', 16:07:54 INFO - 'TMOUT': '86400', 16:07:54 INFO - 'USER': 'cltbld', 16:07:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:54 INFO - '_': '/tools/buildbot/bin/python'} 16:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:55 INFO - Running setup.py (path:/tmp/pip-HIkNuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:55 INFO - Running setup.py (path:/tmp/pip-C58MkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:55 INFO - Running setup.py (path:/tmp/pip-0I030f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:55 INFO - Running setup.py (path:/tmp/pip-6JLmb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:55 INFO - Running setup.py (path:/tmp/pip-Hxo_Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:55 INFO - Running setup.py (path:/tmp/pip-z_SfXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:55 INFO - Running setup.py (path:/tmp/pip-Hy5LWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:55 INFO - Running setup.py (path:/tmp/pip-Ms7iig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:55 INFO - Running setup.py (path:/tmp/pip-HRmCVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:55 INFO - Running setup.py (path:/tmp/pip-5Mh6qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:55 INFO - Running setup.py (path:/tmp/pip-19HfLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:55 INFO - Running setup.py (path:/tmp/pip-RdMtQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:55 INFO - Running setup.py (path:/tmp/pip-4db8dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:56 INFO - Running setup.py (path:/tmp/pip-YfH8lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:56 INFO - Running setup.py (path:/tmp/pip-DAz8Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:56 INFO - Running setup.py (path:/tmp/pip-5YXyXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:56 INFO - Running setup.py (path:/tmp/pip-MwESGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:56 INFO - Running setup.py install for manifestparser 16:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:56 INFO - Running setup.py install for mozcrash 16:07:56 INFO - Running setup.py install for mozdebug 16:07:56 INFO - Running setup.py install for mozdevice 16:07:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:56 INFO - Running setup.py install for mozfile 16:07:56 INFO - Running setup.py install for mozhttpd 16:07:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:56 INFO - Running setup.py install for mozinfo 16:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozInstall 16:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozleak 16:07:57 INFO - Running setup.py install for mozlog 16:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for moznetwork 16:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozprocess 16:07:57 INFO - Running setup.py install for mozprofile 16:07:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozrunner 16:07:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozscreenshot 16:07:57 INFO - Running setup.py install for moztest 16:07:57 INFO - Running setup.py install for mozversion 16:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:58 INFO - Cleaning up... 16:07:58 INFO - Return code: 0 16:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:58 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')]} 16:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:58 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')]} 16:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:58 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:07:58 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 16:07:58 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 16:07:58 INFO - Using env: {'DISPLAY': ':0', 16:07:58 INFO - 'HOME': '/home/cltbld', 16:07:58 INFO - 'LANG': 'en_US.UTF-8', 16:07:58 INFO - 'LANGUAGE': 'en_US:en', 16:07:58 INFO - 'LOGNAME': 'cltbld', 16:07:58 INFO - 'MAIL': '/var/mail/cltbld', 16:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:58 INFO - 'MOZ_NO_REMOTE': '1', 16:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:58 INFO - 'NO_EM_RESTART': '1', 16:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:58 INFO - 'PWD': '/builds/slave/test', 16:07:58 INFO - 'SHELL': '/bin/bash', 16:07:58 INFO - 'SHLVL': '1', 16:07:58 INFO - 'TERM': 'linux', 16:07:58 INFO - 'TMOUT': '86400', 16:07:58 INFO - 'USER': 'cltbld', 16:07:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:58 INFO - '_': '/tools/buildbot/bin/python'} 16:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:58 INFO - Running setup.py (path:/tmp/pip-Jf9ydl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:58 INFO - Running setup.py (path:/tmp/pip-U87jbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:58 INFO - Running setup.py (path:/tmp/pip-tWphA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:58 INFO - Running setup.py (path:/tmp/pip-_zSqhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:58 INFO - Running setup.py (path:/tmp/pip-naBfgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:58 INFO - Running setup.py (path:/tmp/pip-lT9xxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:58 INFO - Running setup.py (path:/tmp/pip-6pLvRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:58 INFO - Running setup.py (path:/tmp/pip-C64u38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:58 INFO - Running setup.py (path:/tmp/pip-T_bPuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:58 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)) 16:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:58 INFO - Running setup.py (path:/tmp/pip-SyOD7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:59 INFO - Running setup.py (path:/tmp/pip-u1eLCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:59 INFO - Running setup.py (path:/tmp/pip-0rsdhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:59 INFO - Running setup.py (path:/tmp/pip-1S0GMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:59 INFO - Running setup.py (path:/tmp/pip-g6rHSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:59 INFO - Running setup.py (path:/tmp/pip-Nn50ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:59 INFO - Running setup.py (path:/tmp/pip-CJjRJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:59 INFO - Running setup.py (path:/tmp/pip-VxM4cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:59 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)) 16:07:59 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)) 16:07:59 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)) 16:07:59 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)) 16:07:59 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)) 16:07:59 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)) 16:07:59 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)) 16:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:59 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 16:07:59 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 16:07:59 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 16:07:59 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 16:08:00 INFO - Downloading blessings-1.6.tar.gz 16:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:00 INFO - Installing collected packages: blessings 16:08:00 INFO - Running setup.py install for blessings 16:08:00 INFO - Successfully installed blessings 16:08:00 INFO - Cleaning up... 16:08:00 INFO - Return code: 0 16:08:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:01 INFO - Reading from file tmpfile_stdout 16:08:01 INFO - Current package versions: 16:08:01 INFO - argparse == 1.2.1 16:08:01 INFO - blessings == 1.6 16:08:01 INFO - blobuploader == 1.2.4 16:08:01 INFO - docopt == 0.6.1 16:08:01 INFO - functools32 == 3.2.3-2 16:08:01 INFO - jsonschema == 2.5.1 16:08:01 INFO - manifestparser == 1.1 16:08:01 INFO - mozInstall == 1.13 16:08:01 INFO - mozcrash == 1.0 16:08:01 INFO - mozdebug == 0.1 16:08:01 INFO - mozdevice == 0.51 16:08:01 INFO - mozfile == 1.2 16:08:01 INFO - mozhttpd == 0.7 16:08:01 INFO - mozinfo == 0.10 16:08:01 INFO - mozleak == 0.1 16:08:01 INFO - mozlog == 3.5 16:08:01 INFO - moznetwork == 0.27 16:08:01 INFO - mozprocess == 0.25 16:08:01 INFO - mozprofile == 0.28 16:08:01 INFO - mozrunner == 6.13 16:08:01 INFO - mozscreenshot == 0.1 16:08:01 INFO - mozsystemmonitor == 0.3 16:08:01 INFO - moztest == 0.8 16:08:01 INFO - mozversion == 1.4 16:08:01 INFO - psutil == 3.1.1 16:08:01 INFO - requests == 1.2.3 16:08:01 INFO - wsgiref == 0.1.2 16:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:01 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')]} 16:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:01 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')]} 16:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:01 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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:08:01 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 16:08:01 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 16:08:01 INFO - Using env: {'DISPLAY': ':0', 16:08:01 INFO - 'HOME': '/home/cltbld', 16:08:01 INFO - 'LANG': 'en_US.UTF-8', 16:08:01 INFO - 'LANGUAGE': 'en_US:en', 16:08:01 INFO - 'LOGNAME': 'cltbld', 16:08:01 INFO - 'MAIL': '/var/mail/cltbld', 16:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:01 INFO - 'MOZ_NO_REMOTE': '1', 16:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:01 INFO - 'NO_EM_RESTART': '1', 16:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:01 INFO - 'PWD': '/builds/slave/test', 16:08:01 INFO - 'SHELL': '/bin/bash', 16:08:01 INFO - 'SHLVL': '1', 16:08:01 INFO - 'TERM': 'linux', 16:08:01 INFO - 'TMOUT': '86400', 16:08:01 INFO - 'USER': 'cltbld', 16:08:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:01 INFO - '_': '/tools/buildbot/bin/python'} 16:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 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)) 16:08:01 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:08:01 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 16:08:01 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 16:08:01 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 16:08:01 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 16:08:02 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:08:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:08:02 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)) 16:08:02 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)) 16:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:08:02 INFO - Installing collected packages: marionette-driver, simplejson 16:08:02 INFO - Running setup.py install for marionette-driver 16:08:02 INFO - Running setup.py install for simplejson 16:08:02 INFO - building 'simplejson._speedups' extension 16:08:02 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 16:08:03 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 16:08:03 INFO - Successfully installed marionette-driver simplejson 16:08:03 INFO - Cleaning up... 16:08:03 INFO - Return code: 0 16:08:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:08:03 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')]} 16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:03 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')]} 16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xc731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', '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 16:08:03 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 16:08:03 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 16:08:03 INFO - Using env: {'DISPLAY': ':0', 16:08:03 INFO - 'HOME': '/home/cltbld', 16:08:03 INFO - 'LANG': 'en_US.UTF-8', 16:08:03 INFO - 'LANGUAGE': 'en_US:en', 16:08:03 INFO - 'LOGNAME': 'cltbld', 16:08:03 INFO - 'MAIL': '/var/mail/cltbld', 16:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:03 INFO - 'MOZ_NO_REMOTE': '1', 16:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:03 INFO - 'NO_EM_RESTART': '1', 16:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:03 INFO - 'PWD': '/builds/slave/test', 16:08:03 INFO - 'SHELL': '/bin/bash', 16:08:03 INFO - 'SHLVL': '1', 16:08:03 INFO - 'TERM': 'linux', 16:08:03 INFO - 'TMOUT': '86400', 16:08:03 INFO - 'USER': 'cltbld', 16:08:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:03 INFO - '_': '/tools/buildbot/bin/python'} 16:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:08:04 INFO - Cleaning up... 16:08:04 INFO - Return code: 0 16:08:04 INFO - Running post-action listener: _resource_record_post_action 16:08:04 INFO - Running post-action listener: _start_resource_monitoring 16:08:04 INFO - Starting resource monitoring. 16:08:04 INFO - [mozharness: 2017-07-10 23:08:04.111981Z] Finished create-virtualenv step (success) 16:08:04 INFO - [mozharness: 2017-07-10 23:08:04.112492Z] Running install step. 16:08:04 INFO - Running pre-action listener: _resource_record_pre_action 16:08:04 INFO - Running main action method: install 16:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:04 INFO - Reading from file tmpfile_stdout 16:08:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:08:04 INFO - Reading from file tmpfile_stdout 16:08:04 INFO - Output received: 16:08:04 INFO - Usage: mozinstall [options] installer 16:08:04 INFO - Options: 16:08:04 INFO - -h, --help show this help message and exit 16:08:04 INFO - -d DEST, --destination=DEST 16:08:04 INFO - Directory to install application into. [default: 16:08:04 INFO - "/builds/slave/test"] 16:08:04 INFO - --app=APP Application being installed. [default: firefox] 16:08:04 INFO - mkdir: /builds/slave/test/build/application 16:08:04 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'] 16:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:08:22 INFO - Reading from file tmpfile_stdout 16:08:22 INFO - Output received: 16:08:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:08:22 INFO - Running post-action listener: _resource_record_post_action 16:08:22 INFO - [mozharness: 2017-07-10 23:08:22.315534Z] Finished install step (success) 16:08:22 INFO - [mozharness: 2017-07-10 23:08:22.315787Z] Running setup-mitmproxy step. 16:08:22 INFO - Running pre-action listener: _resource_record_pre_action 16:08:22 INFO - Running main action method: setup_mitmproxy 16:08:22 INFO - Skipping: mitmproxy is not required 16:08:22 INFO - Running post-action listener: _resource_record_post_action 16:08:22 INFO - [mozharness: 2017-07-10 23:08:22.316961Z] Finished setup-mitmproxy step (success) 16:08:22 INFO - [mozharness: 2017-07-10 23:08:22.317221Z] Running run-tests step. 16:08:22 INFO - Running pre-action listener: _resource_record_pre_action 16:08:22 INFO - Running pre-action listener: _set_gcov_prefix 16:08:22 INFO - Running main action method: run_tests 16:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:08:22 INFO - Python 2.7.3 16:08:22 INFO - Return code: 0 16:08:22 INFO - grabbing minidump binary from tooltool 16:08:22 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')]} 16:08:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0xfe62a0>, '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 0xfe72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe14d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:08:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:08:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:08:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:08:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:22 INFO - Return code: 0 16:08:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:08:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:08:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:08:22 INFO - ENV: RUST_BACKTRACE is now 1 16:08:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:08:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:08:22 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/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:08:22 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/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 16:08:22 INFO - Using env: {'DISPLAY': ':0', 16:08:22 INFO - 'HOME': '/home/cltbld', 16:08:22 INFO - 'LANG': 'en_US.UTF-8', 16:08:22 INFO - 'LANGUAGE': 'en_US:en', 16:08:22 INFO - 'LOGNAME': 'cltbld', 16:08:22 INFO - 'MAIL': '/var/mail/cltbld', 16:08:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:22 INFO - 'MOZ_NO_REMOTE': '1', 16:08:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:22 INFO - 'NO_EM_RESTART': '1', 16:08:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:22 INFO - 'PWD': '/builds/slave/test', 16:08:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:22 INFO - 'RUST_BACKTRACE': '1', 16:08:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:08:22 INFO - 'SHELL': '/bin/bash', 16:08:22 INFO - 'SHLVL': '1', 16:08:22 INFO - 'TERM': 'linux', 16:08:22 INFO - 'TMOUT': '86400', 16:08:22 INFO - 'USER': 'cltbld', 16:08:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212', 16:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:22 INFO - '_': '/tools/buildbot/bin/python'} 16:08:22 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/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:08:22 INFO - mozversion application_buildid: 20170710215417 16:08:22 INFO - mozversion application_changeset: 5d794bf4c4653153e602631f1b8818acd559d8f5 16:08:22 INFO - mozversion application_display_name: Nightly 16:08:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:22 INFO - mozversion application_name: Firefox 16:08:22 INFO - mozversion application_remotingname: firefox 16:08:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:08:22 INFO - mozversion application_vendor: Mozilla 16:08:22 INFO - mozversion application_version: 56.0a1 16:08:22 INFO - mozversion platform_buildid: 20170710215417 16:08:22 INFO - mozversion platform_changeset: 5d794bf4c4653153e602631f1b8818acd559d8f5 16:08:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:08:22 INFO - mozversion platform_version: 56.0a1 16:08:22 INFO - using testdate: 1499728102 16:08:22 INFO - actual date: 1499728102 16:08:22 INFO - starting webserver on 'localhost:35961' 16:08:22 INFO - SUITE-START | Running 2 tests 16:08:22 INFO - TEST-START | dromaeo_css 16:08:22 INFO - Initialising browser for dromaeo_css test... 16:08:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35961/getInfo.html -profile /tmp/tmpKFkOWX/profile 16:08:22 INFO - TEST-INFO | started process 6252 (/builds/slave/test/build/application/firefox/firefox http://localhost:35961/getInfo.html) 16:08:28 INFO - TEST-INFO | 6252: exit 0 16:08:28 INFO - Browser initialized. 16:08:28 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:28 INFO - TEST-INFO | started process 6461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKFkOWX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:39 INFO - PID 6461 | RSS: Main: 163442688 16:08:39 INFO - PID 6461 | 16:11:39 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35961/tests/dromaeo/cssquery-ext.html) 16:11:41 INFO - PID 6461 | RSS: Main: 168452096 16:11:41 INFO - PID 6461 | 16:14:42 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-ext.html (next: http://localhost:35961/tests/dromaeo/cssquery-jquery.html) 16:14:43 INFO - PID 6461 | RSS: Main: 168828928 16:14:43 INFO - PID 6461 | 16:17:44 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35961/tests/dromaeo/cssquery-mootools.html) 16:17:45 INFO - PID 6461 | RSS: Main: 171716608 16:17:45 INFO - PID 6461 | 16:20:47 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35961/tests/dromaeo/cssquery-prototype.html) 16:20:47 INFO - PID 6461 | RSS: Main: 170233856 16:20:47 INFO - PID 6461 | 16:23:50 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35961/tests/dromaeo/cssquery-yui.html) 16:23:51 INFO - PID 6461 | RSS: Main: 169897984 16:23:51 INFO - PID 6461 | 16:26:52 INFO - PID 6461 | Cycle 1(1): loaded http://localhost:35961/tests/dromaeo/cssquery-yui.html (next: http://localhost:35961/tests/dromaeo/cssquery-dojo.html) 16:26:53 INFO - PID 6461 | RSS: Main: 173297664 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | __start_tp_report 16:26:53 INFO - PID 6461 | _x_x_mozilla_page_load 16:26:53 INFO - PID 6461 | _x_x_mozilla_page_load_details 16:26:53 INFO - PID 6461 | |i|pagename|runs| 16:26:53 INFO - PID 6461 | |0;dojo.html;3322.4850148227033;3422.0589337932074;3437.948430773539;3444.7244220462358;3451.879184228551;6100.572959892809;6111.388861113892;6163.784267550636;6171.537134714898;6220.906686399708;6140.171076904617;6167.38326167383;6167.599106058103;6167.691615419222;6193.380661933805;5420.915816836638;5421.430749771276;5424.891502169954;5447.891042179154;5486.149646804752;5387.622866399353;5449.536789372908;5480.3971563128025;5480.780768769245;5498.477644623755;5468.398476167618;5482.095454250044;5485.4788795064605;5489;5496.615236933416;5457.181422786574;5465.344158700942;5470.097433923398;5470.370907345667;5485.286912701363;5416.783328666888;5439.836804895859;5458.536024437927;5480.287562616834;5521.834344969658;6178.165947597062;6213.285472170668;6228.065790131472;6245.437910588023;6283.717232724538;6540.247871494744;6635.6682165892;6678.9332106679285;6802.115724955774;6804.863902721918;6703.195616526048;6703.765368212089;6717.328267173292;6717.361850624183;6718.899216511756;6102.633841969496;6132.41742034506;6164.167837341946;6198.938010619926;6213.285472170668;5208.921866172011;6737.865242695168;6916.20463646677;6939.93060069403;7028.824279392954;6596.241432235259;6655.900161497581;6668.599884006975;6719.328067193339;6736.292689267654;6774.661266936633;6784.626845523544;6805.455563554904;6877.65611719412;6894.655267236618;6409.615423074631;6551.672416379257;6586;6605.07528945948;6618.966905165444;5242.501962313574;6579.769708060195;6737.461003119739;6822.761203357859;6843.247242803288;4929.162042452792;5061.190209566452;5092;5103.413107492686;5129.820456284012;4446.777661116931;4471.888202794956;4481.910361792811;4483.663725220622;4510.932336014962;6269.498440124779;6270.15352927349;6274.309825919146;6277.780277690259;6281.497480201573;6666.799996000128;6669.233038200572;6671.933280667131;6686.331366863372;6687.732490700415;6212.099245609361;6278.497720182374;6290.716917738713;6355.745770169234;6376.649284289316;5634.746436410372;5728.598998070095;5730.054541000772;5744.885102297931;5819.6508209507565;6864.279250678706;6937.965310173417;6940.583564986016;6946.930530694628;6959.234484206733;6552.180977377828;6554.508411869224;6600.207975043026;6613.900791488035;6622.304658011032;6936.79189624312;7057.611831349325;7061.788146355618;7114.110736157981;7123.7506687265695;6550;6601.801945941629;6618.768343107968;6683.097781799589;6703.798886033232;6571.605703657796;6705.597664140168;6727.562708423937;6799.048133261446;6829;6473.320301368289;6496.967515162394;6505.7072431741635;6511.251206111168;6513.54405191632;6440.710168042356;6482.416582507597;6489.643069631215;6491.642959637076;6491.805245842632;5078.644494885322;6466.385693359123;6523.31505191967;6528.836779080561;6621.668916554249;6540.476761858945;6602.10871532337;6625.337466253336;6682.398584127452;6707.463402927657;6369.299377068426;6420.678966051585;6463.870722585428;6472.546921715435;6485.351464853666 16:26:53 INFO - PID 6461 | |1;ext.html;883.9823004444797;920.8296465153951;940.2853831088373;968.365720453103;969.5540051576274;42852.57147428529;43983.56016439835;44141.77929110354;44211.77894110533;44390;41026.79486602563;41343.58656413435;41369;41432.58567414325;41444;6736.66316684165;6812.727490900358;6813.693383797741;6826.795196144124;6836.248012718597;6634.5687530310615;6829.3170682931805;6838.14523184602;6840.28177041411;6846.281140480252;6816.659167041653;6852.588844669336;6860.55406398585;6865.656717164146;6871.347222013926;6749.628770417625;6791.117154769849;6830.624315662637;6834.760783372608;6840.760573379933;5233.450487698813;5271.657342272779;5273.209018647233;5278.208268759717;5280.102382594968;36134;36413;36445.45331820025;36465.63534364649;36535.26929461423;3450.9827450862836;3461.498082777983;3483.599386070609;3622.8188590570367;3682.5949145593963;31101.06696799077;31293.530597041063;32198.195045123826;32490.512642310383;32577.348453031045;4209.494860616745;4329.848455304081;4396.428464299653;4403.493598236212;4413.823447062114;207611;209302;211343.94328028415;215783;217043;47152.22782177418;51067.7446612772;52401.7379913098;52590;52971;54979.175312370346;55275.170872436946;55443.72278138583;55496.16755748667;55559.16661250084;16420;16542.42101526441;16577.66844663124;16586;16679.166041697867;13509.527166549124;13538;13612.31938403076;13690.38393272305;13767.793483097761;15167.559081887202;15243.618909527351;15276.930614856854;15295.311710973034;15332;6046.18376519173;6065;6068.21113255274;6160.969195153995;6211.378862113843;1078.8058149533003;1096.3969816600838;1105.165599972016;1115.3252282369212;1121.0471099565468;25038.874805625856;25152.74847251504;25156.87421562917;25225.24324270275;25231.495370092496;1199.154596009811;1211.9151659383936;1227.4660522672666;1236.9196002259823;1237.1525505029083;13350.599482015556;13491.392887320095;13502.932485337511;13550.864491355158;13690.589282321545;279311;281148;281312;281832;281903;57040.429595703514;57289.713551431974;57413.42586574164;57611.711941440866;57642.7117864408;1516.7118247532933;1552.6428921348154;1578.9921050394905;1582.106652718614;1584.7226735321274;24408.389790255387;24781.364366131227;24951.500969980134;25039.24882253535;25222.62166067547;41104;41146;41256.174876501704;41308.58691413047;41362.37956430596;215877;216617;217795;218015;218070;34062.65937340694;34201.486977694854;36357.45463817992;37163.628363716016;37315.44026839654;42379.7881010593;46012;46394.30408543807;46658.30012549883;46762.532374675815;32853;33291.1677208062;33884;34008.65991340055;34585;33539;33579;33924.32151357008;34240.65759342375;34271.31457370789;43491.78254108836;43700;43877.56122438735;44450.110997779215;44639;33906.49140262849;35468.290634186655;35871.82064089663;35967.28065438624;36297.27405451823;26473.867630662495;26657;26921.86539067292;26978.865105674347;27166.72833271721 16:26:53 INFO - PID 6461 | |2;jquery.html;554.9167624856271;558.6173471172248;568.9345725241599;576.5214871656525;584.1034012790366;23037.884810575946;23807.404814879636;23975.880120599417;24069.518609627798;24077.75922240777;25700.357491062732;26937.595936060927;27821.582676259823;28234.294142646446;28394.29014274639;6289.213848268978;6466.708998095073;6484.092227088211;6487.643179625119;6493.577917435376;6327.746890124413;6356.650384228866;6358.078078678589;6383.616982981036;6402.039694045907;4168.1038576706005;4817.51824817519;6350.460210882057;6385.584936979105;6443.774467893625;6391.968040159816;6405.231372235338;6407.423331900105;6408.455281301095;6418.903716444257;5914.852128696774;5922.4077592240865;5937.228160339171;5940.316863560703;5942.762289508414;30329.848350758326;31192.220194495094;31503;31564;31743.365132697447;2198.934031979043;2232.48652809853;2242.798148166673;2245.7754224577575;2257.063318722728;19675.508112297306;20083.598328033357;20164.19343226269;20173.8991305044;20202;2160.7839216078423;2172.2071443923014;2221.3224966385246;2224.621814291558;2238.8992495337748;147701;149478.25260873736;150283;150945.24527377292;153114;15058.397664093314;15341.769873451907;15462.29914709381;15548.445155484587;15663.608409789846;23491.530169396516;23499.29502114939;23627.645585316233;23659.408514786923;23693.289201323987;10453.111485523816;10585.153187744962;10598;10752.838707419238;10758.354498730101;9820.65627703027;9870.950645246729;9897.66381538483;10018.098371146632;10047.734486291984;9484.857727134098;9631.133198012212;9644.95177524108;9761.707148785548;9791.216702663769;2738.6169984157873;2756.8208066475613;2777.8472184030074;2828.75955543777;2831.9858400707863;1029.1766586730585;1030.7526193713454;1038.60532997462;1052.2634156090767;1076.2197406880107;21482.24812131568;21649.89175054115;21856.125754969624;22181.334559963227;22456.887715561643;1097.8408130820985;1121.4448847820381;1135.636596289196;1143.9771204576027;1145.5990403358924;11949.402529873472;12529;12556.304898838722;12599.685007874694;14357;577032;600787;606647;608875;612972;135978;139865;141024;142055;142451;1280.8783165599439;1302.7199152182327;1337.9799303010464;1347.7776166932347;1363.3932899859467;22101.447463813533;22826.885865570566;22937;23029.76970230276;23039.53920921606;64078.35921640724;66772.3322766766;67243;67557;67855.66072169607;82300.58849705714;82661.58669206615;83099.16900831157;83635.5818220905;84538.57730711553;15147.242637868283;15248.161351125795;15344.923275383999;15420.537383878052;15426.614334641723;24726.752732472443;24838;26223.737762622128;26261.868690656425;26446.206613801616;20321.390358289274;20837.166513339296;21223.044962977012;21393.67909481328;21645.567088658452;16744.748828767333;17225.655486890442;17299;17631.911840440716;18054.91670499774;19822.900885496056;20851.061702223134;20943.58112837704;20962.58074838464;20976;14778.704425911637;15548.222588870285;15659;15671.138087405303;15692.68614627724;19045.809541904404;19333.613327733085;19382.837029778257;19462.12420441112;19471.805281947567 16:26:53 INFO - PID 6461 | |3;mootools.html;1387.0498708384757;1415.2287003583046;1466.9486567970116;1468.155810409015;1469.6693244020103;14612;15285.312160952742;15292.082475051504;15314.846851531482;15352.385904563833;14696.338664760086;14960.326785294661;15060.623484412896;15069.773953390708;15094.09435433872;2701.0546308791963;2755.779537636984;2764.543850264704;2767.2805070681666;2770.7229277072333;2719.714429984853;2782.5408807546733;2784.470950519395;2785.777137828979;2785.8885644574193;2667.7599016088548;2704.864756762164;2758.3655759175404;2758.475889580973;2781.207355903568;2769.62610047643;2782.596523504081;2789.553671412574;2803.5654473556633;2808.4383123375405;2612.8301660392012;2646.1267781632014;2650.112212408845;2662.7204143565036;2669.6129061286197;14570.635734106627;14632.268386580628;14753.188574628392;14790.63023424423;14873.181974991372;7989.960050199712;8272.751817445485;8336.62485188168;8361.581920903931;8365.665373385058;5099.235114732783;5295.708736019517;5344.118220493614;5356.223347614613;5359.38367087786;1886.745314365945;1911.550785565391;1946.4549926020736;1962.8625996180274;1964.72493850861;26504.867475662497;26572;26673.799679014297;26923.730762692514;27098.864505677542;6766.357196066366;6790.354916282945;6902.6203558803745;7025.156981162293;7140.571565706075;17127.229274682668;17138.14309284531;17160.570985725455;17301.307947682202;17332.82667173312;8086.9191308086165;8183.468074575134;8198.262156405952;8227.753167404988;8246.958765206136;7463.514871533333;7559.055118110236;7560.508566943131;7569.772906812805;7618.885716714254;5305.124654432053;5409.323834520685;5452.318460192476;5458.863528411822;5473.370562385377;1501.196859680066;1507.5778781941074;1524.207412145678;1524.6340878189155;1531.693661267751;891.8216356728681;898.6046139698511;914.0950459045497;928.9860652090224;932.6689025396022;7444.73943411978;7567.621618919032;7597.354224890835;7599.658015389321;7636.885446718304;724.3372314332432;741.3661319571796;752.1763668782675;759.2824780582407;763.1872056260177;4424.933625995613;4934.1611925972675;5682.352117885767;5899.439553242435;6019.578629495893;19951;20761.58476830455;20763.896180519;20893.164273428894;20989.37031889046;20268.290609828586;20479.07844147017;20515.845836187284;20543.38369848907;20690.896545517175;11281.210315278016;11589.942050289694;11691.181617286707;11792.115591330685;12023.759524809455;7959.442839001446;8280.544570048463;8393.202645748644;8521.744347669579;8600.956995214983;17558.736618950472;17931.820681793535;18082;18516.259349625863;18622.81377186265;18706;18926.810731892503;19309.227630894606;19632;19842.801571984095;13278.734425311246;13706.725865482835;13884.722305554034;14029.789553156506;14047.719045619235;13973;14006.719865602427;14109.2945352734;14132.15207087578;14133.15201087938;10977.670669879917;11313.773724525628;11450.37022963745;11847.9929206015;12013.45939432745;11399.20205585601;11404.714882128013;11562.595309164475;11816.172867899508;11934.164608477324;10111.949440252753;10241.487925603838;10247.7438064049;10323.63867264642;10328.793424131625;7000.824979375557;7189.173245076674;7382.335589796944;7452.441066920112;7512.8873066905135;6973.930260697328;7083.929160708327;7143.6428178591905;7178.60517671533;7211.495195336276 16:26:53 INFO - PID 6461 | |4;prototype.html;497.7307864944392;505.15134573915805;527.7281750980138;528.585060727329;536.3188750287136;5957.52339812815;5967.433093856088;5982.491488223495;6019.969900150499;6095.75616975321;5695.971520142404;5832.221172542383;5945.721669840983;5983;5987.341392446839;4623.56076172763;4628.583427491525;4641.675082744201;4682.742449165295;4687.062587482517;4620.422447194101;4633.698809577383;4644;4690.859274221762;4712.222483290253;4431.867043988669;4652;4655.508368723457;4671.813127474897;4695.6052413269135;4582.6104781093645;4620.712747190146;4632.745199014053;4643.2802915548145;4645.976770116128;4196.657069737686;4201.474815648044;4223.429836972;4233.322668373045;4234.809433575497;5754.798582049608;5785.5660825437835;5792.971035144839;5841.474267315962;5857.6778277194735;5437.293151890269;5496.230527726121;5525.419830917776;5536.501714845643;5573.888522229573;6358.682065896686;6387.87224255517;6389.1471473272695;6397.8400539986405;6424.453921416685;4806.086843499724;4817.78319975602;4821.325014497973;4822.63830212732;4833.29917162013;6691.866162676719;6699.296573859772;6730.730770769163;6739.157605299338;6767.593944363305;4951.72765497901;4956.91809440036;4958.380202474691;4970.204767237225;4971.862099297265;4949.975250123726;4995.327499787596;5019.3976722793495;5024.723640199824;5026.195808670595;5489.780408783604;5519.172124181325;5531.170324451284;5532.253145825262;5584.357798853184;6375.736613502233;6418.614883107029;6435.678216089177;6439.5170362223025;6479.282990007652;1722.6468573942311;1735.1671197825115;1735.8698097642475;1745.5548835047236;1754.921028553718;1127.1264769803304;1139.5272259197561;1212.5210541835925;1219.1405059433077;1235.7034311765112;5891.646501209942;5892.705364731746;5908.231929849178;5955.612885162451;6024.337322894478;6388.135178217205;6397.4562162216735;6470.7675851831045;6477.384648458389;6483.643399613066;5988;6064.151018857364;6068.787592434243;6071.574989750675;6097.634141951497;3403.7787543809573;3442.5008373785663;3478.1913405029245;3500.562429696288;3505.7204120496344;6765.594064356154;6839.794806155824;6866.759663411756;6897.965510172417;6916.861662766716;6676.79969600903;6700.329967003358;6709.691610136074;6716.5634233774645;6724.361185687352;6761.233330501985;6774.42417394527;6823.055429202654;6825.249222585412;6896.689648965808;6527.869442611216;6565.376289252514;6567.770128045687;6570.47436205112;6571.244306904767;6331.132315966709;6333.240011198685;6353.332900045429;6365.172527571386;6464.450521705708;6642.76750313756;6648.069270302259;6717.9328206719265;6775.1531058617675;6805.740937926499;4811.903761924812;4893.412790465167;4918.581920536794;4929.359183306147;4933.235348520985;6480.805575832733;6520.543561950808;6539.869202616016;6540.574862633914;6556.573822701509;6240.875182496416;6349.746010159542;6366.490680745622;6387.808365749035;6445.484361251182;6364.981602943507;6380.054083504576;6414.871702566016;6472.35276472349;6474.643894585843;6328.0824280478155;6344;6352.745890164341;6354.904676429765;6357.268914074941;5819.330776960704;6279.152314437492;6314.652694101868;6335.683215839282;6341.27075386318;6076.812347554788;6087.36082711309;6148.815535533941;6178.99182765594;6200.255969283715 16:26:53 INFO - PID 6461 | |5;yui.html;922.4280945813597;923.806000739845;934.7102398256541;947.5688561704425;965.2085290062149;17894.552636184086;18358.72461913069;18378.908105459486;18557.907210463964;18558.721619175707;17503.38738144165;17697.292108315683;17847.018413987225;17864.732029019575;19920.203191872344;1031.1802117316713;1057.7091299892552;1060.4697651174413;1062.3944351719524;1062.5537274344795;1056.1603525197447;1065.9893401066006;1066.7173199102244;1067.1622776120746;1070.550368845087;1113.3876367997568;1113.838493418454;1114.7046032801275;1120.5069769301522;1120.7030137013699;1053.0838170791385;1111.22214449885;1114.899659030691;1117.290520519472;1121.4336759936261;798.297498201579;799.9880001799978;802.7671975127206;807.8949736534272;810.088650268448;19067.141978610995;19207.135678894483;19251.22995080195;19369.709454358195;19373.32193373225;19047.42857714271;19872.602547949104;20099.598008039757;20152.29466968664;20152.69770953437;12959.870401296055;13152.736945261136;13249.205047697073;13289.13620614657;13291.933540332237;2963.866626001835;2988.9850550747324;2989.865456054483;2998.3553535989868;3006.4738670732754;100546.4972675132;118057.40971295089;121163;122031;125581.37209313986;12996.610101696964;14125.081869678643;14215.573532794033;14363.21002344881;14370;29094.27264318409;29455.11634650964;29621.25946851346;30242.395152096833;30441.238969025508;8921.01868794432;8924.464532128093;9020.594073266719;9109.908900910907;9148.085191480799;3958.960410395859;4121.175764847043;4125.608067233608;4155.916881662411;4171.353440216772;5199.896002079937;5250.684958902478;5296.4703529647495;5303.04545181871;5304.628675992721;984.606157536991;1068.7381591509975;1133.9149563782748;1135.1940122513108;1155.9595414160633;718.3534818663245;725.2058995400029;729.2197348836694;733.5818583407406;744.6462930108264;11734.88265117355;11811.940940295415;11831.526738930346;12907.419166137546;12930.418131184118;708.1679027143189;718.7304760714732;719.2591630620469;721.0446158839559;740.8110931712379;5438.15708565173;5582.134769110794;5635.464630860061;5643.548516118701;5783.4794868461195;119113;119665.40167299108;123271.383643083;124049.13926291112;126444;101319;103191.4840425808;106108;107426;108350.45824770826;95375.52312238533;96122;96683.99999999859;99214;100732;10892.40091794959;10930.344179349264;11006.944965275443;11023.779524409627;11378.03286720605;43426.07800357979;43441;44436;45426.772866135456;45869;56241.71879140578;57093.42906570881;58153.418465816496;58839.41160588339;59351;16117.516474505783;16574;16600.83399165993;16628.168591570615;16664.250108744895;17840;17883.105844707454;18214.544636383667;18462.076896155406;18474.538136546693;16572.419965301156;16761.664766704354;16968.83031169722;17067.317307308065;17405.129743513025;15702.371905123668;16102.758458623364;16259.918700406422;16527.256273467963;16716.916415417843;16701.2484438203;17138.828611714223;17173.31306747716;19483.220671172996;20621.484462888548;12432.316222607844;12808;13626.318684065955;13912.373943172379;14373.568792936228;14597;15008.849911501182;15296.770548442006;15333.386664533295;16181.11003894797 16:26:53 INFO - PID 6461 | __end_tp_report 16:26:53 INFO - PID 6461 | __start_cc_report 16:26:53 INFO - PID 6461 | _x_x_mozilla_cycle_collect,300 16:26:53 INFO - PID 6461 | __end_cc_report 16:26:53 INFO - PID 6461 | __startTimestamp1499729213158__endTimestamp 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | ------- Summary: start ------- 16:26:53 INFO - PID 6461 | Number of tests: 6 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#0] dojo.html Cycles:165 Average:6141.78 Median:6463.87 stddev:782.21 (12.1%) stddev-sans-first:752.70 16:26:53 INFO - PID 6461 | Values: 3322.5 3422.1 3437.9 3444.7 3451.9 6100.6 6111.4 6163.8 6171.5 6220.9 6140.2 6167.4 6167.6 6167.7 6193.4 5420.9 5421.4 5424.9 5447.9 5486.1 5387.6 5449.5 5480.4 5480.8 5498.5 5468.4 5482.1 5485.5 5489.0 5496.6 5457.2 5465.3 5470.1 5470.4 5485.3 5416.8 5439.8 5458.5 5480.3 5521.8 6178.2 6213.3 6228.1 6245.4 6283.7 6540.2 6635.7 6678.9 6802.1 6804.9 6703.2 6703.8 6717.3 6717.4 6718.9 6102.6 6132.4 6164.2 6198.9 6213.3 5208.9 6737.9 6916.2 6939.9 7028.8 6596.2 6655.9 6668.6 6719.3 6736.3 6774.7 6784.6 6805.5 6877.7 6894.7 6409.6 6551.7 6586.0 6605.1 6619.0 5242.5 6579.8 6737.5 6822.8 6843.2 4929.2 5061.2 5092.0 5103.4 5129.8 4446.8 4471.9 4481.9 4483.7 4510.9 6269.5 6270.2 6274.3 6277.8 6281.5 6666.8 6669.2 6671.9 6686.3 6687.7 6212.1 6278.5 6290.7 6355.7 6376.6 5634.7 5728.6 5730.1 5744.9 5819.7 6864.3 6938.0 6940.6 6946.9 6959.2 6552.2 6554.5 6600.2 6613.9 6622.3 6936.8 7057.6 7061.8 7114.1 7123.8 6550.0 6601.8 6618.8 6683.1 6703.8 6571.6 6705.6 6727.6 6799.0 6829.0 6473.3 6497.0 6505.7 6511.3 6513.5 6440.7 6482.4 6489.6 6491.6 6491.8 5078.6 6466.4 6523.3 6528.8 6621.7 6540.5 6602.1 6625.3 6682.4 6707.5 6369.3 6420.7 6463.9 6472.5 6485.4 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#1] ext.html Cycles:180 Average:41256.15 Median:19960.05 stddev:62236.73 (311.8%) stddev-sans-first:62337.49 16:26:53 INFO - PID 6461 | Values: 884.0 920.8 940.3 968.4 969.6 42852.6 43983.6 44141.8 44211.8 44390.0 41026.8 41343.6 41369.0 41432.6 41444.0 6736.7 6812.7 6813.7 6826.8 6836.2 6634.6 6829.3 6838.1 6840.3 6846.3 6816.7 6852.6 6860.6 6865.7 6871.3 6749.6 6791.1 6830.6 6834.8 6840.8 5233.5 5271.7 5273.2 5278.2 5280.1 36134.0 36413.0 36445.5 36465.6 36535.3 3451.0 3461.5 3483.6 3622.8 3682.6 31101.1 31293.5 32198.2 32490.5 32577.3 4209.5 4329.8 4396.4 4403.5 4413.8 207611.0 209302.0 211343.9 215783.0 217043.0 47152.2 51067.7 52401.7 52590.0 52971.0 54979.2 55275.2 55443.7 55496.2 55559.2 16420.0 16542.4 16577.7 16586.0 16679.2 13509.5 13538.0 13612.3 13690.4 13767.8 15167.6 15243.6 15276.9 15295.3 15332.0 6046.2 6065.0 6068.2 6161.0 6211.4 1078.8 1096.4 1105.2 1115.3 1121.0 25038.9 25152.7 25156.9 25225.2 25231.5 1199.2 1211.9 1227.5 1236.9 1237.2 13350.6 13491.4 13502.9 13550.9 13690.6 279311.0 281148.0 281312.0 281832.0 281903.0 57040.4 57289.7 57413.4 57611.7 57642.7 1516.7 1552.6 1579.0 1582.1 1584.7 24408.4 24781.4 24951.5 25039.2 25222.6 41104.0 41146.0 41256.2 41308.6 41362.4 215877.0 216617.0 217795.0 218015.0 218070.0 34062.7 34201.5 36357.5 37163.6 37315.4 42379.8 46012.0 46394.3 46658.3 46762.5 32853.0 33291.2 33884.0 34008.7 34585.0 33539.0 33579.0 33924.3 34240.7 34271.3 43491.8 43700.0 43877.6 44450.1 44639.0 33906.5 35468.3 35871.8 35967.3 36297.3 26473.9 26657.0 26921.9 26978.9 27166.7 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#2] jquery.html Cycles:180 Average:40226.64 Median:12351.33 stddev:100965.31 (817.4%) stddev-sans-first:101204.60 16:26:53 INFO - PID 6461 | Values: 554.9 558.6 568.9 576.5 584.1 23037.9 23807.4 23975.9 24069.5 24077.8 25700.4 26937.6 27821.6 28234.3 28394.3 6289.2 6466.7 6484.1 6487.6 6493.6 6327.7 6356.7 6358.1 6383.6 6402.0 4168.1 4817.5 6350.5 6385.6 6443.8 6392.0 6405.2 6407.4 6408.5 6418.9 5914.9 5922.4 5937.2 5940.3 5942.8 30329.8 31192.2 31503.0 31564.0 31743.4 2198.9 2232.5 2242.8 2245.8 2257.1 19675.5 20083.6 20164.2 20173.9 20202.0 2160.8 2172.2 2221.3 2224.6 2238.9 147701.0 149478.3 150283.0 150945.2 153114.0 15058.4 15341.8 15462.3 15548.4 15663.6 23491.5 23499.3 23627.6 23659.4 23693.3 10453.1 10585.2 10598.0 10752.8 10758.4 9820.7 9871.0 9897.7 10018.1 10047.7 9484.9 9631.1 9645.0 9761.7 9791.2 2738.6 2756.8 2777.8 2828.8 2832.0 1029.2 1030.8 1038.6 1052.3 1076.2 21482.2 21649.9 21856.1 22181.3 22456.9 1097.8 1121.4 1135.6 1144.0 1145.6 11949.4 12529.0 12556.3 12599.7 14357.0 577032.0 600787.0 606647.0 608875.0 612972.0 135978.0 139865.0 141024.0 142055.0 142451.0 1280.9 1302.7 1338.0 1347.8 1363.4 22101.4 22826.9 22937.0 23029.8 23039.5 64078.4 66772.3 67243.0 67557.0 67855.7 82300.6 82661.6 83099.2 83635.6 84538.6 15147.2 15248.2 15344.9 15420.5 15426.6 24726.8 24838.0 26223.7 26261.9 26446.2 20321.4 20837.2 21223.0 21393.7 21645.6 16744.7 17225.7 17299.0 17631.9 18054.9 19822.9 20851.1 20943.6 20962.6 20976.0 14778.7 15548.2 15659.0 15671.1 15692.7 19045.8 19333.6 19382.8 19462.1 19471.8 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#3] mootools.html Cycles:180 Average:9388.90 Median:2665.24 stddev:6606.04 (247.9%) stddev-sans-first:6597.21 16:26:53 INFO - PID 6461 | Values: 1387.0 1415.2 1466.9 1468.2 1469.7 14612.0 15285.3 15292.1 15314.8 15352.4 14696.3 14960.3 15060.6 15069.8 15094.1 2701.1 2755.8 2764.5 2767.3 2770.7 2719.7 2782.5 2784.5 2785.8 2785.9 2667.8 2704.9 2758.4 2758.5 2781.2 2769.6 2782.6 2789.6 2803.6 2808.4 2612.8 2646.1 2650.1 2662.7 2669.6 14570.6 14632.3 14753.2 14790.6 14873.2 7990.0 8272.8 8336.6 8361.6 8365.7 5099.2 5295.7 5344.1 5356.2 5359.4 1886.7 1911.6 1946.5 1962.9 1964.7 26504.9 26572.0 26673.8 26923.7 27098.9 6766.4 6790.4 6902.6 7025.2 7140.6 17127.2 17138.1 17160.6 17301.3 17332.8 8086.9 8183.5 8198.3 8227.8 8247.0 7463.5 7559.1 7560.5 7569.8 7618.9 5305.1 5409.3 5452.3 5458.9 5473.4 1501.2 1507.6 1524.2 1524.6 1531.7 891.8 898.6 914.1 929.0 932.7 7444.7 7567.6 7597.4 7599.7 7636.9 724.3 741.4 752.2 759.3 763.2 4424.9 4934.2 5682.4 5899.4 6019.6 19951.0 20761.6 20763.9 20893.2 20989.4 20268.3 20479.1 20515.8 20543.4 20690.9 11281.2 11589.9 11691.2 11792.1 12023.8 7959.4 8280.5 8393.2 8521.7 8601.0 17558.7 17931.8 18082.0 18516.3 18622.8 18706.0 18926.8 19309.2 19632.0 19842.8 13278.7 13706.7 13884.7 14029.8 14047.7 13973.0 14006.7 14109.3 14132.2 14133.2 10977.7 11313.8 11450.4 11848.0 12013.5 11399.2 11404.7 11562.6 11816.2 11934.2 10111.9 10241.5 10247.7 10323.6 10328.8 7000.8 7189.2 7382.3 7452.4 7512.9 6973.9 7083.9 7143.6 7178.6 7211.5 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#4] prototype.html Cycles:180 Average:5392.69 Median:5982.75 stddev:1541.64 (25.8%) stddev-sans-first:1501.54 16:26:53 INFO - PID 6461 | Values: 497.7 505.2 527.7 528.6 536.3 5957.5 5967.4 5982.5 6020.0 6095.8 5696.0 5832.2 5945.7 5983.0 5987.3 4623.6 4628.6 4641.7 4682.7 4687.1 4620.4 4633.7 4644.0 4690.9 4712.2 4431.9 4652.0 4655.5 4671.8 4695.6 4582.6 4620.7 4632.7 4643.3 4646.0 4196.7 4201.5 4223.4 4233.3 4234.8 5754.8 5785.6 5793.0 5841.5 5857.7 5437.3 5496.2 5525.4 5536.5 5573.9 6358.7 6387.9 6389.1 6397.8 6424.5 4806.1 4817.8 4821.3 4822.6 4833.3 6691.9 6699.3 6730.7 6739.2 6767.6 4951.7 4956.9 4958.4 4970.2 4971.9 4950.0 4995.3 5019.4 5024.7 5026.2 5489.8 5519.2 5531.2 5532.3 5584.4 6375.7 6418.6 6435.7 6439.5 6479.3 1722.6 1735.2 1735.9 1745.6 1754.9 1127.1 1139.5 1212.5 1219.1 1235.7 5891.6 5892.7 5908.2 5955.6 6024.3 6388.1 6397.5 6470.8 6477.4 6483.6 5988.0 6064.2 6068.8 6071.6 6097.6 3403.8 3442.5 3478.2 3500.6 3505.7 6765.6 6839.8 6866.8 6898.0 6916.9 6676.8 6700.3 6709.7 6716.6 6724.4 6761.2 6774.4 6823.1 6825.2 6896.7 6527.9 6565.4 6567.8 6570.5 6571.2 6331.1 6333.2 6353.3 6365.2 6464.5 6642.8 6648.1 6717.9 6775.2 6805.7 4811.9 4893.4 4918.6 4929.4 4933.2 6480.8 6520.5 6539.9 6540.6 6556.6 6240.9 6349.7 6366.5 6387.8 6445.5 6365.0 6380.1 6414.9 6472.4 6474.6 6328.1 6344.0 6352.7 6354.9 6357.3 5819.3 6279.2 6314.7 6335.7 6341.3 6076.8 6087.4 6148.8 6179.0 6200.3 16:26:53 INFO - PID 6461 | 16:26:53 INFO - PID 6461 | [#5] yui.html Cycles:180 Average:23659.10 Median:17843.51 stddev:33322.26 (186.7%) stddev-sans-first:33372.00 16:26:53 INFO - PID 6461 | Values: 922.4 923.8 934.7 947.6 965.2 17894.6 18358.7 18378.9 18557.9 18558.7 17503.4 17697.3 17847.0 17864.7 19920.2 1031.2 1057.7 1060.5 1062.4 1062.6 1056.2 1066.0 1066.7 1067.2 1070.6 1113.4 1113.8 1114.7 1120.5 1120.7 1053.1 1111.2 1114.9 1117.3 1121.4 798.3 800.0 802.8 807.9 810.1 19067.1 19207.1 19251.2 19369.7 19373.3 19047.4 19872.6 20099.6 20152.3 20152.7 12959.9 13152.7 13249.2 13289.1 13291.9 2963.9 2989.0 2989.9 2998.4 3006.5 100546.5 118057.4 121163.0 122031.0 125581.4 12996.6 14125.1 14215.6 14363.2 14370.0 29094.3 29455.1 29621.3 30242.4 30441.2 8921.0 8924.5 9020.6 9109.9 9148.1 3959.0 4121.2 4125.6 4155.9 4171.4 5199.9 5250.7 5296.5 5303.0 5304.6 984.6 1068.7 1133.9 1135.2 1156.0 718.4 725.2 729.2 733.6 744.6 11734.9 11811.9 11831.5 12907.4 12930.4 708.2 718.7 719.3 721.0 740.8 5438.2 5582.1 5635.5 5643.5 5783.5 119113.0 119665.4 123271.4 124049.1 126444.0 101319.0 103191.5 106108.0 107426.0 108350.5 95375.5 96122.0 96684.0 99214.0 100732.0 10892.4 10930.3 11006.9 11023.8 11378.0 43426.1 43441.0 44436.0 45426.8 45869.0 56241.7 57093.4 58153.4 58839.4 59351.0 16117.5 16574.0 16600.8 16628.2 16664.3 17840.0 17883.1 18214.5 18462.1 18474.5 16572.4 16761.7 16968.8 17067.3 17405.1 15702.4 16102.8 16259.9 16527.3 16716.9 16701.2 17138.8 17173.3 19483.2 20621.5 12432.3 12808.0 13626.3 13912.4 14373.6 14597.0 15008.8 15296.8 15333.4 16181.1 16:26:53 INFO - PID 6461 | -------- Summary: end -------- 16:26:53 INFO - PID 6461 | 16:26:53 INFO - TEST-INFO | 6461: exit 0 16:26:53 INFO - TEST-OK | dromaeo_css | took 1110979ms 16:26:53 INFO - TEST-START | kraken 16:26:53 INFO - Initialising browser for kraken test... 16:26:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35961/getInfo.html -profile /tmp/tmpsY6IdN/profile 16:26:53 INFO - TEST-INFO | started process 6869 (/builds/slave/test/build/application/firefox/firefox http://localhost:35961/getInfo.html) 16:26:58 INFO - TEST-INFO | 6869: exit 0 16:26:59 INFO - Browser initialized. 16:26:59 INFO - Running cycle 1/1 for kraken test... 16:26:59 INFO - TEST-INFO | started process 7078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsY6IdN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:27:10 INFO - PID 7078 | RSS: Main: 164044800 16:27:10 INFO - PID 7078 | 16:27:12 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35961/tests/kraken/driver.html?testName=audio-beat-detection) 16:27:13 INFO - PID 7078 | RSS: Main: 169029632 16:27:13 INFO - PID 7078 | 16:27:16 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35961/tests/kraken/driver.html?testName=audio-dft) 16:27:16 INFO - PID 7078 | RSS: Main: 169799680 16:27:16 INFO - PID 7078 | 16:27:19 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35961/tests/kraken/driver.html?testName=audio-fft) 16:27:20 INFO - PID 7078 | RSS: Main: 166535168 16:27:20 INFO - PID 7078 | 16:27:22 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35961/tests/kraken/driver.html?testName=audio-oscillator) 16:27:22 INFO - PID 7078 | RSS: Main: 167989248 16:27:22 INFO - PID 7078 | 16:27:24 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:25 INFO - PID 7078 | RSS: Main: 166912000 16:27:25 INFO - PID 7078 | 16:27:28 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35961/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:29 INFO - PID 7078 | RSS: Main: 168128512 16:27:29 INFO - PID 7078 | 16:27:32 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35961/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:33 INFO - PID 7078 | RSS: Main: 171134976 16:27:33 INFO - PID 7078 | 16:27:35 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35961/tests/kraken/driver.html?testName=json-parse-financial) 16:27:36 INFO - PID 7078 | RSS: Main: 171626496 16:27:36 INFO - PID 7078 | 16:27:37 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:38 INFO - PID 7078 | RSS: Main: 171065344 16:27:38 INFO - PID 7078 | 16:27:40 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:40 INFO - PID 7078 | RSS: Main: 170258432 16:27:40 INFO - PID 7078 | 16:27:42 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:43 INFO - PID 7078 | RSS: Main: 171360256 16:27:43 INFO - PID 7078 | 16:27:45 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:46 INFO - PID 7078 | RSS: Main: 170496000 16:27:46 INFO - PID 7078 | 16:27:49 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:50 INFO - PID 7078 | RSS: Main: 170508288 16:27:50 INFO - PID 7078 | 16:27:51 INFO - PID 7078 | Cycle 1(1): loaded http://localhost:35961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35961/tests/kraken/driver.html?testName=ai-astar) 16:27:52 INFO - PID 7078 | RSS: Main: 172396544 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | __start_tp_report 16:27:52 INFO - PID 7078 | _x_x_mozilla_page_load 16:27:52 INFO - PID 7078 | _x_x_mozilla_page_load_details 16:27:52 INFO - PID 7078 | |i|pagename|runs| 16:27:52 INFO - PID 7078 | |0;ai-astar;98;106;107;106;106;106;108;108;106;106 16:27:52 INFO - PID 7078 | |1;audio-beat-detection;142;113;139;184;119;144;144;115;170;117 16:27:52 INFO - PID 7078 | |2;audio-dft;162;162;162;163;162;173;164;161;160;163 16:27:52 INFO - PID 7078 | |3;audio-fft;73;74;75;161;75;75;75;76;92;78 16:27:52 INFO - PID 7078 | |4;audio-oscillator;82;81;128;82;82;80;126;81;80;130 16:27:52 INFO - PID 7078 | |5;imaging-gaussian-blur;114;113;114;114;115;116;114;114;113;113 16:27:52 INFO - PID 7078 | |6;imaging-darkroom;147;147;149;148;148;148;148;150;149;147 16:27:52 INFO - PID 7078 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;94;93 16:27:52 INFO - PID 7078 | |8;json-parse-financial;48;48;53;51;46;47;47;47;47;49 16:27:52 INFO - PID 7078 | |9;json-stringify-tinderbox;55;55;57;56;56;56;59;57;58;56 16:27:52 INFO - PID 7078 | |10;stanford-crypto-aes;79;76;77;77;87;77;76;76;75;76 16:27:52 INFO - PID 7078 | |11;stanford-crypto-ccm;121;129;128;123;130;118;124;118;116;141 16:27:52 INFO - PID 7078 | |12;stanford-crypto-pbkdf2;170;176;175;174;177;180;173;171;170;172 16:27:52 INFO - PID 7078 | |13;stanford-crypto-sha256-iterative;64;65;66;63;62;67;62;63;68;61 16:27:52 INFO - PID 7078 | __end_tp_report 16:27:52 INFO - PID 7078 | __start_cc_report 16:27:52 INFO - PID 7078 | _x_x_mozilla_cycle_collect,853 16:27:52 INFO - PID 7078 | __end_cc_report 16:27:52 INFO - PID 7078 | __startTimestamp1499729272095__endTimestamp 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | ------- Summary: start ------- 16:27:52 INFO - PID 7078 | Number of tests: 14 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.50 stddev:2.83 (2.7%) stddev-sans-first:0.88 16:27:52 INFO - PID 7078 | Values: 98.0 106.0 107.0 106.0 106.0 106.0 108.0 108.0 106.0 106.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:143.00 stddev:23.99 (16.8%) stddev-sans-first:25.42 16:27:52 INFO - PID 7078 | Values: 142.0 113.0 139.0 184.0 119.0 144.0 144.0 115.0 170.0 117.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.61 (2.2%) stddev-sans-first:3.81 16:27:52 INFO - PID 7078 | Values: 162.0 162.0 162.0 163.0 162.0 173.0 164.0 161.0 160.0 163.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:27.12 (36.2%) stddev-sans-first:28.39 16:27:52 INFO - PID 7078 | Values: 73.0 74.0 75.0 161.0 75.0 75.0 75.0 76.0 92.0 78.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:81.00 stddev:22.67 (28.0%) stddev-sans-first:23.53 16:27:52 INFO - PID 7078 | Values: 82.0 81.0 128.0 82.0 82.0 80.0 126.0 81.0 80.0 130.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 16:27:52 INFO - PID 7078 | Values: 114.0 113.0 114.0 114.0 115.0 116.0 114.0 114.0 113.0 113.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 16:27:52 INFO - PID 7078 | Values: 147.0 147.0 149.0 148.0 148.0 148.0 148.0 150.0 149.0 147.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:27:52 INFO - PID 7078 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.00 stddev:2.16 (4.5%) stddev-sans-first:2.29 16:27:52 INFO - PID 7078 | Values: 48.0 48.0 53.0 51.0 46.0 47.0 47.0 47.0 47.0 49.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:1.27 (2.2%) stddev-sans-first:1.22 16:27:52 INFO - PID 7078 | Values: 55.0 55.0 57.0 56.0 56.0 56.0 59.0 57.0 58.0 56.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.47 (4.5%) stddev-sans-first:3.64 16:27:52 INFO - PID 7078 | Values: 79.0 76.0 77.0 77.0 87.0 77.0 76.0 76.0 75.0 76.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:126.00 stddev:7.50 (5.9%) stddev-sans-first:7.82 16:27:52 INFO - PID 7078 | Values: 121.0 129.0 128.0 123.0 130.0 118.0 124.0 118.0 116.0 141.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.50 stddev:3.26 (1.9%) stddev-sans-first:3.15 16:27:52 INFO - PID 7078 | Values: 170.0 176.0 175.0 174.0 177.0 180.0 173.0 171.0 170.0 172.0 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:2.33 (3.6%) stddev-sans-first:2.47 16:27:52 INFO - PID 7078 | Values: 64.0 65.0 66.0 63.0 62.0 67.0 62.0 63.0 68.0 61.0 16:27:52 INFO - PID 7078 | -------- Summary: end -------- 16:27:52 INFO - PID 7078 | 16:27:52 INFO - PID 7078 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:27:52 INFO - TEST-INFO | 7078: exit 0 16:27:52 INFO - TEST-OK | kraken | took 59122ms 16:27:52 INFO - SUITE-END | took 1170s 16:27:53 INFO - Completed test suite (00:19:30) 16:27:53 INFO - javascript benchmark 16:27:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8622.592954783828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.4850148227033, 3422.0589337932074, 3437.948430773539, 3444.7244220462358, 3451.879184228551, 6100.572959892809, 6111.388861113892, 6163.784267550636, 6171.537134714898, 6220.906686399708, 6140.171076904617, 6167.38326167383, 6167.599106058103, 6167.691615419222, 6193.380661933805, 5420.915816836638, 5421.430749771276, 5424.891502169954, 5447.891042179154, 5486.149646804752, 5387.622866399353, 5449.536789372908, 5480.3971563128025, 5480.780768769245, 5498.477644623755, 5468.398476167618, 5482.095454250044, 5485.4788795064605, 5489.0, 5496.615236933416, 5457.181422786574, 5465.344158700942, 5470.097433923398, 5470.370907345667, 5485.286912701363, 5416.783328666888, 5439.836804895859, 5458.536024437927, 5480.287562616834, 5521.834344969658, 6178.165947597062, 6213.285472170668, 6228.065790131472, 6245.437910588023, 6283.717232724538, 6540.247871494744, 6635.6682165892, 6678.9332106679285, 6802.115724955774, 6804.863902721918, 6703.195616526048, 6703.765368212089, 6717.328267173292, 6717.361850624183, 6718.899216511756, 6102.633841969496, 6132.41742034506, 6164.167837341946, 6198.938010619926, 6213.285472170668, 5208.921866172011, 6737.865242695168, 6916.20463646677, 6939.93060069403, 7028.824279392954, 6596.241432235259, 6655.900161497581, 6668.599884006975, 6719.328067193339, 6736.292689267654, 6774.661266936633, 6784.626845523544, 6805.455563554904, 6877.65611719412, 6894.655267236618, 6409.615423074631, 6551.672416379257, 6586.0, 6605.07528945948, 6618.966905165444, 5242.501962313574, 6579.769708060195, 6737.461003119739, 6822.761203357859, 6843.247242803288, 4929.162042452792, 5061.190209566452, 5092.0, 5103.413107492686, 5129.820456284012, 4446.777661116931, 4471.888202794956, 4481.910361792811, 4483.663725220622, 4510.932336014962, 6269.498440124779, 6270.15352927349, 6274.309825919146, 6277.780277690259, 6281.497480201573, 6666.799996000128, 6669.233038200572, 6671.933280667131, 6686.331366863372, 6687.732490700415, 6212.099245609361, 6278.497720182374, 6290.716917738713, 6355.745770169234, 6376.649284289316, 5634.746436410372, 5728.598998070095, 5730.054541000772, 5744.885102297931, 5819.6508209507565, 6864.279250678706, 6937.965310173417, 6940.583564986016, 6946.930530694628, 6959.234484206733, 6552.180977377828, 6554.508411869224, 6600.207975043026, 6613.900791488035, 6622.304658011032, 6936.79189624312, 7057.611831349325, 7061.788146355618, 7114.110736157981, 7123.7506687265695, 6550.0, 6601.801945941629, 6618.768343107968, 6683.097781799589, 6703.798886033232, 6571.605703657796, 6705.597664140168, 6727.562708423937, 6799.048133261446, 6829.0, 6473.320301368289, 6496.967515162394, 6505.7072431741635, 6511.251206111168, 6513.54405191632, 6440.710168042356, 6482.416582507597, 6489.643069631215, 6491.642959637076, 6491.805245842632, 5078.644494885322, 6466.385693359123, 6523.31505191967, 6528.836779080561, 6621.668916554249, 6540.476761858945, 6602.10871532337, 6625.337466253336, 6682.398584127452, 6707.463402927657, 6369.299377068426, 6420.678966051585, 6463.870722585428, 6472.546921715435, 6485.351464853666], "value": 6085.7041895805205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.9823004444797, 920.8296465153951, 940.2853831088373, 968.365720453103, 969.5540051576274, 42852.57147428529, 43983.56016439835, 44141.77929110354, 44211.77894110533, 44390.0, 41026.79486602563, 41343.58656413435, 41369.0, 41432.58567414325, 41444.0, 6736.66316684165, 6812.727490900358, 6813.693383797741, 6826.795196144124, 6836.248012718597, 6634.5687530310615, 6829.3170682931805, 6838.14523184602, 6840.28177041411, 6846.281140480252, 6816.659167041653, 6852.588844669336, 6860.55406398585, 6865.656717164146, 6871.347222013926, 6749.628770417625, 6791.117154769849, 6830.624315662637, 6834.760783372608, 6840.760573379933, 5233.450487698813, 5271.657342272779, 5273.209018647233, 5278.208268759717, 5280.102382594968, 36134.0, 36413.0, 36445.45331820025, 36465.63534364649, 36535.26929461423, 3450.9827450862836, 3461.498082777983, 3483.599386070609, 3622.8188590570367, 3682.5949145593963, 31101.06696799077, 31293.530597041063, 32198.195045123826, 32490.512642310383, 32577.348453031045, 4209.494860616745, 4329.848455304081, 4396.428464299653, 4403.493598236212, 4413.823447062114, 207611.0, 209302.0, 211343.94328028415, 215783.0, 217043.0, 47152.22782177418, 51067.7446612772, 52401.7379913098, 52590.0, 52971.0, 54979.175312370346, 55275.170872436946, 55443.72278138583, 55496.16755748667, 55559.16661250084, 16420.0, 16542.42101526441, 16577.66844663124, 16586.0, 16679.166041697867, 13509.527166549124, 13538.0, 13612.31938403076, 13690.38393272305, 13767.793483097761, 15167.559081887202, 15243.618909527351, 15276.930614856854, 15295.311710973034, 15332.0, 6046.18376519173, 6065.0, 6068.21113255274, 6160.969195153995, 6211.378862113843, 1078.8058149533003, 1096.3969816600838, 1105.165599972016, 1115.3252282369212, 1121.0471099565468, 25038.874805625856, 25152.74847251504, 25156.87421562917, 25225.24324270275, 25231.495370092496, 1199.154596009811, 1211.9151659383936, 1227.4660522672666, 1236.9196002259823, 1237.1525505029083, 13350.599482015556, 13491.392887320095, 13502.932485337511, 13550.864491355158, 13690.589282321545, 279311.0, 281148.0, 281312.0, 281832.0, 281903.0, 57040.429595703514, 57289.713551431974, 57413.42586574164, 57611.711941440866, 57642.7117864408, 1516.7118247532933, 1552.6428921348154, 1578.9921050394905, 1582.106652718614, 1584.7226735321274, 24408.389790255387, 24781.364366131227, 24951.500969980134, 25039.24882253535, 25222.62166067547, 41104.0, 41146.0, 41256.174876501704, 41308.58691413047, 41362.37956430596, 215877.0, 216617.0, 217795.0, 218015.0, 218070.0, 34062.65937340694, 34201.486977694854, 36357.45463817992, 37163.628363716016, 37315.44026839654, 42379.7881010593, 46012.0, 46394.30408543807, 46658.30012549883, 46762.532374675815, 32853.0, 33291.1677208062, 33884.0, 34008.65991340055, 34585.0, 33539.0, 33579.0, 33924.32151357008, 34240.65759342375, 34271.31457370789, 43491.78254108836, 43700.0, 43877.56122438735, 44450.110997779215, 44639.0, 33906.49140262849, 35468.290634186655, 35871.82064089663, 35967.28065438624, 36297.27405451823, 26473.867630662495, 26657.0, 26921.86539067292, 26978.865105674347, 27166.72833271721], "value": 17725.166875726227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.9167624856271, 558.6173471172248, 568.9345725241599, 576.5214871656525, 584.1034012790366, 23037.884810575946, 23807.404814879636, 23975.880120599417, 24069.518609627798, 24077.75922240777, 25700.357491062732, 26937.595936060927, 27821.582676259823, 28234.294142646446, 28394.29014274639, 6289.213848268978, 6466.708998095073, 6484.092227088211, 6487.643179625119, 6493.577917435376, 6327.746890124413, 6356.650384228866, 6358.078078678589, 6383.616982981036, 6402.039694045907, 4168.1038576706005, 4817.51824817519, 6350.460210882057, 6385.584936979105, 6443.774467893625, 6391.968040159816, 6405.231372235338, 6407.423331900105, 6408.455281301095, 6418.903716444257, 5914.852128696774, 5922.4077592240865, 5937.228160339171, 5940.316863560703, 5942.762289508414, 30329.848350758326, 31192.220194495094, 31503.0, 31564.0, 31743.365132697447, 2198.934031979043, 2232.48652809853, 2242.798148166673, 2245.7754224577575, 2257.063318722728, 19675.508112297306, 20083.598328033357, 20164.19343226269, 20173.8991305044, 20202.0, 2160.7839216078423, 2172.2071443923014, 2221.3224966385246, 2224.621814291558, 2238.8992495337748, 147701.0, 149478.25260873736, 150283.0, 150945.24527377292, 153114.0, 15058.397664093314, 15341.769873451907, 15462.29914709381, 15548.445155484587, 15663.608409789846, 23491.530169396516, 23499.29502114939, 23627.645585316233, 23659.408514786923, 23693.289201323987, 10453.111485523816, 10585.153187744962, 10598.0, 10752.838707419238, 10758.354498730101, 9820.65627703027, 9870.950645246729, 9897.66381538483, 10018.098371146632, 10047.734486291984, 9484.857727134098, 9631.133198012212, 9644.95177524108, 9761.707148785548, 9791.216702663769, 2738.6169984157873, 2756.8208066475613, 2777.8472184030074, 2828.75955543777, 2831.9858400707863, 1029.1766586730585, 1030.7526193713454, 1038.60532997462, 1052.2634156090767, 1076.2197406880107, 21482.24812131568, 21649.89175054115, 21856.125754969624, 22181.334559963227, 22456.887715561643, 1097.8408130820985, 1121.4448847820381, 1135.636596289196, 1143.9771204576027, 1145.5990403358924, 11949.402529873472, 12529.0, 12556.304898838722, 12599.685007874694, 14357.0, 577032.0, 600787.0, 606647.0, 608875.0, 612972.0, 135978.0, 139865.0, 141024.0, 142055.0, 142451.0, 1280.8783165599439, 1302.7199152182327, 1337.9799303010464, 1347.7776166932347, 1363.3932899859467, 22101.447463813533, 22826.885865570566, 22937.0, 23029.76970230276, 23039.53920921606, 64078.35921640724, 66772.3322766766, 67243.0, 67557.0, 67855.66072169607, 82300.58849705714, 82661.58669206615, 83099.16900831157, 83635.5818220905, 84538.57730711553, 15147.242637868283, 15248.161351125795, 15344.923275383999, 15420.537383878052, 15426.614334641723, 24726.752732472443, 24838.0, 26223.737762622128, 26261.868690656425, 26446.206613801616, 20321.390358289274, 20837.166513339296, 21223.044962977012, 21393.67909481328, 21645.567088658452, 16744.748828767333, 17225.655486890442, 17299.0, 17631.911840440716, 18054.91670499774, 19822.900885496056, 20851.061702223134, 20943.58112837704, 20962.58074838464, 20976.0, 14778.704425911637, 15548.222588870285, 15659.0, 15671.138087405303, 15692.68614627724, 19045.809541904404, 19333.613327733085, 19382.837029778257, 19462.12420441112, 19471.805281947567], "value": 12766.644565488363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.0498708384757, 1415.2287003583046, 1466.9486567970116, 1468.155810409015, 1469.6693244020103, 14612.0, 15285.312160952742, 15292.082475051504, 15314.846851531482, 15352.385904563833, 14696.338664760086, 14960.326785294661, 15060.623484412896, 15069.773953390708, 15094.09435433872, 2701.0546308791963, 2755.779537636984, 2764.543850264704, 2767.2805070681666, 2770.7229277072333, 2719.714429984853, 2782.5408807546733, 2784.470950519395, 2785.777137828979, 2785.8885644574193, 2667.7599016088548, 2704.864756762164, 2758.3655759175404, 2758.475889580973, 2781.207355903568, 2769.62610047643, 2782.596523504081, 2789.553671412574, 2803.5654473556633, 2808.4383123375405, 2612.8301660392012, 2646.1267781632014, 2650.112212408845, 2662.7204143565036, 2669.6129061286197, 14570.635734106627, 14632.268386580628, 14753.188574628392, 14790.63023424423, 14873.181974991372, 7989.960050199712, 8272.751817445485, 8336.62485188168, 8361.581920903931, 8365.665373385058, 5099.235114732783, 5295.708736019517, 5344.118220493614, 5356.223347614613, 5359.38367087786, 1886.745314365945, 1911.550785565391, 1946.4549926020736, 1962.8625996180274, 1964.72493850861, 26504.867475662497, 26572.0, 26673.799679014297, 26923.730762692514, 27098.864505677542, 6766.357196066366, 6790.354916282945, 6902.6203558803745, 7025.156981162293, 7140.571565706075, 17127.229274682668, 17138.14309284531, 17160.570985725455, 17301.307947682202, 17332.82667173312, 8086.9191308086165, 8183.468074575134, 8198.262156405952, 8227.753167404988, 8246.958765206136, 7463.514871533333, 7559.055118110236, 7560.508566943131, 7569.772906812805, 7618.885716714254, 5305.124654432053, 5409.323834520685, 5452.318460192476, 5458.863528411822, 5473.370562385377, 1501.196859680066, 1507.5778781941074, 1524.207412145678, 1524.6340878189155, 1531.693661267751, 891.8216356728681, 898.6046139698511, 914.0950459045497, 928.9860652090224, 932.6689025396022, 7444.73943411978, 7567.621618919032, 7597.354224890835, 7599.658015389321, 7636.885446718304, 724.3372314332432, 741.3661319571796, 752.1763668782675, 759.2824780582407, 763.1872056260177, 4424.933625995613, 4934.1611925972675, 5682.352117885767, 5899.439553242435, 6019.578629495893, 19951.0, 20761.58476830455, 20763.896180519, 20893.164273428894, 20989.37031889046, 20268.290609828586, 20479.07844147017, 20515.845836187284, 20543.38369848907, 20690.896545517175, 11281.210315278016, 11589.942050289694, 11691.181617286707, 11792.115591330685, 12023.759524809455, 7959.442839001446, 8280.544570048463, 8393.202645748644, 8521.744347669579, 8600.956995214983, 17558.736618950472, 17931.820681793535, 18082.0, 18516.259349625863, 18622.81377186265, 18706.0, 18926.810731892503, 19309.227630894606, 19632.0, 19842.801571984095, 13278.734425311246, 13706.725865482835, 13884.722305554034, 14029.789553156506, 14047.719045619235, 13973.0, 14006.719865602427, 14109.2945352734, 14132.15207087578, 14133.15201087938, 10977.670669879917, 11313.773724525628, 11450.37022963745, 11847.9929206015, 12013.45939432745, 11399.20205585601, 11404.714882128013, 11562.595309164475, 11816.172867899508, 11934.164608477324, 10111.949440252753, 10241.487925603838, 10247.7438064049, 10323.63867264642, 10328.793424131625, 7000.824979375557, 7189.173245076674, 7382.335589796944, 7452.441066920112, 7512.8873066905135, 6973.930260697328, 7083.929160708327, 7143.6428178591905, 7178.60517671533, 7211.495195336276], "value": 6707.9154356142935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.7307864944392, 505.15134573915805, 527.7281750980138, 528.585060727329, 536.3188750287136, 5957.52339812815, 5967.433093856088, 5982.491488223495, 6019.969900150499, 6095.75616975321, 5695.971520142404, 5832.221172542383, 5945.721669840983, 5983.0, 5987.341392446839, 4623.56076172763, 4628.583427491525, 4641.675082744201, 4682.742449165295, 4687.062587482517, 4620.422447194101, 4633.698809577383, 4644.0, 4690.859274221762, 4712.222483290253, 4431.867043988669, 4652.0, 4655.508368723457, 4671.813127474897, 4695.6052413269135, 4582.6104781093645, 4620.712747190146, 4632.745199014053, 4643.2802915548145, 4645.976770116128, 4196.657069737686, 4201.474815648044, 4223.429836972, 4233.322668373045, 4234.809433575497, 5754.798582049608, 5785.5660825437835, 5792.971035144839, 5841.474267315962, 5857.6778277194735, 5437.293151890269, 5496.230527726121, 5525.419830917776, 5536.501714845643, 5573.888522229573, 6358.682065896686, 6387.87224255517, 6389.1471473272695, 6397.8400539986405, 6424.453921416685, 4806.086843499724, 4817.78319975602, 4821.325014497973, 4822.63830212732, 4833.29917162013, 6691.866162676719, 6699.296573859772, 6730.730770769163, 6739.157605299338, 6767.593944363305, 4951.72765497901, 4956.91809440036, 4958.380202474691, 4970.204767237225, 4971.862099297265, 4949.975250123726, 4995.327499787596, 5019.3976722793495, 5024.723640199824, 5026.195808670595, 5489.780408783604, 5519.172124181325, 5531.170324451284, 5532.253145825262, 5584.357798853184, 6375.736613502233, 6418.614883107029, 6435.678216089177, 6439.5170362223025, 6479.282990007652, 1722.6468573942311, 1735.1671197825115, 1735.8698097642475, 1745.5548835047236, 1754.921028553718, 1127.1264769803304, 1139.5272259197561, 1212.5210541835925, 1219.1405059433077, 1235.7034311765112, 5891.646501209942, 5892.705364731746, 5908.231929849178, 5955.612885162451, 6024.337322894478, 6388.135178217205, 6397.4562162216735, 6470.7675851831045, 6477.384648458389, 6483.643399613066, 5988.0, 6064.151018857364, 6068.787592434243, 6071.574989750675, 6097.634141951497, 3403.7787543809573, 3442.5008373785663, 3478.1913405029245, 3500.562429696288, 3505.7204120496344, 6765.594064356154, 6839.794806155824, 6866.759663411756, 6897.965510172417, 6916.861662766716, 6676.79969600903, 6700.329967003358, 6709.691610136074, 6716.5634233774645, 6724.361185687352, 6761.233330501985, 6774.42417394527, 6823.055429202654, 6825.249222585412, 6896.689648965808, 6527.869442611216, 6565.376289252514, 6567.770128045687, 6570.47436205112, 6571.244306904767, 6331.132315966709, 6333.240011198685, 6353.332900045429, 6365.172527571386, 6464.450521705708, 6642.76750313756, 6648.069270302259, 6717.9328206719265, 6775.1531058617675, 6805.740937926499, 4811.903761924812, 4893.412790465167, 4918.581920536794, 4929.359183306147, 4933.235348520985, 6480.805575832733, 6520.543561950808, 6539.869202616016, 6540.574862633914, 6556.573822701509, 6240.875182496416, 6349.746010159542, 6366.490680745622, 6387.808365749035, 6445.484361251182, 6364.981602943507, 6380.054083504576, 6414.871702566016, 6472.35276472349, 6474.643894585843, 6328.0824280478155, 6344.0, 6352.745890164341, 6354.904676429765, 6357.268914074941, 5819.330776960704, 6279.152314437492, 6314.652694101868, 6335.683215839282, 6341.27075386318, 6076.812347554788, 6087.36082711309, 6148.815535533941, 6178.99182765594, 6200.255969283715], "value": 4944.091225488587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.4280945813597, 923.806000739845, 934.7102398256541, 947.5688561704425, 965.2085290062149, 17894.552636184086, 18358.72461913069, 18378.908105459486, 18557.907210463964, 18558.721619175707, 17503.38738144165, 17697.292108315683, 17847.018413987225, 17864.732029019575, 19920.203191872344, 1031.1802117316713, 1057.7091299892552, 1060.4697651174413, 1062.3944351719524, 1062.5537274344795, 1056.1603525197447, 1065.9893401066006, 1066.7173199102244, 1067.1622776120746, 1070.550368845087, 1113.3876367997568, 1113.838493418454, 1114.7046032801275, 1120.5069769301522, 1120.7030137013699, 1053.0838170791385, 1111.22214449885, 1114.899659030691, 1117.290520519472, 1121.4336759936261, 798.297498201579, 799.9880001799978, 802.7671975127206, 807.8949736534272, 810.088650268448, 19067.141978610995, 19207.135678894483, 19251.22995080195, 19369.709454358195, 19373.32193373225, 19047.42857714271, 19872.602547949104, 20099.598008039757, 20152.29466968664, 20152.69770953437, 12959.870401296055, 13152.736945261136, 13249.205047697073, 13289.13620614657, 13291.933540332237, 2963.866626001835, 2988.9850550747324, 2989.865456054483, 2998.3553535989868, 3006.4738670732754, 100546.4972675132, 118057.40971295089, 121163.0, 122031.0, 125581.37209313986, 12996.610101696964, 14125.081869678643, 14215.573532794033, 14363.21002344881, 14370.0, 29094.27264318409, 29455.11634650964, 29621.25946851346, 30242.395152096833, 30441.238969025508, 8921.01868794432, 8924.464532128093, 9020.594073266719, 9109.908900910907, 9148.085191480799, 3958.960410395859, 4121.175764847043, 4125.608067233608, 4155.916881662411, 4171.353440216772, 5199.896002079937, 5250.684958902478, 5296.4703529647495, 5303.04545181871, 5304.628675992721, 984.606157536991, 1068.7381591509975, 1133.9149563782748, 1135.1940122513108, 1155.9595414160633, 718.3534818663245, 725.2058995400029, 729.2197348836694, 733.5818583407406, 744.6462930108264, 11734.88265117355, 11811.940940295415, 11831.526738930346, 12907.419166137546, 12930.418131184118, 708.1679027143189, 718.7304760714732, 719.2591630620469, 721.0446158839559, 740.8110931712379, 5438.15708565173, 5582.134769110794, 5635.464630860061, 5643.548516118701, 5783.4794868461195, 119113.0, 119665.40167299108, 123271.383643083, 124049.13926291112, 126444.0, 101319.0, 103191.4840425808, 106108.0, 107426.0, 108350.45824770826, 95375.52312238533, 96122.0, 96683.99999999859, 99214.0, 100732.0, 10892.40091794959, 10930.344179349264, 11006.944965275443, 11023.779524409627, 11378.03286720605, 43426.07800357979, 43441.0, 44436.0, 45426.772866135456, 45869.0, 56241.71879140578, 57093.42906570881, 58153.418465816496, 58839.41160588339, 59351.0, 16117.516474505783, 16574.0, 16600.83399165993, 16628.168591570615, 16664.250108744895, 17840.0, 17883.105844707454, 18214.544636383667, 18462.076896155406, 18474.538136546693, 16572.419965301156, 16761.664766704354, 16968.83031169722, 17067.317307308065, 17405.129743513025, 15702.371905123668, 16102.758458623364, 16259.918700406422, 16527.256273467963, 16716.916415417843, 16701.2484438203, 17138.828611714223, 17173.31306747716, 19483.220671172996, 20621.484462888548, 12432.316222607844, 12808.0, 13626.318684065955, 13912.373943172379, 14373.568792936228, 14597.0, 15008.849911501182, 15296.770548442006, 15333.386664533295, 16181.11003894797], "value": 8998.016653756973, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1489.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 107.0, 106.0, 106.0, 106.0, 108.0, 108.0, 106.0, 106.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 139.0, 184.0, 119.0, 144.0, 144.0, 115.0, 170.0, 117.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 173.0, 164.0, 161.0, 160.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 161.0, 75.0, 75.0, 75.0, 76.0, 92.0, 78.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 128.0, 82.0, 82.0, 80.0, 126.0, 81.0, 80.0, 130.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 115.0, 116.0, 114.0, 114.0, 113.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 150.0, 149.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 53.0, 51.0, 46.0, 47.0, 47.0, 47.0, 47.0, 49.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 56.0, 56.0, 56.0, 59.0, 57.0, 58.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 77.0, 87.0, 77.0, 76.0, 76.0, 75.0, 76.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 129.0, 128.0, 123.0, 130.0, 118.0, 124.0, 118.0, 116.0, 141.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 175.0, 174.0, 177.0, 180.0, 173.0, 171.0, 170.0, 172.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 63.0, 62.0, 67.0, 62.0, 63.0, 68.0, 61.0], "value": 64.1, "unit": "score"}]}]} 16:27:53 INFO - Return code: 0 16:27:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:27:53 INFO - # TBPL SUCCESS # 16:27:53 INFO - Running post-action listener: _package_coverage_data 16:27:53 INFO - Running post-action listener: _resource_record_post_action 16:27:53 INFO - [mozharness: 2017-07-10 23:27:53.404020Z] Finished run-tests step (success) 16:27:53 INFO - Running post-run listener: _resource_record_post_run 16:27:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 462848; Write bytes: 426815488; Read time: 112; Write time: 299988 16:27:53 INFO - TinderboxPrint: CPU usage
13.0% 16:27:53 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 112 16:27:53 INFO - TinderboxPrint: I/O write bytes / time
426,815,488 / 299,988 16:27:53 INFO - TinderboxPrint: CPU idle
8,245.3 (86.9%) 16:27:53 INFO - TinderboxPrint: CPU user
1,191.2 (12.6%) 16:27:53 INFO - TinderboxPrint: Swap in / out
0 / 0 16:27:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112353280; Read time: 0; Write time: 93000 16:27:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:27:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 458752; Write bytes: 314462208; Read time: 96; Write time: 206988 16:27:54 INFO - Running post-run listener: _upload_blobber_files 16:27:54 INFO - Blob upload gear active. 16:27:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:54 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 16:27:54 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'] 16:27:54 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 16:27:54 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:55 INFO - (blobuploader) - INFO - Done attempting. 16:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:58 INFO - (blobuploader) - INFO - Done attempting. 16:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:59 INFO - (blobuploader) - INFO - Done attempting. 16:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:00 INFO - (blobuploader) - INFO - Done attempting. 16:28:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:28:00 INFO - Return code: 0 16:28:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:28:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:28:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd16fe491fd8dcba33e82b10853aa3f172f02137c935916248f92d1a0dff3e2ca9d253eaf0c1ca245503ab07bbecb23daab237a7a54b3c39a34e47a076e20d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/827d9b507245d757abaa691d23e8541a9e232f2901761e74b3e6927573cc90f8df31b2934bf4811c3308cc098f1ec08df8e8c637a7f0115a6af73bd74b15cc1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9846115d262d02ba43494d8275ec2bfad16d4fa1807ffb6c2781443ac1ac431b51b7b576ce4323da66d4b4074c69a1160eb3735a47b864b80eb2ec68d1ac58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676947e8240a6058582164d9dfdd66ad1ed5214d899507096dde88b8c7e412315358d397f8d5529f3b9b09f1280de493dd3ff259cf834723f549bfeaf03b50d2"} 16:28:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:28:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:28:00 INFO - Contents: 16:28:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd16fe491fd8dcba33e82b10853aa3f172f02137c935916248f92d1a0dff3e2ca9d253eaf0c1ca245503ab07bbecb23daab237a7a54b3c39a34e47a076e20d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/827d9b507245d757abaa691d23e8541a9e232f2901761e74b3e6927573cc90f8df31b2934bf4811c3308cc098f1ec08df8e8c637a7f0115a6af73bd74b15cc1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9846115d262d02ba43494d8275ec2bfad16d4fa1807ffb6c2781443ac1ac431b51b7b576ce4323da66d4b4074c69a1160eb3735a47b864b80eb2ec68d1ac58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676947e8240a6058582164d9dfdd66ad1ed5214d899507096dde88b8c7e412315358d397f8d5529f3b9b09f1280de493dd3ff259cf834723f549bfeaf03b50d2"} 16:28:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:28:00 INFO - Copying logs to upload dir... 16:28:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:28:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.887572 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-10 16:27:59.938186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 16:27:59.945821) ========= 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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd16fe491fd8dcba33e82b10853aa3f172f02137c935916248f92d1a0dff3e2ca9d253eaf0c1ca245503ab07bbecb23daab237a7a54b3c39a34e47a076e20d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/827d9b507245d757abaa691d23e8541a9e232f2901761e74b3e6927573cc90f8df31b2934bf4811c3308cc098f1ec08df8e8c637a7f0115a6af73bd74b15cc1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9846115d262d02ba43494d8275ec2bfad16d4fa1807ffb6c2781443ac1ac431b51b7b576ce4323da66d4b4074c69a1160eb3735a47b864b80eb2ec68d1ac58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676947e8240a6058582164d9dfdd66ad1ed5214d899507096dde88b8c7e412315358d397f8d5529f3b9b09f1280de493dd3ff259cf834723f549bfeaf03b50d2"} build_url:https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/VjGQ5cTWQT-QsDUTO1_FFQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd16fe491fd8dcba33e82b10853aa3f172f02137c935916248f92d1a0dff3e2ca9d253eaf0c1ca245503ab07bbecb23daab237a7a54b3c39a34e47a076e20d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/827d9b507245d757abaa691d23e8541a9e232f2901761e74b3e6927573cc90f8df31b2934bf4811c3308cc098f1ec08df8e8c637a7f0115a6af73bd74b15cc1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9846115d262d02ba43494d8275ec2bfad16d4fa1807ffb6c2781443ac1ac431b51b7b576ce4323da66d4b4074c69a1160eb3735a47b864b80eb2ec68d1ac58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676947e8240a6058582164d9dfdd66ad1ed5214d899507096dde88b8c7e412315358d397f8d5529f3b9b09f1280de493dd3ff259cf834723f549bfeaf03b50d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 16:27:59.972597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:27:59.972909) ========= 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=3a3620fb28aea1604ab609ef000001d2-1499728031.397702-2106465212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:28:00.053937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 16:28:00.054224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 16:28:00.057534) ========= ========= Total master_lag: -0.11 =========