builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1503100279.97 results: success (0) revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:19.970069) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:19.970492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:19.970769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:19.988636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:19.988963) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 16:51:20-- 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% 42.2M=0s 2017-08-18 16:51:20 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.116171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.116547) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019612 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.171723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.172120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f4487cc2d30d988742109868dcf21c4113f12f5 --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 4f4487cc2d30d988742109868dcf21c4113f12f5 --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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 16:51:20,310 truncating revision to first 12 chars 2017-08-18 16:51:20,310 Setting DEBUG logging. 2017-08-18 16:51:20,310 attempt 1/10 2017-08-18 16:51:20,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f4487cc2d30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 16:51:20,613 unpacking tar archive at: mozilla-central-4f4487cc2d30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.806070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.806374) ========= script_repo_revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.806738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.811096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 16:51:20.825872) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-18 16:51:20.826215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:51:21 INFO - MultiFileLogger online at 20170818 16:51:21 in /builds/slave/test 16:51:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:51:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:51:21 INFO - {'append_to_log': False, 16:51:21 INFO - 'base_work_dir': '/builds/slave/test', 16:51:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:51:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:51:21 INFO - 'branch': 'Firefox-Non-PGO', 16:51:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:21 INFO - 'code_coverage': False, 16:51:21 INFO - 'config_files': ('talos/linux_config.py',), 16:51:21 INFO - 'default_actions': ('clobber', 16:51:21 INFO - 'read-buildbot-config', 16:51:21 INFO - 'download-and-extract', 16:51:21 INFO - 'populate-webroot', 16:51:21 INFO - 'create-virtualenv', 16:51:21 INFO - 'install', 16:51:21 INFO - 'setup-mitmproxy', 16:51:21 INFO - 'run-tests'), 16:51:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:21 INFO - 'disable_ccov_upload': False, 16:51:21 INFO - 'download_minidump_stackwalk': True, 16:51:21 INFO - 'download_symbols': 'ondemand', 16:51:21 INFO - 'enable_stylo': False, 16:51:21 INFO - 'enable_webrender': False, 16:51:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:21 INFO - 'gecko_profile': False, 16:51:21 INFO - 'gecko_profile_interval': 0, 16:51:21 INFO - 'installer_path': 'installer.exe', 16:51:21 INFO - 'log_level': 'info', 16:51:21 INFO - 'log_name': 'talos', 16:51:21 INFO - 'log_to_console': True, 16:51:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:51:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:51:21 INFO - 'opt_config_files': (), 16:51:21 INFO - 'pip_index': False, 16:51:21 INFO - 'suite': 'dromaeojs-e10s', 16:51:21 INFO - 'system_bits': '32', 16:51:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:21 INFO - 'title': 'talos-linux64-ix-075', 16:51:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:21 INFO - 'use_talos_json': True, 16:51:21 INFO - 'verify': 'False', 16:51:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:51:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:21 INFO - 'work_dir': 'build'} 16:51:21 INFO - [mozharness: 2017-08-18 23:51:21.095316Z] Running clobber step. 16:51:21 INFO - Running pre-action listener: _resource_record_pre_action 16:51:21 INFO - Running main action method: clobber 16:51:21 INFO - rmtree: /builds/slave/test/build 16:51:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:51:22 INFO - Running post-action listener: _resource_record_post_action 16:51:22 INFO - [mozharness: 2017-08-18 23:51:22.117633Z] Finished clobber step (success) 16:51:22 INFO - [mozharness: 2017-08-18 23:51:22.117731Z] Running read-buildbot-config step. 16:51:22 INFO - Running pre-action listener: _resource_record_pre_action 16:51:22 INFO - Running main action method: read_buildbot_config 16:51:22 INFO - Using buildbot properties: 16:51:22 INFO - { 16:51:22 INFO - "project": "", 16:51:22 INFO - "product": "firefox", 16:51:22 INFO - "who": "kwierso@gmail.com", 16:51:22 INFO - "installer_path": "public/build/target.tar.bz2", 16:51:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:51:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:51:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:51:22 INFO - "stage_platform": "linux64", 16:51:22 INFO - "basedir": "/builds/slave/test", 16:51:22 INFO - "buildnumber": 778, 16:51:22 INFO - "platform": "ubuntu64_hw", 16:51:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:51:22 INFO - "slavebuilddir": "test", 16:51:22 INFO - "taskId": "CN48HJEgSFWv2ug8OGvnaQ", 16:51:22 INFO - "branch": "mozilla-central", 16:51:22 INFO - "script_repo_revision": "production", 16:51:22 INFO - "revision": "4f4487cc2d30d988742109868dcf21c4113f12f5", 16:51:22 INFO - "slavename": "talos-linux64-ix-075", 16:51:22 INFO - "repo_path": "mozilla-central" 16:51:22 INFO - } 16:51:22 INFO - Finding installer, test and symbols from parent task. 16:51:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CN48HJEgSFWv2ug8OGvnaQ'}, attempt #1 16:51:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CN48HJEgSFWv2ug8OGvnaQ'}, attempt #1 16:51:23 INFO - Task dependencies: MG9qgLVdSh6Lrf5lTYxwFA 16:51:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA'}, attempt #1 16:51:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:51:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json 16:51:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip 16:51:23 INFO - Running post-action listener: _resource_record_post_action 16:51:23 INFO - [mozharness: 2017-08-18 23:51:23.495237Z] Finished read-buildbot-config step (success) 16:51:23 INFO - [mozharness: 2017-08-18 23:51:23.495454Z] Running download-and-extract step. 16:51:23 INFO - Running pre-action listener: _resource_record_pre_action 16:51:23 INFO - Running main action method: download_and_extract 16:51:23 INFO - mkdir: /builds/slave/test/build/tests 16:51:23 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:51:23 INFO - trying https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json 16:51:23 INFO - Downloading https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:51:24 INFO - Downloaded 989 bytes. 16:51:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:51:24 INFO - Using the following test package requirements: 16:51:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:51:24 INFO - u'common': [u'target.common.tests.zip'], 16:51:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:51:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:51:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:51:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:51:24 INFO - u'mozbase': [u'target.common.tests.zip'], 16:51:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:51:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:51:24 INFO - u'web-platform': [u'target.common.tests.zip', 16:51:24 INFO - u'target.web-platform.tests.tar.gz'], 16:51:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:51:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:51:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip 16:51:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:51:24 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip into memory 16:51:25 INFO - Content-Length response header: 54005097 16:51:25 INFO - Bytes received: 54005097 16:51:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:51:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip 16:51:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:51:36 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip into memory 16:51:37 INFO - Content-Length response header: 54005097 16:51:37 INFO - Bytes received: 54005097 16:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip 16:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip into memory 16:51:49 INFO - Content-Length response header: 14496256 16:51:49 INFO - Bytes received: 14496256 16:51: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:51:50 INFO - trying https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:51:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:51:51 INFO - Downloaded 62133216 bytes. 16:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:51:51 INFO - mkdir: /builds/slave/test/properties 16:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:51:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:51:51 INFO - Contents: 16:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:51:51 INFO - Running post-action listener: _resource_record_post_action 16:51:51 INFO - Running post-action listener: find_tests_for_verification 16:51:51 INFO - Running post-action listener: set_extra_try_arguments 16:51:51 INFO - [mozharness: 2017-08-18 23:51:51.185330Z] Finished download-and-extract step (success) 16:51:51 INFO - [mozharness: 2017-08-18 23:51:51.185428Z] Running populate-webroot step. 16:51:51 INFO - Running pre-action listener: _resource_record_pre_action 16:51:51 INFO - Running main action method: populate_webroot 16:51:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:51:51 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:51:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:51:51 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:51:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:51 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'tests': ['damp', 'tps']}, 16:51:51 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['damp', 'tps']}, 16:51:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:51:51 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:51:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:51:51 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:51:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_many_windows', 16:51:51 INFO - 'sessionrestore_no_auto_restore', 16:51:51 INFO - 'tabpaint']}, 16:51:51 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['a11yr', 16:51:51 INFO - 'ts_paint', 16:51:51 INFO - 'tpaint', 16:51:51 INFO - 'sessionrestore', 16:51:51 INFO - 'sessionrestore_many_windows', 16:51:51 INFO - 'sessionrestore_no_auto_restore', 16:51:51 INFO - 'tabpaint']}, 16:51:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:51:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:51:51 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['bloom_basic_singleton']}, 16:51:51 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['bloom_basic']}, 16:51:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:51:51 INFO - 'tsvgr_opacity', 16:51:51 INFO - 'tart', 16:51:51 INFO - 'tscrollx', 16:51:51 INFO - 'tsvg_static']}, 16:51:51 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['tsvgx', 16:51:51 INFO - 'tsvgr_opacity', 16:51:51 INFO - 'tart', 16:51:51 INFO - 'tscrollx', 16:51:51 INFO - 'tsvg_static']}, 16:51:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:51:51 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--stylo'], 16:51:51 INFO - 'tests': ['tp5o']}, 16:51:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:51:51 INFO - 'talos_options': ['--mitmproxy', 16:51:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:51:51 INFO - '--firstNonBlankPaint'], 16:51:51 INFO - 'tests': ['tp6_google', 16:51:51 INFO - 'tp6_youtube', 16:51:51 INFO - 'tp6_amazon', 16:51:51 INFO - 'tp6_facebook']}, 16:51:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:51:51 INFO - 'talos_options': ['--stylo', 16:51:51 INFO - '--mitmproxy', 16:51:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:51:51 INFO - '--firstNonBlankPaint'], 16:51:51 INFO - 'tests': ['tp6_google', 16:51:51 INFO - 'tp6_youtube', 16:51:51 INFO - 'tp6_amazon', 16:51:51 INFO - 'tp6_facebook']}, 16:51:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:51:51 INFO - 'talos_options': ['--stylo', 16:51:51 INFO - '--stylo-threads=1', 16:51:51 INFO - '--mitmproxy', 16:51:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:51:51 INFO - '--firstNonBlankPaint'], 16:51:51 INFO - 'tests': ['tp6_google', 16:51:51 INFO - 'tp6_youtube', 16:51:51 INFO - 'tp6_amazon', 16:51:51 INFO - 'tp6_facebook']}, 16:51:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--xperf_path', 16:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:51 INFO - 'tests': ['tp5n']}, 16:51:51 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:51:51 INFO - 'talos_options': ['--stylo', 16:51:51 INFO - '--xperf_path', 16:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:51 INFO - 'tests': ['tp5n']}}} 16:51:51 INFO - Running post-action listener: _resource_record_post_action 16:51:51 INFO - [mozharness: 2017-08-18 23:51:51.199524Z] Finished populate-webroot step (success) 16:51:51 INFO - [mozharness: 2017-08-18 23:51:51.199613Z] Running create-virtualenv step. 16:51:51 INFO - Running pre-action listener: _resource_record_pre_action 16:51:51 INFO - Running main action method: create_virtualenv 16:51:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:51:51 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:51:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:51:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:51:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:51 INFO - Using real prefix '/usr' 16:51:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:51:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:53 INFO - Installing pip.................done. 16:51:53 INFO - Return code: 0 16:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:51:53 INFO - Reading from file tmpfile_stdout 16:51:53 INFO - Output received: 16:51:53 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:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:51:53 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:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:53 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:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:53 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:53 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:51:53 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:51:53 INFO - Using env: {'DISPLAY': ':0', 16:51:53 INFO - 'HOME': '/home/cltbld', 16:51:53 INFO - 'LANG': 'en_US.UTF-8', 16:51:53 INFO - 'LANGUAGE': 'en_US:en', 16:51:53 INFO - 'LOGNAME': 'cltbld', 16:51:53 INFO - 'MAIL': '/var/mail/cltbld', 16:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:53 INFO - 'MOZ_NO_REMOTE': '1', 16:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:53 INFO - 'NO_EM_RESTART': '1', 16:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:53 INFO - 'PWD': '/builds/slave/test', 16:51:53 INFO - 'SHELL': '/bin/bash', 16:51:53 INFO - 'SHLVL': '1', 16:51:53 INFO - 'TERM': 'linux', 16:51:53 INFO - 'TMOUT': '86400', 16:51:53 INFO - 'USER': 'cltbld', 16:51:53 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:53 INFO - '_': '/tools/buildbot/bin/python'} 16:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:54 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:51:54 INFO - Cleaning up... 16:51:54 INFO - Return code: 0 16:51:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:51: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:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51: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:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:54 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:54 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:51:54 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:51:54 INFO - Using env: {'DISPLAY': ':0', 16:51:54 INFO - 'HOME': '/home/cltbld', 16:51:54 INFO - 'LANG': 'en_US.UTF-8', 16:51:54 INFO - 'LANGUAGE': 'en_US:en', 16:51:54 INFO - 'LOGNAME': 'cltbld', 16:51:54 INFO - 'MAIL': '/var/mail/cltbld', 16:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:54 INFO - 'MOZ_NO_REMOTE': '1', 16:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:54 INFO - 'NO_EM_RESTART': '1', 16:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:54 INFO - 'PWD': '/builds/slave/test', 16:51:54 INFO - 'SHELL': '/bin/bash', 16:51:54 INFO - 'SHLVL': '1', 16:51:54 INFO - 'TERM': 'linux', 16:51:54 INFO - 'TMOUT': '86400', 16:51:54 INFO - 'USER': 'cltbld', 16:51:54 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:54 INFO - '_': '/tools/buildbot/bin/python'} 16:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:54 INFO - Downloading/unpacking psutil>=3.1.1 16:51: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:51: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:51: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:51: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:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:55 INFO - Installing collected packages: psutil 16:51:55 INFO - Running setup.py install for psutil 16:51:55 INFO - building 'psutil._psutil_linux' extension 16:51:55 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:51:55 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:51:55 INFO - building 'psutil._psutil_posix' extension 16:51:55 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:51:56 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:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:56 INFO - Successfully installed psutil 16:51:56 INFO - Cleaning up... 16:51:56 INFO - Return code: 0 16:51:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:51:56 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:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:56 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:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:56 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:56 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:51:56 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:51:56 INFO - Using env: {'DISPLAY': ':0', 16:51:56 INFO - 'HOME': '/home/cltbld', 16:51:56 INFO - 'LANG': 'en_US.UTF-8', 16:51:56 INFO - 'LANGUAGE': 'en_US:en', 16:51:56 INFO - 'LOGNAME': 'cltbld', 16:51:56 INFO - 'MAIL': '/var/mail/cltbld', 16:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:56 INFO - 'MOZ_NO_REMOTE': '1', 16:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:56 INFO - 'NO_EM_RESTART': '1', 16:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:56 INFO - 'PWD': '/builds/slave/test', 16:51:56 INFO - 'SHELL': '/bin/bash', 16:51:56 INFO - 'SHLVL': '1', 16:51:56 INFO - 'TERM': 'linux', 16:51:56 INFO - 'TMOUT': '86400', 16:51:56 INFO - 'USER': 'cltbld', 16:51:56 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:56 INFO - '_': '/tools/buildbot/bin/python'} 16:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:51:56 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:51:56 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:51:56 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:51:56 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:51:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:51:57 INFO - Installing collected packages: mozsystemmonitor 16:51:57 INFO - Running setup.py install for mozsystemmonitor 16:51:57 INFO - Successfully installed mozsystemmonitor 16:51:57 INFO - Cleaning up... 16:51:57 INFO - Return code: 0 16:51:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:51:57 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:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:57 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:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:57 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:57 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:51:57 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:51:57 INFO - Using env: {'DISPLAY': ':0', 16:51:57 INFO - 'HOME': '/home/cltbld', 16:51:57 INFO - 'LANG': 'en_US.UTF-8', 16:51:57 INFO - 'LANGUAGE': 'en_US:en', 16:51:57 INFO - 'LOGNAME': 'cltbld', 16:51:57 INFO - 'MAIL': '/var/mail/cltbld', 16:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:57 INFO - 'MOZ_NO_REMOTE': '1', 16:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:57 INFO - 'NO_EM_RESTART': '1', 16:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:57 INFO - 'PWD': '/builds/slave/test', 16:51:57 INFO - 'SHELL': '/bin/bash', 16:51:57 INFO - 'SHLVL': '1', 16:51:57 INFO - 'TERM': 'linux', 16:51:57 INFO - 'TMOUT': '86400', 16:51:57 INFO - 'USER': 'cltbld', 16:51:57 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:57 INFO - '_': '/tools/buildbot/bin/python'} 16:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:51:57 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:51:57 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:51:57 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:51:57 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:51:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:51: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:51: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:51: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:51: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:51:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:59 INFO - warning: no files found matching '*.txt' 16:51:59 INFO - no previously-included directories found matching 'build' 16:51:59 INFO - no previously-included directories found matching 'dist' 16:51:59 INFO - no previously-included directories found matching '.git*' 16:51:59 INFO - Installing collected packages: jsonschema, functools32 16:51:59 INFO - Running setup.py install for functools32 16:51:59 INFO - warning: no files found matching '*.txt' 16:51:59 INFO - no previously-included directories found matching 'build' 16:51:59 INFO - no previously-included directories found matching 'dist' 16:51:59 INFO - no previously-included directories found matching '.git*' 16:51:59 INFO - Successfully installed jsonschema functools32 16:51:59 INFO - Cleaning up... 16:51:59 INFO - Return code: 0 16:51:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:51:59 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:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:59 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:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:59 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:59 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:51:59 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:51:59 INFO - Using env: {'DISPLAY': ':0', 16:51:59 INFO - 'HOME': '/home/cltbld', 16:51:59 INFO - 'LANG': 'en_US.UTF-8', 16:51:59 INFO - 'LANGUAGE': 'en_US:en', 16:51:59 INFO - 'LOGNAME': 'cltbld', 16:51:59 INFO - 'MAIL': '/var/mail/cltbld', 16:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:59 INFO - 'MOZ_NO_REMOTE': '1', 16:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:59 INFO - 'NO_EM_RESTART': '1', 16:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:59 INFO - 'PWD': '/builds/slave/test', 16:51:59 INFO - 'SHELL': '/bin/bash', 16:51:59 INFO - 'SHLVL': '1', 16:51:59 INFO - 'TERM': 'linux', 16:51:59 INFO - 'TMOUT': '86400', 16:51:59 INFO - 'USER': 'cltbld', 16:51:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:59 INFO - '_': '/tools/buildbot/bin/python'} 16:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:51:59 INFO - Cleaning up... 16:51:59 INFO - Return code: 0 16:51:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:51:59 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:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:59 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:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:59 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:51:59 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:51:59 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:51:59 INFO - Using env: {'DISPLAY': ':0', 16:51:59 INFO - 'HOME': '/home/cltbld', 16:51:59 INFO - 'LANG': 'en_US.UTF-8', 16:51:59 INFO - 'LANGUAGE': 'en_US:en', 16:51:59 INFO - 'LOGNAME': 'cltbld', 16:51:59 INFO - 'MAIL': '/var/mail/cltbld', 16:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:59 INFO - 'MOZ_NO_REMOTE': '1', 16:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:59 INFO - 'NO_EM_RESTART': '1', 16:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:59 INFO - 'PWD': '/builds/slave/test', 16:51:59 INFO - 'SHELL': '/bin/bash', 16:51:59 INFO - 'SHLVL': '1', 16:51:59 INFO - 'TERM': 'linux', 16:51:59 INFO - 'TMOUT': '86400', 16:51:59 INFO - 'USER': 'cltbld', 16:51:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:59 INFO - '_': '/tools/buildbot/bin/python'} 16:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:51: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:51: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:51: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:51: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:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52:00 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:52:00 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:52:00 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:52:00 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:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52: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:52: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:52: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:52: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:52:01 INFO - Downloading docopt-0.6.1.tar.gz 16:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:01 INFO - Running setup.py install for blobuploader 16:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:01 INFO - Running setup.py install for requests 16:52:01 INFO - Running setup.py install for docopt 16:52:02 INFO - Successfully installed blobuploader requests docopt 16:52:02 INFO - Cleaning up... 16:52:02 INFO - Return code: 0 16:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:02 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:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:02 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:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:02 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:52:02 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:52:02 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:52:02 INFO - Using env: {'DISPLAY': ':0', 16:52:02 INFO - 'HOME': '/home/cltbld', 16:52:02 INFO - 'LANG': 'en_US.UTF-8', 16:52:02 INFO - 'LANGUAGE': 'en_US:en', 16:52:02 INFO - 'LOGNAME': 'cltbld', 16:52:02 INFO - 'MAIL': '/var/mail/cltbld', 16:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:02 INFO - 'MOZ_NO_REMOTE': '1', 16:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:02 INFO - 'NO_EM_RESTART': '1', 16:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:02 INFO - 'PWD': '/builds/slave/test', 16:52:02 INFO - 'SHELL': '/bin/bash', 16:52:02 INFO - 'SHLVL': '1', 16:52:02 INFO - 'TERM': 'linux', 16:52:02 INFO - 'TMOUT': '86400', 16:52:02 INFO - 'USER': 'cltbld', 16:52:02 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:02 INFO - '_': '/tools/buildbot/bin/python'} 16:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:02 INFO - Running setup.py (path:/tmp/pip-aIaa42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:02 INFO - Running setup.py (path:/tmp/pip-qq_0T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:02 INFO - Running setup.py (path:/tmp/pip-fED1t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:02 INFO - Running setup.py (path:/tmp/pip-G8wCII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:02 INFO - Running setup.py (path:/tmp/pip-abqNhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:02 INFO - Running setup.py (path:/tmp/pip-YEyzVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:02 INFO - Running setup.py (path:/tmp/pip-vNtmeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:02 INFO - Running setup.py (path:/tmp/pip-MrjsOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:02 INFO - Running setup.py (path:/tmp/pip-B8aZ_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:02 INFO - Running setup.py (path:/tmp/pip-RsZgoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:03 INFO - Running setup.py (path:/tmp/pip-_q2y2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:03 INFO - Running setup.py (path:/tmp/pip-NsUOWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:03 INFO - Running setup.py (path:/tmp/pip-xxBbu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:03 INFO - Running setup.py (path:/tmp/pip-HBczMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:03 INFO - Running setup.py (path:/tmp/pip-QhvQiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:03 INFO - Running setup.py (path:/tmp/pip-inWWI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:03 INFO - Running setup.py (path:/tmp/pip-kgw2gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:03 INFO - Running setup.py install for manifestparser 16:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:52:03 INFO - Running setup.py install for mozcrash 16:52:03 INFO - Running setup.py install for mozdebug 16:52:03 INFO - Running setup.py install for mozdevice 16:52:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:52:03 INFO - Running setup.py install for mozfile 16:52:04 INFO - Running setup.py install for mozhttpd 16:52:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for mozinfo 16:52:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for mozInstall 16:52:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for mozleak 16:52:04 INFO - Running setup.py install for mozlog 16:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for moznetwork 16:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for mozprocess 16:52:04 INFO - Running setup.py install for mozprofile 16:52:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:52:04 INFO - Running setup.py install for mozrunner 16:52:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:52:05 INFO - Running setup.py install for mozscreenshot 16:52:05 INFO - Running setup.py install for moztest 16:52:05 INFO - Running setup.py install for mozversion 16:52:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:52:05 INFO - Cleaning up... 16:52:05 INFO - Return code: 0 16:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:05 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:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:05 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:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:05 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:52:05 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:52:05 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:52:05 INFO - Using env: {'DISPLAY': ':0', 16:52:05 INFO - 'HOME': '/home/cltbld', 16:52:05 INFO - 'LANG': 'en_US.UTF-8', 16:52:05 INFO - 'LANGUAGE': 'en_US:en', 16:52:05 INFO - 'LOGNAME': 'cltbld', 16:52:05 INFO - 'MAIL': '/var/mail/cltbld', 16:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:05 INFO - 'MOZ_NO_REMOTE': '1', 16:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:05 INFO - 'NO_EM_RESTART': '1', 16:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:05 INFO - 'PWD': '/builds/slave/test', 16:52:05 INFO - 'SHELL': '/bin/bash', 16:52:05 INFO - 'SHLVL': '1', 16:52:05 INFO - 'TERM': 'linux', 16:52:05 INFO - 'TMOUT': '86400', 16:52:05 INFO - 'USER': 'cltbld', 16:52:05 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:05 INFO - '_': '/tools/buildbot/bin/python'} 16:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:05 INFO - Running setup.py (path:/tmp/pip-fitBS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:05 INFO - Running setup.py (path:/tmp/pip-epFo6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:05 INFO - Running setup.py (path:/tmp/pip-fRu0LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:05 INFO - Running setup.py (path:/tmp/pip-1e89Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:05 INFO - Running setup.py (path:/tmp/pip-98tYrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:05 INFO - Running setup.py (path:/tmp/pip-UHryvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:06 INFO - Running setup.py (path:/tmp/pip-xp8Fzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:06 INFO - Running setup.py (path:/tmp/pip-KycJ_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:06 INFO - Running setup.py (path:/tmp/pip-H3iU4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:06 INFO - Running setup.py (path:/tmp/pip-lDE0XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:06 INFO - Running setup.py (path:/tmp/pip-qaixZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:06 INFO - Running setup.py (path:/tmp/pip-qe5zAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:06 INFO - Running setup.py (path:/tmp/pip-4lLPyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:06 INFO - Running setup.py (path:/tmp/pip-CYYnWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:06 INFO - Running setup.py (path:/tmp/pip-o6KNjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:06 INFO - Running setup.py (path:/tmp/pip-IL_uiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:06 INFO - Running setup.py (path:/tmp/pip-MoVVNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:06 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:52:06 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:52:06 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:52:06 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:52:06 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:52:06 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:52:06 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:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:06 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:52:06 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:52:06 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:52:06 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:52:07 INFO - Downloading blessings-1.6.tar.gz 16:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:52:08 INFO - Installing collected packages: blessings 16:52:08 INFO - Running setup.py install for blessings 16:52:08 INFO - Successfully installed blessings 16:52:08 INFO - Cleaning up... 16:52:08 INFO - Return code: 0 16:52:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:08 INFO - Reading from file tmpfile_stdout 16:52:08 INFO - Current package versions: 16:52:08 INFO - argparse == 1.2.1 16:52:08 INFO - blessings == 1.6 16:52:08 INFO - blobuploader == 1.2.4 16:52:08 INFO - docopt == 0.6.1 16:52:08 INFO - functools32 == 3.2.3-2 16:52:08 INFO - jsonschema == 2.5.1 16:52:08 INFO - manifestparser == 1.1 16:52:08 INFO - mozInstall == 1.13 16:52:08 INFO - mozcrash == 1.0 16:52:08 INFO - mozdebug == 0.1 16:52:08 INFO - mozdevice == 0.51 16:52:08 INFO - mozfile == 1.2 16:52:08 INFO - mozhttpd == 0.7 16:52:08 INFO - mozinfo == 0.10 16:52:08 INFO - mozleak == 0.1 16:52:08 INFO - mozlog == 3.5 16:52:08 INFO - moznetwork == 0.27 16:52:08 INFO - mozprocess == 0.25 16:52:08 INFO - mozprofile == 0.28 16:52:08 INFO - mozrunner == 6.13 16:52:08 INFO - mozscreenshot == 0.1 16:52:08 INFO - mozsystemmonitor == 0.3 16:52:08 INFO - moztest == 0.8 16:52:08 INFO - mozversion == 1.4 16:52:08 INFO - psutil == 3.1.1 16:52:08 INFO - requests == 1.2.3 16:52:08 INFO - wsgiref == 0.1.2 16:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:08 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:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:08 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:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:08 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:52:08 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:52:08 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:52:08 INFO - Using env: {'DISPLAY': ':0', 16:52:08 INFO - 'HOME': '/home/cltbld', 16:52:08 INFO - 'LANG': 'en_US.UTF-8', 16:52:08 INFO - 'LANGUAGE': 'en_US:en', 16:52:08 INFO - 'LOGNAME': 'cltbld', 16:52:08 INFO - 'MAIL': '/var/mail/cltbld', 16:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:08 INFO - 'MOZ_NO_REMOTE': '1', 16:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:08 INFO - 'NO_EM_RESTART': '1', 16:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:08 INFO - 'PWD': '/builds/slave/test', 16:52:08 INFO - 'SHELL': '/bin/bash', 16:52:08 INFO - 'SHLVL': '1', 16:52:08 INFO - 'TERM': 'linux', 16:52:08 INFO - 'TMOUT': '86400', 16:52:08 INFO - 'USER': 'cltbld', 16:52:08 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:08 INFO - '_': '/tools/buildbot/bin/python'} 16:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:52:09 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:52:09 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:52:09 INFO - Installing collected packages: simplejson 16:52:09 INFO - Running setup.py install for simplejson 16:52:09 INFO - building 'simplejson._speedups' extension 16:52:09 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:52:10 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:52:10 INFO - Successfully installed simplejson 16:52:10 INFO - Cleaning up... 16:52:10 INFO - Return code: 0 16:52:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:52:10 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:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:10 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:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:10 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 0x16f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a64f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', '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:52:10 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:52:10 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:52:10 INFO - Using env: {'DISPLAY': ':0', 16:52:10 INFO - 'HOME': '/home/cltbld', 16:52:10 INFO - 'LANG': 'en_US.UTF-8', 16:52:10 INFO - 'LANGUAGE': 'en_US:en', 16:52:10 INFO - 'LOGNAME': 'cltbld', 16:52:10 INFO - 'MAIL': '/var/mail/cltbld', 16:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:10 INFO - 'MOZ_NO_REMOTE': '1', 16:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:10 INFO - 'NO_EM_RESTART': '1', 16:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:10 INFO - 'PWD': '/builds/slave/test', 16:52:10 INFO - 'SHELL': '/bin/bash', 16:52:10 INFO - 'SHLVL': '1', 16:52:10 INFO - 'TERM': 'linux', 16:52:10 INFO - 'TMOUT': '86400', 16:52:10 INFO - 'USER': 'cltbld', 16:52:10 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:10 INFO - '_': '/tools/buildbot/bin/python'} 16:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:52:11 INFO - Cleaning up... 16:52:11 INFO - Return code: 0 16:52:11 INFO - Running post-action listener: _resource_record_post_action 16:52:11 INFO - Running post-action listener: _start_resource_monitoring 16:52:11 INFO - Starting resource monitoring. 16:52:11 INFO - [mozharness: 2017-08-18 23:52:11.078636Z] Finished create-virtualenv step (success) 16:52:11 INFO - [mozharness: 2017-08-18 23:52:11.079197Z] Running install step. 16:52:11 INFO - Running pre-action listener: _resource_record_pre_action 16:52:11 INFO - Running main action method: install 16:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:11 INFO - Reading from file tmpfile_stdout 16:52:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:52:11 INFO - Reading from file tmpfile_stdout 16:52:11 INFO - Output received: 16:52:11 INFO - Usage: mozinstall [options] installer 16:52:11 INFO - Options: 16:52:11 INFO - -h, --help show this help message and exit 16:52:11 INFO - -d DEST, --destination=DEST 16:52:11 INFO - Directory to install application into. [default: 16:52:11 INFO - "/builds/slave/test"] 16:52:11 INFO - --app=APP Application being installed. [default: firefox] 16:52:11 INFO - mkdir: /builds/slave/test/build/application 16:52:11 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:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:52:29 INFO - Reading from file tmpfile_stdout 16:52:29 INFO - Output received: 16:52:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:52:29 INFO - Running post-action listener: _resource_record_post_action 16:52:29 INFO - [mozharness: 2017-08-18 23:52:29.944717Z] Finished install step (success) 16:52:29 INFO - [mozharness: 2017-08-18 23:52:29.944863Z] Running setup-mitmproxy step. 16:52:29 INFO - Running pre-action listener: _resource_record_pre_action 16:52:29 INFO - Running main action method: setup_mitmproxy 16:52:29 INFO - Skipping: mitmproxy is not required 16:52:29 INFO - Running post-action listener: _resource_record_post_action 16:52:29 INFO - [mozharness: 2017-08-18 23:52:29.945822Z] Finished setup-mitmproxy step (success) 16:52:29 INFO - [mozharness: 2017-08-18 23:52:29.946040Z] Running run-tests step. 16:52:29 INFO - Running pre-action listener: _resource_record_pre_action 16:52:29 INFO - Running pre-action listener: _set_gcov_prefix 16:52:29 INFO - Running main action method: run_tests 16:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:52:29 INFO - Python 2.7.3 16:52:29 INFO - Return code: 0 16:52:29 INFO - grabbing minidump binary from tooltool 16:52:29 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:52:29 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 0x1a62130>, '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 0x1a63030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a634c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:52:29 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:52:29 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:52:29 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:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:30 INFO - Return code: 0 16:52:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:52:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:52:30 INFO - ENV: RUST_BACKTRACE is now full 16:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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:52:30 INFO - Using env: {'DISPLAY': ':0', 16:52:30 INFO - 'HOME': '/home/cltbld', 16:52:30 INFO - 'LANG': 'en_US.UTF-8', 16:52:30 INFO - 'LANGUAGE': 'en_US:en', 16:52:30 INFO - 'LOGNAME': 'cltbld', 16:52:30 INFO - 'MAIL': '/var/mail/cltbld', 16:52:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:52:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:30 INFO - 'MOZ_NO_REMOTE': '1', 16:52:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:30 INFO - 'NO_EM_RESTART': '1', 16:52:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:30 INFO - 'PWD': '/builds/slave/test', 16:52:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:52:30 INFO - 'RUST_BACKTRACE': 'full', 16:52:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:52:30 INFO - 'SHELL': '/bin/bash', 16:52:30 INFO - 'SHLVL': '1', 16:52:30 INFO - 'TERM': 'linux', 16:52:30 INFO - 'TMOUT': '86400', 16:52:30 INFO - 'USER': 'cltbld', 16:52:30 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501', 16:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:30 INFO - '_': '/tools/buildbot/bin/python'} 16:52:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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:52:30 INFO - mozversion application_buildid: 20170818225328 16:52:30 INFO - mozversion application_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 16:52:30 INFO - mozversion application_display_name: Nightly 16:52:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:30 INFO - mozversion application_name: Firefox 16:52:30 INFO - mozversion application_remotingname: firefox 16:52:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:52:30 INFO - mozversion application_vendor: Mozilla 16:52:30 INFO - mozversion application_version: 57.0a1 16:52:30 INFO - mozversion platform_buildid: 20170818225328 16:52:30 INFO - mozversion platform_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 16:52:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:52:30 INFO - mozversion platform_version: 57.0a1 16:52:30 INFO - using testdate: 1503100350 16:52:30 INFO - actual date: 1503100350 16:52:30 INFO - starting webserver on 'localhost:56263' 16:52:30 INFO - SUITE-START | Running 2 tests 16:52:30 INFO - TEST-START | dromaeo_css 16:52:30 INFO - Initialising browser for dromaeo_css test... 16:52:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56263/getInfo.html -profile /tmp/tmp1FcIhw/profile 16:52:30 INFO - TEST-INFO | started process 20034 (/builds/slave/test/build/application/firefox/firefox http://localhost:56263/getInfo.html) 16:52:36 INFO - TEST-INFO | 20034: exit 0 16:52:36 INFO - Browser initialized. 16:52:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:36 INFO - TEST-INFO | started process 20245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FcIhw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:37 INFO - PID 20245 | 16:52:37 INFO - PID 20245 | (/builds/slave/test/build/application/firefox/firefox:20294): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:52:37 INFO - PID 20245 | 16:52:38 INFO - PID 20245 | 16:52:38 INFO - PID 20245 | (/builds/slave/test/build/application/firefox/firefox:20348): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:52:38 INFO - PID 20245 | 16:52:38 INFO - PID 20245 | __metrics Screen width/height:1600/1200 16:52:38 INFO - PID 20245 | colorDepth:24 16:52:38 INFO - PID 20245 | Browser inner width/height: 1024/768 16:52:38 INFO - PID 20245 | __metrics 16:52:47 INFO - PID 20245 | RSS: Main: 172351488 16:52:47 INFO - PID 20245 | 16:55:46 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56263/tests/dromaeo/cssquery-ext.html) 16:55:48 INFO - PID 20245 | RSS: Main: 176193536 16:55:48 INFO - PID 20245 | 16:58:49 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-ext.html (next: http://localhost:56263/tests/dromaeo/cssquery-jquery.html) 16:58:50 INFO - PID 20245 | RSS: Main: 171606016 16:58:50 INFO - PID 20245 | 17:01:52 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56263/tests/dromaeo/cssquery-mootools.html) 17:01:52 INFO - PID 20245 | RSS: Main: 173522944 17:01:52 INFO - PID 20245 | 17:04:54 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56263/tests/dromaeo/cssquery-prototype.html) 17:04:55 INFO - PID 20245 | RSS: Main: 171352064 17:04:55 INFO - PID 20245 | 17:07:58 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56263/tests/dromaeo/cssquery-yui.html) 17:07:59 INFO - PID 20245 | RSS: Main: 174882816 17:07:59 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | Cycle 1(1): loaded http://localhost:56263/tests/dromaeo/cssquery-yui.html (next: http://localhost:56263/tests/dromaeo/cssquery-dojo.html) 17:11:01 INFO - PID 20245 | RSS: Main: 177397760 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | __start_tp_report 17:11:01 INFO - PID 20245 | _x_x_mozilla_page_load 17:11:01 INFO - PID 20245 | _x_x_mozilla_page_load_details 17:11:01 INFO - PID 20245 | |i|pagename|runs| 17:11:01 INFO - PID 20245 | |0;dojo.html;3128.89048883289;3154.558361829346;3156.7632427567933;3174.492081266997;3189.4259033373996;6057.515398768088;6136.754529818808;6201.193844800176;6243.188385509889;6273.12176295319;6239;6258.593191442565;6276.435120839124;6314.747410103601;6357.71390287437;5634.605577609569;5733.799317023905;5787.102999035156;5825.825225243249;5846.678432686201;5661.943380566204;5683.971580142114;5747.885042299152;5748.367679555246;5752.28096487939;5611.382747897707;5658.8019419320335;5673.886522269573;5681.204631351614;5683.573731970118;5610.046292130348;5631.380548139701;5653.632513886584;5665.943340566583;5714.114312281603;5545.528630066449;5627.493525582717;5635.267415236034;5635.464630860061;5688.658680479143;5947.881042379171;6098.908516372258;6102.359252278536;6117.5717699761035;6135.9079613805825;6557.049227861981;6627.072209890619;6657.900131498031;6721.731130754764;6723.697433615499;6694.531382803206;6705.329467053256;6708.597484150967;6769.898451523231;6804.931950680529;6261.27995280544;6291.559590828644;6295.024271237966;6316;6316.115743795872;6826.897596536056;6861;6891.896621550681;6967.1291088613925;6971.651417429108;6455;6471.288158302583;6487.448566871774;6505.60966342021;6601.900971485432;6619.106420633249;6619.536632435779;6621.973594092923;6639.966800165968;6662.5003124765835;6521.315261897527;6566.179227596551;6571.67141642916;6598.736050557924;6623.933760662332;6525.608463492205;6612.173478315211;6614.239362473281;6672.933270667231;6674.799756007327;4938.604911607063;5390.595705322116;5433.320834895638;5461.808836690697;5482.122860342326;4677.906441871143;4686.39076920005;4689.413823272091;4694.108119457293;4735.479097299294;5800.738966746507;5824.097264923944;5879.706014699248;5906.586538942232;5909.349971503131;6590.5716128451495;6682.064510968371;6720.092787473726;6732.259451460335;6822.351876571718;5786.681732504669;5808.041673123972;5813.418658134237;5822.359540450547;5830.737616807254;5950.4049595041015;5957.4638282553915;5962.612430192024;5970.9701451492465;5976.193213916065;6416.807495775134;6431.517636177306;6446.871062578816;6522.869542609121;6536.0522724205675;6540;6659.034440006075;6667.66661666905;6732.730690772314;6742.69657865407;6387.265464471645;6401.55189136756;6408.423241908251;6414.61512309263;6422.26143993428;6178.41305076017;6521.347865213441;6539.607623542603;6578.671066446563;6587.242467116343;6210.4100110489435;6628.204615446178;6638.53530252897;6732.831679208059;6749.055132281386;6384.9042264367;6384.936150638434;6495.675216239264;6504.837379065561;6533.020046992989;6343;6430.582012169381;6453.032045193258;6510;6510.44661203803;6389.648569328731;6465.288818230085;6482.773102941374;6485.805425837044;6513.088167656627;6568.376004279586;6584.901226481702;6614.305497922841;6631.33686631333;6657.533972622064;6352.714127864349;6353.078803573549;6448.967755161194;6452.451541619015;6455.064015717789 17:11:01 INFO - PID 20245 | |1;ext.html;799.4603642541283;851.7444766570029;879.859222524396;886.3573908916037;1183.118576660388;30404.543931841014;30989.535156972608;30995.690043099592;41353.58646413535;42086.789566052204;42373;42753.57246427543;42760;42762.57237427625;42797.144057118836;7605.277498637648;7623.771286861389;7763;7763.456558040939;7764.767056988299;7670.463067585271;7778.377729781632;7784.610769461533;7786.260305271018;7787.493812902171;7733.690652373898;7791.065072191345;7793.376529877624;7794.493357931745;7796.727114550992;7724.382049436032;7739.3421559167255;7764.534127952341;7771.261730135628;7778.5721785301785;7624.771256862303;7695.961520192363;7713.3443657288635;7714.575698336589;7717.961410192969;39514.60485395138;39569;39704;39769;39928.401073983914;3563.233904710474;3600.0819790953137;3600.261946301002;3615.0600843780544;3615.6022837488117;31696.683033169604;31704.36591268185;31804.20489487758;31838;31863.681363186533;4970.304157417964;4975;4977.303177555145;4995.925061124086;5095.159298715707;199271;199851;200490;200779;200860.99569502205;48101.518984810406;48153.51846481561;48210.758946205744;48221;48263.75868120637;51674;53827;53862;53924.73037634787;53940.46059539433;16356.100414477318;16362.263698133613;16368.508944731677;16380.180990950405;16499;13177.341132943506;13415.798763018562;13419.261940593165;13421.194728316332;13426.060175787601;14492.782608260884;14571;14591.270436478133;14598.489052883098;14724.705505889822;5974.671393073336;5978.222831031938;5994.850128746816;6019.789307374309;6069.206745783885;991.5409783736375;1010.8786945566579;1011.5043628622069;1015.94920253987;1041.6146025970288;22486.325410237718;23280;23449.648255276184;23453.882730586578;23582.764172358056;1086.3101930274333;1088.6298658456162;1102.1458369763498;1104.0891264706488;1121.52895783771;12287.69280767988;12327.93836030814;12334.81497777534;12392;12399.628011159679;239356;241356;242988;243062;243949;53863;54295;54371.72814135983;54373.72813135909;54642.45357546453;1424.8432672406027;1458.4093442155943;1473.911565306085;1481.222358261921;1489.0767724010966;22343.44141396478;22751.203707870147;22794.65808012848;23054.193103241305;23083.88458057699;37902.8104859474;37993.240135197695;38015.42976855294;38043.42934855924;38127.237455250186;206075;221058;226838;227038;227465;36653.450198246515;36838;37117;37156.44265335968;37161.814190928875;43729.781351094316;44989.32516012197;45139.7743011296;45440.31839522476;46268;33773.662263378035;33776.32447351088;33942.83028584841;34068.318633626695;34309.656903430645;33494.16264593405;34175;34569.65430345664;35088.29823403569;35324.293514130084;37071.8146409277;37188.81405593063;37574.81212593919;37657.62342376541;37726.245475090895;32800.343993119524;33244.1688957778;33278;34350.65649343475;34748.30503389968;24401;24504.264872053867;24655.753442465346;25397.238082857544;25760.742392575834 17:11:01 INFO - PID 20245 | |2;jquery.html;561.6630021986808;561.9578531610131;566.6486778197518;570.5093619487237;571.1974675580809;21895.67156492654;22554.54890902181;22570.210042648512;22679.433014174654;22725;25498.74501254987;27800.026999055037;27842.443151136966;27856.3035924102;27928;6923.861522769529;7063.540869843469;7077.079979602644;7081.89377159343;7088.07854978852;6597.406233438989;6911.654417279141;6927.030215769796;6967.721291148348;7015.789526314194;6926.099607051076;6926.619035953021;6933.4106600938985;6933.4106600938985;6938.09804725385;6914.239433662318;6917.377436030731;6917.792466226021;6919.238883722786;6923.896141557881;6792.898106528406;6793.694283757242;6797.762078327284;6801.829954251134;6805.557638753515;30452.69547304521;31121.533177002362;31685.52471712926;31737.365252695046;31837;1877.1646617255326;1929.7105434184843;1931.0634342343951;1931.6136772645527;1932.8357089647398;20371.694424583642;20455.693164602544;20877.58244835095;21557.245496407708;21630.24294149713;2547.197632745679;2549.7067837198774;2619.6463477430493;2620.7248238935017;2627.2643659775295;142652;146715;146790.2660486712;147017;147033.26483367514;20331.695024574645;20656.690149647766;22216.666749998763;22374;23664.881675591856;46356.3046554302;46363;46468.7676561615;46536;46571.53428465672;12037;12191;12193.634190974284;12263.693407664701;12395.442205100791;10105.797884042426;10169.54237059334;10263;10328;10414.531346089445;9464.479453630116;11289.20975531705;11573.710657233636;11926.880731192578;12376.443060062318;3382.729381649462;3531.947020794639;3774.6036666150208;3807.809609519513;3833.7701235492327;930.7952250504878;934.8083642853198;954.8329042417688;960.4093482508207;962.7978124593914;20152.596948060956;20342.186312547332;20451.59096818085;20667;20897;1022.5960745505483;1029.8300780371155;1034.5706531789374;1040.6461802987021;1042.804895694552;10899.727506812393;11031.779364412667;11362.261453005529;11369.829452558219;11386.544538218379;513311.87331927224;535156;538544;540403;549684;123189;124461;125213;125480;126022;1191.1364260910943;1207.6558180918396;1223.7246619510538;1226.88957993781;1238.0838179746743;17143.657126857142;17146.742798858275;17243.65512689714;17562.648747025243;17886;49589.752051240954;51298;51612.22581661203;51805;52324.47675523196;67707.66146169238;68838.31161688319;69024.6548767253;69028;69042.65478672575;14424.350904209545;14733;14830.258487075818;14843.777343339643;14962.401503940157;23232.186873460025;23327.066917323118;23332.76667233374;23374.532509349378;23405.648915265945;18418.447446576625;18583.53541161482;18657.346992855186;18757.249710011445;18841.528961775515;15627.841902763295;16005.839941600434;16182;16396.180190990643;17092.48722538326;18825.811741882953;19149.659523833754;19167.13747881321;19267.51831204231;19299.22803087917;14732.484363047242;14749.778753318495;14757.040792348464;14805.407783688532;14908.701825963637;18333.3583324583;18375.08124593738;18381.26474941041;18719.438416846973;18743.90628046851 17:11:01 INFO - PID 20245 | |3;mootools.html;1315.4146404849841;1387.1191793211308;1407.1135184833556;1421.1686163594304;1425.3585886351145;13727.245001524912;14426.855731442682;14427.639309017266;14481.34833932473;14587.34356953937;14301.570952871405;14670.559883203521;14674.192919389428;14674.486392976249;14694.779578306307;2622.187121992179;2695.070200780732;2757.834529928211;2761.3096725818546;2788.6932437431865;2711.864406779663;2739.5479745842013;2740.1642499037785;2741.1776467059904;2741.616173735679;2661;2688.1666683328135;2688.5429476988957;2698.298442404979;2698.541247987847;2616.5290247755397;2631.1054241557867;2647.2852329870925;2662.7603515683486;2666.226794229671;2595.870206489687;2601.7658410742933;2615.6207349934343;2620.358012286983;2620.606908963671;13743;13865;13871.514496992557;13887.930560347235;13917.373718182605;7642.3121919027;7876.72431464896;7887.250711182429;7900.486468379537;7922.445428819985;4889.559939605417;4997.200447928314;5064.379398592452;5138.332016837825;5152.304438900738;1736.1319340329835;1761.2690733345646;1770.4246120011048;1783.8662100342526;1793.3006127610242;22677.77322226773;23034.308970730905;23161.189358372376;23167.073317067297;23199.304020879234;6816.171288915045;6870.3473170048765;6979.8604027919155;7089.255628158969;7089.680964356617;18709.345172918882;18786;18787.812121878607;18791.34230301933;18803.05984700787;7651.808704782425;7907.486013409225;7915.881261781078;7918.129005809356;7924.722634707758;5919.733611987471;6052.697365131726;6435.22777266731;7001.964990175016;7027.8945815811785;5456.127019676833;5542.63972841764;5611.2224448897505;5665.461781130786;5695.7152142392715;1679.7480377943161;1738.826117388251;1745.3367720266472;1758.2175931710267;1772.5480002599254;884.5179377239419;897.7261935109724;904.014624059778;905.3029167540957;912.8630705394111;7079.575225486487;7145;7156.499045066899;7198.496105272686;7209.35115839577;717.2540557819913;721.4480922094601;726.3898424828593;729.2707292707292;731.579341878422;4642.234031384851;5806.709664516758;5813.447722466359;5819.679917604488;6018.909716354258;19310.227590896207;19311.130999105073;19736.605267894847;19742.30901918426;19743.50641233952;18885.716714249298;19011;19277.614447710966;19319.130639121275;19323.227070917288;10133.733283339583;10344.948275258575;10348.637797677045;10394.844077338998;10454.372737635766;8431.40980131385;8467.57662116904;8483.575821208791;8523.318134549345;8790.692325768567;17042.48872533826;17179.828201717824;17267.65464690674;17393.13034348252;17395.652086957936;17610.38363657266;17761.822381776015;17888.28446862163;17953.910230448764;17976.37082702099;11641.767164656829;11883.702907427383;11901;11907.345096019802;11908.225965312573;13116.344182791014;13125.868741312464;13144.934275328562;13194.274314912773;13209.405576749261;10665.680029599125;10808.405537695502;10821.67534973952;10915.781684366428;11128.666140015812;10692.14462842955;10763.461826908466;10919.672409827717;10999.285046471954;11045.558177672803;9514.38156519824;9576.042395760369;9665.9033409665;9668.516574171123;9753.60985560598;7209.675564599501;7321.194668586558;7395.852082958203;7444;7494.662740176596;7342.743003995049;7597.898304745891;7618.771436856903;7627.923720762721;7647.847043058996 17:11:01 INFO - PID 20245 | |4;prototype.html;497.22433004512965;497.24418883297386;522.4305506997372;527.4013994116677;529.8869143780288;6217.1917650705345;6235.251769787632;6293.181886354773;6378.3621637836195;6381.5851969621945;5955.464008239258;6108.6945652717295;6121.908171377422;6153.323134455206;6172.722227499762;4964;4964.304997300381;4976.104301225778;4985.950140498603;4993.750312484371;4951.826686065989;4975.4527002029745;4990.429928586781;4991.700497970115;5010.298558201855;4832.7583620819;4921.286413470045;4965.702057876539;4972.801087956477;4981.37732783402;4881.633877459187;4957.82647607332;4971.577415919651;4979.950200498003;4987.526185012418;4438.778061096932;4447.844325448594;4471.642268618502;4474.619657329131;4475.440569928759;6090.48230900374;6119.541034422392;6134.478569321568;6186.319504854462;6192.318844927055;5729.28383952006;5758.913616295759;5765.798197063083;5786.987277226511;5792.536597072224;6550.312217217172;6584.473242140617;6597;6657.434118099967;6664.8000559983275;4832;4851.345068415754;4883.046781287513;4884.923907339366;4886.413630364379;6900.861982760367;6929.514933954625;6964.651767411609;7002.159740831133;7004.754833580801;4934.7285899275885;4965.280034394992;4970.72661003641;5015.473375295542;5033.6224783141415;5023.673461225082;5030.7233102179;5039.798408063636;5066.36670416198;5081.2632168335385;5685.147227915846;5696.1455781633085;5738.885222295531;5774.220480235199;5779.913301300484;6632.403083722488;6634.469242460592;6651.900221496681;6680.832979175462;6691.26396096429;1673.3724853180058;1693.0857337038108;1707.2061491406555;1718.561766749471;1773.423637317877;1182.6215611004568;1211.6849619099098;1216.6593353860933;1230.5939040116739;1233.3833083458271;5838.211841401441;5885.911711324334;5903.911441328383;5918.556108291809;5927.103326935339;6628.171478565179;6690.431313338323;6707.899381509281;6717.764878229238;6864.656767161622;5789.681567513743;5856.452443187227;5860.179574859523;5865.824025279248;5941.940580594225;3552.1297282166033;3567.554055743032;3593.658602432765;3598.280343931172;3629;6538.574992625464;6616.305287944792;6617.569857959314;6618.238902526175;6650.301718319603;6902.689378977958;6903.1716194057035;6949.409300209539;7033.437325014089;7053.788386348418;6569.868602627921;6590.7693230736695;6642.4021838034805;6654.168228971379;6694.866102678016;6818.8636227276165;6840.623765692934;6866.725330986905;6868.210155832143;6896.896546551706;6685.8328541784895;6716.361945615159;6781.321867813179;6812.14848143982;6832.965835170792;6624.503162262753;6634.65430143257;6638.17022872141;6653.534252602465;6709.966450167718;5015.22264049073;5051.974740126276;5056.873578160576;5068;5098.566621837185;6850.931490685229;6890.345417185359;6900.275471075464;6911.7926462206215;6919.584824910521;6536.470306034688;6570.77002304917;6609.347663084229;6651.669666066709;6661.566998145105;6246.875062498815;6600.273969863407;6612.669366531558;6633.568818026813;6640.07039014548;6015.548833837567;6396.976483762575;6397.616143031433;6416.230052393743;6450;6583.63789991555;6584.934150658432;6627.237867645283;6640.568363056386;6665.666716664245;6394.616323020447;6397.520185985976;6419.325970773189;6427.260865000585;6440.871182576416 17:11:01 INFO - PID 20245 | |5;yui.html;878.1174919206193;897.2552781191612;907.5552979040273;911.9589618467172;914.8033172867832;19029;19093.23627054918;19900.70148947767;19947.401577952667;19983.700244496307;21573.46066348342;22171.889140554315;22251.44371390712;22335.888320558413;22358.21746238882;1015.8374660054411;1049.664107485605;1052.6947185316249;1052.8052310322576;1052.8052310322614;971.7279161834663;1057.820170571001;1069.6309773128298;1071.201954543866;1071.614218881202;1126.5043380912414;1128.0806142993474;1128.2215271462705;1128.8137457319533;1129.0572372069332;1126.1047467263545;1126.189143816455;1126.3410904620807;1127.1152145565732;1127.5264388956616;824.1922915542742;824.744329257932;825.335604838105;825.8554752918276;825.9132791056973;20189.19243230269;20313.18747250123;20344.69482957757;20357.79642203574;21074.89462552693;20891.95540222983;21022.5795484091;21343.67984480234;21637.67543486833;21700.457488562755;17211.655766884716;17217.966921984596;17289;17318.307267709275;17469.825301747074;3591.586967498745;3597.1726502904216;3610.295992281506;3619.2942376236642;3627.909302267464;128560.35719821342;130121;132046.6795332044;132291.33854330666;134564.32717836447;16766.664666706598;16830.495085147464;16994.150292485327;17403.73894391585;17423;31176;31890.521642175387;32545.51181732276;33054.834725826215;33058.8347058268;7309;7585.127710313384;7692.230776922263;8405.53769542681;8434.704785332484;4346.261135606955;4405.185040767468;4411.580899814512;4432.31299148626;4436.534163912743;4956.8760780980765;5001.424836143818;5004.224345226496;5073.416557095908;5087.135187018216;939.736873675372;959.1271942532262;967.777411195429;969.5636963366513;972.2027937091658;674.649182425146;691.350130876984;694.7846167688033;699.4614147106699;704.5103652961245;11389.544418223179;11871;11938.58214962472;12290.815637765441;12915.483380664857;707.345705222667;711.0827033127312;711.5375006245981;713.4149997002409;716.8566286742672;5365.263715505121;5489.039418101816;5607.214989901417;5734.856628584319;5747.540196784247;109760.4511977435;111972;112936.43531782289;113394;114923.42538287255;98277.50861245648;100063.49968250112;100238;101390;106789.46605266925;85522.57238713767;85605.57197213975;88649.11350886666;88827.55586222028;92052;9810.705678829647;9834.164096051629;9930.553125109533;9956.701298961043;10262.640807571699;38534.45862165482;40636.390454142624;41394.37908431316;41969;42423.787881060394;71604.64197678979;72162.27837721766;73250;74533.25466745264;75530.24469755232;19442.611147777247;19460.610787784448;19549.51126221856;19560.413187604394;19879.701804473232;18078.5480362992;18078.63842723112;20194.89902550478;20298.188072477526;20319.796802032382;18033.278668853098;18140.637187256445;18191.727124092886;18631;19009.809901900804;17453;18073.638527229647;18260.269589216812;18341;18423.81576184221;19478.318258860872;19615.411537653894;19723.901380493007;19916.90041549783;19947;12486.937565312115;12548.99608031337;13410.932945335211;13689.247091410069;14386.928065359607;12361.93819030899;13856.653583660489;13862.306884655929;14331.928340358232;14365.281735913371 17:11:01 INFO - PID 20245 | __end_tp_report 17:11:01 INFO - PID 20245 | __start_cc_report 17:11:01 INFO - PID 20245 | _x_x_mozilla_cycle_collect,375 17:11:01 INFO - PID 20245 | __end_cc_report 17:11:01 INFO - PID 20245 | __startTimestamp1503101461471__endTimestamp 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | ------- Summary: start ------- 17:11:01 INFO - PID 20245 | Number of tests: 6 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#0] dojo.html Cycles:165 Average:6135.61 Median:6387.27 stddev:715.49 (11.2%) stddev-sans-first:677.69 17:11:01 INFO - PID 20245 | Values: 3128.9 3154.6 3156.8 3174.5 3189.4 6057.5 6136.8 6201.2 6243.2 6273.1 6239.0 6258.6 6276.4 6314.7 6357.7 5634.6 5733.8 5787.1 5825.8 5846.7 5661.9 5684.0 5747.9 5748.4 5752.3 5611.4 5658.8 5673.9 5681.2 5683.6 5610.0 5631.4 5653.6 5665.9 5714.1 5545.5 5627.5 5635.3 5635.5 5688.7 5947.9 6098.9 6102.4 6117.6 6135.9 6557.0 6627.1 6657.9 6721.7 6723.7 6694.5 6705.3 6708.6 6769.9 6804.9 6261.3 6291.6 6295.0 6316.0 6316.1 6826.9 6861.0 6891.9 6967.1 6971.7 6455.0 6471.3 6487.4 6505.6 6601.9 6619.1 6619.5 6622.0 6640.0 6662.5 6521.3 6566.2 6571.7 6598.7 6623.9 6525.6 6612.2 6614.2 6672.9 6674.8 4938.6 5390.6 5433.3 5461.8 5482.1 4677.9 4686.4 4689.4 4694.1 4735.5 5800.7 5824.1 5879.7 5906.6 5909.3 6590.6 6682.1 6720.1 6732.3 6822.4 5786.7 5808.0 5813.4 5822.4 5830.7 5950.4 5957.5 5962.6 5971.0 5976.2 6416.8 6431.5 6446.9 6522.9 6536.1 6540.0 6659.0 6667.7 6732.7 6742.7 6387.3 6401.6 6408.4 6414.6 6422.3 6178.4 6521.3 6539.6 6578.7 6587.2 6210.4 6628.2 6638.5 6732.8 6749.1 6384.9 6384.9 6495.7 6504.8 6533.0 6343.0 6430.6 6453.0 6510.0 6510.4 6389.6 6465.3 6482.8 6485.8 6513.1 6568.4 6584.9 6614.3 6631.3 6657.5 6352.7 6353.1 6449.0 6452.5 6455.1 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#1] ext.html Cycles:180 Average:39295.24 Median:3607.66 stddev:57599.70 (1596.6%) stddev-sans-first:57688.75 17:11:01 INFO - PID 20245 | Values: 799.5 851.7 879.9 886.4 1183.1 30404.5 30989.5 30995.7 41353.6 42086.8 42373.0 42753.6 42760.0 42762.6 42797.1 7605.3 7623.8 7763.0 7763.5 7764.8 7670.5 7778.4 7784.6 7786.3 7787.5 7733.7 7791.1 7793.4 7794.5 7796.7 7724.4 7739.3 7764.5 7771.3 7778.6 7624.8 7696.0 7713.3 7714.6 7718.0 39514.6 39569.0 39704.0 39769.0 39928.4 3563.2 3600.1 3600.3 3615.1 3615.6 31696.7 31704.4 31804.2 31838.0 31863.7 4970.3 4975.0 4977.3 4995.9 5095.2 199271.0 199851.0 200490.0 200779.0 200861.0 48101.5 48153.5 48210.8 48221.0 48263.8 51674.0 53827.0 53862.0 53924.7 53940.5 16356.1 16362.3 16368.5 16380.2 16499.0 13177.3 13415.8 13419.3 13421.2 13426.1 14492.8 14571.0 14591.3 14598.5 14724.7 5974.7 5978.2 5994.9 6019.8 6069.2 991.5 1010.9 1011.5 1015.9 1041.6 22486.3 23280.0 23449.6 23453.9 23582.8 1086.3 1088.6 1102.1 1104.1 1121.5 12287.7 12327.9 12334.8 12392.0 12399.6 239356.0 241356.0 242988.0 243062.0 243949.0 53863.0 54295.0 54371.7 54373.7 54642.5 1424.8 1458.4 1473.9 1481.2 1489.1 22343.4 22751.2 22794.7 23054.2 23083.9 37902.8 37993.2 38015.4 38043.4 38127.2 206075.0 221058.0 226838.0 227038.0 227465.0 36653.5 36838.0 37117.0 37156.4 37161.8 43729.8 44989.3 45139.8 45440.3 46268.0 33773.7 33776.3 33942.8 34068.3 34309.7 33494.2 34175.0 34569.7 35088.3 35324.3 37071.8 37188.8 37574.8 37657.6 37726.2 32800.3 33244.2 33278.0 34350.7 34748.3 24401.0 24504.3 24655.8 25397.2 25760.7 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#2] jquery.html Cycles:180 Average:37549.81 Median:21762.96 stddev:89920.04 (413.2%) stddev-sans-first:90129.41 17:11:01 INFO - PID 20245 | Values: 561.7 562.0 566.6 570.5 571.2 21895.7 22554.5 22570.2 22679.4 22725.0 25498.7 27800.0 27842.4 27856.3 27928.0 6923.9 7063.5 7077.1 7081.9 7088.1 6597.4 6911.7 6927.0 6967.7 7015.8 6926.1 6926.6 6933.4 6933.4 6938.1 6914.2 6917.4 6917.8 6919.2 6923.9 6792.9 6793.7 6797.8 6801.8 6805.6 30452.7 31121.5 31685.5 31737.4 31837.0 1877.2 1929.7 1931.1 1931.6 1932.8 20371.7 20455.7 20877.6 21557.2 21630.2 2547.2 2549.7 2619.6 2620.7 2627.3 142652.0 146715.0 146790.3 147017.0 147033.3 20331.7 20656.7 22216.7 22374.0 23664.9 46356.3 46363.0 46468.8 46536.0 46571.5 12037.0 12191.0 12193.6 12263.7 12395.4 10105.8 10169.5 10263.0 10328.0 10414.5 9464.5 11289.2 11573.7 11926.9 12376.4 3382.7 3531.9 3774.6 3807.8 3833.8 930.8 934.8 954.8 960.4 962.8 20152.6 20342.2 20451.6 20667.0 20897.0 1022.6 1029.8 1034.6 1040.6 1042.8 10899.7 11031.8 11362.3 11369.8 11386.5 513311.9 535156.0 538544.0 540403.0 549684.0 123189.0 124461.0 125213.0 125480.0 126022.0 1191.1 1207.7 1223.7 1226.9 1238.1 17143.7 17146.7 17243.7 17562.6 17886.0 49589.8 51298.0 51612.2 51805.0 52324.5 67707.7 68838.3 69024.7 69028.0 69042.7 14424.4 14733.0 14830.3 14843.8 14962.4 23232.2 23327.1 23332.8 23374.5 23405.6 18418.4 18583.5 18657.3 18757.2 18841.5 15627.8 16005.8 16182.0 16396.2 17092.5 18825.8 19149.7 19167.1 19267.5 19299.2 14732.5 14749.8 14757.0 14805.4 14908.7 18333.4 18375.1 18381.3 18719.4 18743.9 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#3] mootools.html Cycles:180 Average:8921.19 Median:2621.40 stddev:6094.10 (232.5%) stddev-sans-first:6084.40 17:11:01 INFO - PID 20245 | Values: 1315.4 1387.1 1407.1 1421.2 1425.4 13727.2 14426.9 14427.6 14481.3 14587.3 14301.6 14670.6 14674.2 14674.5 14694.8 2622.2 2695.1 2757.8 2761.3 2788.7 2711.9 2739.5 2740.2 2741.2 2741.6 2661.0 2688.2 2688.5 2698.3 2698.5 2616.5 2631.1 2647.3 2662.8 2666.2 2595.9 2601.8 2615.6 2620.4 2620.6 13743.0 13865.0 13871.5 13887.9 13917.4 7642.3 7876.7 7887.3 7900.5 7922.4 4889.6 4997.2 5064.4 5138.3 5152.3 1736.1 1761.3 1770.4 1783.9 1793.3 22677.8 23034.3 23161.2 23167.1 23199.3 6816.2 6870.3 6979.9 7089.3 7089.7 18709.3 18786.0 18787.8 18791.3 18803.1 7651.8 7907.5 7915.9 7918.1 7924.7 5919.7 6052.7 6435.2 7002.0 7027.9 5456.1 5542.6 5611.2 5665.5 5695.7 1679.7 1738.8 1745.3 1758.2 1772.5 884.5 897.7 904.0 905.3 912.9 7079.6 7145.0 7156.5 7198.5 7209.4 717.3 721.4 726.4 729.3 731.6 4642.2 5806.7 5813.4 5819.7 6018.9 19310.2 19311.1 19736.6 19742.3 19743.5 18885.7 19011.0 19277.6 19319.1 19323.2 10133.7 10344.9 10348.6 10394.8 10454.4 8431.4 8467.6 8483.6 8523.3 8790.7 17042.5 17179.8 17267.7 17393.1 17395.7 17610.4 17761.8 17888.3 17953.9 17976.4 11641.8 11883.7 11901.0 11907.3 11908.2 13116.3 13125.9 13144.9 13194.3 13209.4 10665.7 10808.4 10821.7 10915.8 11128.7 10692.1 10763.5 10919.7 10999.3 11045.6 9514.4 9576.0 9665.9 9668.5 9753.6 7209.7 7321.2 7395.9 7444.0 7494.7 7342.7 7597.9 7618.8 7627.9 7647.8 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#4] prototype.html Cycles:180 Average:5554.52 Median:6128.19 stddev:1577.00 (25.7%) stddev-sans-first:1535.06 17:11:01 INFO - PID 20245 | Values: 497.2 497.2 522.4 527.4 529.9 6217.2 6235.3 6293.2 6378.4 6381.6 5955.5 6108.7 6121.9 6153.3 6172.7 4964.0 4964.3 4976.1 4986.0 4993.8 4951.8 4975.5 4990.4 4991.7 5010.3 4832.8 4921.3 4965.7 4972.8 4981.4 4881.6 4957.8 4971.6 4980.0 4987.5 4438.8 4447.8 4471.6 4474.6 4475.4 6090.5 6119.5 6134.5 6186.3 6192.3 5729.3 5758.9 5765.8 5787.0 5792.5 6550.3 6584.5 6597.0 6657.4 6664.8 4832.0 4851.3 4883.0 4884.9 4886.4 6900.9 6929.5 6964.7 7002.2 7004.8 4934.7 4965.3 4970.7 5015.5 5033.6 5023.7 5030.7 5039.8 5066.4 5081.3 5685.1 5696.1 5738.9 5774.2 5779.9 6632.4 6634.5 6651.9 6680.8 6691.3 1673.4 1693.1 1707.2 1718.6 1773.4 1182.6 1211.7 1216.7 1230.6 1233.4 5838.2 5885.9 5903.9 5918.6 5927.1 6628.2 6690.4 6707.9 6717.8 6864.7 5789.7 5856.5 5860.2 5865.8 5941.9 3552.1 3567.6 3593.7 3598.3 3629.0 6538.6 6616.3 6617.6 6618.2 6650.3 6902.7 6903.2 6949.4 7033.4 7053.8 6569.9 6590.8 6642.4 6654.2 6694.9 6818.9 6840.6 6866.7 6868.2 6896.9 6685.8 6716.4 6781.3 6812.1 6833.0 6624.5 6634.7 6638.2 6653.5 6710.0 5015.2 5052.0 5056.9 5068.0 5098.6 6850.9 6890.3 6900.3 6911.8 6919.6 6536.5 6570.8 6609.3 6651.7 6661.6 6246.9 6600.3 6612.7 6633.6 6640.1 6015.5 6397.0 6397.6 6416.2 6450.0 6583.6 6584.9 6627.2 6640.6 6665.7 6394.6 6397.5 6419.3 6427.3 6440.9 17:11:01 INFO - PID 20245 | 17:11:01 INFO - PID 20245 | [#5] yui.html Cycles:180 Average:24375.44 Median:20332.25 stddev:33298.36 (163.8%) stddev-sans-first:33345.03 17:11:01 INFO - PID 20245 | Values: 878.1 897.3 907.6 912.0 914.8 19029.0 19093.2 19900.7 19947.4 19983.7 21573.5 22171.9 22251.4 22335.9 22358.2 1015.8 1049.7 1052.7 1052.8 1052.8 971.7 1057.8 1069.6 1071.2 1071.6 1126.5 1128.1 1128.2 1128.8 1129.1 1126.1 1126.2 1126.3 1127.1 1127.5 824.2 824.7 825.3 825.9 825.9 20189.2 20313.2 20344.7 20357.8 21074.9 20892.0 21022.6 21343.7 21637.7 21700.5 17211.7 17218.0 17289.0 17318.3 17469.8 3591.6 3597.2 3610.3 3619.3 3627.9 128560.4 130121.0 132046.7 132291.3 134564.3 16766.7 16830.5 16994.2 17403.7 17423.0 31176.0 31890.5 32545.5 33054.8 33058.8 7309.0 7585.1 7692.2 8405.5 8434.7 4346.3 4405.2 4411.6 4432.3 4436.5 4956.9 5001.4 5004.2 5073.4 5087.1 939.7 959.1 967.8 969.6 972.2 674.6 691.4 694.8 699.5 704.5 11389.5 11871.0 11938.6 12290.8 12915.5 707.3 711.1 711.5 713.4 716.9 5365.3 5489.0 5607.2 5734.9 5747.5 109760.5 111972.0 112936.4 113394.0 114923.4 98277.5 100063.5 100238.0 101390.0 106789.5 85522.6 85605.6 88649.1 88827.6 92052.0 9810.7 9834.2 9930.6 9956.7 10262.6 38534.5 40636.4 41394.4 41969.0 42423.8 71604.6 72162.3 73250.0 74533.3 75530.2 19442.6 19460.6 19549.5 19560.4 19879.7 18078.5 18078.6 20194.9 20298.2 20319.8 18033.3 18140.6 18191.7 18631.0 19009.8 17453.0 18073.6 18260.3 18341.0 18423.8 19478.3 19615.4 19723.9 19916.9 19947.0 12486.9 12549.0 13410.9 13689.2 14386.9 12361.9 13856.7 13862.3 14331.9 14365.3 17:11:01 INFO - PID 20245 | -------- Summary: end -------- 17:11:01 INFO - PID 20245 | 17:11:02 INFO - TEST-INFO | 20245: exit 0 17:11:02 INFO - TEST-OK | dromaeo_css | took 1111896ms 17:11:02 INFO - TEST-START | kraken 17:11:02 INFO - Initialising browser for kraken test... 17:11:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56263/getInfo.html -profile /tmp/tmpvpNHkO/profile 17:11:02 INFO - TEST-INFO | started process 20653 (/builds/slave/test/build/application/firefox/firefox http://localhost:56263/getInfo.html) 17:11:08 INFO - TEST-INFO | 20653: exit 0 17:11:08 INFO - Browser initialized. 17:11:08 INFO - Running cycle 1/1 for kraken test... 17:11:08 INFO - TEST-INFO | started process 20830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvpNHkO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:09 INFO - PID 20830 | 17:11:09 INFO - PID 20830 | (/builds/slave/test/build/application/firefox/firefox:20880): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:11:09 INFO - PID 20830 | 17:11:09 INFO - PID 20830 | 17:11:09 INFO - PID 20830 | (/builds/slave/test/build/application/firefox/firefox:20935): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:11:09 INFO - PID 20830 | 17:11:10 INFO - PID 20830 | __metrics Screen width/height:1600/1200 17:11:10 INFO - PID 20830 | colorDepth:24 17:11:10 INFO - PID 20830 | Browser inner width/height: 1024/768 17:11:10 INFO - PID 20830 | __metrics 17:11:19 INFO - PID 20830 | RSS: Main: 171581440 17:11:19 INFO - PID 20830 | 17:11:22 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56263/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:23 INFO - PID 20830 | RSS: Main: 175992832 17:11:23 INFO - PID 20830 | 17:11:25 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56263/tests/kraken/driver.html?testName=audio-dft) 17:11:26 INFO - PID 20830 | RSS: Main: 175722496 17:11:26 INFO - PID 20830 | 17:11:29 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56263/tests/kraken/driver.html?testName=audio-fft) 17:11:30 INFO - PID 20830 | RSS: Main: 170823680 17:11:30 INFO - PID 20830 | 17:11:32 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56263/tests/kraken/driver.html?testName=audio-oscillator) 17:11:32 INFO - PID 20830 | RSS: Main: 171360256 17:11:32 INFO - PID 20830 | 17:11:34 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:35 INFO - PID 20830 | RSS: Main: 171601920 17:11:35 INFO - PID 20830 | 17:11:38 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56263/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:39 INFO - PID 20830 | RSS: Main: 172802048 17:11:39 INFO - PID 20830 | 17:11:42 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56263/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:43 INFO - PID 20830 | RSS: Main: 172920832 17:11:43 INFO - PID 20830 | 17:11:46 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56263/tests/kraken/driver.html?testName=json-parse-financial) 17:11:46 INFO - PID 20830 | RSS: Main: 172961792 17:11:46 INFO - PID 20830 | 17:11:48 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:49 INFO - PID 20830 | RSS: Main: 173117440 17:11:49 INFO - PID 20830 | 17:11:50 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:51 INFO - PID 20830 | RSS: Main: 173281280 17:11:51 INFO - PID 20830 | 17:11:53 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:54 INFO - PID 20830 | RSS: Main: 173346816 17:11:54 INFO - PID 20830 | 17:11:56 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:57 INFO - PID 20830 | RSS: Main: 173780992 17:11:57 INFO - PID 20830 | 17:12:00 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:01 INFO - PID 20830 | RSS: Main: 173637632 17:12:01 INFO - PID 20830 | 17:12:02 INFO - PID 20830 | Cycle 1(1): loaded http://localhost:56263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56263/tests/kraken/driver.html?testName=ai-astar) 17:12:03 INFO - PID 20830 | RSS: Main: 175001600 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | __start_tp_report 17:12:03 INFO - PID 20830 | _x_x_mozilla_page_load 17:12:03 INFO - PID 20830 | _x_x_mozilla_page_load_details 17:12:03 INFO - PID 20830 | |i|pagename|runs| 17:12:03 INFO - PID 20830 | |0;ai-astar;99;108;99;109;107;108;111;100;108;110 17:12:03 INFO - PID 20830 | |1;audio-beat-detection;148;118;156;185;120;146;148;118;175;119 17:12:03 INFO - PID 20830 | |2;audio-dft;165;163;164;164;161;167;163;165;173;165 17:12:03 INFO - PID 20830 | |3;audio-fft;76;75;75;172;76;75;74;75;158;75 17:12:03 INFO - PID 20830 | |4;audio-oscillator;79;79;135;80;78;78;125;78;79;127 17:12:03 INFO - PID 20830 | |5;imaging-gaussian-blur;115;114;114;117;113;115;114;115;114;113 17:12:03 INFO - PID 20830 | |6;imaging-darkroom;150;150;153;150;151;149;149;149;150;149 17:12:03 INFO - PID 20830 | |7;imaging-desaturate;96;95;94;93;94;94;95;95;94;95 17:12:03 INFO - PID 20830 | |8;json-parse-financial;55;54;53;54;57;54;54;55;54;53 17:12:03 INFO - PID 20830 | |9;json-stringify-tinderbox;55;55;55;55;54;55;54;54;55;55 17:12:03 INFO - PID 20830 | |10;stanford-crypto-aes;75;76;76;75;76;76;75;74;78;77 17:12:03 INFO - PID 20830 | |11;stanford-crypto-ccm;120;119;121;125;121;124;120;120;120;173 17:12:03 INFO - PID 20830 | |12;stanford-crypto-pbkdf2;171;168;168;186;173;169;169;166;171;170 17:12:03 INFO - PID 20830 | |13;stanford-crypto-sha256-iterative;69;69;68;72;68;69;66;68;66;68 17:12:03 INFO - PID 20830 | __end_tp_report 17:12:03 INFO - PID 20830 | __start_cc_report 17:12:03 INFO - PID 20830 | _x_x_mozilla_cycle_collect,945 17:12:03 INFO - PID 20830 | __end_cc_report 17:12:03 INFO - PID 20830 | __startTimestamp1503101523126__endTimestamp 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | ------- Summary: start ------- 17:12:03 INFO - PID 20830 | Number of tests: 14 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#0] ai-astar Cycles:10 Average:105.90 Median:109.50 stddev:4.68 (4.3%) stddev-sans-first:4.24 17:12:03 INFO - PID 20830 | Values: 99.0 108.0 99.0 109.0 107.0 108.0 111.0 100.0 108.0 110.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:148.00 stddev:24.43 (16.5%) stddev-sans-first:25.85 17:12:03 INFO - PID 20830 | Values: 148.0 118.0 156.0 185.0 120.0 146.0 148.0 118.0 175.0 119.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.23 (2.0%) stddev-sans-first:3.43 17:12:03 INFO - PID 20830 | Values: 165.0 163.0 164.0 164.0 161.0 167.0 163.0 165.0 173.0 165.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:38.04 (50.7%) stddev-sans-first:39.84 17:12:03 INFO - PID 20830 | Values: 76.0 75.0 75.0 172.0 76.0 75.0 74.0 75.0 158.0 75.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.50 stddev:24.43 (31.1%) stddev-sans-first:25.31 17:12:03 INFO - PID 20830 | Values: 79.0 79.0 135.0 80.0 78.0 78.0 125.0 78.0 79.0 127.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:1.22 17:12:03 INFO - PID 20830 | Values: 115.0 114.0 114.0 117.0 113.0 115.0 114.0 115.0 114.0 113.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 17:12:03 INFO - PID 20830 | Values: 150.0 150.0 153.0 150.0 151.0 149.0 149.0 149.0 150.0 149.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 17:12:03 INFO - PID 20830 | Values: 96.0 95.0 94.0 93.0 94.0 94.0 95.0 95.0 94.0 95.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 17:12:03 INFO - PID 20830 | Values: 55.0 54.0 53.0 54.0 57.0 54.0 54.0 55.0 54.0 53.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 17:12:03 INFO - PID 20830 | Values: 55.0 55.0 55.0 55.0 54.0 55.0 54.0 54.0 55.0 55.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.14 (1.5%) stddev-sans-first:1.17 17:12:03 INFO - PID 20830 | Values: 75.0 76.0 76.0 75.0 76.0 76.0 75.0 74.0 78.0 77.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:121.00 stddev:16.52 (13.7%) stddev-sans-first:17.36 17:12:03 INFO - PID 20830 | Values: 120.0 119.0 121.0 125.0 121.0 124.0 120.0 120.0 120.0 173.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:170.50 stddev:5.59 (3.3%) stddev-sans-first:5.93 17:12:03 INFO - PID 20830 | Values: 171.0 168.0 168.0 186.0 173.0 169.0 169.0 166.0 171.0 170.0 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.79 17:12:03 INFO - PID 20830 | Values: 69.0 69.0 68.0 72.0 68.0 69.0 66.0 68.0 66.0 68.0 17:12:03 INFO - PID 20830 | -------- Summary: end -------- 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:12:03 INFO - PID 20830 | 17:12:03 INFO - PID 20830 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:12:03 INFO - TEST-INFO | 20830: exit 0 17:12:03 INFO - TEST-OK | kraken | took 61659ms 17:12:03 INFO - SUITE-END | took 1173s 17:12:04 INFO - Completed test suite (00:19:33) 17:12:04 INFO - javascript benchmark 17:12:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8653.421839510595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.89048883289, 3154.558361829346, 3156.7632427567933, 3174.492081266997, 3189.4259033373996, 6057.515398768088, 6136.754529818808, 6201.193844800176, 6243.188385509889, 6273.12176295319, 6239.0, 6258.593191442565, 6276.435120839124, 6314.747410103601, 6357.71390287437, 5634.605577609569, 5733.799317023905, 5787.102999035156, 5825.825225243249, 5846.678432686201, 5661.943380566204, 5683.971580142114, 5747.885042299152, 5748.367679555246, 5752.28096487939, 5611.382747897707, 5658.8019419320335, 5673.886522269573, 5681.204631351614, 5683.573731970118, 5610.046292130348, 5631.380548139701, 5653.632513886584, 5665.943340566583, 5714.114312281603, 5545.528630066449, 5627.493525582717, 5635.267415236034, 5635.464630860061, 5688.658680479143, 5947.881042379171, 6098.908516372258, 6102.359252278536, 6117.5717699761035, 6135.9079613805825, 6557.049227861981, 6627.072209890619, 6657.900131498031, 6721.731130754764, 6723.697433615499, 6694.531382803206, 6705.329467053256, 6708.597484150967, 6769.898451523231, 6804.931950680529, 6261.27995280544, 6291.559590828644, 6295.024271237966, 6316.0, 6316.115743795872, 6826.897596536056, 6861.0, 6891.896621550681, 6967.1291088613925, 6971.651417429108, 6455.0, 6471.288158302583, 6487.448566871774, 6505.60966342021, 6601.900971485432, 6619.106420633249, 6619.536632435779, 6621.973594092923, 6639.966800165968, 6662.5003124765835, 6521.315261897527, 6566.179227596551, 6571.67141642916, 6598.736050557924, 6623.933760662332, 6525.608463492205, 6612.173478315211, 6614.239362473281, 6672.933270667231, 6674.799756007327, 4938.604911607063, 5390.595705322116, 5433.320834895638, 5461.808836690697, 5482.122860342326, 4677.906441871143, 4686.39076920005, 4689.413823272091, 4694.108119457293, 4735.479097299294, 5800.738966746507, 5824.097264923944, 5879.706014699248, 5906.586538942232, 5909.349971503131, 6590.5716128451495, 6682.064510968371, 6720.092787473726, 6732.259451460335, 6822.351876571718, 5786.681732504669, 5808.041673123972, 5813.418658134237, 5822.359540450547, 5830.737616807254, 5950.4049595041015, 5957.4638282553915, 5962.612430192024, 5970.9701451492465, 5976.193213916065, 6416.807495775134, 6431.517636177306, 6446.871062578816, 6522.869542609121, 6536.0522724205675, 6540.0, 6659.034440006075, 6667.66661666905, 6732.730690772314, 6742.69657865407, 6387.265464471645, 6401.55189136756, 6408.423241908251, 6414.61512309263, 6422.26143993428, 6178.41305076017, 6521.347865213441, 6539.607623542603, 6578.671066446563, 6587.242467116343, 6210.4100110489435, 6628.204615446178, 6638.53530252897, 6732.831679208059, 6749.055132281386, 6384.9042264367, 6384.936150638434, 6495.675216239264, 6504.837379065561, 6533.020046992989, 6343.0, 6430.582012169381, 6453.032045193258, 6510.0, 6510.44661203803, 6389.648569328731, 6465.288818230085, 6482.773102941374, 6485.805425837044, 6513.088167656627, 6568.376004279586, 6584.901226481702, 6614.305497922841, 6631.33686631333, 6657.533972622064, 6352.714127864349, 6353.078803573549, 6448.967755161194, 6452.451541619015, 6455.064015717789], "value": 6082.712869555667, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.4603642541283, 851.7444766570029, 879.859222524396, 886.3573908916037, 1183.118576660388, 30404.543931841014, 30989.535156972608, 30995.690043099592, 41353.58646413535, 42086.789566052204, 42373.0, 42753.57246427543, 42760.0, 42762.57237427625, 42797.144057118836, 7605.277498637648, 7623.771286861389, 7763.0, 7763.456558040939, 7764.767056988299, 7670.463067585271, 7778.377729781632, 7784.610769461533, 7786.260305271018, 7787.493812902171, 7733.690652373898, 7791.065072191345, 7793.376529877624, 7794.493357931745, 7796.727114550992, 7724.382049436032, 7739.3421559167255, 7764.534127952341, 7771.261730135628, 7778.5721785301785, 7624.771256862303, 7695.961520192363, 7713.3443657288635, 7714.575698336589, 7717.961410192969, 39514.60485395138, 39569.0, 39704.0, 39769.0, 39928.401073983914, 3563.233904710474, 3600.0819790953137, 3600.261946301002, 3615.0600843780544, 3615.6022837488117, 31696.683033169604, 31704.36591268185, 31804.20489487758, 31838.0, 31863.681363186533, 4970.304157417964, 4975.0, 4977.303177555145, 4995.925061124086, 5095.159298715707, 199271.0, 199851.0, 200490.0, 200779.0, 200860.99569502205, 48101.518984810406, 48153.51846481561, 48210.758946205744, 48221.0, 48263.75868120637, 51674.0, 53827.0, 53862.0, 53924.73037634787, 53940.46059539433, 16356.100414477318, 16362.263698133613, 16368.508944731677, 16380.180990950405, 16499.0, 13177.341132943506, 13415.798763018562, 13419.261940593165, 13421.194728316332, 13426.060175787601, 14492.782608260884, 14571.0, 14591.270436478133, 14598.489052883098, 14724.705505889822, 5974.671393073336, 5978.222831031938, 5994.850128746816, 6019.789307374309, 6069.206745783885, 991.5409783736375, 1010.8786945566579, 1011.5043628622069, 1015.94920253987, 1041.6146025970288, 22486.325410237718, 23280.0, 23449.648255276184, 23453.882730586578, 23582.764172358056, 1086.3101930274333, 1088.6298658456162, 1102.1458369763498, 1104.0891264706488, 1121.52895783771, 12287.69280767988, 12327.93836030814, 12334.81497777534, 12392.0, 12399.628011159679, 239356.0, 241356.0, 242988.0, 243062.0, 243949.0, 53863.0, 54295.0, 54371.72814135983, 54373.72813135909, 54642.45357546453, 1424.8432672406027, 1458.4093442155943, 1473.911565306085, 1481.222358261921, 1489.0767724010966, 22343.44141396478, 22751.203707870147, 22794.65808012848, 23054.193103241305, 23083.88458057699, 37902.8104859474, 37993.240135197695, 38015.42976855294, 38043.42934855924, 38127.237455250186, 206075.0, 221058.0, 226838.0, 227038.0, 227465.0, 36653.450198246515, 36838.0, 37117.0, 37156.44265335968, 37161.814190928875, 43729.781351094316, 44989.32516012197, 45139.7743011296, 45440.31839522476, 46268.0, 33773.662263378035, 33776.32447351088, 33942.83028584841, 34068.318633626695, 34309.656903430645, 33494.16264593405, 34175.0, 34569.65430345664, 35088.29823403569, 35324.293514130084, 37071.8146409277, 37188.81405593063, 37574.81212593919, 37657.62342376541, 37726.245475090895, 32800.343993119524, 33244.1688957778, 33278.0, 34350.65649343475, 34748.30503389968, 24401.0, 24504.264872053867, 24655.753442465346, 25397.238082857544, 25760.742392575834], "value": 17558.818929349625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6630021986808, 561.9578531610131, 566.6486778197518, 570.5093619487237, 571.1974675580809, 21895.67156492654, 22554.54890902181, 22570.210042648512, 22679.433014174654, 22725.0, 25498.74501254987, 27800.026999055037, 27842.443151136966, 27856.3035924102, 27928.0, 6923.861522769529, 7063.540869843469, 7077.079979602644, 7081.89377159343, 7088.07854978852, 6597.406233438989, 6911.654417279141, 6927.030215769796, 6967.721291148348, 7015.789526314194, 6926.099607051076, 6926.619035953021, 6933.4106600938985, 6933.4106600938985, 6938.09804725385, 6914.239433662318, 6917.377436030731, 6917.792466226021, 6919.238883722786, 6923.896141557881, 6792.898106528406, 6793.694283757242, 6797.762078327284, 6801.829954251134, 6805.557638753515, 30452.69547304521, 31121.533177002362, 31685.52471712926, 31737.365252695046, 31837.0, 1877.1646617255326, 1929.7105434184843, 1931.0634342343951, 1931.6136772645527, 1932.8357089647398, 20371.694424583642, 20455.693164602544, 20877.58244835095, 21557.245496407708, 21630.24294149713, 2547.197632745679, 2549.7067837198774, 2619.6463477430493, 2620.7248238935017, 2627.2643659775295, 142652.0, 146715.0, 146790.2660486712, 147017.0, 147033.26483367514, 20331.695024574645, 20656.690149647766, 22216.666749998763, 22374.0, 23664.881675591856, 46356.3046554302, 46363.0, 46468.7676561615, 46536.0, 46571.53428465672, 12037.0, 12191.0, 12193.634190974284, 12263.693407664701, 12395.442205100791, 10105.797884042426, 10169.54237059334, 10263.0, 10328.0, 10414.531346089445, 9464.479453630116, 11289.20975531705, 11573.710657233636, 11926.880731192578, 12376.443060062318, 3382.729381649462, 3531.947020794639, 3774.6036666150208, 3807.809609519513, 3833.7701235492327, 930.7952250504878, 934.8083642853198, 954.8329042417688, 960.4093482508207, 962.7978124593914, 20152.596948060956, 20342.186312547332, 20451.59096818085, 20667.0, 20897.0, 1022.5960745505483, 1029.8300780371155, 1034.5706531789374, 1040.6461802987021, 1042.804895694552, 10899.727506812393, 11031.779364412667, 11362.261453005529, 11369.829452558219, 11386.544538218379, 513311.87331927224, 535156.0, 538544.0, 540403.0, 549684.0, 123189.0, 124461.0, 125213.0, 125480.0, 126022.0, 1191.1364260910943, 1207.6558180918396, 1223.7246619510538, 1226.88957993781, 1238.0838179746743, 17143.657126857142, 17146.742798858275, 17243.65512689714, 17562.648747025243, 17886.0, 49589.752051240954, 51298.0, 51612.22581661203, 51805.0, 52324.47675523196, 67707.66146169238, 68838.31161688319, 69024.6548767253, 69028.0, 69042.65478672575, 14424.350904209545, 14733.0, 14830.258487075818, 14843.777343339643, 14962.401503940157, 23232.186873460025, 23327.066917323118, 23332.76667233374, 23374.532509349378, 23405.648915265945, 18418.447446576625, 18583.53541161482, 18657.346992855186, 18757.249710011445, 18841.528961775515, 15627.841902763295, 16005.839941600434, 16182.0, 16396.180190990643, 17092.48722538326, 18825.811741882953, 19149.659523833754, 19167.13747881321, 19267.51831204231, 19299.22803087917, 14732.484363047242, 14749.778753318495, 14757.040792348464, 14805.407783688532, 14908.701825963637, 18333.3583324583, 18375.08124593738, 18381.26474941041, 18719.438416846973, 18743.90628046851], "value": 12862.992840757131, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.4146404849841, 1387.1191793211308, 1407.1135184833556, 1421.1686163594304, 1425.3585886351145, 13727.245001524912, 14426.855731442682, 14427.639309017266, 14481.34833932473, 14587.34356953937, 14301.570952871405, 14670.559883203521, 14674.192919389428, 14674.486392976249, 14694.779578306307, 2622.187121992179, 2695.070200780732, 2757.834529928211, 2761.3096725818546, 2788.6932437431865, 2711.864406779663, 2739.5479745842013, 2740.1642499037785, 2741.1776467059904, 2741.616173735679, 2661.0, 2688.1666683328135, 2688.5429476988957, 2698.298442404979, 2698.541247987847, 2616.5290247755397, 2631.1054241557867, 2647.2852329870925, 2662.7603515683486, 2666.226794229671, 2595.870206489687, 2601.7658410742933, 2615.6207349934343, 2620.358012286983, 2620.606908963671, 13743.0, 13865.0, 13871.514496992557, 13887.930560347235, 13917.373718182605, 7642.3121919027, 7876.72431464896, 7887.250711182429, 7900.486468379537, 7922.445428819985, 4889.559939605417, 4997.200447928314, 5064.379398592452, 5138.332016837825, 5152.304438900738, 1736.1319340329835, 1761.2690733345646, 1770.4246120011048, 1783.8662100342526, 1793.3006127610242, 22677.77322226773, 23034.308970730905, 23161.189358372376, 23167.073317067297, 23199.304020879234, 6816.171288915045, 6870.3473170048765, 6979.8604027919155, 7089.255628158969, 7089.680964356617, 18709.345172918882, 18786.0, 18787.812121878607, 18791.34230301933, 18803.05984700787, 7651.808704782425, 7907.486013409225, 7915.881261781078, 7918.129005809356, 7924.722634707758, 5919.733611987471, 6052.697365131726, 6435.22777266731, 7001.964990175016, 7027.8945815811785, 5456.127019676833, 5542.63972841764, 5611.2224448897505, 5665.461781130786, 5695.7152142392715, 1679.7480377943161, 1738.826117388251, 1745.3367720266472, 1758.2175931710267, 1772.5480002599254, 884.5179377239419, 897.7261935109724, 904.014624059778, 905.3029167540957, 912.8630705394111, 7079.575225486487, 7145.0, 7156.499045066899, 7198.496105272686, 7209.35115839577, 717.2540557819913, 721.4480922094601, 726.3898424828593, 729.2707292707292, 731.579341878422, 4642.234031384851, 5806.709664516758, 5813.447722466359, 5819.679917604488, 6018.909716354258, 19310.227590896207, 19311.130999105073, 19736.605267894847, 19742.30901918426, 19743.50641233952, 18885.716714249298, 19011.0, 19277.614447710966, 19319.130639121275, 19323.227070917288, 10133.733283339583, 10344.948275258575, 10348.637797677045, 10394.844077338998, 10454.372737635766, 8431.40980131385, 8467.57662116904, 8483.575821208791, 8523.318134549345, 8790.692325768567, 17042.48872533826, 17179.828201717824, 17267.65464690674, 17393.13034348252, 17395.652086957936, 17610.38363657266, 17761.822381776015, 17888.28446862163, 17953.910230448764, 17976.37082702099, 11641.767164656829, 11883.702907427383, 11901.0, 11907.345096019802, 11908.225965312573, 13116.344182791014, 13125.868741312464, 13144.934275328562, 13194.274314912773, 13209.405576749261, 10665.680029599125, 10808.405537695502, 10821.67534973952, 10915.781684366428, 11128.666140015812, 10692.14462842955, 10763.461826908466, 10919.672409827717, 10999.285046471954, 11045.558177672803, 9514.38156519824, 9576.042395760369, 9665.9033409665, 9668.516574171123, 9753.60985560598, 7209.675564599501, 7321.194668586558, 7395.852082958203, 7444.0, 7494.662740176596, 7342.743003995049, 7597.898304745891, 7618.771436856903, 7627.923720762721, 7647.847043058996], "value": 6470.000285635637, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.22433004512965, 497.24418883297386, 522.4305506997372, 527.4013994116677, 529.8869143780288, 6217.1917650705345, 6235.251769787632, 6293.181886354773, 6378.3621637836195, 6381.5851969621945, 5955.464008239258, 6108.6945652717295, 6121.908171377422, 6153.323134455206, 6172.722227499762, 4964.0, 4964.304997300381, 4976.104301225778, 4985.950140498603, 4993.750312484371, 4951.826686065989, 4975.4527002029745, 4990.429928586781, 4991.700497970115, 5010.298558201855, 4832.7583620819, 4921.286413470045, 4965.702057876539, 4972.801087956477, 4981.37732783402, 4881.633877459187, 4957.82647607332, 4971.577415919651, 4979.950200498003, 4987.526185012418, 4438.778061096932, 4447.844325448594, 4471.642268618502, 4474.619657329131, 4475.440569928759, 6090.48230900374, 6119.541034422392, 6134.478569321568, 6186.319504854462, 6192.318844927055, 5729.28383952006, 5758.913616295759, 5765.798197063083, 5786.987277226511, 5792.536597072224, 6550.312217217172, 6584.473242140617, 6597.0, 6657.434118099967, 6664.8000559983275, 4832.0, 4851.345068415754, 4883.046781287513, 4884.923907339366, 4886.413630364379, 6900.861982760367, 6929.514933954625, 6964.651767411609, 7002.159740831133, 7004.754833580801, 4934.7285899275885, 4965.280034394992, 4970.72661003641, 5015.473375295542, 5033.6224783141415, 5023.673461225082, 5030.7233102179, 5039.798408063636, 5066.36670416198, 5081.2632168335385, 5685.147227915846, 5696.1455781633085, 5738.885222295531, 5774.220480235199, 5779.913301300484, 6632.403083722488, 6634.469242460592, 6651.900221496681, 6680.832979175462, 6691.26396096429, 1673.3724853180058, 1693.0857337038108, 1707.2061491406555, 1718.561766749471, 1773.423637317877, 1182.6215611004568, 1211.6849619099098, 1216.6593353860933, 1230.5939040116739, 1233.3833083458271, 5838.211841401441, 5885.911711324334, 5903.911441328383, 5918.556108291809, 5927.103326935339, 6628.171478565179, 6690.431313338323, 6707.899381509281, 6717.764878229238, 6864.656767161622, 5789.681567513743, 5856.452443187227, 5860.179574859523, 5865.824025279248, 5941.940580594225, 3552.1297282166033, 3567.554055743032, 3593.658602432765, 3598.280343931172, 3629.0, 6538.574992625464, 6616.305287944792, 6617.569857959314, 6618.238902526175, 6650.301718319603, 6902.689378977958, 6903.1716194057035, 6949.409300209539, 7033.437325014089, 7053.788386348418, 6569.868602627921, 6590.7693230736695, 6642.4021838034805, 6654.168228971379, 6694.866102678016, 6818.8636227276165, 6840.623765692934, 6866.725330986905, 6868.210155832143, 6896.896546551706, 6685.8328541784895, 6716.361945615159, 6781.321867813179, 6812.14848143982, 6832.965835170792, 6624.503162262753, 6634.65430143257, 6638.17022872141, 6653.534252602465, 6709.966450167718, 5015.22264049073, 5051.974740126276, 5056.873578160576, 5068.0, 5098.566621837185, 6850.931490685229, 6890.345417185359, 6900.275471075464, 6911.7926462206215, 6919.584824910521, 6536.470306034688, 6570.77002304917, 6609.347663084229, 6651.669666066709, 6661.566998145105, 6246.875062498815, 6600.273969863407, 6612.669366531558, 6633.568818026813, 6640.07039014548, 6015.548833837567, 6396.976483762575, 6397.616143031433, 6416.230052393743, 6450.0, 6583.63789991555, 6584.934150658432, 6627.237867645283, 6640.568363056386, 6665.666716664245, 6394.616323020447, 6397.520185985976, 6419.325970773189, 6427.260865000585, 6440.871182576416], "value": 5087.436311687472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.1174919206193, 897.2552781191612, 907.5552979040273, 911.9589618467172, 914.8033172867832, 19029.0, 19093.23627054918, 19900.70148947767, 19947.401577952667, 19983.700244496307, 21573.46066348342, 22171.889140554315, 22251.44371390712, 22335.888320558413, 22358.21746238882, 1015.8374660054411, 1049.664107485605, 1052.6947185316249, 1052.8052310322576, 1052.8052310322614, 971.7279161834663, 1057.820170571001, 1069.6309773128298, 1071.201954543866, 1071.614218881202, 1126.5043380912414, 1128.0806142993474, 1128.2215271462705, 1128.8137457319533, 1129.0572372069332, 1126.1047467263545, 1126.189143816455, 1126.3410904620807, 1127.1152145565732, 1127.5264388956616, 824.1922915542742, 824.744329257932, 825.335604838105, 825.8554752918276, 825.9132791056973, 20189.19243230269, 20313.18747250123, 20344.69482957757, 20357.79642203574, 21074.89462552693, 20891.95540222983, 21022.5795484091, 21343.67984480234, 21637.67543486833, 21700.457488562755, 17211.655766884716, 17217.966921984596, 17289.0, 17318.307267709275, 17469.825301747074, 3591.586967498745, 3597.1726502904216, 3610.295992281506, 3619.2942376236642, 3627.909302267464, 128560.35719821342, 130121.0, 132046.6795332044, 132291.33854330666, 134564.32717836447, 16766.664666706598, 16830.495085147464, 16994.150292485327, 17403.73894391585, 17423.0, 31176.0, 31890.521642175387, 32545.51181732276, 33054.834725826215, 33058.8347058268, 7309.0, 7585.127710313384, 7692.230776922263, 8405.53769542681, 8434.704785332484, 4346.261135606955, 4405.185040767468, 4411.580899814512, 4432.31299148626, 4436.534163912743, 4956.8760780980765, 5001.424836143818, 5004.224345226496, 5073.416557095908, 5087.135187018216, 939.736873675372, 959.1271942532262, 967.777411195429, 969.5636963366513, 972.2027937091658, 674.649182425146, 691.350130876984, 694.7846167688033, 699.4614147106699, 704.5103652961245, 11389.544418223179, 11871.0, 11938.58214962472, 12290.815637765441, 12915.483380664857, 707.345705222667, 711.0827033127312, 711.5375006245981, 713.4149997002409, 716.8566286742672, 5365.263715505121, 5489.039418101816, 5607.214989901417, 5734.856628584319, 5747.540196784247, 109760.4511977435, 111972.0, 112936.43531782289, 113394.0, 114923.42538287255, 98277.50861245648, 100063.49968250112, 100238.0, 101390.0, 106789.46605266925, 85522.57238713767, 85605.57197213975, 88649.11350886666, 88827.55586222028, 92052.0, 9810.705678829647, 9834.164096051629, 9930.553125109533, 9956.701298961043, 10262.640807571699, 38534.45862165482, 40636.390454142624, 41394.37908431316, 41969.0, 42423.787881060394, 71604.64197678979, 72162.27837721766, 73250.0, 74533.25466745264, 75530.24469755232, 19442.611147777247, 19460.610787784448, 19549.51126221856, 19560.413187604394, 19879.701804473232, 18078.5480362992, 18078.63842723112, 20194.89902550478, 20298.188072477526, 20319.796802032382, 18033.278668853098, 18140.637187256445, 18191.727124092886, 18631.0, 19009.809901900804, 17453.0, 18073.638527229647, 18260.269589216812, 18341.0, 18423.81576184221, 19478.318258860872, 19615.411537653894, 19723.901380493007, 19916.90041549783, 19947.0, 12486.937565312115, 12548.99608031337, 13410.932945335211, 13689.247091410069, 14386.928065359607, 12361.93819030899, 13856.653583660489, 13862.306884655929, 14331.928340358232, 14365.281735913371], "value": 9284.559270690599, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 99.0, 109.0, 107.0, 108.0, 111.0, 100.0, 108.0, 110.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 156.0, 185.0, 120.0, 146.0, 148.0, 118.0, 175.0, 119.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 164.0, 161.0, 167.0, 163.0, 165.0, 173.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 172.0, 76.0, 75.0, 74.0, 75.0, 158.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 80.0, 78.0, 78.0, 125.0, 78.0, 79.0, 127.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 117.0, 113.0, 115.0, 114.0, 115.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 151.0, 149.0, 149.0, 149.0, 150.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 57.0, 54.0, 54.0, 55.0, 54.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 74.0, 78.0, 77.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 121.0, 125.0, 121.0, 124.0, 120.0, 120.0, 120.0, 173.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 168.0, 186.0, 173.0, 169.0, 169.0, 166.0, 171.0, 170.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 72.0, 68.0, 69.0, 66.0, 68.0, 66.0, 68.0], "value": 68.3, "unit": "score"}]}]} 17:12:04 INFO - Return code: 0 17:12:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:12:04 INFO - # TBPL SUCCESS # 17:12:04 INFO - Running post-action listener: _package_coverage_data 17:12:04 INFO - Running post-action listener: _resource_record_post_action 17:12:04 INFO - [mozharness: 2017-08-19 00:12:04.417774Z] Finished run-tests step (success) 17:12:04 INFO - Running post-run listener: _resource_record_post_run 17:12:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 28672; Write bytes: 442392576; Read time: 96; Write time: 289248 17:12:04 INFO - TinderboxPrint: CPU usage
13.1% 17:12:04 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 96 17:12:04 INFO - TinderboxPrint: I/O write bytes / time
442,392,576 / 289,248 17:12:04 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 17:12:04 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 17:12:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:12:04 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 117129216; Read time: 0; Write time: 81120 17:12:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:12:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 28672; Write bytes: 325263360; Read time: 96; Write time: 208128 17:12:05 INFO - Running post-run listener: _upload_blobber_files 17:12:05 INFO - Blob upload gear active. 17:12:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:12:05 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 17:12:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:12:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:12:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:06 INFO - (blobuploader) - INFO - Done attempting. 17:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:07 INFO - (blobuploader) - INFO - Done attempting. 17:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:14 INFO - (blobuploader) - INFO - Done attempting. 17:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:15 INFO - (blobuploader) - INFO - Done attempting. 17:12:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:15 INFO - Return code: 0 17:12:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a90bdb6b732438f8a1ff408a88d4c2dce03e5ed947c4901a6dd80a9eafac5535fa30718dd644bebca4d1203e400d6f450e8ee18dfdb612d17b1350aa6ebd83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f565d4b0413e7561d6a24e9772d0a02038144a00904af778ab263fe3697354feff4f30f410a342d5a43ee1b2e98b56accd91210bfc4cd23a719c12aa3446fc7f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ea0593e5afec1f2f5299f896db8f3311dc9a5387bb5f8bc51f593f16e92067b0f5a966d54a262cdf6559d03afc26193e59d4197a6fca04efe4c7657e77b679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f0b267451786ec3c023689dbc9499e1549f1544c7ce7a3afd5a3cba39e71a3b5bf8c37bde6ba0221251abf81b007bcc77a90444bdd6067862446ea1bba99001"} 17:12:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:15 INFO - Contents: 17:12:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a90bdb6b732438f8a1ff408a88d4c2dce03e5ed947c4901a6dd80a9eafac5535fa30718dd644bebca4d1203e400d6f450e8ee18dfdb612d17b1350aa6ebd83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f565d4b0413e7561d6a24e9772d0a02038144a00904af778ab263fe3697354feff4f30f410a342d5a43ee1b2e98b56accd91210bfc4cd23a719c12aa3446fc7f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ea0593e5afec1f2f5299f896db8f3311dc9a5387bb5f8bc51f593f16e92067b0f5a966d54a262cdf6559d03afc26193e59d4197a6fca04efe4c7657e77b679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f0b267451786ec3c023689dbc9499e1549f1544c7ce7a3afd5a3cba39e71a3b5bf8c37bde6ba0221251abf81b007bcc77a90444bdd6067862446ea1bba99001"} 17:12:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:15 INFO - Copying logs to upload dir... 17:12:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.701741 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-18 17:12:15.537146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:12:15.540252) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a90bdb6b732438f8a1ff408a88d4c2dce03e5ed947c4901a6dd80a9eafac5535fa30718dd644bebca4d1203e400d6f450e8ee18dfdb612d17b1350aa6ebd83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f565d4b0413e7561d6a24e9772d0a02038144a00904af778ab263fe3697354feff4f30f410a342d5a43ee1b2e98b56accd91210bfc4cd23a719c12aa3446fc7f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ea0593e5afec1f2f5299f896db8f3311dc9a5387bb5f8bc51f593f16e92067b0f5a966d54a262cdf6559d03afc26193e59d4197a6fca04efe4c7657e77b679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f0b267451786ec3c023689dbc9499e1549f1544c7ce7a3afd5a3cba39e71a3b5bf8c37bde6ba0221251abf81b007bcc77a90444bdd6067862446ea1bba99001"} build_url:https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a90bdb6b732438f8a1ff408a88d4c2dce03e5ed947c4901a6dd80a9eafac5535fa30718dd644bebca4d1203e400d6f450e8ee18dfdb612d17b1350aa6ebd83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f565d4b0413e7561d6a24e9772d0a02038144a00904af778ab263fe3697354feff4f30f410a342d5a43ee1b2e98b56accd91210bfc4cd23a719c12aa3446fc7f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ea0593e5afec1f2f5299f896db8f3311dc9a5387bb5f8bc51f593f16e92067b0f5a966d54a262cdf6559d03afc26193e59d4197a6fca04efe4c7657e77b679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f0b267451786ec3c023689dbc9499e1549f1544c7ce7a3afd5a3cba39e71a3b5bf8c37bde6ba0221251abf81b007bcc77a90444bdd6067862446ea1bba99001"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:12:15.569525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:12:15.572863) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503100278.481016-50278501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004749 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:12:15.653714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:12:15.657054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:12:15.657361) ========= ========= Total master_lag: 0.18 =========