builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1503184951.0 results: success (0) revision: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.997753) ========= 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.998638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:30.999131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.231321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.231662) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 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% 230M=0s 2017-08-19 16:22:32 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182235 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.453811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.454155) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015501 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:31.504722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-19 16:22:31.505087) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 16:22:32,158 truncating revision to first 12 chars 2017-08-19 16:22:32,159 Setting DEBUG logging. 2017-08-19 16:22:32,159 attempt 1/10 2017-08-19 16:22:32,159 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:33,328 unpacking tar archive at: mozilla-central-c40774ced661/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-19 16:22:32.985706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.986079) ========= script_repo_revision: c40774ced6619efd0359fb94a3dbcb144e9d6fc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.986491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.986758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:22:32.998359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-19 16:22:32.998776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 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-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', 16:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:33 INFO - 'branch': 'Firefox-Non-PGO', 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-004', 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.888822Z] 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.863023Z] Finished clobber step (success) 16:22:34 INFO - [mozharness: 2017-08-19 23:22:34.863131Z] 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_test-dromaeojs-e10s", 16:22:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:22:34 INFO - "stage_platform": "linux64", 16:22:34 INFO - "basedir": "/builds/slave/test", 16:22:34 INFO - "buildnumber": 779, 16:22:34 INFO - "platform": "ubuntu64_hw", 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": "XVoHw9f5TI6PVEnrua4kaA", 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-004", 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/XVoHw9f5TI6PVEnrua4kaA'}, attempt #1 16:22:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XVoHw9f5TI6PVEnrua4kaA'}, 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:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:22:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json 16:22:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.crashreporter-symbols.zip 16:22:36 INFO - Running post-action listener: _resource_record_post_action 16:22:36 INFO - [mozharness: 2017-08-19 23:22:36.196626Z] Finished read-buildbot-config step (success) 16:22:36 INFO - [mozharness: 2017-08-19 23:22:36.196842Z] Running download-and-extract step. 16:22:36 INFO - Running pre-action listener: _resource_record_pre_action 16:22:36 INFO - Running main action method: download_and_extract 16:22:36 INFO - mkdir: /builds/slave/test/build/tests 16:22:36 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:36 INFO - trying https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.test_packages.json 16:22:36 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:36 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:04 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:04 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:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.talos.tests.zip into memory 16:23:05 INFO - Content-Length response header: 14496256 16:23:05 INFO - Bytes received: 14496256 16:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:05 INFO - trying https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 16:23:05 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:05 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.550022Z] Finished download-and-extract step (success) 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.550119Z] 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.564196Z] Finished populate-webroot step (success) 16:23:07 INFO - [mozharness: 2017-08-19 23:23:07.564285Z] 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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 - Downloading/unpacking psutil>=3.1.1 16:23:10 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:10 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:10 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:10 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:12 INFO - Installing collected packages: psutil 16:23:12 INFO - Running setup.py install for psutil 16:23:12 INFO - building 'psutil._psutil_linux' extension 16:23:12 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:17 INFO - warning: no files found matching '*.txt' 16:23:17 INFO - no previously-included directories found matching 'build' 16:23:17 INFO - no previously-included directories found matching 'dist' 16:23:17 INFO - no previously-included directories found matching '.git*' 16:23:17 INFO - Installing collected packages: jsonschema, functools32 16:23:17 INFO - Running setup.py install for functools32 16:23:17 INFO - warning: no files found matching '*.txt' 16:23:17 INFO - no previously-included directories found matching 'build' 16:23:17 INFO - no previously-included directories found matching 'dist' 16:23:17 INFO - no previously-included directories found matching '.git*' 16:23:17 INFO - Successfully installed jsonschema functools32 16:23:17 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:20 INFO - Return code: 0 16:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:20 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 16:23:20 INFO - 'HOME': '/home/cltbld', 16:23:20 INFO - 'LANG': 'en_US.UTF-8', 16:23:20 INFO - 'LANGUAGE': 'en_US:en', 16:23:20 INFO - 'LOGNAME': 'cltbld', 16:23:20 INFO - 'MAIL': '/var/mail/cltbld', 16:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:20 INFO - 'MOZ_NO_REMOTE': '1', 16:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:20 INFO - 'NO_EM_RESTART': '1', 16:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:20 INFO - 'PWD': '/builds/slave/test', 16:23:20 INFO - 'SHELL': '/bin/bash', 16:23:20 INFO - 'SHLVL': '1', 16:23:20 INFO - 'TERM': 'linux', 16:23:20 INFO - 'TMOUT': '86400', 16:23:20 INFO - 'USER': 'cltbld', 16:23:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 16:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:20 INFO - '_': '/tools/buildbot/bin/python'} 16:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:20 INFO - Running setup.py (path:/tmp/pip-7rrFu2-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-dIqQJW-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-0SqLNz-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-wLgLHO-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-UuWIxg-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-AQaOy2-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-Ey_2DV-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-uqBnee-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-tbpU1O-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-QMZkad-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-WBDnT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:21 INFO - Running setup.py (path:/tmp/pip-6QKibx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:21 INFO - Running setup.py (path:/tmp/pip-HtvSHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:21 INFO - Running setup.py (path:/tmp/pip-nHjWmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:21 INFO - Running setup.py (path:/tmp/pip-tjceoM-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-sNGKr5-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-W54r5e-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:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozinfo 16:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozInstall 16:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:22 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:23 INFO - Running setup.py install for moztest 16:23:23 INFO - Running setup.py install for mozversion 16:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:23 INFO - Cleaning up... 16:23:23 INFO - Return code: 0 16:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:23 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 16:23:23 INFO - 'HOME': '/home/cltbld', 16:23:23 INFO - 'LANG': 'en_US.UTF-8', 16:23:23 INFO - 'LANGUAGE': 'en_US:en', 16:23:23 INFO - 'LOGNAME': 'cltbld', 16:23:23 INFO - 'MAIL': '/var/mail/cltbld', 16:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:23 INFO - 'MOZ_NO_REMOTE': '1', 16:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:23 INFO - 'NO_EM_RESTART': '1', 16:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:23 INFO - 'PWD': '/builds/slave/test', 16:23:23 INFO - 'SHELL': '/bin/bash', 16:23:23 INFO - 'SHLVL': '1', 16:23:23 INFO - 'TERM': 'linux', 16:23:23 INFO - 'TMOUT': '86400', 16:23:23 INFO - 'USER': 'cltbld', 16:23:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 16:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:23 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-8vq26r-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-NNWRVR-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-0EdgqN-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-qjowBw-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-J_zSiX-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-1nvoF5-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-CfGQnJ-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-QUStyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:24 INFO - Running setup.py (path:/tmp/pip-0y92Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:24 INFO - Running setup.py (path:/tmp/pip-wm_ZxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:24 INFO - Running setup.py (path:/tmp/pip-D2hmrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:24 INFO - Running setup.py (path:/tmp/pip-Jf2ZMD-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-FyKNND-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-TJZrvz-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-HWrl3J-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-TVafRH-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-p3iWj6-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:26 INFO - Return code: 0 16:23:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:26 INFO - Reading from file tmpfile_stdout 16:23:26 INFO - Current package versions: 16:23:26 INFO - argparse == 1.2.1 16:23:26 INFO - blessings == 1.6 16:23:26 INFO - blobuploader == 1.2.4 16:23:26 INFO - docopt == 0.6.1 16:23:26 INFO - functools32 == 3.2.3-2 16:23:26 INFO - jsonschema == 2.5.1 16:23:26 INFO - manifestparser == 1.1 16:23:26 INFO - mozInstall == 1.13 16:23:26 INFO - mozcrash == 1.0 16:23:26 INFO - mozdebug == 0.1 16:23:26 INFO - mozdevice == 0.51 16:23:26 INFO - mozfile == 1.2 16:23:26 INFO - mozhttpd == 0.7 16:23:26 INFO - mozinfo == 0.10 16:23:26 INFO - mozleak == 0.1 16:23:26 INFO - mozlog == 3.5 16:23:26 INFO - moznetwork == 0.27 16:23:26 INFO - mozprocess == 0.25 16:23:26 INFO - mozprofile == 0.28 16:23:26 INFO - mozrunner == 6.13 16:23:26 INFO - mozscreenshot == 0.1 16:23:26 INFO - mozsystemmonitor == 0.3 16:23:26 INFO - moztest == 0.8 16:23:26 INFO - mozversion == 1.4 16:23:26 INFO - psutil == 3.1.1 16:23:26 INFO - requests == 1.2.3 16:23:26 INFO - wsgiref == 0.1.2 16:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:26 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 16:23:26 INFO - 'HOME': '/home/cltbld', 16:23:26 INFO - 'LANG': 'en_US.UTF-8', 16:23:26 INFO - 'LANGUAGE': 'en_US:en', 16:23:26 INFO - 'LOGNAME': 'cltbld', 16:23:26 INFO - 'MAIL': '/var/mail/cltbld', 16:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:26 INFO - 'MOZ_NO_REMOTE': '1', 16:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:26 INFO - 'NO_EM_RESTART': '1', 16:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:26 INFO - 'PWD': '/builds/slave/test', 16:23:26 INFO - 'SHELL': '/bin/bash', 16:23:26 INFO - 'SHLVL': '1', 16:23:26 INFO - 'TERM': 'linux', 16:23:26 INFO - 'TMOUT': '86400', 16:23:26 INFO - 'USER': 'cltbld', 16:23:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 16:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:26 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 0x186e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdcf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', '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': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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:29 INFO - Starting resource monitoring. 16:23:29 INFO - [mozharness: 2017-08-19 23:23:29.010039Z] Finished create-virtualenv step (success) 16:23:29 INFO - [mozharness: 2017-08-19 23:23:29.011069Z] Running install step. 16:23:29 INFO - Running pre-action listener: _resource_record_pre_action 16:23:29 INFO - Running main action method: install 16:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:29 INFO - Reading from file tmpfile_stdout 16:23:29 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:29 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.340002Z] Finished install step (success) 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.340154Z] 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.340692Z] Finished setup-mitmproxy step (success) 16:23:47 INFO - [mozharness: 2017-08-19 23:23:47.340791Z] 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 0x1bda130>, '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 0x1bdb030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb4c0>, '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-Non-PGO', '--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-004', '--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-Non-PGO --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-004 --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 - 'TERM': 'linux', 16:23:47 INFO - 'TMOUT': '86400', 16:23:47 INFO - 'USER': 'cltbld', 16:23:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017', 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-Non-PGO', '--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-004', '--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:55441' 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:55441/getInfo.html -profile /tmp/tmpRTasAD/profile 16:23:47 INFO - TEST-INFO | started process 3374 (/builds/slave/test/build/application/firefox/firefox http://localhost:55441/getInfo.html) 16:23:58 INFO - TEST-INFO | 3374: exit 0 16:23:58 INFO - Browser initialized. 16:23:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:58 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRTasAD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:59 INFO - PID 3593 | 16:23:59 INFO - PID 3593 | (/builds/slave/test/build/application/firefox/firefox:3643): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:59 INFO - PID 3593 | 16:24:00 INFO - PID 3593 | 16:24:00 INFO - PID 3593 | (/builds/slave/test/build/application/firefox/firefox:3696): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:24:00 INFO - PID 3593 | 16:24:00 INFO - PID 3593 | __metrics Screen width/height:1600/1200 16:24:00 INFO - PID 3593 | colorDepth:24 16:24:00 INFO - PID 3593 | Browser inner width/height: 1024/768 16:24:00 INFO - PID 3593 | __metrics 16:24:09 INFO - PID 3593 | RSS: Main: 172179456 16:24:09 INFO - PID 3593 | 16:27:08 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55441/tests/dromaeo/cssquery-ext.html) 16:27:09 INFO - PID 3593 | RSS: Main: 176250880 16:27:09 INFO - PID 3593 | 16:30:11 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-ext.html (next: http://localhost:55441/tests/dromaeo/cssquery-jquery.html) 16:30:12 INFO - PID 3593 | RSS: Main: 172949504 16:30:12 INFO - PID 3593 | 16:33:13 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55441/tests/dromaeo/cssquery-mootools.html) 16:33:14 INFO - PID 3593 | RSS: Main: 172924928 16:33:14 INFO - PID 3593 | 16:36:16 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55441/tests/dromaeo/cssquery-prototype.html) 16:36:16 INFO - PID 3593 | RSS: Main: 171335680 16:36:16 INFO - PID 3593 | 16:39:20 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55441/tests/dromaeo/cssquery-yui.html) 16:39:21 INFO - PID 3593 | RSS: Main: 174481408 16:39:21 INFO - PID 3593 | 16:42:22 INFO - PID 3593 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-yui.html (next: http://localhost:55441/tests/dromaeo/cssquery-dojo.html) 16:42:23 INFO - PID 3593 | RSS: Main: 175792128 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | __start_tp_report 16:42:23 INFO - PID 3593 | _x_x_mozilla_page_load 16:42:23 INFO - PID 3593 | _x_x_mozilla_page_load_details 16:42:23 INFO - PID 3593 | |i|pagename|runs| 16:42:23 INFO - PID 3593 | |0;dojo.html;3125.8749650014015;3151.1019359482552;3175.5871736674235;3187.0279564732764;3189.6491385947547;6063.484603808676;6092.055731361635;6121.051237058257;6256.593321434104;6264.436200741932;6065.848353791157;6074.392560743923;6134.570580059398;6138.109974053771;6172.691365431733;5547.944520554804;5557.638753481031;5621.381648018714;5677.063284558064;5695.658260504362;5620.297462817148;5731.713414329267;5736.713164341787;5745.712714364286;5745.971270143665;5671.177679236508;5708.914366284509;5758.971205143968;5759;5780.653160810365;5543.695096769676;5654.773809047633;5661.2923384576925;5728.054870946289;5736.799212027559;5629.774809007635;5629.8592535186945;5667.8583035424035;5700.458456446631;5706.429357064302;6123.632582045047;6139.969300153515;6205.565610407273;6227.1282020517165;6234.220722409699;6534.901976470357;6565.126575320536;6637.601743895381;6691.498137639696;6717.328267173292;6516.511261655395;6595.10966019586;6601.2738598754095;6601.504887133437;6608.768693095719;6091.11678806575;6092.66490343031;6100.481459075984;6102.786402475892;6107.908381374283;6734.730610775514;6746.325367463312;6854.280300568468;6864.931350686529;6904.1024666794;6405.807825765234;6510.08858759774;6520.836979075561;6523.543351965317;6532.08550802888;6503;6607.041978913031;6635.203775546869;6712.664366781739;6720.966395167993;6523.934760652428;6527.640979746159;6529.836754081091;6537.313582073909;6540.149780528501;6574.474042076622;6682.79951601443;6684.598924064571;6689;6690.665466726644;5421.674699518042;5468.179773034077;5486.478784515544;5491.176323551499;5505;4655.162070827216;4686.882827929261;4689.460712018094;4723.409573803275;4725.669203155746;5652.9152062719095;5731.512821410143;5776.855578610568;5778.248827652378;5834.3290521589715;6717.193936727624;6721.193456785119;6727;6727.495437842182;6731.956546735264;5710.885782284331;5725.484706376363;5735.655860648374;5788.131780232999;5791.82624521265;5862.032764593794;5884.941150588525;5926.703664816742;5931.792387266425;5949.732262048218;6431.614103153825;6447.194100737408;6452;6544.116544266463;6544.3782840630065;6505.772297969548;6601.174853143357;6605.141331626858;6607.57050791697;6754.155730533684;6395.328490508616;6399.136116624382;6413.422791948747;6418.422341989057;6432.839179020562;6497.545171837926;6520.217573891164;6536.901946470902;6543.967280163569;6553.737850486118;5823.970880145572;6624.701888414937;6653;6672.232693240339;6736.259011508632;6392.968035159794;6404;6466.06242094903;6502.6748662567625;6510.967445162744;6254.405831446005;6377.8724425512155;6388.2972872984865;6392.488600911823;6495.837604059747;6195.876082478415;6243.188385509855;6257.374262573706;6263.906041409474;6271.184745982993;6449.484041276781;6452.419282264619;6513.283538810632;6562.114114594468;6576.079348891255;6117.908231376622;6204.875902481835;6221.253449586078;6265.749370025148;6336.303006669171 16:42:23 INFO - PID 3593 | |1;ext.html;805.6052534258215;856.8886044814174;886.6542048601044;888.3381880499034;1147.5008371358465;29278.2680432989;40186.397204041925;41269.3809592856;41392.793036034775;41424.37863432051;40194.79902600483;40243.39634905479;40245.798771006106;40518.18963620726;40687.38968915461;7581.886271705915;7600.2779735925;7694.192109828471;7706.306432421081;7707.30634242918;7480.551166929974;7576.810579735523;7583.469157159001;7599.050118735158;7625.542467451943;7551.471397002212;7705.306522412981;7707.383409327241;7707.807304817368;7709.3061624453785;7610.657520411595;7637.083549973983;7652.923470765305;7694.653740581687;7702.152763196016;7553.546787192786;7581.734639287653;7631.771046868603;7641.465097443182;7650.73222437212;38174;38496.422553661716;38685.226295473934;38685.419718704245;38779.41830872539;3529.400001999666;3570.6072332043454;3577.5349204603494;3577.731670124725;3578.7673801202836;31064.534031989537;31213.531797023064;31305.68694313073;31314.686853131407;31347.84326078378;4851.34506841579;4894.951050489485;4966.55301022906;5011.599072074226;5035.773390197413;189550;190257;190630;192041;192369;48789.5121048785;48868;48892.51107488951;48902.75548622234;48949;51157.48842511602;51213;51250;51282;51292.74353628208;14025.78961315581;14274.785878211835;15816.60458488547;16105.19474026294;16131.838681613268;13312;13397.330133493286;13399.397027133802;13418.932905335607;13426.865731342561;14287.285635718172;14312.785308220386;14342.211178385289;14404.783928241084;14533.92733036328;5653.717314134276;5694.772209111672;5800.303963524319;5856.677882716492;5859.5019423349495;986.921046316293;1010.3533738407425;1012.4532752313816;1014.0467960117466;1019.7813612732862;23117.884410578175;23225.53548929012;23250;23267.534649307257;23431.062757489508;1106.6845948904524;1109.6615532262738;1111.4442778610694;1112.4993752811267;1126.3973774030853;12150;12388.752224955451;12440.502379904883;12486.562970295996;12534.68663283407;225113;226417;228049;228066;229160;51410;51487;51740.74129629328;51794.74102629538;51838.481615183366;1448.4640682947165;1454.461849115834;1490.344248530643;1496.6931778985281;1503.691743192643;22460.887695561418;22561.323160305215;22742.431439214153;22792.886035569714;23002.07991680381;36632.81683591565;36644.45033324449;36715.81642091773;36717.08207294839;36725;187516;188046;189450;189784;190659;33544.83227583847;35640.28719425649;36500.269994599425;36506.45240321344;36528.81735591305;46335;46685;46844.29733554068;47004.52995470002;47267.290990635855;34252.31495370029;34278;34598;34721.479177811845;34888;33529.66470335265;33545.66454335425;33792.324153517286;33918.66081339155;34475.82762086173;37102.257954840214;37280.813595931846;37317;37412.43881341837;37623.24753504969;32770;32846.34307313888;32860.98958255556;32878.83560582182;32910.670893290764;23680.28959131229;23903.771791439027;24289.63565546483;24485.632715508924;24730 16:42:23 INFO - PID 3593 | |2;jquery.html;557.1920714963302;557.9191017302494;565.9405762394948;570.9771609135635;573.8278516445065;21474.785252147474;22326.441838954015;22348.32955011352;22370.55258894823;22434.102635894546;26401.47197056058;26865.194044178705;26952.460950780973;26992.32519187021;27025.594616080776;6331.955227387487;6476.255230648489;6481.74073037078;6493.383128602775;6497.285298617172;6282.874342513147;6568.868622627545;6871.38157565819;6895.482838787086;6915.827104322382;6866.759663411782;6871.312868713138;6880.071190389309;6885.931140688579;6893.896591551131;6861.965690171567;6871.656417179146;6891.3797758202;6897.724091036378;6904.9654751726175;6726.630035348054;6739.966300168468;6740.427063699592;6743.393094621508;6745.561538499982;31385.05844824659;31657.84171079153;31943;32045.679543204504;32225.87209447658;1929.4693959161202;1964.4597735622676;1965.9508512287164;1968.7243785869846;1970.1725275384229;20487.795122048738;21305.786942130537;21322.253721119687;21349.679754803692;21376.786232137634;2036.4094412620323;2168.913243470275;2196.670499425099;2203.2398822406244;2212.0598745533243;140487;143779.28110359382;144804.93182738658;144922;145581;15238.238088095552;15622.29699663518;15776;15800.446984355493;15890.205489725698;24389.14637987662;24402.755972440402;24426.389340266636;24456;24496.387590310027;10277.845832312521;10315.306535526317;10417.062464378243;10759.740454504485;10900.855410181975;8211.466254693425;9841.212702983745;9891.208703303719;9906.405615663083;10003.79992400148;8300.377471689648;9494.620215191315;9836.3606365586;9839.3112482127;9865.704028879145;2751.463464624379;2754.7796176305847;2759.530879750447;2788.4562510310293;2842.0905310300504;930.4277869110448;956.2732323434101;962.5187406296851;978.1001478639669;989.1345073061071;20548.691769623467;20607;20630.17479300811;21053.789462105487;21096.683549746765;1000.1398797034544;1017.9694609161737;1018.1193267823428;1020.3622735790132;1036.4403222259896;11491.080713542897;11556.017738492323;13617.455301788015;14212.857871421153;14594.34325455357;517055;517105;522017;534497;537701;121936;123932.38033809954;124737;125749.37125314499;127392.36303818422;1220.4324988880214;1273.9554115605908;1290.5934630591335;1291.4640424223842;1296.0603562416984;21516.677249840952;21635.91820409005;21700.131994720035;21788.346349609536;22036.88981555082;58182;59718;59765;59886.40113598983;61015.69492152511;72552.63723681348;73166.63416683096;73631;73780.63109684417;74358.62820685862;14971.176585287914;15091.698166036836;22284.554308914056;22947;23114.191003315475;24260.514789703753;24630.13794517183;25333.873330633967;25516.617250741627;25573.744262557135;18684.34604788826;19191.90404047971;19524.414267571996;19527.316543920893;19545.12046957862;17580.73628895542;17751.201195945956;17755.911220443813;17784.644307114046;18506;18797.248110075445;19188.232470701016;19586.412407627795;20108.994550272135;20219.696704549737;21274.893625531775;21632.322505173845;21735.456613584156;21805.345839624835;22005.33983980483;19070.713939290643;19300.517487062934;19397.127129278935;19451.416457506297;19487.8051219486 16:42:23 INFO - PID 3593 | |3;mootools.html;1355.789852572851;1385.6051025457746;1397.7973193886883;1416.0370947755534;1421.5451055662186;13546.322683865805;13907.165570065803;13974.790378144337;14052.156870587773;14063.296835158253;13879;14983.475578354759;14986;15003.474878379258;15018.324175412105;2654.761071503569;2717.578775289823;2723.891044358223;2724.5913113033102;2724.931876703088;2615.2677250369834;2661.334666333417;2702.9189124326303;2704.323919020245;2705.5130076586306;2621.9606705899428;2654.336415896026;2676.304160918156;2688.07261494784;2704.2157774245543;2645.8809353579136;2652.071774878796;2653.5356312645404;2658.295551678797;2662.986685066562;2603.3621762668267;2614.790816734657;2630.5659566171557;2631.8289311194712;2632.5787873940076;13858.792118118236;14130.364133614012;14154;14173;14180.716385672333;7446.255374462565;7715.151333353327;7719.228077192292;7729.420293478011;7731.729389471341;4929.1374009548545;4961.776720047606;5032.597392208614;5111.386633603991;5125.333706618153;1782.3532054898465;1788.2578729827105;1820.817918208182;1853.2216469083016;1861.9906900465546;22988.310350689506;23295.650565241536;23312.417189570227;23323.53352932949;23357.99999999983;6164.630122192593;6447.323031081763;6461.61230326182;6633.369829866155;6635.369639884203;16062.277197526138;16063.919680401523;16067.919660401623;16087;16113.27490262941;7241.42068634508;7454.068241469817;7469.141048779351;7473.40212782987;7496.0255166827965;5826.563007774434;5895.882082358329;6319.115323854664;6321.051842223611;6890.345417185359;4991.201407774739;5093.719845408464;5180.404253510895;5199.818006369759;5212.348456442945;1389.2498051052319;1394.1286695815115;1394.6792237785367;1411.4354258296764;1414.9858501414853;893.25413279912;914.4696076275744;914.5975770660888;926.6849271247808;931.7624005878457;7449.88825167623;7530.510516816499;7546.20764819697;7576.924230757732;7655.004849369547;729.0704351951305;735.1398863329916;740.8814589665735;741.9406447484188;745.2584678245181;4749.097671442415;5763.4812866842185;5829.62107463022;5942.138389933435;6113.755449782047;19790.604187916448;20643.4839129023;20645.27741529039;20678.793212067987;20679.483012924797;18839.05804709759;19978;20094;20188.596228075356;20223.696644550342;11009.504572294267;11230.887691123147;11247.156463265288;11247.550097996153;11251.549938002388;8384.413091083565;8571.22858942698;8619.741407757778;8712.607932642919;8838.690645827364;17324.133793310033;17543.298268069135;17554.21006054756;17723.46829595114;17795.555111122325;17807.19867605935;18024;18279.086045697928;18350.357737479124;18534.165962531988;11810.82283765727;11903.166778325434;12014.519419223483;12065.155439119528;12085.577004804789;13375.197488150741;13575.38910748999;13580.86419135796;13589.524366647516;13610.455581777014;10787.568497260021;10863.185261105607;10911.290766100177;10980.231383803057;11084.501197445972;10395.32430392022;10607.41659208751;10925.125989920629;10992.395418252074;11061.281016734209;9660.516974151124;9777.706668799947;9867.605295788087;9867.851982220416;9870.259730520384;7143.964280178566;7149.714011439484;7164.605946672775;7204.459665525212;7213.855722885618;7334.926650733424;7360.926390736024;7460;7534.8493030138;7535.8116047099265 16:42:23 INFO - PID 3593 | |4;prototype.html;493.05333759182366;502.14133831148723;520.5575261028129;526.9762860671269;533.6877926413048;6185.752569897199;6318.431341179293;6379.298277189506;6379.617222966614;6408.679566021698;6106.008056052536;6142.969285153568;6194.349593292695;6211.440970312671;6211.968940155304;4932.728699921503;5033.974830125844;5041.546260836524;5047.798088076491;5055.154868473018;4862.7325497097645;4937.506249375069;4980.726060066695;5006.69959802413;5038.39539255288;4886.535779100997;4957.876053098684;4966.553010229079;4971.602271818246;5020.774065167058;4922.089413458521;4957.677750946195;4989.181112671329;4994.875128121826;5070.163423035195;4432.312991486325;4499.325101234808;4505.864824055284;4512.842050528248;4512.977435112836;6128.958077126899;6159.076138579204;6175.228096487939;6185.938140618626;6234.875302493925;5724.561666416879;5755.30936287644;5818.767249310023;5836.416358364172;5848.502877255439;6522.869542609169;6547.116139321226;6559.868042886033;6610.86778264432;6651.60090394573;4906.522206285838;4926.064047830901;4957.950420495821;4974.850754477371;4984.501549844987;6922.896156557656;6928.826779330507;6939.93060069403;6986;6998.405135563534;4959.652824302337;4979.804846836805;5010.799568017312;5026.396832380138;5032.572231360302;5078.339815823919;5090.465501122403;5106.897862042739;5135.255387968724;5139.254808052811;5690.548910027999;5735.4551317624755;5767.8558036049435;5771.989901767174;5811.738471768781;6507.934920650828;6532.804015879531;6552.14822073137;6574.704138313788;6594.274629790719;1672.6654669066236;1696.3214714114454;1741.5733145379463;1762.9334252777142;1780.6171673090348;1207.287700256835;1212.6180253220207;1232.1394694012106;1240.2186622427994;1243.9502419903283;5694.288213973254;5719.942800572025;5737.254156959569;5789.594728369058;5813.215215945877;6583;6751.729930802713;6851.691673874688;6871.347222013901;6882.657881713118;5774.595778295479;5794.130880367894;5818.301803783573;5819.709014549256;5859.824205273849;3631.5460567429072;3632.693239792698;3665.9266814663556;3673.412254039341;3677.1358730698266;6597.406233438917;6673.799786006428;6710.463162946952;6716.026176204521;6728.529002969745;6980.301969802979;6997.545159564612;7046.401055910203;7047.54190977595;7055.576665400093;6542.640154791532;6627.734890604418;6631.668416579152;6641.966790166019;6687.230968438692;6852.417544508772;6901.689423976033;6918.06606108189;6931.579026299697;6936.514443989075;6763.830904227434;6782.253952065367;6793.456523478011;6809.795706128824;6817.659117044029;6529.151210342625;6560.146336343706;6637.701303441453;6659.866802663822;6667.166604174478;5005.674631148963;5012.824551140692;5040.773165207501;5081.314022606901;5098.2862399263395;6511.544191906521;6769.526133170631;6822.771901057858;6835.07726456922;6938.93061069403;6438.710258038306;6538.1500404947055;6565.638889861103;6578.210614726264;6631.502637302318;6567.737290508326;6609.272979972103;6609.272979972296;6632.568883022588;6678.198616165897;6538.738450461929;6559.540832141895;6566.967165164144;6579.374959378852;6597.4392176663605;6622.304658010839;6645.235797883305;6658.400743933069;6699.722094487897;6722.764703235363;6380.585261957958;6418.165638467156;6420.839479013062;6434.903476447951;6484.837879053061 16:42:23 INFO - PID 3593 | |5;yui.html;653.7646447278981;663.2704025571871;728.726727477196;910.7950711090004;925.6806401791384;19030.714539281922;19662.410127696156;19669.31157409491;19678.508037299074;21776.782232177673;21940.8902955485;22112;22393.888030559825;22488.8875555622;22538.09847606094;1026.7843752811918;1065.0999905080196;1065.616378103882;1066.1950227578207;1066.642674703975;1012.567217387396;1044.9425281609508;1057.27576610022;1066.1577353890457;1069.0325255643654;1108.0802933565121;1108.2242430298784;1108.7228192951761;1113.7271368514726;1114.0586204657052;1111.2943281016612;1111.4998250787137;1111.5442668505873;1111.6387174168387;1119.7312644965232;817.8323443694028;818.0919179710517;818.2186012358184;818.6970820796344;818.758466252457;20144.194232230693;20284.695729564068;20417.897910510354;20531.692024619642;20937.371878843507;21928.671069933964;21930.232441864617;22206.222782202705;22308.665370019462;22374.328770136923;17228.310867565284;17244.56888577783;17262.395816146374;17381.478555643353;17493.7375939361;3640.199156185635;3679.521662183926;3679.8712045078296;3681.5950245472977;3686.078480379905;125407.37296313551;125593.37203314016;125624;128055.35972320172;128765;16631;17525.561860953323;17595.912020439817;17708.29166833338;18382.540436489195;31417.21456963594;31983.52024719631;32061.198470038435;32442.188945276557;32605.347893042006;7055.0828392309695;7382.5939573323985;8642.135786421308;8928.910710892938;9248.630054797733;4211.642010429148;4274.4443222381515;4291.914161716811;4298.957010429918;4310.870673879788;5059.8988020239385;5096.949030509648;5256.369235691742;5279.709615971082;5331.44019877915;1027.1269420992246;1030.701096681969;1050.0129877914887;1050.0654417568371;1061.2571200159919;670.2727540618483;686.327399148827;692.1832237959256;692.6709812838963;702.5328156775789;11747.88252117485;11988.820167697491;12136.211146275464;12245.448954797055;12543.623691289276;681.2131987554383;683.1563019670702;684.2370756606348;686.5743239191734;693.8508220732466;5466.7699767551985;5716.742746576414;5758.510526605201;5779.884402312015;6076.088586712029;104864;107295.92704073015;107487;109737;111278.44360778145;98411.50794246126;98802.5059874696;100619.49690251502;101734;104036.47981760194;85076;85261;85278.57360713281;86162.56918715492;87070.12929870747;11071.778564428827;11138.443077846237;11204.93553112453;11488.827667584826;12798.424070917017;38562;38586.22827543377;38739.612603874724;39974.400383993685;40076;69825;71859.64070179616;72979.63510182415;73676.63161684158;76496.61751691205;19591.31430399929;19821.108050138067;20124.496887577927;20153;20633.071511781705;22052.77947220507;22131.225407110673;22602.09591616317;22767.203147889744;22894.969726362022;18839.90580047091;19874;19891.403257902286;20165.193392264144;20386.184552617728;18410.539736506693;18463.81536184621;20167.798322017177;20377.89811050935;20390.69413958762;17776.733349000035;18082.186301616723;18088.819111808712;18117.547061323574;18149;14011.159330440207;14636.341364638829;14648.194349310465;14712.55862324132;14843.332050057557;14662.926685366932;14948.327325270606;15220.391184352944;15956.042637441791;15988.360465581247 16:42:23 INFO - PID 3593 | __end_tp_report 16:42:23 INFO - PID 3593 | __start_cc_report 16:42:23 INFO - PID 3593 | _x_x_mozilla_cycle_collect,391 16:42:23 INFO - PID 3593 | __end_cc_report 16:42:23 INFO - PID 3593 | __startTimestamp1503186143088__endTimestamp 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | ------- Summary: start ------- 16:42:23 INFO - PID 3593 | Number of tests: 6 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#0] dojo.html Cycles:165 Average:6096.19 Median:6263.91 stddev:698.16 (11.1%) stddev-sans-first:660.28 16:42:23 INFO - PID 3593 | Values: 3125.9 3151.1 3175.6 3187.0 3189.6 6063.5 6092.1 6121.1 6256.6 6264.4 6065.8 6074.4 6134.6 6138.1 6172.7 5547.9 5557.6 5621.4 5677.1 5695.7 5620.3 5731.7 5736.7 5745.7 5746.0 5671.2 5708.9 5759.0 5759.0 5780.7 5543.7 5654.8 5661.3 5728.1 5736.8 5629.8 5629.9 5667.9 5700.5 5706.4 6123.6 6140.0 6205.6 6227.1 6234.2 6534.9 6565.1 6637.6 6691.5 6717.3 6516.5 6595.1 6601.3 6601.5 6608.8 6091.1 6092.7 6100.5 6102.8 6107.9 6734.7 6746.3 6854.3 6864.9 6904.1 6405.8 6510.1 6520.8 6523.5 6532.1 6503.0 6607.0 6635.2 6712.7 6721.0 6523.9 6527.6 6529.8 6537.3 6540.1 6574.5 6682.8 6684.6 6689.0 6690.7 5421.7 5468.2 5486.5 5491.2 5505.0 4655.2 4686.9 4689.5 4723.4 4725.7 5652.9 5731.5 5776.9 5778.2 5834.3 6717.2 6721.2 6727.0 6727.5 6732.0 5710.9 5725.5 5735.7 5788.1 5791.8 5862.0 5884.9 5926.7 5931.8 5949.7 6431.6 6447.2 6452.0 6544.1 6544.4 6505.8 6601.2 6605.1 6607.6 6754.2 6395.3 6399.1 6413.4 6418.4 6432.8 6497.5 6520.2 6536.9 6544.0 6553.7 5824.0 6624.7 6653.0 6672.2 6736.3 6393.0 6404.0 6466.1 6502.7 6511.0 6254.4 6377.9 6388.3 6392.5 6495.8 6195.9 6243.2 6257.4 6263.9 6271.2 6449.5 6452.4 6513.3 6562.1 6576.1 6117.9 6204.9 6221.3 6265.7 6336.3 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#1] ext.html Cycles:180 Average:37460.28 Median:3577.63 stddev:52618.29 (1470.8%) stddev-sans-first:52693.91 16:42:23 INFO - PID 3593 | Values: 805.6 856.9 886.7 888.3 1147.5 29278.3 40186.4 41269.4 41392.8 41424.4 40194.8 40243.4 40245.8 40518.2 40687.4 7581.9 7600.3 7694.2 7706.3 7707.3 7480.6 7576.8 7583.5 7599.1 7625.5 7551.5 7705.3 7707.4 7707.8 7709.3 7610.7 7637.1 7652.9 7694.7 7702.2 7553.5 7581.7 7631.8 7641.5 7650.7 38174.0 38496.4 38685.2 38685.4 38779.4 3529.4 3570.6 3577.5 3577.7 3578.8 31064.5 31213.5 31305.7 31314.7 31347.8 4851.3 4895.0 4966.6 5011.6 5035.8 189550.0 190257.0 190630.0 192041.0 192369.0 48789.5 48868.0 48892.5 48902.8 48949.0 51157.5 51213.0 51250.0 51282.0 51292.7 14025.8 14274.8 15816.6 16105.2 16131.8 13312.0 13397.3 13399.4 13418.9 13426.9 14287.3 14312.8 14342.2 14404.8 14533.9 5653.7 5694.8 5800.3 5856.7 5859.5 986.9 1010.4 1012.5 1014.0 1019.8 23117.9 23225.5 23250.0 23267.5 23431.1 1106.7 1109.7 1111.4 1112.5 1126.4 12150.0 12388.8 12440.5 12486.6 12534.7 225113.0 226417.0 228049.0 228066.0 229160.0 51410.0 51487.0 51740.7 51794.7 51838.5 1448.5 1454.5 1490.3 1496.7 1503.7 22460.9 22561.3 22742.4 22792.9 23002.1 36632.8 36644.5 36715.8 36717.1 36725.0 187516.0 188046.0 189450.0 189784.0 190659.0 33544.8 35640.3 36500.3 36506.5 36528.8 46335.0 46685.0 46844.3 47004.5 47267.3 34252.3 34278.0 34598.0 34721.5 34888.0 33529.7 33545.7 33792.3 33918.7 34475.8 37102.3 37280.8 37317.0 37412.4 37623.2 32770.0 32846.3 32861.0 32878.8 32910.7 23680.3 23903.8 24289.6 24485.6 24730.0 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#2] jquery.html Cycles:180 Average:37272.68 Median:22337.39 stddev:88395.77 (395.7%) stddev-sans-first:88600.76 16:42:23 INFO - PID 3593 | Values: 557.2 557.9 565.9 571.0 573.8 21474.8 22326.4 22348.3 22370.6 22434.1 26401.5 26865.2 26952.5 26992.3 27025.6 6332.0 6476.3 6481.7 6493.4 6497.3 6282.9 6568.9 6871.4 6895.5 6915.8 6866.8 6871.3 6880.1 6885.9 6893.9 6862.0 6871.7 6891.4 6897.7 6905.0 6726.6 6740.0 6740.4 6743.4 6745.6 31385.1 31657.8 31943.0 32045.7 32225.9 1929.5 1964.5 1966.0 1968.7 1970.2 20487.8 21305.8 21322.3 21349.7 21376.8 2036.4 2168.9 2196.7 2203.2 2212.1 140487.0 143779.3 144804.9 144922.0 145581.0 15238.2 15622.3 15776.0 15800.4 15890.2 24389.1 24402.8 24426.4 24456.0 24496.4 10277.8 10315.3 10417.1 10759.7 10900.9 8211.5 9841.2 9891.2 9906.4 10003.8 8300.4 9494.6 9836.4 9839.3 9865.7 2751.5 2754.8 2759.5 2788.5 2842.1 930.4 956.3 962.5 978.1 989.1 20548.7 20607.0 20630.2 21053.8 21096.7 1000.1 1018.0 1018.1 1020.4 1036.4 11491.1 11556.0 13617.5 14212.9 14594.3 517055.0 517105.0 522017.0 534497.0 537701.0 121936.0 123932.4 124737.0 125749.4 127392.4 1220.4 1274.0 1290.6 1291.5 1296.1 21516.7 21635.9 21700.1 21788.3 22036.9 58182.0 59718.0 59765.0 59886.4 61015.7 72552.6 73166.6 73631.0 73780.6 74358.6 14971.2 15091.7 22284.6 22947.0 23114.2 24260.5 24630.1 25333.9 25516.6 25573.7 18684.3 19191.9 19524.4 19527.3 19545.1 17580.7 17751.2 17755.9 17784.6 18506.0 18797.2 19188.2 19586.4 20109.0 20219.7 21274.9 21632.3 21735.5 21805.3 22005.3 19070.7 19300.5 19397.1 19451.4 19487.8 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#3] mootools.html Cycles:180 Average:8904.73 Median:2632.20 stddev:6157.35 (233.9%) stddev-sans-first:6148.50 16:42:23 INFO - PID 3593 | Values: 1355.8 1385.6 1397.8 1416.0 1421.5 13546.3 13907.2 13974.8 14052.2 14063.3 13879.0 14983.5 14986.0 15003.5 15018.3 2654.8 2717.6 2723.9 2724.6 2724.9 2615.3 2661.3 2702.9 2704.3 2705.5 2622.0 2654.3 2676.3 2688.1 2704.2 2645.9 2652.1 2653.5 2658.3 2663.0 2603.4 2614.8 2630.6 2631.8 2632.6 13858.8 14130.4 14154.0 14173.0 14180.7 7446.3 7715.2 7719.2 7729.4 7731.7 4929.1 4961.8 5032.6 5111.4 5125.3 1782.4 1788.3 1820.8 1853.2 1862.0 22988.3 23295.7 23312.4 23323.5 23358.0 6164.6 6447.3 6461.6 6633.4 6635.4 16062.3 16063.9 16067.9 16087.0 16113.3 7241.4 7454.1 7469.1 7473.4 7496.0 5826.6 5895.9 6319.1 6321.1 6890.3 4991.2 5093.7 5180.4 5199.8 5212.3 1389.2 1394.1 1394.7 1411.4 1415.0 893.3 914.5 914.6 926.7 931.8 7449.9 7530.5 7546.2 7576.9 7655.0 729.1 735.1 740.9 741.9 745.3 4749.1 5763.5 5829.6 5942.1 6113.8 19790.6 20643.5 20645.3 20678.8 20679.5 18839.1 19978.0 20094.0 20188.6 20223.7 11009.5 11230.9 11247.2 11247.6 11251.5 8384.4 8571.2 8619.7 8712.6 8838.7 17324.1 17543.3 17554.2 17723.5 17795.6 17807.2 18024.0 18279.1 18350.4 18534.2 11810.8 11903.2 12014.5 12065.2 12085.6 13375.2 13575.4 13580.9 13589.5 13610.5 10787.6 10863.2 10911.3 10980.2 11084.5 10395.3 10607.4 10925.1 10992.4 11061.3 9660.5 9777.7 9867.6 9867.9 9870.3 7144.0 7149.7 7164.6 7204.5 7213.9 7334.9 7360.9 7460.0 7534.8 7535.8 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#4] prototype.html Cycles:180 Average:5572.29 Median:6185.85 stddev:1575.07 (25.5%) stddev-sans-first:1532.66 16:42:23 INFO - PID 3593 | Values: 493.1 502.1 520.6 527.0 533.7 6185.8 6318.4 6379.3 6379.6 6408.7 6106.0 6143.0 6194.3 6211.4 6212.0 4932.7 5034.0 5041.5 5047.8 5055.2 4862.7 4937.5 4980.7 5006.7 5038.4 4886.5 4957.9 4966.6 4971.6 5020.8 4922.1 4957.7 4989.2 4994.9 5070.2 4432.3 4499.3 4505.9 4512.8 4513.0 6129.0 6159.1 6175.2 6185.9 6234.9 5724.6 5755.3 5818.8 5836.4 5848.5 6522.9 6547.1 6559.9 6610.9 6651.6 4906.5 4926.1 4958.0 4974.9 4984.5 6922.9 6928.8 6939.9 6986.0 6998.4 4959.7 4979.8 5010.8 5026.4 5032.6 5078.3 5090.5 5106.9 5135.3 5139.3 5690.5 5735.5 5767.9 5772.0 5811.7 6507.9 6532.8 6552.1 6574.7 6594.3 1672.7 1696.3 1741.6 1762.9 1780.6 1207.3 1212.6 1232.1 1240.2 1244.0 5694.3 5719.9 5737.3 5789.6 5813.2 6583.0 6751.7 6851.7 6871.3 6882.7 5774.6 5794.1 5818.3 5819.7 5859.8 3631.5 3632.7 3665.9 3673.4 3677.1 6597.4 6673.8 6710.5 6716.0 6728.5 6980.3 6997.5 7046.4 7047.5 7055.6 6542.6 6627.7 6631.7 6642.0 6687.2 6852.4 6901.7 6918.1 6931.6 6936.5 6763.8 6782.3 6793.5 6809.8 6817.7 6529.2 6560.1 6637.7 6659.9 6667.2 5005.7 5012.8 5040.8 5081.3 5098.3 6511.5 6769.5 6822.8 6835.1 6938.9 6438.7 6538.2 6565.6 6578.2 6631.5 6567.7 6609.3 6609.3 6632.6 6678.2 6538.7 6559.5 6567.0 6579.4 6597.4 6622.3 6645.2 6658.4 6699.7 6722.8 6380.6 6418.2 6420.8 6434.9 6484.8 16:42:23 INFO - PID 3593 | 16:42:23 INFO - PID 3593 | [#5] yui.html Cycles:180 Average:24289.77 Median:20382.04 stddev:32250.87 (158.2%) stddev-sans-first:32292.51 16:42:23 INFO - PID 3593 | Values: 653.8 663.3 728.7 910.8 925.7 19030.7 19662.4 19669.3 19678.5 21776.8 21940.9 22112.0 22393.9 22488.9 22538.1 1026.8 1065.1 1065.6 1066.2 1066.6 1012.6 1044.9 1057.3 1066.2 1069.0 1108.1 1108.2 1108.7 1113.7 1114.1 1111.3 1111.5 1111.5 1111.6 1119.7 817.8 818.1 818.2 818.7 818.8 20144.2 20284.7 20417.9 20531.7 20937.4 21928.7 21930.2 22206.2 22308.7 22374.3 17228.3 17244.6 17262.4 17381.5 17493.7 3640.2 3679.5 3679.9 3681.6 3686.1 125407.4 125593.4 125624.0 128055.4 128765.0 16631.0 17525.6 17595.9 17708.3 18382.5 31417.2 31983.5 32061.2 32442.2 32605.3 7055.1 7382.6 8642.1 8928.9 9248.6 4211.6 4274.4 4291.9 4299.0 4310.9 5059.9 5096.9 5256.4 5279.7 5331.4 1027.1 1030.7 1050.0 1050.1 1061.3 670.3 686.3 692.2 692.7 702.5 11747.9 11988.8 12136.2 12245.4 12543.6 681.2 683.2 684.2 686.6 693.9 5466.8 5716.7 5758.5 5779.9 6076.1 104864.0 107295.9 107487.0 109737.0 111278.4 98411.5 98802.5 100619.5 101734.0 104036.5 85076.0 85261.0 85278.6 86162.6 87070.1 11071.8 11138.4 11204.9 11488.8 12798.4 38562.0 38586.2 38739.6 39974.4 40076.0 69825.0 71859.6 72979.6 73676.6 76496.6 19591.3 19821.1 20124.5 20153.0 20633.1 22052.8 22131.2 22602.1 22767.2 22895.0 18839.9 19874.0 19891.4 20165.2 20386.2 18410.5 18463.8 20167.8 20377.9 20390.7 17776.7 18082.2 18088.8 18117.5 18149.0 14011.2 14636.3 14648.2 14712.6 14843.3 14662.9 14948.3 15220.4 15956.0 15988.4 16:42:23 INFO - PID 3593 | -------- Summary: end -------- 16:42:23 INFO - PID 3593 | 16:42:23 INFO - TEST-INFO | 3593: exit 0 16:42:23 INFO - TEST-OK | dromaeo_css | took 1115992ms 16:42:23 INFO - TEST-START | kraken 16:42:23 INFO - Initialising browser for kraken test... 16:42:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55441/getInfo.html -profile /tmp/tmpRNffXx/profile 16:42:23 INFO - TEST-INFO | started process 4000 (/builds/slave/test/build/application/firefox/firefox http://localhost:55441/getInfo.html) 16:42:29 INFO - TEST-INFO | 4000: exit 0 16:42:29 INFO - Browser initialized. 16:42:29 INFO - Running cycle 1/1 for kraken test... 16:42:29 INFO - TEST-INFO | started process 4218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNffXx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:30 INFO - PID 4218 | 16:42:30 INFO - PID 4218 | (/builds/slave/test/build/application/firefox/firefox:4268): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:30 INFO - PID 4218 | 16:42:31 INFO - PID 4218 | 16:42:31 INFO - PID 4218 | (/builds/slave/test/build/application/firefox/firefox:4326): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:31 INFO - PID 4218 | 16:42:31 INFO - PID 4218 | __metrics Screen width/height:1600/1200 16:42:31 INFO - PID 4218 | colorDepth:24 16:42:31 INFO - PID 4218 | Browser inner width/height: 1024/768 16:42:31 INFO - PID 4218 | __metrics 16:42:40 INFO - PID 4218 | RSS: Main: 171806720 16:42:40 INFO - PID 4218 | 16:42:43 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:44 INFO - PID 4218 | RSS: Main: 175636480 16:42:44 INFO - PID 4218 | 16:42:47 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-dft) 16:42:47 INFO - PID 4218 | RSS: Main: 176156672 16:42:47 INFO - PID 4218 | 16:42:50 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-fft) 16:42:51 INFO - PID 4218 | RSS: Main: 170442752 16:42:51 INFO - PID 4218 | 16:42:53 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator) 16:42:53 INFO - PID 4218 | RSS: Main: 171114496 16:42:53 INFO - PID 4218 | 16:42:56 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:56 INFO - PID 4218 | RSS: Main: 171712512 16:42:56 INFO - PID 4218 | 16:42:59 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:00 INFO - PID 4218 | RSS: Main: 172965888 16:43:00 INFO - PID 4218 | 16:43:03 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:04 INFO - PID 4218 | RSS: Main: 173203456 16:43:04 INFO - PID 4218 | 16:43:07 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial) 16:43:08 INFO - PID 4218 | RSS: Main: 173486080 16:43:08 INFO - PID 4218 | 16:43:09 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:10 INFO - PID 4218 | RSS: Main: 172679168 16:43:10 INFO - PID 4218 | 16:43:12 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:12 INFO - PID 4218 | RSS: Main: 173338624 16:43:12 INFO - PID 4218 | 16:43:14 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:15 INFO - PID 4218 | RSS: Main: 173068288 16:43:15 INFO - PID 4218 | 16:43:18 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:18 INFO - PID 4218 | RSS: Main: 173633536 16:43:18 INFO - PID 4218 | 16:43:21 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:22 INFO - PID 4218 | RSS: Main: 173830144 16:43:22 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55441/tests/kraken/driver.html?testName=ai-astar) 16:43:24 INFO - PID 4218 | RSS: Main: 175128576 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | __start_tp_report 16:43:24 INFO - PID 4218 | _x_x_mozilla_page_load 16:43:24 INFO - PID 4218 | _x_x_mozilla_page_load_details 16:43:24 INFO - PID 4218 | |i|pagename|runs| 16:43:24 INFO - PID 4218 | |0;ai-astar;99;108;101;107;108;109;122;99;110;109 16:43:24 INFO - PID 4218 | |1;audio-beat-detection;143;121;139;164;123;140;142;119;173;124 16:43:24 INFO - PID 4218 | |2;audio-dft;163;162;163;163;162;162;161;170;165;163 16:43:24 INFO - PID 4218 | |3;audio-fft;79;76;74;173;77;75;74;74;154;75 16:43:24 INFO - PID 4218 | |4;audio-oscillator;80;79;137;78;79;78;132;79;79;125 16:43:24 INFO - PID 4218 | |5;imaging-gaussian-blur;114;116;113;114;115;114;115;115;113;114 16:43:24 INFO - PID 4218 | |6;imaging-darkroom;150;151;150;150;149;160;150;149;150;151 16:43:24 INFO - PID 4218 | |7;imaging-desaturate;94;94;101;93;99;98;94;94;95;94 16:43:24 INFO - PID 4218 | |8;json-parse-financial;53;53;54;53;52;53;54;55;54;52 16:43:24 INFO - PID 4218 | |9;json-stringify-tinderbox;55;54;55;54;54;54;54;55;54;54 16:43:24 INFO - PID 4218 | |10;stanford-crypto-aes;90;75;79;77;75;75;75;77;81;75 16:43:24 INFO - PID 4218 | |11;stanford-crypto-ccm;132;133;127;129;125;124;132;123;125;166 16:43:24 INFO - PID 4218 | |12;stanford-crypto-pbkdf2;173;186;180;169;177;169;167;174;167;182 16:43:24 INFO - PID 4218 | |13;stanford-crypto-sha256-iterative;78;67;66;74;66;68;66;66;66;67 16:43:24 INFO - PID 4218 | __end_tp_report 16:43:24 INFO - PID 4218 | __start_cc_report 16:43:24 INFO - PID 4218 | _x_x_mozilla_cycle_collect,952 16:43:24 INFO - PID 4218 | __end_cc_report 16:43:24 INFO - PID 4218 | __startTimestamp1503186204518__endTimestamp 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | ------- Summary: start ------- 16:43:24 INFO - PID 4218 | Number of tests: 14 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.50 stddev:6.73 (6.1%) stddev-sans-first:6.45 16:43:24 INFO - PID 4218 | Values: 99.0 108.0 101.0 107.0 108.0 109.0 122.0 99.0 110.0 109.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:141.00 stddev:18.29 (13.0%) stddev-sans-first:19.34 16:43:24 INFO - PID 4218 | Values: 143.0 121.0 139.0 164.0 123.0 140.0 142.0 119.0 173.0 124.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.55 (1.6%) stddev-sans-first:2.70 16:43:24 INFO - PID 4218 | Values: 163.0 162.0 163.0 163.0 162.0 162.0 161.0 170.0 165.0 163.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.41 (49.9%) stddev-sans-first:39.33 16:43:24 INFO - PID 4218 | Values: 79.0 76.0 74.0 173.0 77.0 75.0 74.0 74.0 154.0 75.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:25.51 (32.3%) stddev-sans-first:26.51 16:43:24 INFO - PID 4218 | Values: 80.0 79.0 137.0 78.0 79.0 78.0 132.0 79.0 79.0 125.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 16:43:24 INFO - PID 4218 | Values: 114.0 116.0 113.0 114.0 115.0 114.0 115.0 115.0 113.0 114.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:150.00 stddev:3.23 (2.2%) stddev-sans-first:3.41 16:43:24 INFO - PID 4218 | Values: 150.0 151.0 150.0 150.0 149.0 160.0 150.0 149.0 150.0 151.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:2.72 (2.9%) stddev-sans-first:2.82 16:43:24 INFO - PID 4218 | Values: 94.0 94.0 101.0 93.0 99.0 98.0 94.0 94.0 95.0 94.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 16:43:24 INFO - PID 4218 | Values: 53.0 53.0 54.0 53.0 52.0 53.0 54.0 55.0 54.0 52.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 16:43:24 INFO - PID 4218 | Values: 55.0 54.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:4.72 (6.1%) stddev-sans-first:2.19 16:43:24 INFO - PID 4218 | Values: 90.0 75.0 79.0 77.0 75.0 75.0 75.0 77.0 81.0 75.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.50 stddev:12.62 (9.7%) stddev-sans-first:13.38 16:43:24 INFO - PID 4218 | Values: 132.0 133.0 127.0 129.0 125.0 124.0 132.0 123.0 125.0 166.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.50 stddev:6.67 (3.8%) stddev-sans-first:7.06 16:43:24 INFO - PID 4218 | Values: 173.0 186.0 180.0 169.0 177.0 169.0 167.0 174.0 167.0 182.0 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.00 stddev:4.17 (6.2%) stddev-sans-first:2.60 16:43:24 INFO - PID 4218 | Values: 78.0 67.0 66.0 74.0 66.0 68.0 66.0 66.0 66.0 67.0 16:43:24 INFO - PID 4218 | -------- Summary: end -------- 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 16:43:24 INFO - PID 4218 | 16:43:24 INFO - PID 4218 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:43:25 INFO - TEST-INFO | 4218: exit 0 16:43:25 INFO - TEST-OK | kraken | took 61486ms 16:43:25 INFO - SUITE-END | took 1177s 16:43:25 INFO - Completed test suite (00:19:37) 16:43:25 INFO - javascript benchmark 16:43:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8614.874483451584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.8749650014015, 3151.1019359482552, 3175.5871736674235, 3187.0279564732764, 3189.6491385947547, 6063.484603808676, 6092.055731361635, 6121.051237058257, 6256.593321434104, 6264.436200741932, 6065.848353791157, 6074.392560743923, 6134.570580059398, 6138.109974053771, 6172.691365431733, 5547.944520554804, 5557.638753481031, 5621.381648018714, 5677.063284558064, 5695.658260504362, 5620.297462817148, 5731.713414329267, 5736.713164341787, 5745.712714364286, 5745.971270143665, 5671.177679236508, 5708.914366284509, 5758.971205143968, 5759.0, 5780.653160810365, 5543.695096769676, 5654.773809047633, 5661.2923384576925, 5728.054870946289, 5736.799212027559, 5629.774809007635, 5629.8592535186945, 5667.8583035424035, 5700.458456446631, 5706.429357064302, 6123.632582045047, 6139.969300153515, 6205.565610407273, 6227.1282020517165, 6234.220722409699, 6534.901976470357, 6565.126575320536, 6637.601743895381, 6691.498137639696, 6717.328267173292, 6516.511261655395, 6595.10966019586, 6601.2738598754095, 6601.504887133437, 6608.768693095719, 6091.11678806575, 6092.66490343031, 6100.481459075984, 6102.786402475892, 6107.908381374283, 6734.730610775514, 6746.325367463312, 6854.280300568468, 6864.931350686529, 6904.1024666794, 6405.807825765234, 6510.08858759774, 6520.836979075561, 6523.543351965317, 6532.08550802888, 6503.0, 6607.041978913031, 6635.203775546869, 6712.664366781739, 6720.966395167993, 6523.934760652428, 6527.640979746159, 6529.836754081091, 6537.313582073909, 6540.149780528501, 6574.474042076622, 6682.79951601443, 6684.598924064571, 6689.0, 6690.665466726644, 5421.674699518042, 5468.179773034077, 5486.478784515544, 5491.176323551499, 5505.0, 4655.162070827216, 4686.882827929261, 4689.460712018094, 4723.409573803275, 4725.669203155746, 5652.9152062719095, 5731.512821410143, 5776.855578610568, 5778.248827652378, 5834.3290521589715, 6717.193936727624, 6721.193456785119, 6727.0, 6727.495437842182, 6731.956546735264, 5710.885782284331, 5725.484706376363, 5735.655860648374, 5788.131780232999, 5791.82624521265, 5862.032764593794, 5884.941150588525, 5926.703664816742, 5931.792387266425, 5949.732262048218, 6431.614103153825, 6447.194100737408, 6452.0, 6544.116544266463, 6544.3782840630065, 6505.772297969548, 6601.174853143357, 6605.141331626858, 6607.57050791697, 6754.155730533684, 6395.328490508616, 6399.136116624382, 6413.422791948747, 6418.422341989057, 6432.839179020562, 6497.545171837926, 6520.217573891164, 6536.901946470902, 6543.967280163569, 6553.737850486118, 5823.970880145572, 6624.701888414937, 6653.0, 6672.232693240339, 6736.259011508632, 6392.968035159794, 6404.0, 6466.06242094903, 6502.6748662567625, 6510.967445162744, 6254.405831446005, 6377.8724425512155, 6388.2972872984865, 6392.488600911823, 6495.837604059747, 6195.876082478415, 6243.188385509855, 6257.374262573706, 6263.906041409474, 6271.184745982993, 6449.484041276781, 6452.419282264619, 6513.283538810632, 6562.114114594468, 6576.079348891255, 6117.908231376622, 6204.875902481835, 6221.253449586078, 6265.749370025148, 6336.303006669171], "value": 6045.643015403268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.6052534258215, 856.8886044814174, 886.6542048601044, 888.3381880499034, 1147.5008371358465, 29278.2680432989, 40186.397204041925, 41269.3809592856, 41392.793036034775, 41424.37863432051, 40194.79902600483, 40243.39634905479, 40245.798771006106, 40518.18963620726, 40687.38968915461, 7581.886271705915, 7600.2779735925, 7694.192109828471, 7706.306432421081, 7707.30634242918, 7480.551166929974, 7576.810579735523, 7583.469157159001, 7599.050118735158, 7625.542467451943, 7551.471397002212, 7705.306522412981, 7707.383409327241, 7707.807304817368, 7709.3061624453785, 7610.657520411595, 7637.083549973983, 7652.923470765305, 7694.653740581687, 7702.152763196016, 7553.546787192786, 7581.734639287653, 7631.771046868603, 7641.465097443182, 7650.73222437212, 38174.0, 38496.422553661716, 38685.226295473934, 38685.419718704245, 38779.41830872539, 3529.400001999666, 3570.6072332043454, 3577.5349204603494, 3577.731670124725, 3578.7673801202836, 31064.534031989537, 31213.531797023064, 31305.68694313073, 31314.686853131407, 31347.84326078378, 4851.34506841579, 4894.951050489485, 4966.55301022906, 5011.599072074226, 5035.773390197413, 189550.0, 190257.0, 190630.0, 192041.0, 192369.0, 48789.5121048785, 48868.0, 48892.51107488951, 48902.75548622234, 48949.0, 51157.48842511602, 51213.0, 51250.0, 51282.0, 51292.74353628208, 14025.78961315581, 14274.785878211835, 15816.60458488547, 16105.19474026294, 16131.838681613268, 13312.0, 13397.330133493286, 13399.397027133802, 13418.932905335607, 13426.865731342561, 14287.285635718172, 14312.785308220386, 14342.211178385289, 14404.783928241084, 14533.92733036328, 5653.717314134276, 5694.772209111672, 5800.303963524319, 5856.677882716492, 5859.5019423349495, 986.921046316293, 1010.3533738407425, 1012.4532752313816, 1014.0467960117466, 1019.7813612732862, 23117.884410578175, 23225.53548929012, 23250.0, 23267.534649307257, 23431.062757489508, 1106.6845948904524, 1109.6615532262738, 1111.4442778610694, 1112.4993752811267, 1126.3973774030853, 12150.0, 12388.752224955451, 12440.502379904883, 12486.562970295996, 12534.68663283407, 225113.0, 226417.0, 228049.0, 228066.0, 229160.0, 51410.0, 51487.0, 51740.74129629328, 51794.74102629538, 51838.481615183366, 1448.4640682947165, 1454.461849115834, 1490.344248530643, 1496.6931778985281, 1503.691743192643, 22460.887695561418, 22561.323160305215, 22742.431439214153, 22792.886035569714, 23002.07991680381, 36632.81683591565, 36644.45033324449, 36715.81642091773, 36717.08207294839, 36725.0, 187516.0, 188046.0, 189450.0, 189784.0, 190659.0, 33544.83227583847, 35640.28719425649, 36500.269994599425, 36506.45240321344, 36528.81735591305, 46335.0, 46685.0, 46844.29733554068, 47004.52995470002, 47267.290990635855, 34252.31495370029, 34278.0, 34598.0, 34721.479177811845, 34888.0, 33529.66470335265, 33545.66454335425, 33792.324153517286, 33918.66081339155, 34475.82762086173, 37102.257954840214, 37280.813595931846, 37317.0, 37412.43881341837, 37623.24753504969, 32770.0, 32846.34307313888, 32860.98958255556, 32878.83560582182, 32910.670893290764, 23680.28959131229, 23903.771791439027, 24289.63565546483, 24485.632715508924, 24730.0], "value": 17247.22781765334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1920714963302, 557.9191017302494, 565.9405762394948, 570.9771609135635, 573.8278516445065, 21474.785252147474, 22326.441838954015, 22348.32955011352, 22370.55258894823, 22434.102635894546, 26401.47197056058, 26865.194044178705, 26952.460950780973, 26992.32519187021, 27025.594616080776, 6331.955227387487, 6476.255230648489, 6481.74073037078, 6493.383128602775, 6497.285298617172, 6282.874342513147, 6568.868622627545, 6871.38157565819, 6895.482838787086, 6915.827104322382, 6866.759663411782, 6871.312868713138, 6880.071190389309, 6885.931140688579, 6893.896591551131, 6861.965690171567, 6871.656417179146, 6891.3797758202, 6897.724091036378, 6904.9654751726175, 6726.630035348054, 6739.966300168468, 6740.427063699592, 6743.393094621508, 6745.561538499982, 31385.05844824659, 31657.84171079153, 31943.0, 32045.679543204504, 32225.87209447658, 1929.4693959161202, 1964.4597735622676, 1965.9508512287164, 1968.7243785869846, 1970.1725275384229, 20487.795122048738, 21305.786942130537, 21322.253721119687, 21349.679754803692, 21376.786232137634, 2036.4094412620323, 2168.913243470275, 2196.670499425099, 2203.2398822406244, 2212.0598745533243, 140487.0, 143779.28110359382, 144804.93182738658, 144922.0, 145581.0, 15238.238088095552, 15622.29699663518, 15776.0, 15800.446984355493, 15890.205489725698, 24389.14637987662, 24402.755972440402, 24426.389340266636, 24456.0, 24496.387590310027, 10277.845832312521, 10315.306535526317, 10417.062464378243, 10759.740454504485, 10900.855410181975, 8211.466254693425, 9841.212702983745, 9891.208703303719, 9906.405615663083, 10003.79992400148, 8300.377471689648, 9494.620215191315, 9836.3606365586, 9839.3112482127, 9865.704028879145, 2751.463464624379, 2754.7796176305847, 2759.530879750447, 2788.4562510310293, 2842.0905310300504, 930.4277869110448, 956.2732323434101, 962.5187406296851, 978.1001478639669, 989.1345073061071, 20548.691769623467, 20607.0, 20630.17479300811, 21053.789462105487, 21096.683549746765, 1000.1398797034544, 1017.9694609161737, 1018.1193267823428, 1020.3622735790132, 1036.4403222259896, 11491.080713542897, 11556.017738492323, 13617.455301788015, 14212.857871421153, 14594.34325455357, 517055.0, 517105.0, 522017.0, 534497.0, 537701.0, 121936.0, 123932.38033809954, 124737.0, 125749.37125314499, 127392.36303818422, 1220.4324988880214, 1273.9554115605908, 1290.5934630591335, 1291.4640424223842, 1296.0603562416984, 21516.677249840952, 21635.91820409005, 21700.131994720035, 21788.346349609536, 22036.88981555082, 58182.0, 59718.0, 59765.0, 59886.40113598983, 61015.69492152511, 72552.63723681348, 73166.63416683096, 73631.0, 73780.63109684417, 74358.62820685862, 14971.176585287914, 15091.698166036836, 22284.554308914056, 22947.0, 23114.191003315475, 24260.514789703753, 24630.13794517183, 25333.873330633967, 25516.617250741627, 25573.744262557135, 18684.34604788826, 19191.90404047971, 19524.414267571996, 19527.316543920893, 19545.12046957862, 17580.73628895542, 17751.201195945956, 17755.911220443813, 17784.644307114046, 18506.0, 18797.248110075445, 19188.232470701016, 19586.412407627795, 20108.994550272135, 20219.696704549737, 21274.893625531775, 21632.322505173845, 21735.456613584156, 21805.345839624835, 22005.33983980483, 19070.713939290643, 19300.517487062934, 19397.127129278935, 19451.416457506297, 19487.8051219486], "value": 12722.460994161642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.789852572851, 1385.6051025457746, 1397.7973193886883, 1416.0370947755534, 1421.5451055662186, 13546.322683865805, 13907.165570065803, 13974.790378144337, 14052.156870587773, 14063.296835158253, 13879.0, 14983.475578354759, 14986.0, 15003.474878379258, 15018.324175412105, 2654.761071503569, 2717.578775289823, 2723.891044358223, 2724.5913113033102, 2724.931876703088, 2615.2677250369834, 2661.334666333417, 2702.9189124326303, 2704.323919020245, 2705.5130076586306, 2621.9606705899428, 2654.336415896026, 2676.304160918156, 2688.07261494784, 2704.2157774245543, 2645.8809353579136, 2652.071774878796, 2653.5356312645404, 2658.295551678797, 2662.986685066562, 2603.3621762668267, 2614.790816734657, 2630.5659566171557, 2631.8289311194712, 2632.5787873940076, 13858.792118118236, 14130.364133614012, 14154.0, 14173.0, 14180.716385672333, 7446.255374462565, 7715.151333353327, 7719.228077192292, 7729.420293478011, 7731.729389471341, 4929.1374009548545, 4961.776720047606, 5032.597392208614, 5111.386633603991, 5125.333706618153, 1782.3532054898465, 1788.2578729827105, 1820.817918208182, 1853.2216469083016, 1861.9906900465546, 22988.310350689506, 23295.650565241536, 23312.417189570227, 23323.53352932949, 23357.99999999983, 6164.630122192593, 6447.323031081763, 6461.61230326182, 6633.369829866155, 6635.369639884203, 16062.277197526138, 16063.919680401523, 16067.919660401623, 16087.0, 16113.27490262941, 7241.42068634508, 7454.068241469817, 7469.141048779351, 7473.40212782987, 7496.0255166827965, 5826.563007774434, 5895.882082358329, 6319.115323854664, 6321.051842223611, 6890.345417185359, 4991.201407774739, 5093.719845408464, 5180.404253510895, 5199.818006369759, 5212.348456442945, 1389.2498051052319, 1394.1286695815115, 1394.6792237785367, 1411.4354258296764, 1414.9858501414853, 893.25413279912, 914.4696076275744, 914.5975770660888, 926.6849271247808, 931.7624005878457, 7449.88825167623, 7530.510516816499, 7546.20764819697, 7576.924230757732, 7655.004849369547, 729.0704351951305, 735.1398863329916, 740.8814589665735, 741.9406447484188, 745.2584678245181, 4749.097671442415, 5763.4812866842185, 5829.62107463022, 5942.138389933435, 6113.755449782047, 19790.604187916448, 20643.4839129023, 20645.27741529039, 20678.793212067987, 20679.483012924797, 18839.05804709759, 19978.0, 20094.0, 20188.596228075356, 20223.696644550342, 11009.504572294267, 11230.887691123147, 11247.156463265288, 11247.550097996153, 11251.549938002388, 8384.413091083565, 8571.22858942698, 8619.741407757778, 8712.607932642919, 8838.690645827364, 17324.133793310033, 17543.298268069135, 17554.21006054756, 17723.46829595114, 17795.555111122325, 17807.19867605935, 18024.0, 18279.086045697928, 18350.357737479124, 18534.165962531988, 11810.82283765727, 11903.166778325434, 12014.519419223483, 12065.155439119528, 12085.577004804789, 13375.197488150741, 13575.38910748999, 13580.86419135796, 13589.524366647516, 13610.455581777014, 10787.568497260021, 10863.185261105607, 10911.290766100177, 10980.231383803057, 11084.501197445972, 10395.32430392022, 10607.41659208751, 10925.125989920629, 10992.395418252074, 11061.281016734209, 9660.516974151124, 9777.706668799947, 9867.605295788087, 9867.851982220416, 9870.259730520384, 7143.964280178566, 7149.714011439484, 7164.605946672775, 7204.459665525212, 7213.855722885618, 7334.926650733424, 7360.926390736024, 7460.0, 7534.8493030138, 7535.8116047099265], "value": 6413.54989932906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.05333759182366, 502.14133831148723, 520.5575261028129, 526.9762860671269, 533.6877926413048, 6185.752569897199, 6318.431341179293, 6379.298277189506, 6379.617222966614, 6408.679566021698, 6106.008056052536, 6142.969285153568, 6194.349593292695, 6211.440970312671, 6211.968940155304, 4932.728699921503, 5033.974830125844, 5041.546260836524, 5047.798088076491, 5055.154868473018, 4862.7325497097645, 4937.506249375069, 4980.726060066695, 5006.69959802413, 5038.39539255288, 4886.535779100997, 4957.876053098684, 4966.553010229079, 4971.602271818246, 5020.774065167058, 4922.089413458521, 4957.677750946195, 4989.181112671329, 4994.875128121826, 5070.163423035195, 4432.312991486325, 4499.325101234808, 4505.864824055284, 4512.842050528248, 4512.977435112836, 6128.958077126899, 6159.076138579204, 6175.228096487939, 6185.938140618626, 6234.875302493925, 5724.561666416879, 5755.30936287644, 5818.767249310023, 5836.416358364172, 5848.502877255439, 6522.869542609169, 6547.116139321226, 6559.868042886033, 6610.86778264432, 6651.60090394573, 4906.522206285838, 4926.064047830901, 4957.950420495821, 4974.850754477371, 4984.501549844987, 6922.896156557656, 6928.826779330507, 6939.93060069403, 6986.0, 6998.405135563534, 4959.652824302337, 4979.804846836805, 5010.799568017312, 5026.396832380138, 5032.572231360302, 5078.339815823919, 5090.465501122403, 5106.897862042739, 5135.255387968724, 5139.254808052811, 5690.548910027999, 5735.4551317624755, 5767.8558036049435, 5771.989901767174, 5811.738471768781, 6507.934920650828, 6532.804015879531, 6552.14822073137, 6574.704138313788, 6594.274629790719, 1672.6654669066236, 1696.3214714114454, 1741.5733145379463, 1762.9334252777142, 1780.6171673090348, 1207.287700256835, 1212.6180253220207, 1232.1394694012106, 1240.2186622427994, 1243.9502419903283, 5694.288213973254, 5719.942800572025, 5737.254156959569, 5789.594728369058, 5813.215215945877, 6583.0, 6751.729930802713, 6851.691673874688, 6871.347222013901, 6882.657881713118, 5774.595778295479, 5794.130880367894, 5818.301803783573, 5819.709014549256, 5859.824205273849, 3631.5460567429072, 3632.693239792698, 3665.9266814663556, 3673.412254039341, 3677.1358730698266, 6597.406233438917, 6673.799786006428, 6710.463162946952, 6716.026176204521, 6728.529002969745, 6980.301969802979, 6997.545159564612, 7046.401055910203, 7047.54190977595, 7055.576665400093, 6542.640154791532, 6627.734890604418, 6631.668416579152, 6641.966790166019, 6687.230968438692, 6852.417544508772, 6901.689423976033, 6918.06606108189, 6931.579026299697, 6936.514443989075, 6763.830904227434, 6782.253952065367, 6793.456523478011, 6809.795706128824, 6817.659117044029, 6529.151210342625, 6560.146336343706, 6637.701303441453, 6659.866802663822, 6667.166604174478, 5005.674631148963, 5012.824551140692, 5040.773165207501, 5081.314022606901, 5098.2862399263395, 6511.544191906521, 6769.526133170631, 6822.771901057858, 6835.07726456922, 6938.93061069403, 6438.710258038306, 6538.1500404947055, 6565.638889861103, 6578.210614726264, 6631.502637302318, 6567.737290508326, 6609.272979972103, 6609.272979972296, 6632.568883022588, 6678.198616165897, 6538.738450461929, 6559.540832141895, 6566.967165164144, 6579.374959378852, 6597.4392176663605, 6622.304658010839, 6645.235797883305, 6658.400743933069, 6699.722094487897, 6722.764703235363, 6380.585261957958, 6418.165638467156, 6420.839479013062, 6434.903476447951, 6484.837879053061], "value": 5106.5101975971165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.7646447278981, 663.2704025571871, 728.726727477196, 910.7950711090004, 925.6806401791384, 19030.714539281922, 19662.410127696156, 19669.31157409491, 19678.508037299074, 21776.782232177673, 21940.8902955485, 22112.0, 22393.888030559825, 22488.8875555622, 22538.09847606094, 1026.7843752811918, 1065.0999905080196, 1065.616378103882, 1066.1950227578207, 1066.642674703975, 1012.567217387396, 1044.9425281609508, 1057.27576610022, 1066.1577353890457, 1069.0325255643654, 1108.0802933565121, 1108.2242430298784, 1108.7228192951761, 1113.7271368514726, 1114.0586204657052, 1111.2943281016612, 1111.4998250787137, 1111.5442668505873, 1111.6387174168387, 1119.7312644965232, 817.8323443694028, 818.0919179710517, 818.2186012358184, 818.6970820796344, 818.758466252457, 20144.194232230693, 20284.695729564068, 20417.897910510354, 20531.692024619642, 20937.371878843507, 21928.671069933964, 21930.232441864617, 22206.222782202705, 22308.665370019462, 22374.328770136923, 17228.310867565284, 17244.56888577783, 17262.395816146374, 17381.478555643353, 17493.7375939361, 3640.199156185635, 3679.521662183926, 3679.8712045078296, 3681.5950245472977, 3686.078480379905, 125407.37296313551, 125593.37203314016, 125624.0, 128055.35972320172, 128765.0, 16631.0, 17525.561860953323, 17595.912020439817, 17708.29166833338, 18382.540436489195, 31417.21456963594, 31983.52024719631, 32061.198470038435, 32442.188945276557, 32605.347893042006, 7055.0828392309695, 7382.5939573323985, 8642.135786421308, 8928.910710892938, 9248.630054797733, 4211.642010429148, 4274.4443222381515, 4291.914161716811, 4298.957010429918, 4310.870673879788, 5059.8988020239385, 5096.949030509648, 5256.369235691742, 5279.709615971082, 5331.44019877915, 1027.1269420992246, 1030.701096681969, 1050.0129877914887, 1050.0654417568371, 1061.2571200159919, 670.2727540618483, 686.327399148827, 692.1832237959256, 692.6709812838963, 702.5328156775789, 11747.88252117485, 11988.820167697491, 12136.211146275464, 12245.448954797055, 12543.623691289276, 681.2131987554383, 683.1563019670702, 684.2370756606348, 686.5743239191734, 693.8508220732466, 5466.7699767551985, 5716.742746576414, 5758.510526605201, 5779.884402312015, 6076.088586712029, 104864.0, 107295.92704073015, 107487.0, 109737.0, 111278.44360778145, 98411.50794246126, 98802.5059874696, 100619.49690251502, 101734.0, 104036.47981760194, 85076.0, 85261.0, 85278.57360713281, 86162.56918715492, 87070.12929870747, 11071.778564428827, 11138.443077846237, 11204.93553112453, 11488.827667584826, 12798.424070917017, 38562.0, 38586.22827543377, 38739.612603874724, 39974.400383993685, 40076.0, 69825.0, 71859.64070179616, 72979.63510182415, 73676.63161684158, 76496.61751691205, 19591.31430399929, 19821.108050138067, 20124.496887577927, 20153.0, 20633.071511781705, 22052.77947220507, 22131.225407110673, 22602.09591616317, 22767.203147889744, 22894.969726362022, 18839.90580047091, 19874.0, 19891.403257902286, 20165.193392264144, 20386.184552617728, 18410.539736506693, 18463.81536184621, 20167.798322017177, 20377.89811050935, 20390.69413958762, 17776.733349000035, 18082.186301616723, 18088.819111808712, 18117.547061323574, 18149.0, 14011.159330440207, 14636.341364638829, 14648.194349310465, 14712.55862324132, 14843.332050057557, 14662.926685366932, 14948.327325270606, 15220.391184352944, 15956.042637441791, 15988.360465581247], "value": 9408.286208138814, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 101.0, 107.0, 108.0, 109.0, 122.0, 99.0, 110.0, 109.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 139.0, 164.0, 123.0, 140.0, 142.0, 119.0, 173.0, 124.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 170.0, 165.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 74.0, 173.0, 77.0, 75.0, 74.0, 74.0, 154.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 137.0, 78.0, 79.0, 78.0, 132.0, 79.0, 79.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 114.0, 115.0, 114.0, 115.0, 115.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 149.0, 160.0, 150.0, 149.0, 150.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 101.0, 93.0, 99.0, 98.0, 94.0, 94.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 52.0, 53.0, 54.0, 55.0, 54.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 75.0, 79.0, 77.0, 75.0, 75.0, 75.0, 77.0, 81.0, 75.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 127.0, 129.0, 125.0, 124.0, 132.0, 123.0, 125.0, 166.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 186.0, 180.0, 169.0, 177.0, 169.0, 167.0, 174.0, 167.0, 182.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 67.0, 66.0, 74.0, 66.0, 68.0, 66.0, 66.0, 66.0, 67.0], "value": 68.4, "unit": "score"}]}]} 16:43:25 INFO - Return code: 0 16:43:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:25 INFO - # TBPL SUCCESS # 16:43:25 INFO - Running post-action listener: _package_coverage_data 16:43:25 INFO - Running post-action listener: _resource_record_post_action 16:43:25 INFO - [mozharness: 2017-08-19 23:43:25.821023Z] Finished run-tests step (success) 16:43:25 INFO - Running post-run listener: _resource_record_post_run 16:43:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5480448; Write bytes: 435286016; Read time: 2072; Write time: 443776 16:43:25 INFO - TinderboxPrint: CPU usage
13.1% 16:43:25 INFO - TinderboxPrint: I/O read bytes / time
5,480,448 / 2,072 16:43:25 INFO - TinderboxPrint: I/O write bytes / time
435,286,016 / 443,776 16:43:25 INFO - TinderboxPrint: CPU idle
8,282.0 (86.8%) 16:43:25 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 16:43:25 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106913792; Read time: 308; Write time: 115104 16:43:25 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:25 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3108864; Write bytes: 327839744; Read time: 1292; Write time: 328628 16:43:26 INFO - Running post-run listener: _upload_blobber_files 16:43:26 INFO - Blob upload gear active. 16:43:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:26 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:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:43:26 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 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: dromaeojs-e10s_errorsummary.log: 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/perfherder-data.json ... 16:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:28 INFO - (blobuploader) - INFO - Done attempting. 16:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:29 INFO - (blobuploader) - INFO - Done attempting. 16:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:36 INFO - (blobuploader) - INFO - Done attempting. 16:43:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:36 INFO - Return code: 0 16:43:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cb6b0f5512cb1a7b11fd6efd5f61ca1c4c5647fffcf91078d45abf65c8fc24e6a62cbc8b39917ffe2f8e3f48db0a8b86f096d7ee574c1f2bceb18b4a64dbc41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2863c19ab8ba0ae1cf7181bbe9ac8d67fe9237da015b7a25f69f1790c0be256f941d5502f5700024f12d09167b0cd9a36bdbbf630008e14247d948d254eed387", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6ebdd010d46a302ab38c9c342f1463bdffb491b449327a54c87262d67a63f53652d907e7aeca9d30146757738d14d6a5cab8c2f2f62aabb099413c5e5aa0652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fe4ef15ce22f3fc851006a4a7785f027c64f39d7a253233d7e5fe27b41cf4398a8c61d2b3f30050291acdc757892d7983d11c05357fcdea36dc6abe10f8b29b"} 16:43:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:36 INFO - Contents: 16:43:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cb6b0f5512cb1a7b11fd6efd5f61ca1c4c5647fffcf91078d45abf65c8fc24e6a62cbc8b39917ffe2f8e3f48db0a8b86f096d7ee574c1f2bceb18b4a64dbc41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2863c19ab8ba0ae1cf7181bbe9ac8d67fe9237da015b7a25f69f1790c0be256f941d5502f5700024f12d09167b0cd9a36bdbbf630008e14247d948d254eed387", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6ebdd010d46a302ab38c9c342f1463bdffb491b449327a54c87262d67a63f53652d907e7aeca9d30146757738d14d6a5cab8c2f2f62aabb099413c5e5aa0652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fe4ef15ce22f3fc851006a4a7785f027c64f39d7a253233d7e5fe27b41cf4398a8c61d2b3f30050291acdc757892d7983d11c05357fcdea36dc6abe10f8b29b"} 16:43:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:36 INFO - Copying logs to upload dir... 16:43:36 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.627522 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-19 16:43:36.529336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:36.536503) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 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-Non-PGO/sha512/1cb6b0f5512cb1a7b11fd6efd5f61ca1c4c5647fffcf91078d45abf65c8fc24e6a62cbc8b39917ffe2f8e3f48db0a8b86f096d7ee574c1f2bceb18b4a64dbc41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2863c19ab8ba0ae1cf7181bbe9ac8d67fe9237da015b7a25f69f1790c0be256f941d5502f5700024f12d09167b0cd9a36bdbbf630008e14247d948d254eed387", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6ebdd010d46a302ab38c9c342f1463bdffb491b449327a54c87262d67a63f53652d907e7aeca9d30146757738d14d6a5cab8c2f2f62aabb099413c5e5aa0652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fe4ef15ce22f3fc851006a4a7785f027c64f39d7a253233d7e5fe27b41cf4398a8c61d2b3f30050291acdc757892d7983d11c05357fcdea36dc6abe10f8b29b"} build_url:https://queue.taskcluster.net/v1/task/Kcb71XQySuWAd4wmZ9eZuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 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-Non-PGO/sha512/1cb6b0f5512cb1a7b11fd6efd5f61ca1c4c5647fffcf91078d45abf65c8fc24e6a62cbc8b39917ffe2f8e3f48db0a8b86f096d7ee574c1f2bceb18b4a64dbc41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2863c19ab8ba0ae1cf7181bbe9ac8d67fe9237da015b7a25f69f1790c0be256f941d5502f5700024f12d09167b0cd9a36bdbbf630008e14247d948d254eed387", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6ebdd010d46a302ab38c9c342f1463bdffb491b449327a54c87262d67a63f53652d907e7aeca9d30146757738d14d6a5cab8c2f2f62aabb099413c5e5aa0652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fe4ef15ce22f3fc851006a4a7785f027c64f39d7a253233d7e5fe27b41cf4398a8c61d2b3f30050291acdc757892d7983d11c05357fcdea36dc6abe10f8b29b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:36.565613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:36.565948) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503169755.531598-1738551017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:43:36.647874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:43:36.651255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:43:36.651585) ========= ========= Total master_lag: 1.09 =========