builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1503184950.86 results: success (0) revision: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.862712) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.863580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.863874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.975658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.975962) ========= 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=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-19 16:22:31-- 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% 221M=0s 2017-08-19 16:22:32 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.193274 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.221687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.222032) ========= 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=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020116 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.292152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.292520) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40774ced6619efd0359fb94a3dbcb144e9d6fc9 --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 c40774ced6619efd0359fb94a3dbcb144e9d6fc9 --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=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 16:22:32,343 truncating revision to first 12 chars 2017-08-19 16:22:32,343 Setting DEBUG logging. 2017-08-19 16:22:32,343 attempt 1/10 2017-08-19 16:22:32,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40774ced661?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-19 16:22:32,757 unpacking tar archive at: mozilla-central-c40774ced661/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.019541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.019970) ========= script_repo_revision: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.020401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.020683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.032291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-19 16:22:32.032742) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:33 INFO - MultiFileLogger online at 20170819 16:22:33 in /builds/slave/test 16:22:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:22:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:33 INFO - {'append_to_log': False, 16:22:33 INFO - 'base_work_dir': '/builds/slave/test', 16:22:33 INFO - 'blob_upload_branch': 'Firefox', 16:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:33 INFO - 'branch': 'Firefox', 16:22:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:33 INFO - 'code_coverage': False, 16:22:33 INFO - 'config_files': ('talos/linux_config.py',), 16:22:33 INFO - 'default_actions': ('clobber', 16:22:33 INFO - 'read-buildbot-config', 16:22:33 INFO - 'download-and-extract', 16:22:33 INFO - 'populate-webroot', 16:22:33 INFO - 'create-virtualenv', 16:22:33 INFO - 'install', 16:22:33 INFO - 'setup-mitmproxy', 16:22:33 INFO - 'run-tests'), 16:22:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:33 INFO - 'disable_ccov_upload': False, 16:22:33 INFO - 'download_minidump_stackwalk': True, 16:22:33 INFO - 'download_symbols': 'ondemand', 16:22:33 INFO - 'enable_stylo': False, 16:22:33 INFO - 'enable_webrender': False, 16:22:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:33 INFO - 'gecko_profile': False, 16:22:33 INFO - 'gecko_profile_interval': 0, 16:22:33 INFO - 'installer_path': 'installer.exe', 16:22:33 INFO - 'log_level': 'info', 16:22:33 INFO - 'log_name': 'talos', 16:22:33 INFO - 'log_to_console': True, 16:22:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:33 INFO - 'opt_config_files': (), 16:22:33 INFO - 'pip_index': False, 16:22:33 INFO - 'suite': 'dromaeojs-e10s', 16:22:33 INFO - 'system_bits': '32', 16:22:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:33 INFO - 'title': 'talos-linux64-ix-080', 16:22:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:33 INFO - 'use_talos_json': True, 16:22:33 INFO - 'verify': 'False', 16:22:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:33 INFO - 'work_dir': 'build'} 16:22:33 INFO - [mozharness: 2017-08-19 23:22:33.221532Z] Running clobber step. 16:22:33 INFO - Running pre-action listener: _resource_record_pre_action 16:22:33 INFO - Running main action method: clobber 16:22:33 INFO - rmtree: /builds/slave/test/build 16:22:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:34 INFO - Running post-action listener: _resource_record_post_action 16:22:34 INFO - [mozharness: 2017-08-19 23:22:34.253608Z] Finished clobber step (success) 16:22:34 INFO - [mozharness: 2017-08-19 23:22:34.253706Z] Running read-buildbot-config step. 16:22:34 INFO - Running pre-action listener: _resource_record_pre_action 16:22:34 INFO - Running main action method: read_buildbot_config 16:22:34 INFO - Using buildbot properties: 16:22:34 INFO - { 16:22:34 INFO - "project": "", 16:22:34 INFO - "product": "firefox", 16:22:34 INFO - "who": "philringnalda@gmail.com", 16:22:34 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:22:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:22:34 INFO - "stage_platform": "linux64-stylo", 16:22:34 INFO - "basedir": "/builds/slave/test", 16:22:34 INFO - "buildnumber": 92, 16:22:34 INFO - "platform": "ubuntu64_hw_stylo", 16:22:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:22:34 INFO - "slavebuilddir": "test", 16:22:34 INFO - "taskId": "TO2Xjw5wTbGkpJYuyzCo2A", 16:22:34 INFO - "branch": "mozilla-central", 16:22:34 INFO - "script_repo_revision": "production", 16:22:34 INFO - "revision": "c40774ced6619efd0359fb94a3dbcb144e9d6fc9", 16:22:34 INFO - "slavename": "talos-linux64-ix-080", 16:22:34 INFO - "repo_path": "mozilla-central" 16:22:34 INFO - } 16:22:34 INFO - Finding installer, test and symbols from parent task. 16:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TO2Xjw5wTbGkpJYuyzCo2A'}, attempt #1 16:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TO2Xjw5wTbGkpJYuyzCo2A'}, attempt #1 16:22:35 INFO - Task dependencies: Kcb71XQySuWAd4wmZ9eZuA 16:22:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA'}, attempt #1 16:22:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:22:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json 16:22:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.crashreporter-symbols.zip 16:22:35 INFO - Running post-action listener: _resource_record_post_action 16:22:35 INFO - [mozharness: 2017-08-19 23:22:35.602198Z] Finished read-buildbot-config step (success) 16:22:35 INFO - [mozharness: 2017-08-19 23:22:35.602413Z] Running download-and-extract step. 16:22:35 INFO - Running pre-action listener: _resource_record_pre_action 16:22:35 INFO - Running main action method: download_and_extract 16:22:35 INFO - mkdir: /builds/slave/test/build/tests 16:22:35 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:22:35 INFO - trying https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json 16:22:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:36 INFO - Downloaded 989 bytes. 16:22:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:36 INFO - Using the following test package requirements: 16:22:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:36 INFO - u'common': [u'target.common.tests.zip'], 16:22:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:36 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:36 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:36 INFO - u'target.web-platform.tests.tar.gz'], 16:22:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip 16:22:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip into memory 16:22:38 INFO - Content-Length response header: 54005055 16:22:38 INFO - Bytes received: 54005055 16:22:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:22:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip 16:22:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.common.tests.zip into memory 16:22:51 INFO - Content-Length response header: 54005055 16:22:51 INFO - Bytes received: 54005055 16:23:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.talos.tests.zip 16:23:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:23:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.talos.tests.zip into memory 16:23:04 INFO - Content-Length response header: 14496256 16:23:04 INFO - Bytes received: 14496256 16:23:04 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:23:04 INFO - trying https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:23:07 INFO - Downloaded 62157436 bytes. 16:23:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:23:07 INFO - mkdir: /builds/slave/test/properties 16:23:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:07 INFO - Contents: 16:23:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:23:07 INFO - Running post-action listener: _resource_record_post_action 16:23:07 INFO - Running post-action listener: find_tests_for_verification 16:23:07 INFO - Running post-action listener: set_extra_try_arguments 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.844985Z] Finished download-and-extract step (success) 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.845213Z] Running populate-webroot step. 16:23:07 INFO - Running pre-action listener: _resource_record_pre_action 16:23:07 INFO - Running main action method: populate_webroot 16:23:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:07 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:07 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:07 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'tests': ['damp', 'tps']}, 16:23:07 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['damp', 'tps']}, 16:23:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:23:07 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:23:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:23:07 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:23:07 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:07 INFO - 'ts_paint', 16:23:07 INFO - 'tpaint', 16:23:07 INFO - 'sessionrestore', 16:23:07 INFO - 'sessionrestore_many_windows', 16:23:07 INFO - 'sessionrestore_no_auto_restore', 16:23:07 INFO - 'tabpaint']}, 16:23:07 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['a11yr', 16:23:07 INFO - 'ts_paint', 16:23:07 INFO - 'tpaint', 16:23:07 INFO - 'sessionrestore', 16:23:07 INFO - 'sessionrestore_many_windows', 16:23:07 INFO - 'sessionrestore_no_auto_restore', 16:23:07 INFO - 'tabpaint']}, 16:23:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:23:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:23:07 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['bloom_basic_singleton']}, 16:23:07 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['bloom_basic']}, 16:23:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:07 INFO - 'tsvgr_opacity', 16:23:07 INFO - 'tart', 16:23:07 INFO - 'tscrollx', 16:23:07 INFO - 'tsvg_static']}, 16:23:07 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['tsvgx', 16:23:07 INFO - 'tsvgr_opacity', 16:23:07 INFO - 'tart', 16:23:07 INFO - 'tscrollx', 16:23:07 INFO - 'tsvg_static']}, 16:23:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:23:07 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--stylo'], 16:23:07 INFO - 'tests': ['tp5o']}, 16:23:07 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:07 INFO - 'talos_options': ['--mitmproxy', 16:23:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:07 INFO - '--firstNonBlankPaint'], 16:23:07 INFO - 'tests': ['tp6_google', 16:23:07 INFO - 'tp6_youtube', 16:23:07 INFO - 'tp6_amazon', 16:23:07 INFO - 'tp6_facebook']}, 16:23:07 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:07 INFO - 'talos_options': ['--stylo', 16:23:07 INFO - '--mitmproxy', 16:23:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:07 INFO - '--firstNonBlankPaint'], 16:23:07 INFO - 'tests': ['tp6_google', 16:23:07 INFO - 'tp6_youtube', 16:23:07 INFO - 'tp6_amazon', 16:23:07 INFO - 'tp6_facebook']}, 16:23:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:07 INFO - 'talos_options': ['--stylo', 16:23:07 INFO - '--stylo-threads=1', 16:23:07 INFO - '--mitmproxy', 16:23:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:07 INFO - '--firstNonBlankPaint'], 16:23:07 INFO - 'tests': ['tp6_google', 16:23:07 INFO - 'tp6_youtube', 16:23:07 INFO - 'tp6_amazon', 16:23:07 INFO - 'tp6_facebook']}, 16:23:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--xperf_path', 16:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:07 INFO - 'tests': ['tp5n']}, 16:23:07 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:23:07 INFO - 'talos_options': ['--stylo', 16:23:07 INFO - '--xperf_path', 16:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:07 INFO - 'tests': ['tp5n']}}} 16:23:07 INFO - Running post-action listener: _resource_record_post_action 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.862925Z] Finished populate-webroot step (success) 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.863033Z] Running create-virtualenv step. 16:23:07 INFO - Running pre-action listener: _resource_record_pre_action 16:23:07 INFO - Running main action method: create_virtualenv 16:23:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:07 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:23:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:23:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:07 INFO - Using real prefix '/usr' 16:23:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:10 INFO - Installing pip.................done. 16:23:10 INFO - Return code: 0 16:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:23:10 INFO - Reading from file tmpfile_stdout 16:23:10 INFO - Output received: 16:23:10 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:23:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23: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:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23: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:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23: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', 'pip>=1.5'] in /builds/slave/test/build 16:23: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 pip>=1.5 16:23:10 INFO - Using env: {'DISPLAY': ':0', 16:23:10 INFO - 'HOME': '/home/cltbld', 16:23:10 INFO - 'LANG': 'en_US.UTF-8', 16:23:10 INFO - 'LANGUAGE': 'en_US:en', 16:23:10 INFO - 'LOGNAME': 'cltbld', 16:23:10 INFO - 'MAIL': '/var/mail/cltbld', 16:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:10 INFO - 'MOZ_NO_REMOTE': '1', 16:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:10 INFO - 'NO_EM_RESTART': '1', 16:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:10 INFO - 'PWD': '/builds/slave/test', 16:23:10 INFO - 'SHELL': '/bin/bash', 16:23:10 INFO - 'SHLVL': '1', 16:23:10 INFO - 'TERM': 'linux', 16:23:10 INFO - 'TMOUT': '86400', 16:23:10 INFO - 'USER': 'cltbld', 16:23:10 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:10 INFO - '_': '/tools/buildbot/bin/python'} 16:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:10 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:23:10 INFO - Cleaning up... 16:23:10 INFO - Return code: 0 16:23:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23: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:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23: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:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23: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', '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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:23: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 psutil>=3.1.1 16:23:10 INFO - Using env: {'DISPLAY': ':0', 16:23:10 INFO - 'HOME': '/home/cltbld', 16:23:10 INFO - 'LANG': 'en_US.UTF-8', 16:23:10 INFO - 'LANGUAGE': 'en_US:en', 16:23:10 INFO - 'LOGNAME': 'cltbld', 16:23:10 INFO - 'MAIL': '/var/mail/cltbld', 16:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:10 INFO - 'MOZ_NO_REMOTE': '1', 16:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:10 INFO - 'NO_EM_RESTART': '1', 16:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:10 INFO - 'PWD': '/builds/slave/test', 16:23:10 INFO - 'SHELL': '/bin/bash', 16:23:10 INFO - 'SHLVL': '1', 16:23:10 INFO - 'TERM': 'linux', 16:23:10 INFO - 'TMOUT': '86400', 16:23:10 INFO - 'USER': 'cltbld', 16:23:10 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:10 INFO - '_': '/tools/buildbot/bin/python'} 16:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:11 INFO - Downloading/unpacking psutil>=3.1.1 16:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:13 INFO - Installing collected packages: psutil 16:23:13 INFO - Running setup.py install for psutil 16:23:13 INFO - building 'psutil._psutil_linux' extension 16:23:13 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:23:13 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:23:13 INFO - building 'psutil._psutil_posix' extension 16:23:13 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:23:13 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:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:13 INFO - Successfully installed psutil 16:23:13 INFO - Cleaning up... 16:23:13 INFO - Return code: 0 16:23:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:13 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:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:13 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:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 16:23:13 INFO - 'HOME': '/home/cltbld', 16:23:13 INFO - 'LANG': 'en_US.UTF-8', 16:23:13 INFO - 'LANGUAGE': 'en_US:en', 16:23:13 INFO - 'LOGNAME': 'cltbld', 16:23:13 INFO - 'MAIL': '/var/mail/cltbld', 16:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:13 INFO - 'MOZ_NO_REMOTE': '1', 16:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:13 INFO - 'NO_EM_RESTART': '1', 16:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:13 INFO - 'PWD': '/builds/slave/test', 16:23:13 INFO - 'SHELL': '/bin/bash', 16:23:13 INFO - 'SHLVL': '1', 16:23:13 INFO - 'TERM': 'linux', 16:23:13 INFO - 'TMOUT': '86400', 16:23:13 INFO - 'USER': 'cltbld', 16:23:13 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:13 INFO - '_': '/tools/buildbot/bin/python'} 16:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:14 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:23:14 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:23:14 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:23:14 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:23:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:15 INFO - Installing collected packages: mozsystemmonitor 16:23:15 INFO - Running setup.py install for mozsystemmonitor 16:23:15 INFO - Successfully installed mozsystemmonitor 16:23:15 INFO - Cleaning up... 16:23:15 INFO - Return code: 0 16:23:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:23:15 INFO - Using env: {'DISPLAY': ':0', 16:23:15 INFO - 'HOME': '/home/cltbld', 16:23:15 INFO - 'LANG': 'en_US.UTF-8', 16:23:15 INFO - 'LANGUAGE': 'en_US:en', 16:23:15 INFO - 'LOGNAME': 'cltbld', 16:23:15 INFO - 'MAIL': '/var/mail/cltbld', 16:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:15 INFO - 'MOZ_NO_REMOTE': '1', 16:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:15 INFO - 'NO_EM_RESTART': '1', 16:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:15 INFO - 'PWD': '/builds/slave/test', 16:23:15 INFO - 'SHELL': '/bin/bash', 16:23:15 INFO - 'SHLVL': '1', 16:23:15 INFO - 'TERM': 'linux', 16:23:15 INFO - 'TMOUT': '86400', 16:23:15 INFO - 'USER': 'cltbld', 16:23:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:15 INFO - '_': '/tools/buildbot/bin/python'} 16:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:15 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:15 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:23:15 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:23:15 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:23:15 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:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:16 INFO - warning: no files found matching '*.txt' 16:23:16 INFO - no previously-included directories found matching 'build' 16:23:16 INFO - no previously-included directories found matching 'dist' 16:23:16 INFO - no previously-included directories found matching '.git*' 16:23:16 INFO - Installing collected packages: jsonschema, functools32 16:23:16 INFO - Running setup.py install for functools32 16:23:16 INFO - warning: no files found matching '*.txt' 16:23:16 INFO - no previously-included directories found matching 'build' 16:23:16 INFO - no previously-included directories found matching 'dist' 16:23:16 INFO - no previously-included directories found matching '.git*' 16:23:16 INFO - Successfully installed jsonschema functools32 16:23:16 INFO - Cleaning up... 16:23:17 INFO - Return code: 0 16:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:17 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:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:17 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:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:17 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:17 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:23:17 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:23:17 INFO - Using env: {'DISPLAY': ':0', 16:23:17 INFO - 'HOME': '/home/cltbld', 16:23:17 INFO - 'LANG': 'en_US.UTF-8', 16:23:17 INFO - 'LANGUAGE': 'en_US:en', 16:23:17 INFO - 'LOGNAME': 'cltbld', 16:23:17 INFO - 'MAIL': '/var/mail/cltbld', 16:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:17 INFO - 'MOZ_NO_REMOTE': '1', 16:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:17 INFO - 'NO_EM_RESTART': '1', 16:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:17 INFO - 'PWD': '/builds/slave/test', 16:23:17 INFO - 'SHELL': '/bin/bash', 16:23:17 INFO - 'SHLVL': '1', 16:23:17 INFO - 'TERM': 'linux', 16:23:17 INFO - 'TMOUT': '86400', 16:23:17 INFO - 'USER': 'cltbld', 16:23:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:17 INFO - '_': '/tools/buildbot/bin/python'} 16:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:17 INFO - Cleaning up... 16:23:17 INFO - Return code: 0 16:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:17 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:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:17 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:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:17 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:17 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:23:17 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:23:17 INFO - Using env: {'DISPLAY': ':0', 16:23:17 INFO - 'HOME': '/home/cltbld', 16:23:17 INFO - 'LANG': 'en_US.UTF-8', 16:23:17 INFO - 'LANGUAGE': 'en_US:en', 16:23:17 INFO - 'LOGNAME': 'cltbld', 16:23:17 INFO - 'MAIL': '/var/mail/cltbld', 16:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:17 INFO - 'MOZ_NO_REMOTE': '1', 16:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:17 INFO - 'NO_EM_RESTART': '1', 16:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:17 INFO - 'PWD': '/builds/slave/test', 16:23:17 INFO - 'SHELL': '/bin/bash', 16:23:17 INFO - 'SHLVL': '1', 16:23:17 INFO - 'TERM': 'linux', 16:23:17 INFO - 'TMOUT': '86400', 16:23:17 INFO - 'USER': 'cltbld', 16:23:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:17 INFO - '_': '/tools/buildbot/bin/python'} 16:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:17 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:23:17 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:23:17 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:23:17 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:23:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:19 INFO - Downloading docopt-0.6.1.tar.gz 16:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:19 INFO - Running setup.py install for blobuploader 16:23:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:19 INFO - Running setup.py install for requests 16:23:19 INFO - Running setup.py install for docopt 16:23:19 INFO - Successfully installed blobuploader requests docopt 16:23:19 INFO - Cleaning up... 16:23:19 INFO - Return code: 0 16:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:19 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:19 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:23:19 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:23:19 INFO - Using env: {'DISPLAY': ':0', 16:23:19 INFO - 'HOME': '/home/cltbld', 16:23:19 INFO - 'LANG': 'en_US.UTF-8', 16:23:19 INFO - 'LANGUAGE': 'en_US:en', 16:23:19 INFO - 'LOGNAME': 'cltbld', 16:23:19 INFO - 'MAIL': '/var/mail/cltbld', 16:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:19 INFO - 'MOZ_NO_REMOTE': '1', 16:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:19 INFO - 'NO_EM_RESTART': '1', 16:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:19 INFO - 'PWD': '/builds/slave/test', 16:23:19 INFO - 'SHELL': '/bin/bash', 16:23:19 INFO - 'SHLVL': '1', 16:23:19 INFO - 'TERM': 'linux', 16:23:19 INFO - 'TMOUT': '86400', 16:23:19 INFO - 'USER': 'cltbld', 16:23:19 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:19 INFO - '_': '/tools/buildbot/bin/python'} 16:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:19 INFO - Running setup.py (path:/tmp/pip-HJKYkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:20 INFO - Running setup.py (path:/tmp/pip-B14zP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:20 INFO - Running setup.py (path:/tmp/pip-BOSojl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:20 INFO - Running setup.py (path:/tmp/pip-69GiU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:20 INFO - Running setup.py (path:/tmp/pip-zf7Y8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:20 INFO - Running setup.py (path:/tmp/pip-vBxNcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:20 INFO - Running setup.py (path:/tmp/pip-SXDiob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:20 INFO - Running setup.py (path:/tmp/pip-LSuSDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:20 INFO - Running setup.py (path:/tmp/pip-Nzo5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:20 INFO - Running setup.py (path:/tmp/pip-jTxLsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:20 INFO - Running setup.py (path:/tmp/pip-TxpPug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:20 INFO - Running setup.py (path:/tmp/pip-QqGveA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:20 INFO - Running setup.py (path:/tmp/pip-3uDU1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:20 INFO - Running setup.py (path:/tmp/pip-qzVTig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:20 INFO - Running setup.py (path:/tmp/pip-h73XRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:21 INFO - Running setup.py (path:/tmp/pip-JWlLwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:21 INFO - Running setup.py (path:/tmp/pip-MzbJ1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:21 INFO - Running setup.py install for manifestparser 16:23:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Running setup.py install for mozcrash 16:23:21 INFO - Running setup.py install for mozdebug 16:23:21 INFO - Running setup.py install for mozdevice 16:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Running setup.py install for mozfile 16:23:21 INFO - Running setup.py install for mozhttpd 16:23:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Running setup.py install for mozinfo 16:23:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Running setup.py install for mozInstall 16:23:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:21 INFO - Running setup.py install for mozleak 16:23:22 INFO - Running setup.py install for mozlog 16:23:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for moznetwork 16:23:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozprocess 16:23:22 INFO - Running setup.py install for mozprofile 16:23:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozrunner 16:23:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozscreenshot 16:23:22 INFO - Running setup.py install for moztest 16:23:22 INFO - Running setup.py install for mozversion 16:23:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:22 INFO - Cleaning up... 16:23:22 INFO - Return code: 0 16:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:22 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:22 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:23:22 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:23:22 INFO - Using env: {'DISPLAY': ':0', 16:23:22 INFO - 'HOME': '/home/cltbld', 16:23:22 INFO - 'LANG': 'en_US.UTF-8', 16:23:22 INFO - 'LANGUAGE': 'en_US:en', 16:23:22 INFO - 'LOGNAME': 'cltbld', 16:23:22 INFO - 'MAIL': '/var/mail/cltbld', 16:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:22 INFO - 'MOZ_NO_REMOTE': '1', 16:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:22 INFO - 'NO_EM_RESTART': '1', 16:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:22 INFO - 'PWD': '/builds/slave/test', 16:23:22 INFO - 'SHELL': '/bin/bash', 16:23:22 INFO - 'SHLVL': '1', 16:23:22 INFO - 'TERM': 'linux', 16:23:22 INFO - 'TMOUT': '86400', 16:23:22 INFO - 'USER': 'cltbld', 16:23:22 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:22 INFO - '_': '/tools/buildbot/bin/python'} 16:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:23 INFO - Running setup.py (path:/tmp/pip-JkGFeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:23 INFO - Running setup.py (path:/tmp/pip-BDDW54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:23 INFO - Running setup.py (path:/tmp/pip-V4CQ_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:23 INFO - Running setup.py (path:/tmp/pip-398oRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:23 INFO - Running setup.py (path:/tmp/pip-vZFAVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:23 INFO - Running setup.py (path:/tmp/pip-PT6bvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:23 INFO - Running setup.py (path:/tmp/pip-s2wjEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:23 INFO - Running setup.py (path:/tmp/pip-kP79e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:23 INFO - Running setup.py (path:/tmp/pip-aoVL9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:23 INFO - Running setup.py (path:/tmp/pip-vuidJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:23 INFO - Running setup.py (path:/tmp/pip-f9d1jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:24 INFO - Running setup.py (path:/tmp/pip-aPsBUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:24 INFO - Running setup.py (path:/tmp/pip-OEpjHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:24 INFO - Running setup.py (path:/tmp/pip-osinRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:24 INFO - Running setup.py (path:/tmp/pip-sFwY3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:24 INFO - Running setup.py (path:/tmp/pip-AI4Yrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:24 INFO - Running setup.py (path:/tmp/pip-1rgWKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:25 INFO - Downloading blessings-1.6.tar.gz 16:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:25 INFO - Installing collected packages: blessings 16:23:25 INFO - Running setup.py install for blessings 16:23:25 INFO - Successfully installed blessings 16:23:25 INFO - Cleaning up... 16:23:25 INFO - Return code: 0 16:23:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:25 INFO - Reading from file tmpfile_stdout 16:23:25 INFO - Current package versions: 16:23:25 INFO - argparse == 1.2.1 16:23:25 INFO - blessings == 1.6 16:23:25 INFO - blobuploader == 1.2.4 16:23:25 INFO - docopt == 0.6.1 16:23:25 INFO - functools32 == 3.2.3-2 16:23:25 INFO - jsonschema == 2.5.1 16:23:25 INFO - manifestparser == 1.1 16:23:25 INFO - mozInstall == 1.13 16:23:25 INFO - mozcrash == 1.0 16:23:25 INFO - mozdebug == 0.1 16:23:25 INFO - mozdevice == 0.51 16:23:25 INFO - mozfile == 1.2 16:23:25 INFO - mozhttpd == 0.7 16:23:25 INFO - mozinfo == 0.10 16:23:25 INFO - mozleak == 0.1 16:23:25 INFO - mozlog == 3.5 16:23:25 INFO - moznetwork == 0.27 16:23:25 INFO - mozprocess == 0.25 16:23:25 INFO - mozprofile == 0.28 16:23:25 INFO - mozrunner == 6.13 16:23:25 INFO - mozscreenshot == 0.1 16:23:25 INFO - mozsystemmonitor == 0.3 16:23:25 INFO - moztest == 0.8 16:23:25 INFO - mozversion == 1.4 16:23:25 INFO - psutil == 3.1.1 16:23:25 INFO - requests == 1.2.3 16:23:25 INFO - wsgiref == 0.1.2 16:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:25 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:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:25 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:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:25 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:25 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:23:25 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:23:25 INFO - Using env: {'DISPLAY': ':0', 16:23:25 INFO - 'HOME': '/home/cltbld', 16:23:25 INFO - 'LANG': 'en_US.UTF-8', 16:23:25 INFO - 'LANGUAGE': 'en_US:en', 16:23:25 INFO - 'LOGNAME': 'cltbld', 16:23:25 INFO - 'MAIL': '/var/mail/cltbld', 16:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:25 INFO - 'MOZ_NO_REMOTE': '1', 16:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:25 INFO - 'NO_EM_RESTART': '1', 16:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:25 INFO - 'PWD': '/builds/slave/test', 16:23:25 INFO - 'SHELL': '/bin/bash', 16:23:25 INFO - 'SHLVL': '1', 16:23:25 INFO - 'TERM': 'linux', 16:23:25 INFO - 'TMOUT': '86400', 16:23:25 INFO - 'USER': 'cltbld', 16:23:25 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:25 INFO - '_': '/tools/buildbot/bin/python'} 16:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:23:26 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:23:26 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:23:26 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:23:26 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:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:23:27 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:23:27 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:23:27 INFO - Installing collected packages: simplejson 16:23:27 INFO - Running setup.py install for simplejson 16:23:27 INFO - building 'simplejson._speedups' extension 16:23:27 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:23:28 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:23:28 INFO - Successfully installed simplejson 16:23:28 INFO - Cleaning up... 16:23:28 INFO - Return code: 0 16:23:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:28 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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:28 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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:28 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 0x1d341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1effa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a2f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, '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': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', '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:23:28 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:23:28 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:23:28 INFO - Using env: {'DISPLAY': ':0', 16:23:28 INFO - 'HOME': '/home/cltbld', 16:23:28 INFO - 'LANG': 'en_US.UTF-8', 16:23:28 INFO - 'LANGUAGE': 'en_US:en', 16:23:28 INFO - 'LOGNAME': 'cltbld', 16:23:28 INFO - 'MAIL': '/var/mail/cltbld', 16:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:28 INFO - 'MOZ_NO_REMOTE': '1', 16:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:28 INFO - 'NO_EM_RESTART': '1', 16:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:28 INFO - 'PWD': '/builds/slave/test', 16:23:28 INFO - 'SHELL': '/bin/bash', 16:23:28 INFO - 'SHLVL': '1', 16:23:28 INFO - 'TERM': 'linux', 16:23:28 INFO - 'TMOUT': '86400', 16:23:28 INFO - 'USER': 'cltbld', 16:23:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:28 INFO - '_': '/tools/buildbot/bin/python'} 16:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:28 INFO - Cleaning up... 16:23:28 INFO - Return code: 0 16:23:28 INFO - Running post-action listener: _resource_record_post_action 16:23:28 INFO - Running post-action listener: _start_resource_monitoring 16:23:28 INFO - Starting resource monitoring. 16:23:28 INFO - [mozharness: 2017-08-19 23:23:28.710604Z] Finished create-virtualenv step (success) 16:23:28 INFO - [mozharness: 2017-08-19 23:23:28.711172Z] Running install step. 16:23:28 INFO - Running pre-action listener: _resource_record_pre_action 16:23:28 INFO - Running main action method: install 16:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:28 INFO - Reading from file tmpfile_stdout 16:23:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:29 INFO - Reading from file tmpfile_stdout 16:23:29 INFO - Output received: 16:23:29 INFO - Usage: mozinstall [options] installer 16:23:29 INFO - Options: 16:23:29 INFO - -h, --help show this help message and exit 16:23:29 INFO - -d DEST, --destination=DEST 16:23:29 INFO - Directory to install application into. [default: 16:23:29 INFO - "/builds/slave/test"] 16:23:29 INFO - --app=APP Application being installed. [default: firefox] 16:23:29 INFO - mkdir: /builds/slave/test/build/application 16:23:29 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:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:47 INFO - Reading from file tmpfile_stdout 16:23:47 INFO - Output received: 16:23:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:47 INFO - Running post-action listener: _resource_record_post_action 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.048307Z] Finished install step (success) 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.048448Z] Running setup-mitmproxy step. 16:23:47 INFO - Running pre-action listener: _resource_record_pre_action 16:23:47 INFO - Running main action method: setup_mitmproxy 16:23:47 INFO - Skipping: mitmproxy is not required 16:23:47 INFO - Running post-action listener: _resource_record_post_action 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.048925Z] Finished setup-mitmproxy step (success) 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.049015Z] Running run-tests step. 16:23:47 INFO - Running pre-action listener: _resource_record_pre_action 16:23:47 INFO - Running pre-action listener: _set_gcov_prefix 16:23:47 INFO - Running main action method: run_tests 16:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:47 INFO - Python 2.7.3 16:23:47 INFO - Return code: 0 16:23:47 INFO - grabbing minidump binary from tooltool 16:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:47 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 0x20a0130>, '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 0x20a1030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a14c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:47 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:23:47 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:23:47 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:23:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:47 INFO - Return code: 0 16:23:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:47 INFO - ENV: RUST_BACKTRACE is now full 16:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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:23:47 INFO - Using env: {'DISPLAY': ':0', 16:23:47 INFO - 'HOME': '/home/cltbld', 16:23:47 INFO - 'LANG': 'en_US.UTF-8', 16:23:47 INFO - 'LANGUAGE': 'en_US:en', 16:23:47 INFO - 'LOGNAME': 'cltbld', 16:23:47 INFO - 'MAIL': '/var/mail/cltbld', 16:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:47 INFO - 'MOZ_NO_REMOTE': '1', 16:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:47 INFO - 'NO_EM_RESTART': '1', 16:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:47 INFO - 'PWD': '/builds/slave/test', 16:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:47 INFO - 'RUST_BACKTRACE': 'full', 16:23:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:47 INFO - 'SHELL': '/bin/bash', 16:23:47 INFO - 'SHLVL': '1', 16:23:47 INFO - 'STYLO_FORCE_ENABLED': '1', 16:23:47 INFO - 'TERM': 'linux', 16:23:47 INFO - 'TMOUT': '86400', 16:23:47 INFO - 'USER': 'cltbld', 16:23:47 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219', 16:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:47 INFO - '_': '/tools/buildbot/bin/python'} 16:23:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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:23:47 INFO - mozversion application_buildid: 20170819222834 16:23:47 INFO - mozversion application_changeset: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 16:23:47 INFO - mozversion application_display_name: Nightly 16:23:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:47 INFO - mozversion application_name: Firefox 16:23:47 INFO - mozversion application_remotingname: firefox 16:23:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:47 INFO - mozversion application_vendor: Mozilla 16:23:47 INFO - mozversion application_version: 57.0a1 16:23:47 INFO - mozversion platform_buildid: 20170819222834 16:23:47 INFO - mozversion platform_changeset: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 16:23:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:47 INFO - mozversion platform_version: 57.0a1 16:23:47 INFO - using testdate: 1503185027 16:23:47 INFO - actual date: 1503185027 16:23:47 INFO - starting webserver on 'localhost:36880' 16:23:47 INFO - SUITE-START | Running 2 tests 16:23:47 INFO - TEST-START | dromaeo_css 16:23:47 INFO - Initialising browser for dromaeo_css test... 16:23:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36880/getInfo.html -profile /tmp/tmpIrDESB/profile 16:23:47 INFO - TEST-INFO | started process 14437 (/builds/slave/test/build/application/firefox/firefox http://localhost:36880/getInfo.html) 16:23:54 INFO - TEST-INFO | 14437: exit 0 16:23:54 INFO - Browser initialized. 16:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:54 INFO - TEST-INFO | started process 14624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIrDESB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:55 INFO - PID 14624 | 16:23:55 INFO - PID 14624 | (/builds/slave/test/build/application/firefox/firefox:14673): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:55 INFO - PID 14624 | 16:23:55 INFO - PID 14624 | 16:23:55 INFO - PID 14624 | (/builds/slave/test/build/application/firefox/firefox:14734): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:55 INFO - PID 14624 | 16:23:55 INFO - PID 14624 | __metrics Screen width/height:1600/1200 16:23:55 INFO - PID 14624 | colorDepth:24 16:23:55 INFO - PID 14624 | Browser inner width/height: 1024/768 16:23:55 INFO - PID 14624 | __metrics 16:24:05 INFO - PID 14624 | RSS: Main: 175091712 16:24:05 INFO - PID 14624 | 16:27:04 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36880/tests/dromaeo/cssquery-ext.html) 16:27:05 INFO - PID 14624 | RSS: Main: 178724864 16:27:05 INFO - PID 14624 | 16:30:07 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-ext.html (next: http://localhost:36880/tests/dromaeo/cssquery-jquery.html) 16:30:08 INFO - PID 14624 | RSS: Main: 175042560 16:30:08 INFO - PID 14624 | 16:33:09 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36880/tests/dromaeo/cssquery-mootools.html) 16:33:10 INFO - PID 14624 | RSS: Main: 177557504 16:33:10 INFO - PID 14624 | 16:36:12 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36880/tests/dromaeo/cssquery-prototype.html) 16:36:12 INFO - PID 14624 | RSS: Main: 176033792 16:36:12 INFO - PID 14624 | 16:39:16 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36880/tests/dromaeo/cssquery-yui.html) 16:39:17 INFO - PID 14624 | RSS: Main: 179240960 16:39:17 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | Cycle 1(1): loaded http://localhost:36880/tests/dromaeo/cssquery-yui.html (next: http://localhost:36880/tests/dromaeo/cssquery-dojo.html) 16:42:19 INFO - PID 14624 | RSS: Main: 179892224 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | __start_tp_report 16:42:19 INFO - PID 14624 | _x_x_mozilla_page_load 16:42:19 INFO - PID 14624 | _x_x_mozilla_page_load_details 16:42:19 INFO - PID 14624 | |i|pagename|runs| 16:42:19 INFO - PID 14624 | |0;dojo.html;3117.236277112108;3132.890348837791;3160.067780004899;3179.7615178861583;3223.306988997365;6073.0890366445055;6120.296165940918;6132.8160155195355;6135;6151.138840562325;6102.481289090432;6130.785422510202;6215.19202503675;6279.560430769848;6306.211723534559;5677.403872593381;5713.71431428429;5732.942670573282;5739.053056245735;5799.449052340042;5532.806351777688;5636.689982050985;5709;5740.512056475204;5820.941790582104;5591.41290164533;5609.551235901118;5660.490555849993;5666.490015898568;5694.601377903548;5661.1508273758855;5683.687397193153;5707;5716.1997320375185;5719;5557;5600.327960644708;5669.773209071632;5686.601937864351;5700.914486282709;5977.193078934331;6000.489958353545;6014.037753959389;6038.969805150946;6206.379362063803;6513.837154071139;6557.278699343068;6558.704858281341;6640.501962352794;6640.535162538624;6746.93253067468;6767.796966091025;6775.796726098225;6782.050512928194;6790.796276111675;6180.474659653934;6206.813795586139;6220.782272620437;6266.811995640138;6296.307406185362;6708.530402871752;6824.863502729918;6851;6910.7581234656545;6933.930660693329;6504.414602685781;6507;6515.804525864231;6520.152380190545;6532.183477065367;6520.445762110179;6599.670016499156;6602.372774586406;6603.372679595431;6607.669616519155;6563;6564.4420224281475;6568.934310656928;6589.044588534732;6595.670216489157;6615.569987950767;6632.568883022588;6660.200775906826;6691.096701945273;6692.564983276072;5435.239066530688;5454.59090568201;5473.890522189614;5487.862803429946;5501.724913754297;4642.3500709900645;4648.511906249795;4695.037517308943;4707.223308154184;4724.338592597039;5648.406917273709;5661.037623603997;5726.169705392695;5726.255586773693;5743.684097374685;6647.933520664828;6657.267700552935;6688.699008544627;6696.866062678817;6700.162479690039;5717.971410143005;5788.594798364158;5792.94207057924;5802.390748971297;5809.157672137517;5853.0635098384055;5888.352281249059;5961.910571341434;5973.910391344133;5982.282126144891;6332.968335158387;6412.935870641234;6429.485641148697;6441.645709486023;6525.64108974011;6565.835854103686;6603.174603174603;6623.966880165568;6638.269790322964;6644.103046088716;6255.24937007562;6268.811935641938;6321.431071203614;6341.112244285711;6357.237131544244;6499.28507864144;6513.772017979348;6545.050967609574;6555.180602424697;6555.311692272243;6574.276829548841;6603;6675.399214070757;6684.364985326386;6687.565308254948;6167.414095660905;6318.368163183645;6357.491400687842;6357.491400688026;6361.650109244036;6385.074164246065;6402.35976402356;6446.871062578628;6448.677566121769;6448.774292899726;6328.240611126695;6398.264199617103;6403.615783053032;6409.198850143732;6450.193725784277;6482.092507048923;6495.253045899782;6508.446782023581;6548.246951600627;6602.702878370581;6201.348858369986;6298.874022519432;6318.4313411793155;6394.23269207698;6401.071844582602 16:42:19 INFO - PID 14624 | |1;ext.html;835.7075023741692;873.9999999999999;898.9505577193256;903.3315346643482;1191.0471622701837;41584.792076039615;43777.12445751083;43795.78102109489;43807.3428898566;43987.56012439875;43233;43719.78140109295;43798.562014379844;43835.12329753403;43875.56124438754;7671.117821450549;7837.7648670539975;7900.802479938019;7988.081370642363;7994.48035877669;7804.29761321481;7884.684612615489;7886.250806173433;7886.447948643598;7922.48503847251;7865.646045927919;7921.603919804015;7923.168067352932;7926.722564710236;7928.088269848983;7891.644875980566;7895.881561776578;7899.881501777478;7900.249476299742;7901.8024549386155;7737.148913619498;7808;7818.022747156606;7822.295993360625;7834.647440865175;40351;40501;40631.39052914209;40662.79668601668;40687.79656101701;3552.8578856845697;3589.4436362363876;3591.676749092594;3603.4414665726854;3603.6756691897594;32710.836445817855;32791.83604081988;32890.50664240038;32937.3412531748;32971.6702832971;4474.082813023322;4485.641148708096;4500.459944806611;4561.429821272341;4566.06395688883;187560;188858.99999999863;189127;189132;189496;49482;49797;49819.750901245265;49856.252156217684;50111.243881586866;53731;53854;53892.73053634785;53925.46074539205;53953.73023134938;16558.917205413894;16668.499945001426;16691.99848009123;16693.33226670944;16715.414960476326;11727;11760.529578816922;13227.404766785517;13439.596812095653;13534.255615941218;14438.422463101359;14492.34784434703;14559;14624.561263162122;14735.631609209855;5749.626274292241;5813.349320543548;5814.447627475383;5896.941030589725;5918.822435326947;1007.3452256033637;1013.9239557033252;1015.1726343030407;1023.5854478936043;1027.0602398805158;23117.422064448525;23147;23187.420314491934;23382.883085584803;23394.64908026381;1121.4280716834473;1128.4470609401499;1131.422974283105;1131.5813149134872;1134.8751637319888;12160.695982600506;12208.267503949792;12262.81605775914;12387.814182787266;12576.748465030649;224453;225681;226417;226783;228700;53440.73279633577;53872.461275387526;54068;54078.72960635171;54190;1466.0470694048954;1473.9852601474063;1507.7512210485365;1513.7956375889335;1520.1639098495782;22821.429464263525;22915.312540623807;22986.54026919486;23061.88469057644;23186.65220021667;37929.81035094807;37946.620533795416;38005.809970949966;38150.80924595359;38207;189424;190823;190869;191348;192652;35314.646853531136;38035.619643803206;38691.613083868804;39051.2189756209;39121.6087839118;46303.30545041894;48143;48305.27542086942;48406.757966209945;48519.02961940812;34834.82582587071;34940.12649683677;34988.47517287294;35338.46992295066;35802.462963056096;34558.48162277517;34598.13504662403;34654.148419221834;35033;35126;37757.05607359838;37987;37993;38062.80968595139;38140.427893581065;34154;34492;34808.82595587006;35353;35497;24340.26979190627;24941.251762447155;25196.49607007813;25270.49459010846;25341.74658253394 16:42:19 INFO - PID 14624 | |2;jquery.html;567.2965522751787;568.6559631422989;573.750418567923;573.9426057394259;587.8177764892883;20614.587708245846;21516.139354425824;21546.138154473803;21571.784282157172;23380;26011;26290.605640915353;26324.473510529777;26504.33739156522;26517.734822651768;6457.83855403614;6602.504812139085;6603.70283337251;6620.205575330967;6625.668716564177;6279.654618995954;6570.474362051024;6597.60414375139;6616.801495955105;6620.205575330943;6571.244306904719;6579.736810527597;6581.144451221335;6582;6583.14419125513;6577.473802095821;6585.111010013658;6586.045023471618;6587.9670601646685;6601;6105.938940610626;6113.083037544359;6113.816585502442;6121.296050954108;6135.815925522242;28770.856145719346;28994.855025724948;29248.830046798103;29334.55998160008;29460.26349341262;1938.0890981238936;1966.6558352288291;1966.9016549172627;1968.6554852900829;1980.5048737815546;19030.143643535936;19594.31419900311;19626.50933726654;19676.114574844167;19753.60492790136;2149.3981685128033;2188.7592364839857;2245.831562632809;2248.696425982504;2282.7260728712663;136270;139458;139541;139613.30193349172;140149;14106.871450283952;14817.333220005126;14868.702625947637;15018.474353397578;15702.528924132066;23481.178158764702;23787.52424951526;24326.756732432805;24397.26808195757;24414.26757197287;9995.350302230332;10078.949605251926;10164.288499804943;10168.33905796121;10301.896981030093;9002.459852408876;9197.862032069525;9220;9221.538923053955;9262.675806346746;9555.665551705657;9591.856122158173;9735.513224338896;9753.122219000325;9789.58051082589;2796.2170592234206;2803.41128363042;2824.7740180785486;2836.6879643239226;2898.1885072179825;952.8380175370204;964.9626651349827;978.9608415663436;986.5609803637456;994.6618149829093;19733.703994440093;20149.697754533692;20286.492837679176;20298.69551956692;20359.08384122718;1039.1998161415818;1039.2413538117066;1049.506731836036;1049.5277125293649;1054.504382940017;10929.945350273198;11162.330260184415;11279.93484658473;11324.830127548094;11332.603358882565;457869;473318;480918;482966.17033829214;485290;104314.47842760738;106580;106638;107366;112686;1181.781370446453;1198.2930071258;1228.2569045727384;1232.1128787273149;1234.154604096197;17401;17711.31742484462;17945.192466338784;18003.369882054067;18170.27318907229;54613.1808022872;55457;55545.16682249689;56020.71989640026;56406;63852;64889.675551623826;67485;68175;68910;14628.707425851211;14671.853281467049;14737.852621473648;14943.626409339853;14955.700885982436;22839.086436543017;23226;23241.186558470374;23347.766522335238;23404.882975585013;17002.48992530226;18470.168842402392;18587.721184181977;18604.44186674402;18645.347412841027;16532.586685332964;17718.114094294975;17842.643147137245;18022.459326220236;18127.728084078484;18636.813631863508;18906.43280701581;18946.905265473586;18965.146568404733;19133.712994304817;14805.481808136663;15074.54776356711;15112.09327440357;15118.319675614845;15193.392264309305;18127.90936045364;18974.051297435348;19099.90450047741;19120.757150785153;19139.904300478964 16:42:19 INFO - PID 14624 | |3;mootools.html;1385.8752712255898;1446.1106419551973;1452.811134552508;1453.5711964970326;1466.6480044789241;13972.720545589094;14417.495387661407;14534.055286406376;14552.126872387664;14560;13817.51638692646;15063.397464101423;15072.849271507283;15078.849211507883;15085.39658413662;2753.6144939708406;2823.477656633519;2824.7881408894314;2825.293676580855;2829.278533973834;2667.6131960865664;2676.344295647569;2718.9184324470198;2724.9591256131075;2726.754592086712;2596.363890846745;2697.2852194168563;2739.986205104114;2740.5341092014305;2753;2670.2389818901715;2683.6779586449557;2685.2078636802094;2686.6775986881603;2705;2575.549278876208;2624.6719160104985;2626.921192364213;2626.975479562972;2630.605409188618;13717.17696938187;14022.649433764136;14025.228612426414;14032;14032.859671403257;7272.781816545459;7553.66008529612;7598.772036838904;7606.847863042708;7612.847743045163;4928.778204980785;5082.822101226439;5090.694558326512;5215.817446389358;5220.269162317279;1890.4423195157462;1901.3060233014987;1905.504568812105;1906.1898693055396;1943.1353047893692;22549.098036078536;22653.999999999836;22689.205877794197;22700.432489187737;22705.65941510879;6288.685565721696;6430.196225471816;6483.800496908088;6586.901196482057;6629.403353698094;15786;15803.762943555856;15858.682826343409;15877.761833572506;15891.125988070537;7467.551946883204;7567.659455324524;7604.087509498785;7608.972788673569;7615.5430674159725;5848.444397782204;6062.939370606326;6261.655608941552;6279.215098112736;6297.244330680348;5003.424606170264;5100.515451032146;5181.53366197044;5217.321748172713;5219.817306394334;1499.7300485912422;1527.0990115831712;1530.1503288131812;1541.9306131223898;1553.1768162873695;922.2253307221965;934.9392289501161;940.5203346293303;943.5942544705705;946.1437399153776;7234.855302894018;7313.524620899624;7346;7372.889406658905;7512.361449276764;705.1256442011868;722.2091809468728;727.8398752274492;730.1092666946317;733.2191216354565;5238.476152384807;5680.68756218412;5855.414458554195;5897.8204359127485;5955.642661440327;18899.3385231519;19630.705539416922;19718.8028119717;19773.505662358555;19779.703304450446;18558.350457733915;19214.711779323323;19243.422697319103;19366.70949935752;19377.4186774397;10010.949945250228;10223.182145428496;10256.794864102676;10278.023587759151;10289.228307876789;8398.95800521018;8486.61810218554;8658.610362533827;8692.782680432787;8705.912940870763;16783.573396261454;17502.562435938693;17529.211185496428;17987.640247195246;18016.729749053513;17425.128743563026;17707.20317585686;17719.29122835072;17802.46592602224;17809;12878.227306361274;13182.736345273233;13474.19154850712;13527.323633818072;13531.729365412833;13071.607851764462;13102.213867168;13125.73748525005;13138.343082846011;13153.868461315264;10405.739856503647;10453.790924181625;11018.779624407307;11091.279066860629;11158.497867595815;10372.481375931324;10541.262111652111;10599.629012984817;10629.787404252027;10865.78268434611;9749.805003900025;9826.06652368024;9827.852582211415;9922.107010369102;9943.552540135566;7329.413646908341;7380.741674041383;7441.293077157661;7467.58928258951;7509.061367329084;7183.20984691694;7236.20401755817;7244.927550724636;7284.890726639211;7285.271472852673 16:42:19 INFO - PID 14624 | |4;prototype.html;495.92772772673294;498.5705665304831;524.2529395611253;525.262006880333;525.9079661059315;6235.53233507487;6260.092286618444;6276.372362763721;6328.8101356959305;6345.175127233465;5974.223350964368;6121.938780612192;6156.599821011631;6159.5996260243055;6187.319394866561;4989.9750501247445;4995.725235112085;5004.874878128039;5025.120603894313;5035.521625445595;4885.364902562662;4998.750062496861;5004.674696144739;5028.446870844205;5028.717676992362;4948.901021979558;4992.850214493571;4994.825181118662;5002.624803139761;5022;5013.974930125362;5020.171671674169;5022.5730812880765;5039.72281524516;5057.115004874132;4485.349624304457;4485.416895803557;4489.124620698965;4505.211587972091;4507.932381014288;6128.38716128388;6146.35463276354;6167.44492995628;6170.321264660884;6190.133381326618;5764.913526297109;5765.875654247424;5771.797987070432;5815.214945982323;5838.124281357788;6543.149390579194;6570;6586.242582103072;6629.337066293332;6648.434883034948;4902.2156454967035;4938.678985865908;4945.629077819178;4952.87617809554;4966.726830024347;6936.930630693679;6957.721691132399;6963.303669633046;7046.224915259318;7081.645917704094;4983.90032199354;5007.674501157413;5027.296178535008;5048.242763585418;5069.44236134025;5127.307813445137;5135.87160320995;5144.845654630367;5155.705710958662;5160.587153027749;5683.204351390808;5760.884782304331;5791.131330300404;5800.50695690871;5815.651060936273;6573.1454910861285;6612.471002319803;6691.297413771581;6692.263850976388;6719.563228390237;1680.7478878168372;1683.560555724862;1685.3427163406282;1731.385358197847;1734.3149455964824;1213.9878601213875;1221.328269451798;1223.9938800305943;1233.272369302116;1260.9369531523387;5704.686242256716;5748.741306641211;5828.446297601721;5829.423902236724;5873.177755114288;6538.215414150237;6710.261871194165;6729.995652586703;6803.421709154777;6813.523053386314;5811.79658711943;5825.941740582624;5842.474177324061;5847.210626565445;5862.296524417097;3556.359855226084;3614.6746792788776;3623.9818800905828;3630.7640003399692;3659.670629643345;6549.6070235786;6635.307996460871;6638.4357329626555;6650.135482387259;6659.9354200198095;7020.5787652741;7025.402840758593;7043.542169758949;7047.471439642048;7057.4001209896705;6590.507031273337;6599.175103112111;6618.702158402787;6627.602343859384;6649.769792588387;6846.691898864663;6854.931450685429;6856.24581296047;6857.965710171417;6907.066021513984;6744.662766861539;6758.966205168943;6785.660716964231;6790.72837086511;6815.853006302998;6620.5034622402545;6636.634985075867;6639.3692599203;6653.301403352578;6668.766593169215;5027.170516864677;5044.394672639307;5048.3941926969;5054.73631592102;5058.696478211319;6883.558220889555;6884.277150899084;6915.6887940043825;6916.273791251846;6925.445964322943;6669.332666833292;6681.29846366144;6695;6709.329067093252;6755.831104222434;6350.808466412146;6611.644612854449;6647.833804154935;6654.700538475683;6690.762208991352;6415.486761059197;6456.257530384066;6471.676416179078;6503.991881258413;6557.2131344239;6531.216254049545;6599.208095028627;6605.979455613864;6622.437092847162;6644.501662375244;6353.618782873043;6421;6439.130717353098;6442.806715798533;6485.059666348258 16:42:19 INFO - PID 14624 | |5;yui.html;914.2366124286217;915.3455279475176;929.3355250995537;938.3056538161762;938.96244150234;18404.81595184048;19216.615667686638;19275.325363612294;19319.806801931976;21829.563408731818;21335.466613334636;21725.23961661342;21785.891070544665;21870.125194992183;21884.671729924023;1023.779887324227;1062.75556621977;1062.952167152476;1063.0591926145378;1063.1601035182198;1016.7153197104785;1060.7666313411037;1069.8609180806523;1072.5816931396723;1072.9034386905178;1116.2353787655481;1126.5887950897904;1126.6056880091985;1129.5594718059922;1131.6774719205027;1115.4924509348268;1124.8537690100234;1126.3748619516166;1128.8871112888728;1128.9717757056058;820.3150369441464;825.8183199696057;826.3017750001239;826.3265438667527;827.3753316246256;19654.410367688848;19911.701324480146;20038.098285577184;20089.698654520194;20369.79630203694;21247.0438830253;21359.572808543897;21485.785142148692;21719.457013574785;21849.563008739737;16023.439179628773;16052.27764750589;16151.192440378052;16191.352345906149;16218.675626487522;3669.7614655047337;3689.797061161635;3690.907727306812;3692.8153592320277;3704.7036237100965;129247;129263;129963.35018324848;131239.3438032813;134004.32997834947;16143.273552690158;16790.83209167917;16842.157892105344;16981;17607.735883961752;31588.842055789573;31775;31977.200569985936;32356.191095222806;32462.513062303613;6663.566868153554;6995.510314277952;8949.418287811272;9254.444733316022;9326.673566425143;4082.0611259410502;4261.552536983634;4268.317069268902;4271.337942618837;4293.570642935744;5275.60432967529;5326.707031113248;5354.759035843396;5398.865028374244;5405.70268635221;1069.2996087562658;1103.6578660615235;1105.2152971390403;1117.5306371324064;1120.1878637987556;674.8211723893172;686.9313068693091;695.1276148433784;695.6904177641003;700.1493185779302;11802;11859.940700296444;11893.167478276611;12406.56577019818;13469.865301347058;688.6694386694314;704.4223736535992;709.3013381818904;716.6703316474376;718.2458418660385;5403.756830942617;5667.376588575254;5675.460831221028;5955.315138759098;6104.359042300494;98362.5081874586;100690;101992;103033;103926.8059320682;93637;95206;99739.50130249302;100509.49745251227;105538.4723076395;86265.56867215624;88170.55914720513;88573;89145.10854891498;92278.53860730653;11250.7749845001;12553.748925021631;13026.804597931228;13148.276844773629;13321.400536976053;37450.625493744716;37946.810265948494;38879.6112038876;39207.03964801806;39298.410523841594;65626.67186664036;66123;68536.22985843476;69426.305736944;70213.64893175501;17893.821061789215;19431.902840485705;19810.70283945713;19815.702764458256;20059;19143.617127657646;19900.800991989894;21973.67039494441;22309.77690223077;22601.66097508506;17308.307667693654;19689.409317720492;20100.69848952296;20331.491712707302;20342.59314813725;16549.751753723944;17079.658406831546;17093.316267349168;17130;20140.79859201448;18400.17199226065;18967.71548426747;19109.522261943006;19118.904405477882;19125.33061342902;13366.93316533411;13378.598642040753;13518.59444216675;13672.589822305346;13855.445782168601;13537.458501659823;13671.589852304447;13711.314434278047;13780.310984450536;14034.719305614035 16:42:19 INFO - PID 14624 | __end_tp_report 16:42:19 INFO - PID 14624 | __start_cc_report 16:42:19 INFO - PID 14624 | _x_x_mozilla_cycle_collect,384 16:42:19 INFO - PID 14624 | __end_cc_report 16:42:19 INFO - PID 14624 | __startTimestamp1503186139401__endTimestamp 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | ------- Summary: start ------- 16:42:19 INFO - PID 14624 | Number of tests: 6 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#0] dojo.html Cycles:165 Average:6105.52 Median:6321.43 stddev:702.96 (11.1%) stddev-sans-first:664.88 16:42:19 INFO - PID 14624 | Values: 3117.2 3132.9 3160.1 3179.8 3223.3 6073.1 6120.3 6132.8 6135.0 6151.1 6102.5 6130.8 6215.2 6279.6 6306.2 5677.4 5713.7 5732.9 5739.1 5799.4 5532.8 5636.7 5709.0 5740.5 5820.9 5591.4 5609.6 5660.5 5666.5 5694.6 5661.2 5683.7 5707.0 5716.2 5719.0 5557.0 5600.3 5669.8 5686.6 5700.9 5977.2 6000.5 6014.0 6039.0 6206.4 6513.8 6557.3 6558.7 6640.5 6640.5 6746.9 6767.8 6775.8 6782.1 6790.8 6180.5 6206.8 6220.8 6266.8 6296.3 6708.5 6824.9 6851.0 6910.8 6933.9 6504.4 6507.0 6515.8 6520.2 6532.2 6520.4 6599.7 6602.4 6603.4 6607.7 6563.0 6564.4 6568.9 6589.0 6595.7 6615.6 6632.6 6660.2 6691.1 6692.6 5435.2 5454.6 5473.9 5487.9 5501.7 4642.4 4648.5 4695.0 4707.2 4724.3 5648.4 5661.0 5726.2 5726.3 5743.7 6647.9 6657.3 6688.7 6696.9 6700.2 5718.0 5788.6 5792.9 5802.4 5809.2 5853.1 5888.4 5961.9 5973.9 5982.3 6333.0 6412.9 6429.5 6441.6 6525.6 6565.8 6603.2 6624.0 6638.3 6644.1 6255.2 6268.8 6321.4 6341.1 6357.2 6499.3 6513.8 6545.1 6555.2 6555.3 6574.3 6603.0 6675.4 6684.4 6687.6 6167.4 6318.4 6357.5 6357.5 6361.7 6385.1 6402.4 6446.9 6448.7 6448.8 6328.2 6398.3 6403.6 6409.2 6450.2 6482.1 6495.3 6508.4 6548.2 6602.7 6201.3 6298.9 6318.4 6394.2 6401.1 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#1] ext.html Cycles:180 Average:38241.37 Median:3603.56 stddev:52523.21 (1457.5%) stddev-sans-first:52595.45 16:42:19 INFO - PID 14624 | Values: 835.7 874.0 899.0 903.3 1191.0 41584.8 43777.1 43795.8 43807.3 43987.6 43233.0 43719.8 43798.6 43835.1 43875.6 7671.1 7837.8 7900.8 7988.1 7994.5 7804.3 7884.7 7886.3 7886.4 7922.5 7865.6 7921.6 7923.2 7926.7 7928.1 7891.6 7895.9 7899.9 7900.2 7901.8 7737.1 7808.0 7818.0 7822.3 7834.6 40351.0 40501.0 40631.4 40662.8 40687.8 3552.9 3589.4 3591.7 3603.4 3603.7 32710.8 32791.8 32890.5 32937.3 32971.7 4474.1 4485.6 4500.5 4561.4 4566.1 187560.0 188859.0 189127.0 189132.0 189496.0 49482.0 49797.0 49819.8 49856.3 50111.2 53731.0 53854.0 53892.7 53925.5 53953.7 16558.9 16668.5 16692.0 16693.3 16715.4 11727.0 11760.5 13227.4 13439.6 13534.3 14438.4 14492.3 14559.0 14624.6 14735.6 5749.6 5813.3 5814.4 5896.9 5918.8 1007.3 1013.9 1015.2 1023.6 1027.1 23117.4 23147.0 23187.4 23382.9 23394.6 1121.4 1128.4 1131.4 1131.6 1134.9 12160.7 12208.3 12262.8 12387.8 12576.7 224453.0 225681.0 226417.0 226783.0 228700.0 53440.7 53872.5 54068.0 54078.7 54190.0 1466.0 1474.0 1507.8 1513.8 1520.2 22821.4 22915.3 22986.5 23061.9 23186.7 37929.8 37946.6 38005.8 38150.8 38207.0 189424.0 190823.0 190869.0 191348.0 192652.0 35314.6 38035.6 38691.6 39051.2 39121.6 46303.3 48143.0 48305.3 48406.8 48519.0 34834.8 34940.1 34988.5 35338.5 35802.5 34558.5 34598.1 34654.1 35033.0 35126.0 37757.1 37987.0 37993.0 38062.8 38140.4 34154.0 34492.0 34808.8 35353.0 35497.0 24340.3 24941.3 25196.5 25270.5 25341.7 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#2] jquery.html Cycles:180 Average:34134.57 Median:2247.26 stddev:80177.66 (3567.8%) stddev-sans-first:80362.97 16:42:19 INFO - PID 14624 | Values: 567.3 568.7 573.8 573.9 587.8 20614.6 21516.1 21546.1 21571.8 23380.0 26011.0 26290.6 26324.5 26504.3 26517.7 6457.8 6602.5 6603.7 6620.2 6625.7 6279.7 6570.5 6597.6 6616.8 6620.2 6571.2 6579.7 6581.1 6582.0 6583.1 6577.5 6585.1 6586.0 6588.0 6601.0 6105.9 6113.1 6113.8 6121.3 6135.8 28770.9 28994.9 29248.8 29334.6 29460.3 1938.1 1966.7 1966.9 1968.7 1980.5 19030.1 19594.3 19626.5 19676.1 19753.6 2149.4 2188.8 2245.8 2248.7 2282.7 136270.0 139458.0 139541.0 139613.3 140149.0 14106.9 14817.3 14868.7 15018.5 15702.5 23481.2 23787.5 24326.8 24397.3 24414.3 9995.4 10078.9 10164.3 10168.3 10301.9 9002.5 9197.9 9220.0 9221.5 9262.7 9555.7 9591.9 9735.5 9753.1 9789.6 2796.2 2803.4 2824.8 2836.7 2898.2 952.8 965.0 979.0 986.6 994.7 19733.7 20149.7 20286.5 20298.7 20359.1 1039.2 1039.2 1049.5 1049.5 1054.5 10929.9 11162.3 11279.9 11324.8 11332.6 457869.0 473318.0 480918.0 482966.2 485290.0 104314.5 106580.0 106638.0 107366.0 112686.0 1181.8 1198.3 1228.3 1232.1 1234.2 17401.0 17711.3 17945.2 18003.4 18170.3 54613.2 55457.0 55545.2 56020.7 56406.0 63852.0 64889.7 67485.0 68175.0 68910.0 14628.7 14671.9 14737.9 14943.6 14955.7 22839.1 23226.0 23241.2 23347.8 23404.9 17002.5 18470.2 18587.7 18604.4 18645.3 16532.6 17718.1 17842.6 18022.5 18127.7 18636.8 18906.4 18946.9 18965.1 19133.7 14805.5 15074.5 15112.1 15118.3 15193.4 18127.9 18974.1 19099.9 19120.8 19139.9 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#3] mootools.html Cycles:180 Average:8833.17 Median:2649.11 stddev:6005.79 (226.7%) stddev-sans-first:5996.57 16:42:19 INFO - PID 14624 | Values: 1385.9 1446.1 1452.8 1453.6 1466.6 13972.7 14417.5 14534.1 14552.1 14560.0 13817.5 15063.4 15072.8 15078.8 15085.4 2753.6 2823.5 2824.8 2825.3 2829.3 2667.6 2676.3 2718.9 2725.0 2726.8 2596.4 2697.3 2740.0 2740.5 2753.0 2670.2 2683.7 2685.2 2686.7 2705.0 2575.5 2624.7 2626.9 2627.0 2630.6 13717.2 14022.6 14025.2 14032.0 14032.9 7272.8 7553.7 7598.8 7606.8 7612.8 4928.8 5082.8 5090.7 5215.8 5220.3 1890.4 1901.3 1905.5 1906.2 1943.1 22549.1 22654.0 22689.2 22700.4 22705.7 6288.7 6430.2 6483.8 6586.9 6629.4 15786.0 15803.8 15858.7 15877.8 15891.1 7467.6 7567.7 7604.1 7609.0 7615.5 5848.4 6062.9 6261.7 6279.2 6297.2 5003.4 5100.5 5181.5 5217.3 5219.8 1499.7 1527.1 1530.2 1541.9 1553.2 922.2 934.9 940.5 943.6 946.1 7234.9 7313.5 7346.0 7372.9 7512.4 705.1 722.2 727.8 730.1 733.2 5238.5 5680.7 5855.4 5897.8 5955.6 18899.3 19630.7 19718.8 19773.5 19779.7 18558.4 19214.7 19243.4 19366.7 19377.4 10010.9 10223.2 10256.8 10278.0 10289.2 8399.0 8486.6 8658.6 8692.8 8705.9 16783.6 17502.6 17529.2 17987.6 18016.7 17425.1 17707.2 17719.3 17802.5 17809.0 12878.2 13182.7 13474.2 13527.3 13531.7 13071.6 13102.2 13125.7 13138.3 13153.9 10405.7 10453.8 11018.8 11091.3 11158.5 10372.5 10541.3 10599.6 10629.8 10865.8 9749.8 9826.1 9827.9 9922.1 9943.6 7329.4 7380.7 7441.3 7467.6 7509.1 7183.2 7236.2 7244.9 7284.9 7285.3 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#4] prototype.html Cycles:180 Average:5576.55 Median:6163.52 stddev:1578.22 (25.6%) stddev-sans-first:1535.89 16:42:19 INFO - PID 14624 | Values: 495.9 498.6 524.3 525.3 525.9 6235.5 6260.1 6276.4 6328.8 6345.2 5974.2 6121.9 6156.6 6159.6 6187.3 4990.0 4995.7 5004.9 5025.1 5035.5 4885.4 4998.8 5004.7 5028.4 5028.7 4948.9 4992.9 4994.8 5002.6 5022.0 5014.0 5020.2 5022.6 5039.7 5057.1 4485.3 4485.4 4489.1 4505.2 4507.9 6128.4 6146.4 6167.4 6170.3 6190.1 5764.9 5765.9 5771.8 5815.2 5838.1 6543.1 6570.0 6586.2 6629.3 6648.4 4902.2 4938.7 4945.6 4952.9 4966.7 6936.9 6957.7 6963.3 7046.2 7081.6 4983.9 5007.7 5027.3 5048.2 5069.4 5127.3 5135.9 5144.8 5155.7 5160.6 5683.2 5760.9 5791.1 5800.5 5815.7 6573.1 6612.5 6691.3 6692.3 6719.6 1680.7 1683.6 1685.3 1731.4 1734.3 1214.0 1221.3 1224.0 1233.3 1260.9 5704.7 5748.7 5828.4 5829.4 5873.2 6538.2 6710.3 6730.0 6803.4 6813.5 5811.8 5825.9 5842.5 5847.2 5862.3 3556.4 3614.7 3624.0 3630.8 3659.7 6549.6 6635.3 6638.4 6650.1 6659.9 7020.6 7025.4 7043.5 7047.5 7057.4 6590.5 6599.2 6618.7 6627.6 6649.8 6846.7 6854.9 6856.2 6858.0 6907.1 6744.7 6759.0 6785.7 6790.7 6815.9 6620.5 6636.6 6639.4 6653.3 6668.8 5027.2 5044.4 5048.4 5054.7 5058.7 6883.6 6884.3 6915.7 6916.3 6925.4 6669.3 6681.3 6695.0 6709.3 6755.8 6350.8 6611.6 6647.8 6654.7 6690.8 6415.5 6456.3 6471.7 6504.0 6557.2 6531.2 6599.2 6606.0 6622.4 6644.5 6353.6 6421.0 6439.1 6442.8 6485.1 16:42:19 INFO - PID 14624 | 16:42:19 INFO - PID 14624 | [#5] yui.html Cycles:180 Average:23873.28 Median:20074.35 stddev:32043.23 (159.6%) stddev-sans-first:32086.74 16:42:19 INFO - PID 14624 | Values: 914.2 915.3 929.3 938.3 939.0 18404.8 19216.6 19275.3 19319.8 21829.6 21335.5 21725.2 21785.9 21870.1 21884.7 1023.8 1062.8 1063.0 1063.1 1063.2 1016.7 1060.8 1069.9 1072.6 1072.9 1116.2 1126.6 1126.6 1129.6 1131.7 1115.5 1124.9 1126.4 1128.9 1129.0 820.3 825.8 826.3 826.3 827.4 19654.4 19911.7 20038.1 20089.7 20369.8 21247.0 21359.6 21485.8 21719.5 21849.6 16023.4 16052.3 16151.2 16191.4 16218.7 3669.8 3689.8 3690.9 3692.8 3704.7 129247.0 129263.0 129963.4 131239.3 134004.3 16143.3 16790.8 16842.2 16981.0 17607.7 31588.8 31775.0 31977.2 32356.2 32462.5 6663.6 6995.5 8949.4 9254.4 9326.7 4082.1 4261.6 4268.3 4271.3 4293.6 5275.6 5326.7 5354.8 5398.9 5405.7 1069.3 1103.7 1105.2 1117.5 1120.2 674.8 686.9 695.1 695.7 700.1 11802.0 11859.9 11893.2 12406.6 13469.9 688.7 704.4 709.3 716.7 718.2 5403.8 5667.4 5675.5 5955.3 6104.4 98362.5 100690.0 101992.0 103033.0 103926.8 93637.0 95206.0 99739.5 100509.5 105538.5 86265.6 88170.6 88573.0 89145.1 92278.5 11250.8 12553.7 13026.8 13148.3 13321.4 37450.6 37946.8 38879.6 39207.0 39298.4 65626.7 66123.0 68536.2 69426.3 70213.6 17893.8 19431.9 19810.7 19815.7 20059.0 19143.6 19900.8 21973.7 22309.8 22601.7 17308.3 19689.4 20100.7 20331.5 20342.6 16549.8 17079.7 17093.3 17130.0 20140.8 18400.2 18967.7 19109.5 19118.9 19125.3 13366.9 13378.6 13518.6 13672.6 13855.4 13537.5 13671.6 13711.3 13780.3 14034.7 16:42:19 INFO - PID 14624 | -------- Summary: end -------- 16:42:19 INFO - PID 14624 | 16:42:20 INFO - TEST-INFO | 14624: exit 0 16:42:20 INFO - TEST-OK | dromaeo_css | took 1112716ms 16:42:20 INFO - TEST-START | kraken 16:42:20 INFO - Initialising browser for kraken test... 16:42:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36880/getInfo.html -profile /tmp/tmpfYbi_B/profile 16:42:20 INFO - TEST-INFO | started process 15047 (/builds/slave/test/build/application/firefox/firefox http://localhost:36880/getInfo.html) 16:42:26 INFO - TEST-INFO | 15047: exit 0 16:42:26 INFO - Browser initialized. 16:42:26 INFO - Running cycle 1/1 for kraken test... 16:42:26 INFO - TEST-INFO | started process 15233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYbi_B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:27 INFO - PID 15233 | 16:42:27 INFO - PID 15233 | (/builds/slave/test/build/application/firefox/firefox:15282): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:27 INFO - PID 15233 | 16:42:28 INFO - PID 15233 | 16:42:28 INFO - PID 15233 | (/builds/slave/test/build/application/firefox/firefox:15343): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:28 INFO - PID 15233 | 16:42:28 INFO - PID 15233 | __metrics Screen width/height:1600/1200 16:42:28 INFO - PID 15233 | colorDepth:24 16:42:28 INFO - PID 15233 | Browser inner width/height: 1024/768 16:42:28 INFO - PID 15233 | __metrics 16:42:37 INFO - PID 15233 | RSS: Main: 174194688 16:42:37 INFO - PID 15233 | 16:42:40 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36880/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:41 INFO - PID 15233 | RSS: Main: 178302976 16:42:41 INFO - PID 15233 | 16:42:44 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36880/tests/kraken/driver.html?testName=audio-dft) 16:42:44 INFO - PID 15233 | RSS: Main: 180535296 16:42:44 INFO - PID 15233 | 16:42:47 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36880/tests/kraken/driver.html?testName=audio-fft) 16:42:48 INFO - PID 15233 | RSS: Main: 174333952 16:42:48 INFO - PID 15233 | 16:42:50 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36880/tests/kraken/driver.html?testName=audio-oscillator) 16:42:51 INFO - PID 15233 | RSS: Main: 175079424 16:42:51 INFO - PID 15233 | 16:42:53 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:54 INFO - PID 15233 | RSS: Main: 175472640 16:42:54 INFO - PID 15233 | 16:42:57 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36880/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:57 INFO - PID 15233 | RSS: Main: 176504832 16:42:57 INFO - PID 15233 | 16:43:01 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36880/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:01 INFO - PID 15233 | RSS: Main: 176394240 16:43:01 INFO - PID 15233 | 16:43:04 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36880/tests/kraken/driver.html?testName=json-parse-financial) 16:43:05 INFO - PID 15233 | RSS: Main: 177467392 16:43:05 INFO - PID 15233 | 16:43:07 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:07 INFO - PID 15233 | RSS: Main: 176852992 16:43:07 INFO - PID 15233 | 16:43:09 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:10 INFO - PID 15233 | RSS: Main: 177307648 16:43:10 INFO - PID 15233 | 16:43:12 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:13 INFO - PID 15233 | RSS: Main: 176816128 16:43:13 INFO - PID 15233 | 16:43:15 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:16 INFO - PID 15233 | RSS: Main: 177401856 16:43:16 INFO - PID 15233 | 16:43:19 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:20 INFO - PID 15233 | RSS: Main: 177225728 16:43:20 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | Cycle 1(1): loaded http://localhost:36880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36880/tests/kraken/driver.html?testName=ai-astar) 16:43:22 INFO - PID 15233 | RSS: Main: 178659328 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | __start_tp_report 16:43:22 INFO - PID 15233 | _x_x_mozilla_page_load 16:43:22 INFO - PID 15233 | _x_x_mozilla_page_load_details 16:43:22 INFO - PID 15233 | |i|pagename|runs| 16:43:22 INFO - PID 15233 | |0;ai-astar;97;108;101;115;107;109;108;98;108;112 16:43:22 INFO - PID 15233 | |1;audio-beat-detection;140;121;147;182;124;145;144;119;177;119 16:43:22 INFO - PID 15233 | |2;audio-dft;170;168;162;164;162;164;163;165;171;166 16:43:22 INFO - PID 15233 | |3;audio-fft;75;85;75;165;80;75;76;76;150;77 16:43:22 INFO - PID 15233 | |4;audio-oscillator;80;78;130;86;78;79;149;78;78;137 16:43:22 INFO - PID 15233 | |5;imaging-gaussian-blur;113;115;117;120;114;113;114;113;115;114 16:43:22 INFO - PID 15233 | |6;imaging-darkroom;148;150;149;158;153;150;150;155;150;151 16:43:22 INFO - PID 15233 | |7;imaging-desaturate;102;94;94;97;94;94;99;99;94;95 16:43:22 INFO - PID 15233 | |8;json-parse-financial;53;54;53;52;52;60;57;53;53;58 16:43:22 INFO - PID 15233 | |9;json-stringify-tinderbox;54;54;54;58;54;62;61;56;54;55 16:43:22 INFO - PID 15233 | |10;stanford-crypto-aes;77;76;76;80;78;76;74;79;84;77 16:43:22 INFO - PID 15233 | |11;stanford-crypto-ccm;125;126;128;129;127;119;120;124;118;156 16:43:22 INFO - PID 15233 | |12;stanford-crypto-pbkdf2;168;172;173;171;178;173;173;180;175;169 16:43:22 INFO - PID 15233 | |13;stanford-crypto-sha256-iterative;77;65;69;71;66;66;65;66;68;68 16:43:22 INFO - PID 15233 | __end_tp_report 16:43:22 INFO - PID 15233 | __start_cc_report 16:43:22 INFO - PID 15233 | _x_x_mozilla_cycle_collect,943 16:43:22 INFO - PID 15233 | __end_cc_report 16:43:22 INFO - PID 15233 | __startTimestamp1503186202264__endTimestamp 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | ------- Summary: start ------- 16:43:22 INFO - PID 15233 | Number of tests: 14 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#0] ai-astar Cycles:10 Average:106.30 Median:110.50 stddev:5.85 (5.3%) stddev-sans-first:5.15 16:43:22 INFO - PID 15233 | Values: 97.0 108.0 101.0 115.0 107.0 109.0 108.0 98.0 108.0 112.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:144.50 stddev:22.83 (15.8%) stddev-sans-first:24.20 16:43:22 INFO - PID 15233 | Values: 140.0 121.0 147.0 182.0 124.0 145.0 144.0 119.0 177.0 119.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.21 (1.9%) stddev-sans-first:2.96 16:43:22 INFO - PID 15233 | Values: 170.0 168.0 162.0 164.0 162.0 164.0 163.0 165.0 171.0 166.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:34.11 (44.9%) stddev-sans-first:35.52 16:43:22 INFO - PID 15233 | Values: 75.0 85.0 75.0 165.0 80.0 75.0 76.0 76.0 150.0 77.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:78.00 stddev:29.00 (37.2%) stddev-sans-first:30.08 16:43:22 INFO - PID 15233 | Values: 80.0 78.0 130.0 86.0 78.0 79.0 149.0 78.0 78.0 137.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:2.20 (1.9%) stddev-sans-first:2.24 16:43:22 INFO - PID 15233 | Values: 113.0 115.0 117.0 120.0 114.0 113.0 114.0 113.0 115.0 114.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:150.50 stddev:3.06 (2.0%) stddev-sans-first:2.99 16:43:22 INFO - PID 15233 | Values: 148.0 150.0 149.0 158.0 153.0 150.0 150.0 155.0 150.0 151.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:94.50 stddev:2.90 (3.1%) stddev-sans-first:2.19 16:43:22 INFO - PID 15233 | Values: 102.0 94.0 94.0 97.0 94.0 94.0 99.0 99.0 94.0 95.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:53.50 stddev:2.80 (5.2%) stddev-sans-first:2.92 16:43:22 INFO - PID 15233 | Values: 53.0 54.0 53.0 52.0 52.0 60.0 57.0 53.0 53.0 58.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:55.50 stddev:3.08 (5.6%) stddev-sans-first:3.17 16:43:22 INFO - PID 15233 | Values: 54.0 54.0 54.0 58.0 54.0 62.0 61.0 56.0 54.0 55.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.79 (3.6%) stddev-sans-first:2.95 16:43:22 INFO - PID 15233 | Values: 77.0 76.0 76.0 80.0 78.0 76.0 74.0 79.0 84.0 77.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:126.50 stddev:10.82 (8.6%) stddev-sans-first:11.45 16:43:22 INFO - PID 15233 | Values: 125.0 126.0 128.0 129.0 127.0 119.0 120.0 124.0 118.0 156.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:3.71 (2.1%) stddev-sans-first:3.42 16:43:22 INFO - PID 15233 | Values: 168.0 172.0 173.0 171.0 178.0 173.0 173.0 180.0 175.0 169.0 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:3.67 (5.4%) stddev-sans-first:2.03 16:43:22 INFO - PID 15233 | Values: 77.0 65.0 69.0 71.0 66.0 66.0 65.0 66.0 68.0 68.0 16:43:22 INFO - PID 15233 | -------- Summary: end -------- 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 16:43:22 INFO - PID 15233 | 16:43:22 INFO - PID 15233 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:43:22 INFO - TEST-INFO | 15233: exit 0 16:43:23 INFO - TEST-OK | kraken | took 62873ms 16:43:23 INFO - SUITE-END | took 1175s 16:43:23 INFO - Completed test suite (00:19:35) 16:43:23 INFO - javascript benchmark 16:43:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8560.0303525232, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.236277112108, 3132.890348837791, 3160.067780004899, 3179.7615178861583, 3223.306988997365, 6073.0890366445055, 6120.296165940918, 6132.8160155195355, 6135.0, 6151.138840562325, 6102.481289090432, 6130.785422510202, 6215.19202503675, 6279.560430769848, 6306.211723534559, 5677.403872593381, 5713.71431428429, 5732.942670573282, 5739.053056245735, 5799.449052340042, 5532.806351777688, 5636.689982050985, 5709.0, 5740.512056475204, 5820.941790582104, 5591.41290164533, 5609.551235901118, 5660.490555849993, 5666.490015898568, 5694.601377903548, 5661.1508273758855, 5683.687397193153, 5707.0, 5716.1997320375185, 5719.0, 5557.0, 5600.327960644708, 5669.773209071632, 5686.601937864351, 5700.914486282709, 5977.193078934331, 6000.489958353545, 6014.037753959389, 6038.969805150946, 6206.379362063803, 6513.837154071139, 6557.278699343068, 6558.704858281341, 6640.501962352794, 6640.535162538624, 6746.93253067468, 6767.796966091025, 6775.796726098225, 6782.050512928194, 6790.796276111675, 6180.474659653934, 6206.813795586139, 6220.782272620437, 6266.811995640138, 6296.307406185362, 6708.530402871752, 6824.863502729918, 6851.0, 6910.7581234656545, 6933.930660693329, 6504.414602685781, 6507.0, 6515.804525864231, 6520.152380190545, 6532.183477065367, 6520.445762110179, 6599.670016499156, 6602.372774586406, 6603.372679595431, 6607.669616519155, 6563.0, 6564.4420224281475, 6568.934310656928, 6589.044588534732, 6595.670216489157, 6615.569987950767, 6632.568883022588, 6660.200775906826, 6691.096701945273, 6692.564983276072, 5435.239066530688, 5454.59090568201, 5473.890522189614, 5487.862803429946, 5501.724913754297, 4642.3500709900645, 4648.511906249795, 4695.037517308943, 4707.223308154184, 4724.338592597039, 5648.406917273709, 5661.037623603997, 5726.169705392695, 5726.255586773693, 5743.684097374685, 6647.933520664828, 6657.267700552935, 6688.699008544627, 6696.866062678817, 6700.162479690039, 5717.971410143005, 5788.594798364158, 5792.94207057924, 5802.390748971297, 5809.157672137517, 5853.0635098384055, 5888.352281249059, 5961.910571341434, 5973.910391344133, 5982.282126144891, 6332.968335158387, 6412.935870641234, 6429.485641148697, 6441.645709486023, 6525.64108974011, 6565.835854103686, 6603.174603174603, 6623.966880165568, 6638.269790322964, 6644.103046088716, 6255.24937007562, 6268.811935641938, 6321.431071203614, 6341.112244285711, 6357.237131544244, 6499.28507864144, 6513.772017979348, 6545.050967609574, 6555.180602424697, 6555.311692272243, 6574.276829548841, 6603.0, 6675.399214070757, 6684.364985326386, 6687.565308254948, 6167.414095660905, 6318.368163183645, 6357.491400687842, 6357.491400688026, 6361.650109244036, 6385.074164246065, 6402.35976402356, 6446.871062578628, 6448.677566121769, 6448.774292899726, 6328.240611126695, 6398.264199617103, 6403.615783053032, 6409.198850143732, 6450.193725784277, 6482.092507048923, 6495.253045899782, 6508.446782023581, 6548.246951600627, 6602.702878370581, 6201.348858369986, 6298.874022519432, 6318.4313411793155, 6394.23269207698, 6401.071844582602], "value": 6054.038092401228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.7075023741692, 873.9999999999999, 898.9505577193256, 903.3315346643482, 1191.0471622701837, 41584.792076039615, 43777.12445751083, 43795.78102109489, 43807.3428898566, 43987.56012439875, 43233.0, 43719.78140109295, 43798.562014379844, 43835.12329753403, 43875.56124438754, 7671.117821450549, 7837.7648670539975, 7900.802479938019, 7988.081370642363, 7994.48035877669, 7804.29761321481, 7884.684612615489, 7886.250806173433, 7886.447948643598, 7922.48503847251, 7865.646045927919, 7921.603919804015, 7923.168067352932, 7926.722564710236, 7928.088269848983, 7891.644875980566, 7895.881561776578, 7899.881501777478, 7900.249476299742, 7901.8024549386155, 7737.148913619498, 7808.0, 7818.022747156606, 7822.295993360625, 7834.647440865175, 40351.0, 40501.0, 40631.39052914209, 40662.79668601668, 40687.79656101701, 3552.8578856845697, 3589.4436362363876, 3591.676749092594, 3603.4414665726854, 3603.6756691897594, 32710.836445817855, 32791.83604081988, 32890.50664240038, 32937.3412531748, 32971.6702832971, 4474.082813023322, 4485.641148708096, 4500.459944806611, 4561.429821272341, 4566.06395688883, 187560.0, 188858.99999999863, 189127.0, 189132.0, 189496.0, 49482.0, 49797.0, 49819.750901245265, 49856.252156217684, 50111.243881586866, 53731.0, 53854.0, 53892.73053634785, 53925.46074539205, 53953.73023134938, 16558.917205413894, 16668.499945001426, 16691.99848009123, 16693.33226670944, 16715.414960476326, 11727.0, 11760.529578816922, 13227.404766785517, 13439.596812095653, 13534.255615941218, 14438.422463101359, 14492.34784434703, 14559.0, 14624.561263162122, 14735.631609209855, 5749.626274292241, 5813.349320543548, 5814.447627475383, 5896.941030589725, 5918.822435326947, 1007.3452256033637, 1013.9239557033252, 1015.1726343030407, 1023.5854478936043, 1027.0602398805158, 23117.422064448525, 23147.0, 23187.420314491934, 23382.883085584803, 23394.64908026381, 1121.4280716834473, 1128.4470609401499, 1131.422974283105, 1131.5813149134872, 1134.8751637319888, 12160.695982600506, 12208.267503949792, 12262.81605775914, 12387.814182787266, 12576.748465030649, 224453.0, 225681.0, 226417.0, 226783.0, 228700.0, 53440.73279633577, 53872.461275387526, 54068.0, 54078.72960635171, 54190.0, 1466.0470694048954, 1473.9852601474063, 1507.7512210485365, 1513.7956375889335, 1520.1639098495782, 22821.429464263525, 22915.312540623807, 22986.54026919486, 23061.88469057644, 23186.65220021667, 37929.81035094807, 37946.620533795416, 38005.809970949966, 38150.80924595359, 38207.0, 189424.0, 190823.0, 190869.0, 191348.0, 192652.0, 35314.646853531136, 38035.619643803206, 38691.613083868804, 39051.2189756209, 39121.6087839118, 46303.30545041894, 48143.0, 48305.27542086942, 48406.757966209945, 48519.02961940812, 34834.82582587071, 34940.12649683677, 34988.47517287294, 35338.46992295066, 35802.462963056096, 34558.48162277517, 34598.13504662403, 34654.148419221834, 35033.0, 35126.0, 37757.05607359838, 37987.0, 37993.0, 38062.80968595139, 38140.427893581065, 34154.0, 34492.0, 34808.82595587006, 35353.0, 35497.0, 24340.26979190627, 24941.251762447155, 25196.49607007813, 25270.49459010846, 25341.74658253394], "value": 17670.50272399201, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2965522751787, 568.6559631422989, 573.750418567923, 573.9426057394259, 587.8177764892883, 20614.587708245846, 21516.139354425824, 21546.138154473803, 21571.784282157172, 23380.0, 26011.0, 26290.605640915353, 26324.473510529777, 26504.33739156522, 26517.734822651768, 6457.83855403614, 6602.504812139085, 6603.70283337251, 6620.205575330967, 6625.668716564177, 6279.654618995954, 6570.474362051024, 6597.60414375139, 6616.801495955105, 6620.205575330943, 6571.244306904719, 6579.736810527597, 6581.144451221335, 6582.0, 6583.14419125513, 6577.473802095821, 6585.111010013658, 6586.045023471618, 6587.9670601646685, 6601.0, 6105.938940610626, 6113.083037544359, 6113.816585502442, 6121.296050954108, 6135.815925522242, 28770.856145719346, 28994.855025724948, 29248.830046798103, 29334.55998160008, 29460.26349341262, 1938.0890981238936, 1966.6558352288291, 1966.9016549172627, 1968.6554852900829, 1980.5048737815546, 19030.143643535936, 19594.31419900311, 19626.50933726654, 19676.114574844167, 19753.60492790136, 2149.3981685128033, 2188.7592364839857, 2245.831562632809, 2248.696425982504, 2282.7260728712663, 136270.0, 139458.0, 139541.0, 139613.30193349172, 140149.0, 14106.871450283952, 14817.333220005126, 14868.702625947637, 15018.474353397578, 15702.528924132066, 23481.178158764702, 23787.52424951526, 24326.756732432805, 24397.26808195757, 24414.26757197287, 9995.350302230332, 10078.949605251926, 10164.288499804943, 10168.33905796121, 10301.896981030093, 9002.459852408876, 9197.862032069525, 9220.0, 9221.538923053955, 9262.675806346746, 9555.665551705657, 9591.856122158173, 9735.513224338896, 9753.122219000325, 9789.58051082589, 2796.2170592234206, 2803.41128363042, 2824.7740180785486, 2836.6879643239226, 2898.1885072179825, 952.8380175370204, 964.9626651349827, 978.9608415663436, 986.5609803637456, 994.6618149829093, 19733.703994440093, 20149.697754533692, 20286.492837679176, 20298.69551956692, 20359.08384122718, 1039.1998161415818, 1039.2413538117066, 1049.506731836036, 1049.5277125293649, 1054.504382940017, 10929.945350273198, 11162.330260184415, 11279.93484658473, 11324.830127548094, 11332.603358882565, 457869.0, 473318.0, 480918.0, 482966.17033829214, 485290.0, 104314.47842760738, 106580.0, 106638.0, 107366.0, 112686.0, 1181.781370446453, 1198.2930071258, 1228.2569045727384, 1232.1128787273149, 1234.154604096197, 17401.0, 17711.31742484462, 17945.192466338784, 18003.369882054067, 18170.27318907229, 54613.1808022872, 55457.0, 55545.16682249689, 56020.71989640026, 56406.0, 63852.0, 64889.675551623826, 67485.0, 68175.0, 68910.0, 14628.707425851211, 14671.853281467049, 14737.852621473648, 14943.626409339853, 14955.700885982436, 22839.086436543017, 23226.0, 23241.186558470374, 23347.766522335238, 23404.882975585013, 17002.48992530226, 18470.168842402392, 18587.721184181977, 18604.44186674402, 18645.347412841027, 16532.586685332964, 17718.114094294975, 17842.643147137245, 18022.459326220236, 18127.728084078484, 18636.813631863508, 18906.43280701581, 18946.905265473586, 18965.146568404733, 19133.712994304817, 14805.481808136663, 15074.54776356711, 15112.09327440357, 15118.319675614845, 15193.392264309305, 18127.90936045364, 18974.051297435348, 19099.90450047741, 19120.757150785153, 19139.904300478964], "value": 11983.50684172636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.8752712255898, 1446.1106419551973, 1452.811134552508, 1453.5711964970326, 1466.6480044789241, 13972.720545589094, 14417.495387661407, 14534.055286406376, 14552.126872387664, 14560.0, 13817.51638692646, 15063.397464101423, 15072.849271507283, 15078.849211507883, 15085.39658413662, 2753.6144939708406, 2823.477656633519, 2824.7881408894314, 2825.293676580855, 2829.278533973834, 2667.6131960865664, 2676.344295647569, 2718.9184324470198, 2724.9591256131075, 2726.754592086712, 2596.363890846745, 2697.2852194168563, 2739.986205104114, 2740.5341092014305, 2753.0, 2670.2389818901715, 2683.6779586449557, 2685.2078636802094, 2686.6775986881603, 2705.0, 2575.549278876208, 2624.6719160104985, 2626.921192364213, 2626.975479562972, 2630.605409188618, 13717.17696938187, 14022.649433764136, 14025.228612426414, 14032.0, 14032.859671403257, 7272.781816545459, 7553.66008529612, 7598.772036838904, 7606.847863042708, 7612.847743045163, 4928.778204980785, 5082.822101226439, 5090.694558326512, 5215.817446389358, 5220.269162317279, 1890.4423195157462, 1901.3060233014987, 1905.504568812105, 1906.1898693055396, 1943.1353047893692, 22549.098036078536, 22653.999999999836, 22689.205877794197, 22700.432489187737, 22705.65941510879, 6288.685565721696, 6430.196225471816, 6483.800496908088, 6586.901196482057, 6629.403353698094, 15786.0, 15803.762943555856, 15858.682826343409, 15877.761833572506, 15891.125988070537, 7467.551946883204, 7567.659455324524, 7604.087509498785, 7608.972788673569, 7615.5430674159725, 5848.444397782204, 6062.939370606326, 6261.655608941552, 6279.215098112736, 6297.244330680348, 5003.424606170264, 5100.515451032146, 5181.53366197044, 5217.321748172713, 5219.817306394334, 1499.7300485912422, 1527.0990115831712, 1530.1503288131812, 1541.9306131223898, 1553.1768162873695, 922.2253307221965, 934.9392289501161, 940.5203346293303, 943.5942544705705, 946.1437399153776, 7234.855302894018, 7313.524620899624, 7346.0, 7372.889406658905, 7512.361449276764, 705.1256442011868, 722.2091809468728, 727.8398752274492, 730.1092666946317, 733.2191216354565, 5238.476152384807, 5680.68756218412, 5855.414458554195, 5897.8204359127485, 5955.642661440327, 18899.3385231519, 19630.705539416922, 19718.8028119717, 19773.505662358555, 19779.703304450446, 18558.350457733915, 19214.711779323323, 19243.422697319103, 19366.70949935752, 19377.4186774397, 10010.949945250228, 10223.182145428496, 10256.794864102676, 10278.023587759151, 10289.228307876789, 8398.95800521018, 8486.61810218554, 8658.610362533827, 8692.782680432787, 8705.912940870763, 16783.573396261454, 17502.562435938693, 17529.211185496428, 17987.640247195246, 18016.729749053513, 17425.128743563026, 17707.20317585686, 17719.29122835072, 17802.46592602224, 17809.0, 12878.227306361274, 13182.736345273233, 13474.19154850712, 13527.323633818072, 13531.729365412833, 13071.607851764462, 13102.213867168, 13125.73748525005, 13138.343082846011, 13153.868461315264, 10405.739856503647, 10453.790924181625, 11018.779624407307, 11091.279066860629, 11158.497867595815, 10372.481375931324, 10541.262111652111, 10599.629012984817, 10629.787404252027, 10865.78268434611, 9749.805003900025, 9826.06652368024, 9827.852582211415, 9922.107010369102, 9943.552540135566, 7329.413646908341, 7380.741674041383, 7441.293077157661, 7467.58928258951, 7509.061367329084, 7183.20984691694, 7236.20401755817, 7244.927550724636, 7284.890726639211, 7285.271472852673], "value": 6424.959911497177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.92772772673294, 498.5705665304831, 524.2529395611253, 525.262006880333, 525.9079661059315, 6235.53233507487, 6260.092286618444, 6276.372362763721, 6328.8101356959305, 6345.175127233465, 5974.223350964368, 6121.938780612192, 6156.599821011631, 6159.5996260243055, 6187.319394866561, 4989.9750501247445, 4995.725235112085, 5004.874878128039, 5025.120603894313, 5035.521625445595, 4885.364902562662, 4998.750062496861, 5004.674696144739, 5028.446870844205, 5028.717676992362, 4948.901021979558, 4992.850214493571, 4994.825181118662, 5002.624803139761, 5022.0, 5013.974930125362, 5020.171671674169, 5022.5730812880765, 5039.72281524516, 5057.115004874132, 4485.349624304457, 4485.416895803557, 4489.124620698965, 4505.211587972091, 4507.932381014288, 6128.38716128388, 6146.35463276354, 6167.44492995628, 6170.321264660884, 6190.133381326618, 5764.913526297109, 5765.875654247424, 5771.797987070432, 5815.214945982323, 5838.124281357788, 6543.149390579194, 6570.0, 6586.242582103072, 6629.337066293332, 6648.434883034948, 4902.2156454967035, 4938.678985865908, 4945.629077819178, 4952.87617809554, 4966.726830024347, 6936.930630693679, 6957.721691132399, 6963.303669633046, 7046.224915259318, 7081.645917704094, 4983.90032199354, 5007.674501157413, 5027.296178535008, 5048.242763585418, 5069.44236134025, 5127.307813445137, 5135.87160320995, 5144.845654630367, 5155.705710958662, 5160.587153027749, 5683.204351390808, 5760.884782304331, 5791.131330300404, 5800.50695690871, 5815.651060936273, 6573.1454910861285, 6612.471002319803, 6691.297413771581, 6692.263850976388, 6719.563228390237, 1680.7478878168372, 1683.560555724862, 1685.3427163406282, 1731.385358197847, 1734.3149455964824, 1213.9878601213875, 1221.328269451798, 1223.9938800305943, 1233.272369302116, 1260.9369531523387, 5704.686242256716, 5748.741306641211, 5828.446297601721, 5829.423902236724, 5873.177755114288, 6538.215414150237, 6710.261871194165, 6729.995652586703, 6803.421709154777, 6813.523053386314, 5811.79658711943, 5825.941740582624, 5842.474177324061, 5847.210626565445, 5862.296524417097, 3556.359855226084, 3614.6746792788776, 3623.9818800905828, 3630.7640003399692, 3659.670629643345, 6549.6070235786, 6635.307996460871, 6638.4357329626555, 6650.135482387259, 6659.9354200198095, 7020.5787652741, 7025.402840758593, 7043.542169758949, 7047.471439642048, 7057.4001209896705, 6590.507031273337, 6599.175103112111, 6618.702158402787, 6627.602343859384, 6649.769792588387, 6846.691898864663, 6854.931450685429, 6856.24581296047, 6857.965710171417, 6907.066021513984, 6744.662766861539, 6758.966205168943, 6785.660716964231, 6790.72837086511, 6815.853006302998, 6620.5034622402545, 6636.634985075867, 6639.3692599203, 6653.301403352578, 6668.766593169215, 5027.170516864677, 5044.394672639307, 5048.3941926969, 5054.73631592102, 5058.696478211319, 6883.558220889555, 6884.277150899084, 6915.6887940043825, 6916.273791251846, 6925.445964322943, 6669.332666833292, 6681.29846366144, 6695.0, 6709.329067093252, 6755.831104222434, 6350.808466412146, 6611.644612854449, 6647.833804154935, 6654.700538475683, 6690.762208991352, 6415.486761059197, 6456.257530384066, 6471.676416179078, 6503.991881258413, 6557.2131344239, 6531.216254049545, 6599.208095028627, 6605.979455613864, 6622.437092847162, 6644.501662375244, 6353.618782873043, 6421.0, 6439.130717353098, 6442.806715798533, 6485.059666348258], "value": 5108.354844788221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.2366124286217, 915.3455279475176, 929.3355250995537, 938.3056538161762, 938.96244150234, 18404.81595184048, 19216.615667686638, 19275.325363612294, 19319.806801931976, 21829.563408731818, 21335.466613334636, 21725.23961661342, 21785.891070544665, 21870.125194992183, 21884.671729924023, 1023.779887324227, 1062.75556621977, 1062.952167152476, 1063.0591926145378, 1063.1601035182198, 1016.7153197104785, 1060.7666313411037, 1069.8609180806523, 1072.5816931396723, 1072.9034386905178, 1116.2353787655481, 1126.5887950897904, 1126.6056880091985, 1129.5594718059922, 1131.6774719205027, 1115.4924509348268, 1124.8537690100234, 1126.3748619516166, 1128.8871112888728, 1128.9717757056058, 820.3150369441464, 825.8183199696057, 826.3017750001239, 826.3265438667527, 827.3753316246256, 19654.410367688848, 19911.701324480146, 20038.098285577184, 20089.698654520194, 20369.79630203694, 21247.0438830253, 21359.572808543897, 21485.785142148692, 21719.457013574785, 21849.563008739737, 16023.439179628773, 16052.27764750589, 16151.192440378052, 16191.352345906149, 16218.675626487522, 3669.7614655047337, 3689.797061161635, 3690.907727306812, 3692.8153592320277, 3704.7036237100965, 129247.0, 129263.0, 129963.35018324848, 131239.3438032813, 134004.32997834947, 16143.273552690158, 16790.83209167917, 16842.157892105344, 16981.0, 17607.735883961752, 31588.842055789573, 31775.0, 31977.200569985936, 32356.191095222806, 32462.513062303613, 6663.566868153554, 6995.510314277952, 8949.418287811272, 9254.444733316022, 9326.673566425143, 4082.0611259410502, 4261.552536983634, 4268.317069268902, 4271.337942618837, 4293.570642935744, 5275.60432967529, 5326.707031113248, 5354.759035843396, 5398.865028374244, 5405.70268635221, 1069.2996087562658, 1103.6578660615235, 1105.2152971390403, 1117.5306371324064, 1120.1878637987556, 674.8211723893172, 686.9313068693091, 695.1276148433784, 695.6904177641003, 700.1493185779302, 11802.0, 11859.940700296444, 11893.167478276611, 12406.56577019818, 13469.865301347058, 688.6694386694314, 704.4223736535992, 709.3013381818904, 716.6703316474376, 718.2458418660385, 5403.756830942617, 5667.376588575254, 5675.460831221028, 5955.315138759098, 6104.359042300494, 98362.5081874586, 100690.0, 101992.0, 103033.0, 103926.8059320682, 93637.0, 95206.0, 99739.50130249302, 100509.49745251227, 105538.4723076395, 86265.56867215624, 88170.55914720513, 88573.0, 89145.10854891498, 92278.53860730653, 11250.7749845001, 12553.748925021631, 13026.804597931228, 13148.276844773629, 13321.400536976053, 37450.625493744716, 37946.810265948494, 38879.6112038876, 39207.03964801806, 39298.410523841594, 65626.67186664036, 66123.0, 68536.22985843476, 69426.305736944, 70213.64893175501, 17893.821061789215, 19431.902840485705, 19810.70283945713, 19815.702764458256, 20059.0, 19143.617127657646, 19900.800991989894, 21973.67039494441, 22309.77690223077, 22601.66097508506, 17308.307667693654, 19689.409317720492, 20100.69848952296, 20331.491712707302, 20342.59314813725, 16549.751753723944, 17079.658406831546, 17093.316267349168, 17130.0, 20140.79859201448, 18400.17199226065, 18967.71548426747, 19109.522261943006, 19118.904405477882, 19125.33061342902, 13366.93316533411, 13378.598642040753, 13518.59444216675, 13672.589822305346, 13855.445782168601, 13537.458501659823, 13671.589852304447, 13711.314434278047, 13780.310984450536, 14034.719305614035], "value": 9349.64596942403, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 101.0, 115.0, 107.0, 109.0, 108.0, 98.0, 108.0, 112.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 121.0, 147.0, 182.0, 124.0, 145.0, 144.0, 119.0, 177.0, 119.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 162.0, 164.0, 162.0, 164.0, 163.0, 165.0, 171.0, 166.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 75.0, 165.0, 80.0, 75.0, 76.0, 76.0, 150.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 130.0, 86.0, 78.0, 79.0, 149.0, 78.0, 78.0, 137.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 117.0, 120.0, 114.0, 113.0, 114.0, 113.0, 115.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 158.0, 153.0, 150.0, 150.0, 155.0, 150.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 94.0, 94.0, 97.0, 94.0, 94.0, 99.0, 99.0, 94.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 52.0, 60.0, 57.0, 53.0, 53.0, 58.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 58.0, 54.0, 62.0, 61.0, 56.0, 54.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 80.0, 78.0, 76.0, 74.0, 79.0, 84.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 128.0, 129.0, 127.0, 119.0, 120.0, 124.0, 118.0, 156.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 173.0, 171.0, 178.0, 173.0, 173.0, 180.0, 175.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 65.0, 69.0, 71.0, 66.0, 66.0, 65.0, 66.0, 68.0, 68.0], "value": 68.1, "unit": "score"}]}]} 16:43:23 INFO - Return code: 0 16:43:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:23 INFO - # TBPL SUCCESS # 16:43:23 INFO - Running post-action listener: _package_coverage_data 16:43:23 INFO - Running post-action listener: _resource_record_post_action 16:43:23 INFO - [mozharness: 2017-08-19 23:43:23.540463Z] Finished run-tests step (success) 16:43:23 INFO - Running post-run listener: _resource_record_post_run 16:43:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 20480; Write bytes: 435474432; Read time: 572; Write time: 415440 16:43:23 INFO - TinderboxPrint: CPU usage
13.2% 16:43:23 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 572 16:43:23 INFO - TinderboxPrint: I/O write bytes / time
435,474,432 / 415,440 16:43:23 INFO - TinderboxPrint: CPU idle
8,264.7 (86.8%) 16:43:23 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 16:43:23 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106917888; Read time: 76; Write time: 102992 16:43:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:43:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 325472256; Read time: 476; Write time: 311312 16:43:24 INFO - Running post-run listener: _upload_blobber_files 16:43:24 INFO - Blob upload gear active. 16:43:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:43:24 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:25 INFO - (blobuploader) - INFO - Done attempting. 16:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:26 INFO - (blobuploader) - INFO - Done attempting. 16:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:27 INFO - (blobuploader) - INFO - Done attempting. 16:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:33 INFO - (blobuploader) - INFO - Done attempting. 16:43:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:33 INFO - Return code: 0 16:43:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab8196f83d38d7d2d87677f18b15cbabc44ccb8f7a99c5ce824b67612011b244713e650e32f5d8d8bcd612dfd624ef5b3f0f4800ad678da556f4ddc9b264509", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfcba86c34fa76d4bea252a481dabe1de963af71494b8962ec513564dab37cd658dc5db75ebb96eaba57ceb86b9d60c425fc0b10d79ef8f48bca47d4422449d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5667d199247df08c06f622e541d5f55dcecd695baa1f08520b8491034c1d715a0f54c57082805f496aaa5633f76e9fbbcfcb2eb2326930b2a6821b4aa93c566c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aacc053730f48ce853edbf80d2b5b4c8431274cf26d3d6ca04d69f3b90db977b7034e3509b46ea9979fa8802f1f8e077441a791d9e39f06e62ff93c1699af2"} 16:43:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:33 INFO - Contents: 16:43:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab8196f83d38d7d2d87677f18b15cbabc44ccb8f7a99c5ce824b67612011b244713e650e32f5d8d8bcd612dfd624ef5b3f0f4800ad678da556f4ddc9b264509", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfcba86c34fa76d4bea252a481dabe1de963af71494b8962ec513564dab37cd658dc5db75ebb96eaba57ceb86b9d60c425fc0b10d79ef8f48bca47d4422449d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5667d199247df08c06f622e541d5f55dcecd695baa1f08520b8491034c1d715a0f54c57082805f496aaa5633f76e9fbbcfcb2eb2326930b2a6821b4aa93c566c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aacc053730f48ce853edbf80d2b5b4c8431274cf26d3d6ca04d69f3b90db977b7034e3509b46ea9979fa8802f1f8e077441a791d9e39f06e62ff93c1699af2"} 16:43:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:33 INFO - Copying logs to upload dir... 16:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.667817 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-19 16:43:33.117119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:33.121543) ========= 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=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab8196f83d38d7d2d87677f18b15cbabc44ccb8f7a99c5ce824b67612011b244713e650e32f5d8d8bcd612dfd624ef5b3f0f4800ad678da556f4ddc9b264509", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfcba86c34fa76d4bea252a481dabe1de963af71494b8962ec513564dab37cd658dc5db75ebb96eaba57ceb86b9d60c425fc0b10d79ef8f48bca47d4422449d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5667d199247df08c06f622e541d5f55dcecd695baa1f08520b8491034c1d715a0f54c57082805f496aaa5633f76e9fbbcfcb2eb2326930b2a6821b4aa93c566c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aacc053730f48ce853edbf80d2b5b4c8431274cf26d3d6ca04d69f3b90db977b7034e3509b46ea9979fa8802f1f8e077441a791d9e39f06e62ff93c1699af2"} build_url:https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab8196f83d38d7d2d87677f18b15cbabc44ccb8f7a99c5ce824b67612011b244713e650e32f5d8d8bcd612dfd624ef5b3f0f4800ad678da556f4ddc9b264509", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfcba86c34fa76d4bea252a481dabe1de963af71494b8962ec513564dab37cd658dc5db75ebb96eaba57ceb86b9d60c425fc0b10d79ef8f48bca47d4422449d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5667d199247df08c06f622e541d5f55dcecd695baa1f08520b8491034c1d715a0f54c57082805f496aaa5633f76e9fbbcfcb2eb2326930b2a6821b4aa93c566c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5aacc053730f48ce853edbf80d2b5b4c8431274cf26d3d6ca04d69f3b90db977b7034e3509b46ea9979fa8802f1f8e077441a791d9e39f06e62ff93c1699af2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:33.150203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:33.150489) ========= 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=781b77c4c33858b1f599d705000001c1-1503170182.166298-374449219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:33.232714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:43:33.232993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:43:33.236290) ========= ========= Total master_lag: 0.64 =========