builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1503483905.84 results: success (0) revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:05.843870) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:05.844482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:05.844776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:05.862355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:05.862764) ========= 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-1503483904.429060-1567837659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 03:25:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-08-23 03:25:06 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.201282 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:06.102916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:06.103298) ========= 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-1503483904.429060-1567837659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:06.157076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:06.158961) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 --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 b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 --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-1503483904.429060-1567837659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 03:25:06,455 truncating revision to first 12 chars 2017-08-23 03:25:06,455 Setting DEBUG logging. 2017-08-23 03:25:06,455 attempt 1/10 2017-08-23 03:25:06,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b911a4c97fde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 03:25:07,053 unpacking tar archive at: mozilla-central-b911a4c97fde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.957720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:07.131687) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:07.132045) ========= script_repo_revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:07.132461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:07.132730) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:07.148129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-23 03:25:07.148467) ========= /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-1503483904.429060-1567837659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:07 INFO - MultiFileLogger online at 20170823 03:25:07 in /builds/slave/test 03:25:07 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 03:25:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:07 INFO - {'append_to_log': False, 03:25:07 INFO - 'base_work_dir': '/builds/slave/test', 03:25:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:25:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:07 INFO - 'branch': 'Firefox-Non-PGO', 03:25:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:07 INFO - 'code_coverage': False, 03:25:07 INFO - 'config_files': ('talos/linux_config.py',), 03:25:07 INFO - 'default_actions': ('clobber', 03:25:07 INFO - 'read-buildbot-config', 03:25:07 INFO - 'download-and-extract', 03:25:07 INFO - 'populate-webroot', 03:25:07 INFO - 'create-virtualenv', 03:25:07 INFO - 'install', 03:25:07 INFO - 'setup-mitmproxy', 03:25:07 INFO - 'run-tests'), 03:25:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:07 INFO - 'disable_ccov_upload': False, 03:25:07 INFO - 'download_minidump_stackwalk': True, 03:25:07 INFO - 'download_symbols': 'ondemand', 03:25:07 INFO - 'enable_stylo': False, 03:25:07 INFO - 'enable_webrender': False, 03:25:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:07 INFO - 'gecko_profile': False, 03:25:07 INFO - 'gecko_profile_interval': 0, 03:25:07 INFO - 'installer_path': 'installer.exe', 03:25:07 INFO - 'log_level': 'info', 03:25:07 INFO - 'log_name': 'talos', 03:25:07 INFO - 'log_to_console': True, 03:25:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:07 INFO - 'opt_config_files': (), 03:25:07 INFO - 'pip_index': False, 03:25:07 INFO - 'suite': 'dromaeojs-e10s', 03:25:07 INFO - 'system_bits': '32', 03:25:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:07 INFO - 'title': 'talos-linux64-ix-004', 03:25:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:07 INFO - 'use_talos_json': True, 03:25:07 INFO - 'verify': 'False', 03:25:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:07 INFO - 'work_dir': 'build'} 03:25:07 INFO - [mozharness: 2017-08-23 10:25:07.691953Z] Running clobber step. 03:25:07 INFO - Running pre-action listener: _resource_record_pre_action 03:25:07 INFO - Running main action method: clobber 03:25:07 INFO - rmtree: /builds/slave/test/build 03:25:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:08 INFO - Running post-action listener: _resource_record_post_action 03:25:08 INFO - [mozharness: 2017-08-23 10:25:08.762464Z] Finished clobber step (success) 03:25:08 INFO - [mozharness: 2017-08-23 10:25:08.762560Z] Running read-buildbot-config step. 03:25:08 INFO - Running pre-action listener: _resource_record_pre_action 03:25:08 INFO - Running main action method: read_buildbot_config 03:25:08 INFO - Using buildbot properties: 03:25:08 INFO - { 03:25:08 INFO - "project": "", 03:25:08 INFO - "product": "firefox", 03:25:08 INFO - "who": "archaeopteryx@coole-files.de", 03:25:08 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:25:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:25:08 INFO - "stage_platform": "linux64", 03:25:08 INFO - "basedir": "/builds/slave/test", 03:25:08 INFO - "buildnumber": 785, 03:25:08 INFO - "platform": "ubuntu64_hw", 03:25:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:08 INFO - "slavebuilddir": "test", 03:25:08 INFO - "taskId": "H6jodh4UReCKupIbUEfNtg", 03:25:08 INFO - "branch": "mozilla-central", 03:25:08 INFO - "script_repo_revision": "production", 03:25:08 INFO - "revision": "b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2", 03:25:08 INFO - "slavename": "talos-linux64-ix-004", 03:25:08 INFO - "repo_path": "mozilla-central" 03:25:08 INFO - } 03:25:08 INFO - Finding installer, test and symbols from parent task. 03:25:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H6jodh4UReCKupIbUEfNtg'}, attempt #1 03:25:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H6jodh4UReCKupIbUEfNtg'}, attempt #1 03:25:09 INFO - Task dependencies: Fvl1I_gnToGP5nRGmDBdyw 03:25:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw'}, attempt #1 03:25:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:25:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip 03:25:10 INFO - Running post-action listener: _resource_record_post_action 03:25:10 INFO - [mozharness: 2017-08-23 10:25:10.095250Z] Finished read-buildbot-config step (success) 03:25:10 INFO - [mozharness: 2017-08-23 10:25:10.095468Z] Running download-and-extract step. 03:25:10 INFO - Running pre-action listener: _resource_record_pre_action 03:25:10 INFO - Running main action method: download_and_extract 03:25:10 INFO - mkdir: /builds/slave/test/build/tests 03:25: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')]} 03:25:10 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:25:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:25:10 INFO - Downloaded 989 bytes. 03:25:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:10 INFO - Using the following test package requirements: 03:25:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:10 INFO - u'common': [u'target.common.tests.zip'], 03:25:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:10 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:10 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:10 INFO - u'target.web-platform.tests.tar.gz'], 03:25:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:25:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip 03:25:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:25:13 INFO - Content-Length response header: 54949653 03:25:13 INFO - Bytes received: 54949653 03:25:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:25:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip 03:25:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:25:26 INFO - Content-Length response header: 54949653 03:25:26 INFO - Bytes received: 54949653 03:25:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip 03:25:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:25:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip into memory 03:25:43 INFO - Content-Length response header: 14496256 03:25:43 INFO - Bytes received: 14496256 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:43 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:25:45 INFO - Downloaded 61202624 bytes. 03:25:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:45 INFO - mkdir: /builds/slave/test/properties 03:25:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:45 INFO - Contents: 03:25:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - Running post-action listener: find_tests_for_verification 03:25:45 INFO - Running post-action listener: set_extra_try_arguments 03:25:45 INFO - [mozharness: 2017-08-23 10:25:45.387643Z] Finished download-and-extract step (success) 03:25:45 INFO - [mozharness: 2017-08-23 10:25:45.387741Z] Running populate-webroot step. 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: populate_webroot 03:25:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:45 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:25:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:45 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_many_windows', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_many_windows', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:45 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:45 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['bloom_basic']}, 03:25:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'tsvg_static']}, 03:25:45 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'tsvg_static']}, 03:25:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:45 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--stylo'], 03:25:45 INFO - 'tests': ['tp5o']}, 03:25:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:45 INFO - 'talos_options': ['--mitmproxy', 03:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:45 INFO - '--firstNonBlankPaint'], 03:25:45 INFO - 'tests': ['tp6_google', 03:25:45 INFO - 'tp6_youtube', 03:25:45 INFO - 'tp6_amazon', 03:25:45 INFO - 'tp6_facebook']}, 03:25:45 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:45 INFO - 'talos_options': ['--stylo', 03:25:45 INFO - '--mitmproxy', 03:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:45 INFO - '--firstNonBlankPaint'], 03:25:45 INFO - 'tests': ['tp6_google', 03:25:45 INFO - 'tp6_youtube', 03:25:45 INFO - 'tp6_amazon', 03:25:45 INFO - 'tp6_facebook']}, 03:25:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:45 INFO - 'talos_options': ['--stylo', 03:25:45 INFO - '--stylo-threads=1', 03:25:45 INFO - '--mitmproxy', 03:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:45 INFO - '--firstNonBlankPaint'], 03:25:45 INFO - 'tests': ['tp6_google', 03:25:45 INFO - 'tp6_youtube', 03:25:45 INFO - 'tp6_amazon', 03:25:45 INFO - 'tp6_facebook']}, 03:25:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}, 03:25:45 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:45 INFO - 'talos_options': ['--stylo', 03:25:45 INFO - '--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}}} 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - [mozharness: 2017-08-23 10:25:45.402060Z] Finished populate-webroot step (success) 03:25:45 INFO - [mozharness: 2017-08-23 10:25:45.402150Z] Running create-virtualenv step. 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: create_virtualenv 03:25:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:45 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 03:25:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:45 INFO - Using real prefix '/usr' 03:25:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:48 INFO - Installing pip.................done. 03:25:48 INFO - Return code: 0 03:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:48 INFO - Reading from file tmpfile_stdout 03:25:48 INFO - Output received: 03:25:48 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) 03:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:48 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')]} 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:48 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')]} 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:48 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:48 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 03:25:48 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 03:25:48 INFO - Using env: {'DISPLAY': ':0', 03:25:48 INFO - 'HOME': '/home/cltbld', 03:25:48 INFO - 'LANG': 'en_US.UTF-8', 03:25:48 INFO - 'LANGUAGE': 'en_US:en', 03:25:48 INFO - 'LOGNAME': 'cltbld', 03:25:48 INFO - 'MAIL': '/var/mail/cltbld', 03:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:48 INFO - 'MOZ_NO_REMOTE': '1', 03:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:48 INFO - 'NO_EM_RESTART': '1', 03:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:48 INFO - 'PWD': '/builds/slave/test', 03:25:48 INFO - 'SHELL': '/bin/bash', 03:25:48 INFO - 'SHLVL': '1', 03:25:48 INFO - 'TERM': 'linux', 03:25:48 INFO - 'TMOUT': '86400', 03:25:48 INFO - 'USER': 'cltbld', 03:25:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:48 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:48 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 03:25:48 INFO - Cleaning up... 03:25:48 INFO - Return code: 0 03:25:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:48 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')]} 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:48 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')]} 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:48 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:48 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 03:25:48 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 03:25:48 INFO - Using env: {'DISPLAY': ':0', 03:25:48 INFO - 'HOME': '/home/cltbld', 03:25:48 INFO - 'LANG': 'en_US.UTF-8', 03:25:48 INFO - 'LANGUAGE': 'en_US:en', 03:25:48 INFO - 'LOGNAME': 'cltbld', 03:25:48 INFO - 'MAIL': '/var/mail/cltbld', 03:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:48 INFO - 'MOZ_NO_REMOTE': '1', 03:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:48 INFO - 'NO_EM_RESTART': '1', 03:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:48 INFO - 'PWD': '/builds/slave/test', 03:25:48 INFO - 'SHELL': '/bin/bash', 03:25:48 INFO - 'SHLVL': '1', 03:25:48 INFO - 'TERM': 'linux', 03:25:48 INFO - 'TMOUT': '86400', 03:25:48 INFO - 'USER': 'cltbld', 03:25:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:48 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:48 INFO - Downloading/unpacking psutil>=3.1.1 03:25:48 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 03:25:48 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 03:25:48 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 03:25:48 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 03:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Installing collected packages: psutil 03:25:50 INFO - Running setup.py install for psutil 03:25:50 INFO - building 'psutil._psutil_linux' extension 03:25:50 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 03:25:51 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 03:25:51 INFO - building 'psutil._psutil_posix' extension 03:25:51 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 03:25:51 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 03:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:51 INFO - Successfully installed psutil 03:25:51 INFO - Cleaning up... 03:25:51 INFO - Return code: 0 03:25:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:51 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')]} 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:51 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')]} 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:51 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:51 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 03:25:51 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 03:25:51 INFO - Using env: {'DISPLAY': ':0', 03:25:51 INFO - 'HOME': '/home/cltbld', 03:25:51 INFO - 'LANG': 'en_US.UTF-8', 03:25:51 INFO - 'LANGUAGE': 'en_US:en', 03:25:51 INFO - 'LOGNAME': 'cltbld', 03:25:51 INFO - 'MAIL': '/var/mail/cltbld', 03:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:51 INFO - 'MOZ_NO_REMOTE': '1', 03:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:51 INFO - 'NO_EM_RESTART': '1', 03:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:51 INFO - 'PWD': '/builds/slave/test', 03:25:51 INFO - 'SHELL': '/bin/bash', 03:25:51 INFO - 'SHLVL': '1', 03:25:51 INFO - 'TERM': 'linux', 03:25:51 INFO - 'TMOUT': '86400', 03:25:51 INFO - 'USER': 'cltbld', 03:25:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:51 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:53 INFO - Installing collected packages: mozsystemmonitor 03:25:53 INFO - Running setup.py install for mozsystemmonitor 03:25:53 INFO - Successfully installed mozsystemmonitor 03:25:53 INFO - Cleaning up... 03:25:53 INFO - Return code: 0 03:25:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:25:53 INFO - Using env: {'DISPLAY': ':0', 03:25:53 INFO - 'HOME': '/home/cltbld', 03:25:53 INFO - 'LANG': 'en_US.UTF-8', 03:25:53 INFO - 'LANGUAGE': 'en_US:en', 03:25:53 INFO - 'LOGNAME': 'cltbld', 03:25:53 INFO - 'MAIL': '/var/mail/cltbld', 03:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:53 INFO - 'MOZ_NO_REMOTE': '1', 03:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:53 INFO - 'NO_EM_RESTART': '1', 03:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:53 INFO - 'PWD': '/builds/slave/test', 03:25:53 INFO - 'SHELL': '/bin/bash', 03:25:53 INFO - 'SHLVL': '1', 03:25:53 INFO - 'TERM': 'linux', 03:25:53 INFO - 'TMOUT': '86400', 03:25:53 INFO - 'USER': 'cltbld', 03:25:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:53 INFO - '_': '/tools/buildbot/bin/python'} 03:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:54 INFO - warning: no files found matching '*.txt' 03:25:54 INFO - no previously-included directories found matching 'build' 03:25:54 INFO - no previously-included directories found matching 'dist' 03:25:54 INFO - no previously-included directories found matching '.git*' 03:25:54 INFO - Installing collected packages: jsonschema, functools32 03:25:54 INFO - Running setup.py install for functools32 03:25:54 INFO - warning: no files found matching '*.txt' 03:25:54 INFO - no previously-included directories found matching 'build' 03:25:54 INFO - no previously-included directories found matching 'dist' 03:25:54 INFO - no previously-included directories found matching '.git*' 03:25:54 INFO - Successfully installed jsonschema functools32 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:55 INFO - Cleaning up... 03:25:55 INFO - Return code: 0 03:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:55 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')]} 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:55 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')]} 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:55 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:55 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 03:25:55 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 03:25:55 INFO - Using env: {'DISPLAY': ':0', 03:25:55 INFO - 'HOME': '/home/cltbld', 03:25:55 INFO - 'LANG': 'en_US.UTF-8', 03:25:55 INFO - 'LANGUAGE': 'en_US:en', 03:25:55 INFO - 'LOGNAME': 'cltbld', 03:25:55 INFO - 'MAIL': '/var/mail/cltbld', 03:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:55 INFO - 'MOZ_NO_REMOTE': '1', 03:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:55 INFO - 'NO_EM_RESTART': '1', 03:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:55 INFO - 'PWD': '/builds/slave/test', 03:25:55 INFO - 'SHELL': '/bin/bash', 03:25:55 INFO - 'SHLVL': '1', 03:25:55 INFO - 'TERM': 'linux', 03:25:55 INFO - 'TMOUT': '86400', 03:25:55 INFO - 'USER': 'cltbld', 03:25:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:55 INFO - '_': '/tools/buildbot/bin/python'} 03:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:55 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 03:25:55 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 03:25:55 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 03:25:55 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 03:25:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - Downloading docopt-0.6.1.tar.gz 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:57 INFO - Running setup.py install for blobuploader 03:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:57 INFO - Running setup.py install for requests 03:25:57 INFO - Running setup.py install for docopt 03:25:57 INFO - Successfully installed blobuploader requests docopt 03:25:57 INFO - Cleaning up... 03:25:57 INFO - Return code: 0 03:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:57 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:25:57 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 03:25:57 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 03:25:57 INFO - Using env: {'DISPLAY': ':0', 03:25:57 INFO - 'HOME': '/home/cltbld', 03:25:57 INFO - 'LANG': 'en_US.UTF-8', 03:25:57 INFO - 'LANGUAGE': 'en_US:en', 03:25:57 INFO - 'LOGNAME': 'cltbld', 03:25:57 INFO - 'MAIL': '/var/mail/cltbld', 03:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:57 INFO - 'MOZ_NO_REMOTE': '1', 03:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:57 INFO - 'NO_EM_RESTART': '1', 03:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:57 INFO - 'PWD': '/builds/slave/test', 03:25:57 INFO - 'SHELL': '/bin/bash', 03:25:57 INFO - 'SHLVL': '1', 03:25:57 INFO - 'TERM': 'linux', 03:25:57 INFO - 'TMOUT': '86400', 03:25:57 INFO - 'USER': 'cltbld', 03:25:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:57 INFO - '_': '/tools/buildbot/bin/python'} 03:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:57 INFO - Running setup.py (path:/tmp/pip-AlZTTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:57 INFO - Running setup.py (path:/tmp/pip-qC4MXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:57 INFO - Running setup.py (path:/tmp/pip-71LWd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:58 INFO - Running setup.py (path:/tmp/pip-3L59wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:58 INFO - Running setup.py (path:/tmp/pip-NXQ7bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:58 INFO - Running setup.py (path:/tmp/pip-parHzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:58 INFO - Running setup.py (path:/tmp/pip-SLHEGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:58 INFO - Running setup.py (path:/tmp/pip-hmJs_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:58 INFO - Running setup.py (path:/tmp/pip-x46Ony-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:58 INFO - Running setup.py (path:/tmp/pip-EpfQl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:58 INFO - Running setup.py (path:/tmp/pip-8C4Sk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:58 INFO - Running setup.py (path:/tmp/pip-jvMXDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:58 INFO - Running setup.py (path:/tmp/pip-cahw7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:58 INFO - Running setup.py (path:/tmp/pip-uw_bqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:58 INFO - Running setup.py (path:/tmp/pip-hb4LGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:58 INFO - Running setup.py (path:/tmp/pip-5lGX9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:58 INFO - Running setup.py (path:/tmp/pip-1ce3w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:59 INFO - Running setup.py install for manifestparser 03:25:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozcrash 03:25:59 INFO - Running setup.py install for mozdebug 03:25:59 INFO - Running setup.py install for mozdevice 03:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozfile 03:25:59 INFO - Running setup.py install for mozhttpd 03:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozinfo 03:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozInstall 03:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozleak 03:25:59 INFO - Running setup.py install for mozlog 03:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for moznetwork 03:26:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozprocess 03:26:00 INFO - Running setup.py install for mozprofile 03:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozrunner 03:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozscreenshot 03:26:00 INFO - Running setup.py install for moztest 03:26:00 INFO - Running setup.py install for mozversion 03:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:00 INFO - Cleaning up... 03:26:00 INFO - Return code: 0 03:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:00 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')]} 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:00 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')]} 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:00 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:26:00 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 03:26:00 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 03:26:00 INFO - Using env: {'DISPLAY': ':0', 03:26:00 INFO - 'HOME': '/home/cltbld', 03:26:00 INFO - 'LANG': 'en_US.UTF-8', 03:26:00 INFO - 'LANGUAGE': 'en_US:en', 03:26:00 INFO - 'LOGNAME': 'cltbld', 03:26:00 INFO - 'MAIL': '/var/mail/cltbld', 03:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:00 INFO - 'MOZ_NO_REMOTE': '1', 03:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:00 INFO - 'NO_EM_RESTART': '1', 03:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:00 INFO - 'PWD': '/builds/slave/test', 03:26:00 INFO - 'SHELL': '/bin/bash', 03:26:00 INFO - 'SHLVL': '1', 03:26:00 INFO - 'TERM': 'linux', 03:26:00 INFO - 'TMOUT': '86400', 03:26:00 INFO - 'USER': 'cltbld', 03:26:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:00 INFO - '_': '/tools/buildbot/bin/python'} 03:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:00 INFO - Running setup.py (path:/tmp/pip-DYNrRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:01 INFO - Running setup.py (path:/tmp/pip-sT_F3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:01 INFO - Running setup.py (path:/tmp/pip-pBWYLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:01 INFO - Running setup.py (path:/tmp/pip-FgsaNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:01 INFO - Running setup.py (path:/tmp/pip-i7WuP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:01 INFO - Running setup.py (path:/tmp/pip-JWVVAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:01 INFO - Running setup.py (path:/tmp/pip-dYywpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:01 INFO - Running setup.py (path:/tmp/pip-cEevD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:01 INFO - Running setup.py (path:/tmp/pip-Nioh5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:01 INFO - Running setup.py (path:/tmp/pip-d5oJix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:01 INFO - Running setup.py (path:/tmp/pip-ERkLn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:01 INFO - Running setup.py (path:/tmp/pip-DLJDdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:01 INFO - Running setup.py (path:/tmp/pip-v_stkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:01 INFO - Running setup.py (path:/tmp/pip-98VHK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:02 INFO - Running setup.py (path:/tmp/pip-uUcqHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:02 INFO - Running setup.py (path:/tmp/pip-sWVqUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:02 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)) 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:02 INFO - Running setup.py (path:/tmp/pip-Yw_Cjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:02 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)) 03:26:02 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)) 03:26:02 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)) 03:26:02 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)) 03:26:02 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)) 03:26:02 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)) 03:26:02 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)) 03:26:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - Downloading blessings-1.6.tar.gz 03:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:03 INFO - Installing collected packages: blessings 03:26:03 INFO - Running setup.py install for blessings 03:26:03 INFO - Successfully installed blessings 03:26:03 INFO - Cleaning up... 03:26:03 INFO - Return code: 0 03:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:03 INFO - Reading from file tmpfile_stdout 03:26:03 INFO - Current package versions: 03:26:03 INFO - argparse == 1.2.1 03:26:03 INFO - blessings == 1.6 03:26:03 INFO - blobuploader == 1.2.4 03:26:03 INFO - docopt == 0.6.1 03:26:03 INFO - functools32 == 3.2.3-2 03:26:03 INFO - jsonschema == 2.5.1 03:26:03 INFO - manifestparser == 1.1 03:26:03 INFO - mozInstall == 1.13 03:26:03 INFO - mozcrash == 1.0 03:26:03 INFO - mozdebug == 0.1 03:26:03 INFO - mozdevice == 0.51 03:26:03 INFO - mozfile == 1.2 03:26:03 INFO - mozhttpd == 0.7 03:26:03 INFO - mozinfo == 0.10 03:26:03 INFO - mozleak == 0.1 03:26:03 INFO - mozlog == 3.5 03:26:03 INFO - moznetwork == 0.27 03:26:03 INFO - mozprocess == 0.25 03:26:03 INFO - mozprofile == 0.28 03:26:03 INFO - mozrunner == 6.13 03:26:03 INFO - mozscreenshot == 0.1 03:26:03 INFO - mozsystemmonitor == 0.3 03:26:03 INFO - moztest == 0.8 03:26:03 INFO - mozversion == 1.4 03:26:03 INFO - psutil == 3.1.1 03:26:03 INFO - requests == 1.2.3 03:26:03 INFO - wsgiref == 0.1.2 03:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:03 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:26:03 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 03:26:03 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 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 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)) 03:26:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:04 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 03:26:04 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 03:26:04 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 03:26:04 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 03:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:05 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)) 03:26:05 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)) 03:26:05 INFO - Installing collected packages: simplejson 03:26:05 INFO - Running setup.py install for simplejson 03:26:05 INFO - building 'simplejson._speedups' extension 03:26:05 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 03:26:06 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 03:26:06 INFO - Successfully installed simplejson 03:26:06 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:06 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')]} 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:06 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')]} 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:06 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 0x18fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c68f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, '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-1503483904.429060-1567837659', '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 03:26:06 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 03:26:06 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 03:26:06 INFO - Using env: {'DISPLAY': ':0', 03:26:06 INFO - 'HOME': '/home/cltbld', 03:26:06 INFO - 'LANG': 'en_US.UTF-8', 03:26:06 INFO - 'LANGUAGE': 'en_US:en', 03:26:06 INFO - 'LOGNAME': 'cltbld', 03:26:06 INFO - 'MAIL': '/var/mail/cltbld', 03:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:06 INFO - 'MOZ_NO_REMOTE': '1', 03:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:06 INFO - 'NO_EM_RESTART': '1', 03:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:06 INFO - 'PWD': '/builds/slave/test', 03:26:06 INFO - 'SHELL': '/bin/bash', 03:26:06 INFO - 'SHLVL': '1', 03:26:06 INFO - 'TERM': 'linux', 03:26:06 INFO - 'TMOUT': '86400', 03:26:06 INFO - 'USER': 'cltbld', 03:26:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:06 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:06 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Running post-action listener: _resource_record_post_action 03:26:06 INFO - Running post-action listener: _start_resource_monitoring 03:26:06 INFO - Starting resource monitoring. 03:26:06 INFO - [mozharness: 2017-08-23 10:26:06.573458Z] Finished create-virtualenv step (success) 03:26:06 INFO - [mozharness: 2017-08-23 10:26:06.574464Z] Running install step. 03:26:06 INFO - Running pre-action listener: _resource_record_pre_action 03:26:06 INFO - Running main action method: install 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Output received: 03:26:06 INFO - Usage: mozinstall [options] installer 03:26:06 INFO - Options: 03:26:06 INFO - -h, --help show this help message and exit 03:26:06 INFO - -d DEST, --destination=DEST 03:26:06 INFO - Directory to install application into. [default: 03:26:06 INFO - "/builds/slave/test"] 03:26:06 INFO - --app=APP Application being installed. [default: firefox] 03:26:06 INFO - mkdir: /builds/slave/test/build/application 03:26:06 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'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:26:24 INFO - Reading from file tmpfile_stdout 03:26:24 INFO - Output received: 03:26:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:24 INFO - Running post-action listener: _resource_record_post_action 03:26:24 INFO - [mozharness: 2017-08-23 10:26:24.634239Z] Finished install step (success) 03:26:24 INFO - [mozharness: 2017-08-23 10:26:24.634517Z] Running setup-mitmproxy step. 03:26:24 INFO - Running pre-action listener: _resource_record_pre_action 03:26:24 INFO - Running main action method: setup_mitmproxy 03:26:24 INFO - Skipping: mitmproxy is not required 03:26:24 INFO - Running post-action listener: _resource_record_post_action 03:26:24 INFO - [mozharness: 2017-08-23 10:26:24.635652Z] Finished setup-mitmproxy step (success) 03:26:24 INFO - [mozharness: 2017-08-23 10:26:24.635872Z] Running run-tests step. 03:26:24 INFO - Running pre-action listener: _resource_record_pre_action 03:26:24 INFO - Running pre-action listener: _set_gcov_prefix 03:26:24 INFO - Running main action method: run_tests 03:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:24 INFO - Python 2.7.3 03:26:24 INFO - Return code: 0 03:26:24 INFO - grabbing minidump binary from tooltool 03:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:24 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 0x1c66130>, '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 0x1c67030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c674c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:24 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 03:26:24 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 03:26:24 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 03:26:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:24 INFO - Return code: 0 03:26:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:24 INFO - ENV: RUST_BACKTRACE is now full 03:26:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:24 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/Fvl1I_gnToGP5nRGmDBdyw/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 03:26:24 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/Fvl1I_gnToGP5nRGmDBdyw/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 03:26:24 INFO - Using env: {'DISPLAY': ':0', 03:26:24 INFO - 'HOME': '/home/cltbld', 03:26:24 INFO - 'LANG': 'en_US.UTF-8', 03:26:24 INFO - 'LANGUAGE': 'en_US:en', 03:26:24 INFO - 'LOGNAME': 'cltbld', 03:26:24 INFO - 'MAIL': '/var/mail/cltbld', 03:26:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:24 INFO - 'MOZ_NO_REMOTE': '1', 03:26:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:24 INFO - 'NO_EM_RESTART': '1', 03:26:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:24 INFO - 'PWD': '/builds/slave/test', 03:26:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:24 INFO - 'RUST_BACKTRACE': 'full', 03:26:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:24 INFO - 'SHELL': '/bin/bash', 03:26:24 INFO - 'SHLVL': '1', 03:26:24 INFO - 'TERM': 'linux', 03:26:24 INFO - 'TMOUT': '86400', 03:26:24 INFO - 'USER': 'cltbld', 03:26:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503483904.429060-1567837659', 03:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:24 INFO - '_': '/tools/buildbot/bin/python'} 03:26:24 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/Fvl1I_gnToGP5nRGmDBdyw/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 03:26:25 INFO - mozversion application_buildid: 20170823094126 03:26:25 INFO - mozversion application_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:26:25 INFO - mozversion application_display_name: Nightly 03:26:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:25 INFO - mozversion application_name: Firefox 03:26:25 INFO - mozversion application_remotingname: firefox 03:26:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:25 INFO - mozversion application_vendor: Mozilla 03:26:25 INFO - mozversion application_version: 57.0a1 03:26:25 INFO - mozversion platform_buildid: 20170823094126 03:26:25 INFO - mozversion platform_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:26:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:25 INFO - mozversion platform_version: 57.0a1 03:26:25 INFO - using testdate: 1503483985 03:26:25 INFO - actual date: 1503483985 03:26:25 INFO - starting webserver on 'localhost:53406' 03:26:25 INFO - SUITE-START | Running 2 tests 03:26:25 INFO - TEST-START | dromaeo_css 03:26:25 INFO - Initialising browser for dromaeo_css test... 03:26:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53406/getInfo.html -profile /tmp/tmp8BBdYE/profile 03:26:25 INFO - TEST-INFO | started process 3329 (/builds/slave/test/build/application/firefox/firefox http://localhost:53406/getInfo.html) 03:26:34 INFO - TEST-INFO | 3329: exit 0 03:26:34 INFO - Browser initialized. 03:26:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:34 INFO - TEST-INFO | started process 3547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8BBdYE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:35 INFO - PID 3547 | 03:26:35 INFO - PID 3547 | (/builds/slave/test/build/application/firefox/firefox:3596): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:35 INFO - PID 3547 | 03:26:36 INFO - PID 3547 | 03:26:36 INFO - PID 3547 | (/builds/slave/test/build/application/firefox/firefox:3649): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:36 INFO - PID 3547 | 03:26:36 INFO - PID 3547 | __metrics Screen width/height:1600/1200 03:26:36 INFO - PID 3547 | colorDepth:24 03:26:36 INFO - PID 3547 | Browser inner width/height: 1024/768 03:26:36 INFO - PID 3547 | __metrics 03:26:45 INFO - PID 3547 | RSS: Main: 171479040 03:26:45 INFO - PID 3547 | 03:29:44 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53406/tests/dromaeo/cssquery-ext.html) 03:29:45 INFO - PID 3547 | RSS: Main: 175828992 03:29:45 INFO - PID 3547 | 03:32:47 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-ext.html (next: http://localhost:53406/tests/dromaeo/cssquery-jquery.html) 03:32:47 INFO - PID 3547 | RSS: Main: 171556864 03:32:47 INFO - PID 3547 | 03:35:49 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53406/tests/dromaeo/cssquery-mootools.html) 03:35:50 INFO - PID 3547 | RSS: Main: 174358528 03:35:50 INFO - PID 3547 | 03:38:52 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53406/tests/dromaeo/cssquery-prototype.html) 03:38:52 INFO - PID 3547 | RSS: Main: 172503040 03:38:52 INFO - PID 3547 | 03:41:56 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53406/tests/dromaeo/cssquery-yui.html) 03:41:56 INFO - PID 3547 | RSS: Main: 174006272 03:41:56 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-yui.html (next: http://localhost:53406/tests/dromaeo/cssquery-dojo.html) 03:44:58 INFO - PID 3547 | RSS: Main: 176672768 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | __start_tp_report 03:44:58 INFO - PID 3547 | _x_x_mozilla_page_load 03:44:58 INFO - PID 3547 | _x_x_mozilla_page_load_details 03:44:58 INFO - PID 3547 | |i|pagename|runs| 03:44:58 INFO - PID 3547 | |0;dojo.html;3266.150800791795;3272.656371081038;3289.4901290300004;3308.421026320393;3330.750193735469;6147.508199344053;6257.71840267188;6275.403836635518;6287.528435367349;6319;6121.081837724343;6209.2859321178075;6216.813495595128;6222.0355844844125;6227.28386235583;5711.971440142794;5721.971390143064;5729.512991395715;5781.306243250816;5831.650100993954;5767.509761670263;5784.710764461781;5812.82561523155;5843.5325173985975;5845.503132233765;5522.364928033247;5660.85847853807;5745.166950792132;5868.061110222366;5869.735861886225;5717.028105222123;5738.340090889559;5792.275965504312;5813.069908814569;5829.446202610745;5719.084946408555;5723;5765.250517432707;5781.537477001872;5804.506616937523;6004.489618382443;6071.362506936796;6083.6045657032155;6106.358832322587;6131.172291740602;6615.900761488581;6652.966735166293;6667.266600673922;6670.299618540032;6672.69972851218;6704.497162712816;6717.529772915897;6753.392194702451;6822.863542729117;6823.624700641462;6259;6264.279607845065;6314.7474101035905;6329.335419780903;6343.111964324999;6887.104676392137;6918.238993710688;6926.965365173242;7005.579665220103;7023.262557431498;6459.515536334794;6536.607803531803;6548.148740663683;6560.311167327457;6667.466602671775;6653.866922661519;6660.200775906826;6667.066610674509;6669.1330127083165;6674.2658307586125;6599.109120268702;6613.537052406382;6635.336466353326;6642.966785166043;6646.069550262967;6557.082008518812;6627.801165965029;6656.733730650816;6666.933330666631;6706.329367063352;5257.973710131425;5270.288511051036;5272.736363181825;5272.815451459181;5279.1817268323475;4558.475775285819;4625.861224163214;4641.094986477672;4682.578567928903;4707.6233901287815;5744.684042377626;5749.482546570829;5754.338251101093;5834.504067154339;5838.416158384212;6633.402993730588;6645.003249512612;6651.368120028589;6655.933440665628;6656.201255849329;5097.8215762448135;5750.3099628044065;5761.164631128547;5786.942130578725;5878.412158784173;5778.971105144531;5784.3926387729525;5861.0915308127305;5864.472197502245;5880.529557635379;6368.681565921685;6494.415502604694;6508.414242718178;6607.537472376984;6615.040819081206;6700.530962832555;6770.93229067703;6789.422899053636;6790.864182716219;6797;6503;6519.250286217146;6558.508111891531;6576.0464732612545;6587.143671322698;6614.239362473377;6646.368594983469;6726.529142960141;6738.629375384401;6740.325967403416;6699.296573859675;6721.361470660279;6746.797596072126;6821.931780682328;6843.076184715199;6444.162258906312;6446.7098980546925;6492.707828147839;6509.609423434609;6527.412532871875;6446.484281257582;6459.257185423737;6523.543351965507;6526.379993900572;6528.053432252392;6373.267074286517;6385.45723613498;6456;6465.159529261354;6472.514561407819;6375.171227740364;6469.482441404771;6497.740090396331;6505.479561635152;6510.73957041732;6278.246610406781;6282.183316168869;6289.150964619901;6300.905486417616;6301.40136687014 03:44:58 INFO - PID 3547 | |1;ext.html;806.959652017399;855.717613187648;877.3376101043712;880.9603567839445;1128.1707944660668;29453;40551.18897622046;40755.796221018856;40786.59213407865;40807.59192408075;41366;41777;41855.79072104635;42111.36832947508;42114.78942605291;7588.58262795546;7679.769606911787;7798.25916537928;7807.063152421717;7828.491148075385;7644.120926093515;7738.613069346538;7756.301932826044;7756.457048006641;7757;7743.380529557622;7782.027246594176;7791.065072191317;7792.493487923295;7810.297073263405;7713.112992005907;7757.5733334666575;7775.261350171753;7775.650095745705;7781.027371578552;7605.429592780563;7626.504277221963;7637.350825179867;7651.693932242703;7659.080910290745;36240.27519449623;36286.63713362859;36528.26943461116;36577.45133822995;36586.63413365859;3383.390989621867;3409.9659003410143;3411.300683359905;3411.8294085295884;3412.3004784019217;30523.542146867814;30636.234094147603;30762.077137685905;30828;30828.2292942676;4957.553820156203;5131.461196574381;5137.2037334213255;5151.896962060775;5156.793728250866;186103;187649;187724;188412;188688.99999999863;45981.310280345824;46102.53897461049;46118;46138;46145.76927115343;48784.26823597649;48838.26742598864;48888.26667599989;48891;48928.75535622299;14118.788218176736;14329.6417589559;14892.627684307763;15102.093874367572;15696.293666785023;13224.074314798065;13265.933670331586;13274.203547787163;13301.26843023643;13312.201267923956;13338.799918001238;13340.19958802475;13419.664508387174;13505.189688618715;13695.726085478234;5269.762860671279;5466.316710411199;5483.945160548344;5496.917546236809;5615.634983726045;995.1740055753708;1007.1087087927237;1008.1682611845257;1019.0726438940528;1025.702546261576;22722.659160112613;22821.771782282296;22843.771562284495;22866.771332286797;23265.76734232636;1102.3496137278883;1111.3054341036852;1112.8720197177267;1115.5816568786704;1127.8533790607332;12244.81632775509;12267;12267.325297108566;12303.876961230273;12334.383280835922;231591;232014;232427;232501;233788;49940.25089623658;50402.747986259834;50409.495905041214;50594;50601;1378.4072848675166;1421.8649228323293;1429.6783223774567;1432.8280606327098;1446.4214314274163;22444.551108978056;22553.323400298017;22593.322200334016;22681.319560413212;22833.65749513792;36541.81729091444;36546.63453365432;36769.26461470809;36842.81578592197;36879.26241475209;193408;193674;193790;193828;194731;30207.546886797154;30346.089617311514;30460;33382.83308583441;33760.15599610029;42147.57852421559;42383.15233695247;42442.78778606087;42592;42594.787026064674;30915.536266956464;30945.226369340948;30961.535576966813;31195;31339.84330078426;31236.843815780776;31361.52957705682;31393.8430307847;31439.37121257608;31547.369052619277;35214.64785352216;35630.465543016355;35701.28597428089;35875;35929;30723;31147.688523114477;32962.50556241706;33990.32019359549;34210.14474638154;25056.749432505443;25151.74848251567;25320.493590128463;25673.229803105936;25762.09832655848 03:44:58 INFO - PID 3547 | |2;jquery.html;547.5674217368279;548.6735392441501;551.6882961126963;553.6346011632321;577.1285359107748;21099.15603375865;21804.45488862779;21876.671849922222;21906.45233869154;21965.450863728416;24223.75776242237;24756.381090472703;24790.628140577905;24815.255542333758;24817.62773558398;6447.355264473538;6616.900746488806;6618.602883826961;6633.734650613969;6642.435392991577;6277.183966084425;6570.277269500351;6896.137982752156;6903.309669033081;6912.412444942186;6923.3076692330615;6923.619200943971;6925.134358205224;6925.272846351136;6926.341997510229;6911.930880691179;6941.930580694179;6953.513254072217;6954.965225173893;6955.547889387173;6786.3892249697765;6792.150981127359;6798.490113241527;6809.421199198074;6818.249992500821;29726.40547189066;30082.09753707392;30153.547696784564;30243;30270.394592108034;2133.6266153423244;2163.588918105555;2163.6538153895303;2163.7836216378396;2164.0910817456547;19950.600987980306;20917.581648366948;20977.475563110893;21021.894890525604;21083.367498975054;2241.8094461970754;2494.276659768665;2517.9370515737255;2579.7549232822853;2622.5148347555764;141076;144604.99999999895;145461;145681;145988;19843.503912402306;19881.105350259273;20716.896415517826;20896.164153433998;21211.363659090253;41812;41951;42017.78991105025;42264.78867605704;42299.36550951738;11672.299662020307;11724.531018759324;11906.107041971714;11957.641270761891;11991.700207494883;9694.951525242328;9777.071178238057;9856.605735770632;9889.357191782512;10027;10894.455277236106;10919.727006824893;10996.835047474295;11156.665300041012;11646.301221926711;3525.7003154732133;3708.870189543353;3833.731638785314;4292.463442069741;4384.846530371486;937.4094320577992;962.2446379591987;967.1537404770826;978.0413304546025;1016.2987538598344;18961.24155033811;19350.90324548368;19496.80503194978;19507;19661.213551457782;1034.1519953638094;1053.8682664666917;1059.2320567588438;1071.4696225368336;1075.956961721538;10565.260431769702;10675.0392464677;10710.250282480307;10775.568977240979;10914.508847101899;508383;512385;518307;543230;548676;116618;118371.40814295874;121264;121516;121562.39218803849;1176.5293882446917;1181.2026881854713;1205.9638210853689;1209.625016244967;1210.7578484303174;16829.906056106312;17049.203270887956;17067.573310667332;17332.913335433746;17377.739333910253;51937.48062519327;53373.46626533685;53658.463415365346;53680.46319536755;54142.458575415316;71104.28895710976;71363.28636713566;71670.64164679144;72391.63804180945;72532.27467725256;14164.929175354056;14295.07082039664;14454.855451445352;14462.626050525183;14477.203753793643;22251.332460026224;22347;22718.65922011138;22741.77258227463;22887.42781430411;18048.548786279924;18337.816621833612;18344.174512147252;18436.63126737431;18443.907780461013;15014.774778378114;15190.696186076437;15711.292991815624;15738.134402607966;16015.359385624444;18642.254309827455;18685.719714204028;18704.719429208846;19040.809591903904;19049.619007619494;14160.150390976163;14193.29033548339;14284.57146285613;14292.571222863331;14323.14061156334;16980.06609636482;17082.658346833243;17697.38059167923;19128.8087119127;19215.423537293904 03:44:58 INFO - PID 3547 | |3;mootools.html;1310.4889093253632;1366.3031853754583;1369.678125640475;1371.0608233360147;1375.0786972728283;14293;14465.20441375724;14873.330700118493;14877.18175500347;14935.551933442013;14868.107913525197;15283.92358038211;15303.234838258099;15315.157666328347;15328.386864525433;2642.9074982375573;2677.491276657429;2682.5439675255157;2685.9462810743776;2688.502627014009;2563.6667233259745;2667.266501712035;2736.521108805951;2749.7112803155583;2749.9037533686324;2599.155274535774;2601.2716439396904;2628.6582744243224;2632.9210123696225;2633.2626864477975;2585.6250843627663;2594.403287243935;2644.920652380422;2646.5765477523696;2659.946801063987;2542.6694529711203;2572.266903932389;2601.1026195962363;2617.790576753874;2625.2518032360686;14499.855001449956;14644;14654.706905861929;14657.70684586313;14669.193194374306;7848.76453706384;8092.1503242159315;8102.513849169069;8113.716019939274;8114.391420643476;4909.754512274408;5133.820316288912;5230.137027390476;5236.633435659505;5238.973805130988;1874.306506592556;1906.9523261918425;1933.1107690462404;1951.7950615185343;1963.8527110466773;25536.36159096019;25674.358141046625;25692.48615027689;25730.485390292277;25735.356616084562;6571.244306904671;6931.2375638679705;7207.819804504825;7228.204897461275;7229.457790665721;16289.104099274653;16736.916315418344;16803.831961680473;16878;16887;7880.369570434352;8177.386695997824;8189.385796065319;8202.38482113844;8218.137095604994;7149.857002859913;7302.634868256566;7412.814679633052;7437.070366204224;7447.255274472509;5100.438951715309;5193.610479214074;5217.2434996925995;5224.05966925957;5413.918791218135;1475.1665309100324;1493.6415260337442;1502.5417247739545;1502.5942995391183;1504.292982298318;856.5717141429285;870.2037635563389;879.9516026618469;888.2716172738293;894.1460904835866;6918.308169183142;6949.44404447643;6971.825704357431;6976.860462790817;6998.6150761708595;705.3933617089299;707.9681414336264;714.0752725220851;715.2561336210387;719.1693593899055;5346.385165705994;5378.273933019071;5437.9939711153565;5527.613067085265;5646.6047376684055;19656;20473.181072756925;20818.791812081687;21314.14743410277;21372.57254854925;20404.18383264653;20476.18095276202;20478.385648430572;20576.176952922015;20670.58658826815;10600.257981941344;10803.729906752236;10915;11168.218224724355;11225.101991840796;8049;8422.24199822019;8533.35999800005;8647.567621618768;8655.740327790176;17490.212940417456;18018;18056.27774889042;18422.72365914539;18586.814131858508;17761.200745966722;18327.816721832613;18366.540836479195;18513.722294165327;19090.140943657847;11405.372704501333;11456.770864582828;11490.080793536665;11504.022158116319;11542;12771.61685149447;12893.097483176087;12921.547745828851;12973.870261297267;13049.739005220032;10966.232363734462;10975.451227438756;11091.667249982513;11270.94364528172;11287.661370158909;10201.59193632276;10296.948515257376;10366.68899932973;10479.68560943173;10701.571937122739;9638.180754635934;9801.607935682492;9810.411375317504;9816.116549510578;9816.950915245377;7001.159860816734;7053.083099197277;7070.46971477131;7084.893726594209;7102.928970710227;6641.302663220292;6705.262421133769;6732.427743641845;6769.864602707819;6810.182778066664 03:44:58 INFO - PID 3547 | |4;prototype.html;486.39443892354024;491.5760856443364;511.2842021170361;513.4352212566176;517.9637425380223;6047.518358002285;6076.118962750398;6110.358412366704;6148.477379422743;6177.505799536038;5886.146508756227;5906.409359064102;5965.910511342333;5966.970165149168;6018.247719035121;4860.684055536379;4922.606191504689;4929.605631549485;4938.50614938506;4940.481249468808;4801.2798080287885;4943.530364615373;4943.739346466646;4962.354893863792;4966.379202599675;4891.339669144655;4893.143699852511;4914.459409464974;4918.778654960535;4967.826126085588;4892.975535122301;4905.3623029006;4911.189653707134;4918.827841025565;4928.33467481889;4414.602685758265;4415.337699345092;4421.53573874745;4422.889427764299;4422.977885110586;5975.342712301644;5988.041913293852;6009.338972712998;6011.1283863839935;6032.396760323976;5619.100943848965;5627.831165065055;5638.464345887134;5649.689267090308;5666.46168613981;6316.1788967434395;6380.744770209186;6388.520860935449;6414.262359828633;6436.356364363573;4697.7181369117625;4780.139574876521;4798.448178459452;4805;4813.542713442217;6637.800865974028;6768.458523318172;6776.864462710768;6834.965825170842;6893.4829887758115;4897.14299997499;4902.926456103161;4903.656744027955;4904.754762261872;4917.311576379309;4978.77595508203;4992.226204938168;5003.2745251938995;5005.249212618136;5007.349044624249;5563.332400112013;5605.216478876742;5611.0080921273175;5613.270274864241;5644.5484361251;6361.586496877688;6442.35576442352;6457.192850893638;6574.811216559965;6610.834729131714;1606.2932309783657;1657.7927759030122;1671.7575951486967;1704.2927185218243;1721.1566332496986;1179.4928180882303;1192.4931903940965;1202.5430336472084;1211.2248161176854;1225.1179151011436;5475.233467314579;5559.749811258503;5567.721613919288;5595.356533998561;5675.659460432387;6360.586561873556;6455.838604034842;6514.413702766774;6574.178227721535;6652.401283884474;5619.606627536115;5642.153676948491;5665.490105890407;5699.259096317535;5735.8566035849435;3413.5391722117693;3469.872291505271;3481.547398838135;3505.544279243733;3523.3129539740016;6293.590916590407;6392.4566411854585;6403.327650596713;6422;6465.450436712932;6655.168103987002;6731.1922569292;6731.932680673229;6790.626515541594;6869.278725733726;6475.870482590321;6485.448736857231;6494.740210391626;6505.3819887111595;6524.119243902012;6597.80206593803;6641.900371494528;6656.437271650353;6657.201135863727;6683.63240021784;6487.708053137714;6576.013597960345;6654.367835055662;6654.700538475877;6672.599644021374;6406;6416.48668106541;6433.485321174388;6456.289808121009;6516.57642253271;5317;5325.227841962971;5330.307060082319;5395.4604539545735;5404.5406140476925;6373.235211774617;6568.540202185801;6585.275619681927;6617;6698.430633396216;6189.659568723583;6260.248770147611;6271.560990730605;6348.555601108063;6413.294537600954;6276.654783986742;6310;6315.842103947438;6322.399372059647;6395.944669129542;6134.607797603788;6171.753129874754;6220.906686399617;6232.220972378453;6326.272478665012;6346.50857048584;6409.775657851953;6413.615183089029;6431.421172094534;6498.220213574401;6158.846028849135;6173.32093469727;6209.875802483834;6223.101953904103;6312.368763123651 03:44:58 INFO - PID 3547 | |5;yui.html;875.8729984152302;896.4352457951492;897.9234276385212;905.6196397513044;908.8273228086663;15906.045637261757;16388;16388.918055409722;16409.425670101533;21469.248576299833;19842.801571984277;20246.89876550615;20615.896920515377;20684.172633094695;20703.585928281424;915.8214148241112;922.8154369126169;931.1340453378356;933.9626414943394;934.2245935873209;912.6714382822179;949.5537097564134;950.4344914775697;950.9619615215383;963.3449254506933;988.614440368257;1000.9499525023756;1002.5538635307291;1003.6537394598852;1004.70361243433;993.0714781679153;993.6124911284605;995.5171741705267;1001.3090967232623;1001.8747656542969;724.0008787872755;724.8369116948644;730.5069078372078;731.7036600176937;735.7314580178196;18788.34240801579;19039.333623323255;19492.610147797106;19736.01319934012;19797.901010495;20551.486212844648;20741.27405540799;20834.27080052191;21293.467663308387;21314.89342553293;15321.233938303152;15610.9219453902;15846.128462934534;15963.760543591856;15973.201339933074;3442.4319987202334;3482.7562070655063;3483.6342184070563;3484.7212223022098;3485.4771784232316;124752.9999999991;125160.37419812843;127711;129625.35187324097;130279;16833.747493787603;16846.578835528966;17123.486295411156;17139.314427423014;17260.74108888368;29515.85242073776;29791.255218619273;30311.696883031327;30314.242143946576;30919.69080309213;7650.464467487333;8051.59742012897;8332.541710205996;8650.307975361957;8889.73330800077;4222.641075508554;4304.418903448057;4315.913681726348;4317.654587632982;4318.265894797892;4778.1638213312535;4864.513548645107;4883.804647814119;4902.4362198346935;4904.190808516555;1024.4570377699831;1037.159900480613;1042.2027149230844;1049.994750026245;1050.0182329521922;669.8224970382853;692.854500554879;697.1390332938817;704.2042491984025;717.2433083097383;11219.1585631078;11368.261063031043;11924;12020.579279725343;12530.561430349893;692.6571347183177;698.2075344483945;699.5557820783839;703.6341102626606;712.9679164437613;5349.973250133802;5386.730663466889;5388.030154572136;5412.5940554458575;5586.608937374344;115044;115212.42393787978;116109;117732;122947;99467;100605;102550;104821;107638;78948.6052569745;80006;80329.19670803218;87376.12623873807;88684.5565772167;11634.418279086181;11723.706907327385;11987.700307492383;12038.128734438027;12272.877271227173;40749.38875916805;41224.38163427491;41344;42084.36873446962;43555;68926;70857;72696.27303726895;73225;78706.21293786989;18298.908505457388;18362.265509379475;18373.908130459797;18486.722699159254;18533.07334633236;20239.4940126498;20489;20666.276680316118;20723.27468538594;20927.37217883466;15749.291281892114;17192.14039298005;17578.824211757717;17586.82413175852;17634;16184.352625895302;16196.91901540532;16398.180090995163;16459.34162633481;16687;16733.414330498374;17249.39627113045;17254.051027193625;17288.308467661154;17664.646707066044;12678.175918565265;12734.490620375082;12763.298018608693;12951;13127;13308.866911330762;13989.160650361011;14023.859761402255;14027.579172624837;14074.577762667137 03:44:58 INFO - PID 3547 | __end_tp_report 03:44:58 INFO - PID 3547 | __start_cc_report 03:44:58 INFO - PID 3547 | _x_x_mozilla_cycle_collect,356 03:44:58 INFO - PID 3547 | __end_cc_report 03:44:58 INFO - PID 3547 | __startTimestamp1503485098783__endTimestamp 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | ------- Summary: start ------- 03:44:58 INFO - PID 3547 | Number of tests: 6 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#0] dojo.html Cycles:165 Average:6155.62 Median:6375.17 stddev:716.24 (11.2%) stddev-sans-first:681.63 03:44:58 INFO - PID 3547 | Values: 3266.2 3272.7 3289.5 3308.4 3330.8 6147.5 6257.7 6275.4 6287.5 6319.0 6121.1 6209.3 6216.8 6222.0 6227.3 5712.0 5722.0 5729.5 5781.3 5831.7 5767.5 5784.7 5812.8 5843.5 5845.5 5522.4 5660.9 5745.2 5868.1 5869.7 5717.0 5738.3 5792.3 5813.1 5829.4 5719.1 5723.0 5765.3 5781.5 5804.5 6004.5 6071.4 6083.6 6106.4 6131.2 6615.9 6653.0 6667.3 6670.3 6672.7 6704.5 6717.5 6753.4 6822.9 6823.6 6259.0 6264.3 6314.7 6329.3 6343.1 6887.1 6918.2 6927.0 7005.6 7023.3 6459.5 6536.6 6548.1 6560.3 6667.5 6653.9 6660.2 6667.1 6669.1 6674.3 6599.1 6613.5 6635.3 6643.0 6646.1 6557.1 6627.8 6656.7 6666.9 6706.3 5258.0 5270.3 5272.7 5272.8 5279.2 4558.5 4625.9 4641.1 4682.6 4707.6 5744.7 5749.5 5754.3 5834.5 5838.4 6633.4 6645.0 6651.4 6655.9 6656.2 5097.8 5750.3 5761.2 5786.9 5878.4 5779.0 5784.4 5861.1 5864.5 5880.5 6368.7 6494.4 6508.4 6607.5 6615.0 6700.5 6770.9 6789.4 6790.9 6797.0 6503.0 6519.3 6558.5 6576.0 6587.1 6614.2 6646.4 6726.5 6738.6 6740.3 6699.3 6721.4 6746.8 6821.9 6843.1 6444.2 6446.7 6492.7 6509.6 6527.4 6446.5 6459.3 6523.5 6526.4 6528.1 6373.3 6385.5 6456.0 6465.2 6472.5 6375.2 6469.5 6497.7 6505.5 6510.7 6278.2 6282.2 6289.2 6300.9 6301.4 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#1] ext.html Cycles:180 Average:36951.93 Median:18700.14 stddev:53249.41 (284.8%) stddev-sans-first:53329.62 03:44:58 INFO - PID 3547 | Values: 807.0 855.7 877.3 881.0 1128.2 29453.0 40551.2 40755.8 40786.6 40807.6 41366.0 41777.0 41855.8 42111.4 42114.8 7588.6 7679.8 7798.3 7807.1 7828.5 7644.1 7738.6 7756.3 7756.5 7757.0 7743.4 7782.0 7791.1 7792.5 7810.3 7713.1 7757.6 7775.3 7775.7 7781.0 7605.4 7626.5 7637.4 7651.7 7659.1 36240.3 36286.6 36528.3 36577.5 36586.6 3383.4 3410.0 3411.3 3411.8 3412.3 30523.5 30636.2 30762.1 30828.0 30828.2 4957.6 5131.5 5137.2 5151.9 5156.8 186103.0 187649.0 187724.0 188412.0 188689.0 45981.3 46102.5 46118.0 46138.0 46145.8 48784.3 48838.3 48888.3 48891.0 48928.8 14118.8 14329.6 14892.6 15102.1 15696.3 13224.1 13265.9 13274.2 13301.3 13312.2 13338.8 13340.2 13419.7 13505.2 13695.7 5269.8 5466.3 5483.9 5496.9 5615.6 995.2 1007.1 1008.2 1019.1 1025.7 22722.7 22821.8 22843.8 22866.8 23265.8 1102.3 1111.3 1112.9 1115.6 1127.9 12244.8 12267.0 12267.3 12303.9 12334.4 231591.0 232014.0 232427.0 232501.0 233788.0 49940.3 50402.7 50409.5 50594.0 50601.0 1378.4 1421.9 1429.7 1432.8 1446.4 22444.6 22553.3 22593.3 22681.3 22833.7 36541.8 36546.6 36769.3 36842.8 36879.3 193408.0 193674.0 193790.0 193828.0 194731.0 30207.5 30346.1 30460.0 33382.8 33760.2 42147.6 42383.2 42442.8 42592.0 42594.8 30915.5 30945.2 30961.5 31195.0 31339.8 31236.8 31361.5 31393.8 31439.4 31547.4 35214.6 35630.5 35701.3 35875.0 35929.0 30723.0 31147.7 32962.5 33990.3 34210.1 25056.7 25151.7 25320.5 25673.2 25762.1 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#2] jquery.html Cycles:180 Average:36778.21 Median:2163.72 stddev:88427.35 (4086.8%) stddev-sans-first:88633.57 03:44:58 INFO - PID 3547 | Values: 547.6 548.7 551.7 553.6 577.1 21099.2 21804.5 21876.7 21906.5 21965.5 24223.8 24756.4 24790.6 24815.3 24817.6 6447.4 6616.9 6618.6 6633.7 6642.4 6277.2 6570.3 6896.1 6903.3 6912.4 6923.3 6923.6 6925.1 6925.3 6926.3 6911.9 6941.9 6953.5 6955.0 6955.5 6786.4 6792.2 6798.5 6809.4 6818.2 29726.4 30082.1 30153.5 30243.0 30270.4 2133.6 2163.6 2163.7 2163.8 2164.1 19950.6 20917.6 20977.5 21021.9 21083.4 2241.8 2494.3 2517.9 2579.8 2622.5 141076.0 144605.0 145461.0 145681.0 145988.0 19843.5 19881.1 20716.9 20896.2 21211.4 41812.0 41951.0 42017.8 42264.8 42299.4 11672.3 11724.5 11906.1 11957.6 11991.7 9695.0 9777.1 9856.6 9889.4 10027.0 10894.5 10919.7 10996.8 11156.7 11646.3 3525.7 3708.9 3833.7 4292.5 4384.8 937.4 962.2 967.2 978.0 1016.3 18961.2 19350.9 19496.8 19507.0 19661.2 1034.2 1053.9 1059.2 1071.5 1076.0 10565.3 10675.0 10710.3 10775.6 10914.5 508383.0 512385.0 518307.0 543230.0 548676.0 116618.0 118371.4 121264.0 121516.0 121562.4 1176.5 1181.2 1206.0 1209.6 1210.8 16829.9 17049.2 17067.6 17332.9 17377.7 51937.5 53373.5 53658.5 53680.5 54142.5 71104.3 71363.3 71670.6 72391.6 72532.3 14164.9 14295.1 14454.9 14462.6 14477.2 22251.3 22347.0 22718.7 22741.8 22887.4 18048.5 18337.8 18344.2 18436.6 18443.9 15014.8 15190.7 15711.3 15738.1 16015.4 18642.3 18685.7 18704.7 19040.8 19049.6 14160.2 14193.3 14284.6 14292.6 14323.1 16980.1 17082.7 17697.4 19128.8 19215.4 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#3] mootools.html Cycles:180 Average:9071.21 Median:2600.13 stddev:6430.31 (247.3%) stddev-sans-first:6421.91 03:44:58 INFO - PID 3547 | Values: 1310.5 1366.3 1369.7 1371.1 1375.1 14293.0 14465.2 14873.3 14877.2 14935.6 14868.1 15283.9 15303.2 15315.2 15328.4 2642.9 2677.5 2682.5 2685.9 2688.5 2563.7 2667.3 2736.5 2749.7 2749.9 2599.2 2601.3 2628.7 2632.9 2633.3 2585.6 2594.4 2644.9 2646.6 2659.9 2542.7 2572.3 2601.1 2617.8 2625.3 14499.9 14644.0 14654.7 14657.7 14669.2 7848.8 8092.2 8102.5 8113.7 8114.4 4909.8 5133.8 5230.1 5236.6 5239.0 1874.3 1907.0 1933.1 1951.8 1963.9 25536.4 25674.4 25692.5 25730.5 25735.4 6571.2 6931.2 7207.8 7228.2 7229.5 16289.1 16736.9 16803.8 16878.0 16887.0 7880.4 8177.4 8189.4 8202.4 8218.1 7149.9 7302.6 7412.8 7437.1 7447.3 5100.4 5193.6 5217.2 5224.1 5413.9 1475.2 1493.6 1502.5 1502.6 1504.3 856.6 870.2 880.0 888.3 894.1 6918.3 6949.4 6971.8 6976.9 6998.6 705.4 708.0 714.1 715.3 719.2 5346.4 5378.3 5438.0 5527.6 5646.6 19656.0 20473.2 20818.8 21314.1 21372.6 20404.2 20476.2 20478.4 20576.2 20670.6 10600.3 10803.7 10915.0 11168.2 11225.1 8049.0 8422.2 8533.4 8647.6 8655.7 17490.2 18018.0 18056.3 18422.7 18586.8 17761.2 18327.8 18366.5 18513.7 19090.1 11405.4 11456.8 11490.1 11504.0 11542.0 12771.6 12893.1 12921.5 12973.9 13049.7 10966.2 10975.5 11091.7 11270.9 11287.7 10201.6 10296.9 10366.7 10479.7 10701.6 9638.2 9801.6 9810.4 9816.1 9817.0 7001.2 7053.1 7070.5 7084.9 7102.9 6641.3 6705.3 6732.4 6769.9 6810.2 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#4] prototype.html Cycles:180 Average:5419.57 Median:5998.69 stddev:1515.03 (25.3%) stddev-sans-first:1473.34 03:44:58 INFO - PID 3547 | Values: 486.4 491.6 511.3 513.4 518.0 6047.5 6076.1 6110.4 6148.5 6177.5 5886.1 5906.4 5965.9 5967.0 6018.2 4860.7 4922.6 4929.6 4938.5 4940.5 4801.3 4943.5 4943.7 4962.4 4966.4 4891.3 4893.1 4914.5 4918.8 4967.8 4893.0 4905.4 4911.2 4918.8 4928.3 4414.6 4415.3 4421.5 4422.9 4423.0 5975.3 5988.0 6009.3 6011.1 6032.4 5619.1 5627.8 5638.5 5649.7 5666.5 6316.2 6380.7 6388.5 6414.3 6436.4 4697.7 4780.1 4798.4 4805.0 4813.5 6637.8 6768.5 6776.9 6835.0 6893.5 4897.1 4902.9 4903.7 4904.8 4917.3 4978.8 4992.2 5003.3 5005.2 5007.3 5563.3 5605.2 5611.0 5613.3 5644.5 6361.6 6442.4 6457.2 6574.8 6610.8 1606.3 1657.8 1671.8 1704.3 1721.2 1179.5 1192.5 1202.5 1211.2 1225.1 5475.2 5559.7 5567.7 5595.4 5675.7 6360.6 6455.8 6514.4 6574.2 6652.4 5619.6 5642.2 5665.5 5699.3 5735.9 3413.5 3469.9 3481.5 3505.5 3523.3 6293.6 6392.5 6403.3 6422.0 6465.5 6655.2 6731.2 6731.9 6790.6 6869.3 6475.9 6485.4 6494.7 6505.4 6524.1 6597.8 6641.9 6656.4 6657.2 6683.6 6487.7 6576.0 6654.4 6654.7 6672.6 6406.0 6416.5 6433.5 6456.3 6516.6 5317.0 5325.2 5330.3 5395.5 5404.5 6373.2 6568.5 6585.3 6617.0 6698.4 6189.7 6260.2 6271.6 6348.6 6413.3 6276.7 6310.0 6315.8 6322.4 6395.9 6134.6 6171.8 6220.9 6232.2 6326.3 6346.5 6409.8 6413.6 6431.4 6498.2 6158.8 6173.3 6209.9 6223.1 6312.4 03:44:58 INFO - PID 3547 | 03:44:58 INFO - PID 3547 | [#5] yui.html Cycles:180 Average:23923.89 Median:20675.22 stddev:33203.44 (160.6%) stddev-sans-first:33251.48 03:44:58 INFO - PID 3547 | Values: 875.9 896.4 897.9 905.6 908.8 15906.0 16388.0 16388.9 16409.4 21469.2 19842.8 20246.9 20615.9 20684.2 20703.6 915.8 922.8 931.1 934.0 934.2 912.7 949.6 950.4 951.0 963.3 988.6 1000.9 1002.6 1003.7 1004.7 993.1 993.6 995.5 1001.3 1001.9 724.0 724.8 730.5 731.7 735.7 18788.3 19039.3 19492.6 19736.0 19797.9 20551.5 20741.3 20834.3 21293.5 21314.9 15321.2 15610.9 15846.1 15963.8 15973.2 3442.4 3482.8 3483.6 3484.7 3485.5 124753.0 125160.4 127711.0 129625.4 130279.0 16833.7 16846.6 17123.5 17139.3 17260.7 29515.9 29791.3 30311.7 30314.2 30919.7 7650.5 8051.6 8332.5 8650.3 8889.7 4222.6 4304.4 4315.9 4317.7 4318.3 4778.2 4864.5 4883.8 4902.4 4904.2 1024.5 1037.2 1042.2 1050.0 1050.0 669.8 692.9 697.1 704.2 717.2 11219.2 11368.3 11924.0 12020.6 12530.6 692.7 698.2 699.6 703.6 713.0 5350.0 5386.7 5388.0 5412.6 5586.6 115044.0 115212.4 116109.0 117732.0 122947.0 99467.0 100605.0 102550.0 104821.0 107638.0 78948.6 80006.0 80329.2 87376.1 88684.6 11634.4 11723.7 11987.7 12038.1 12272.9 40749.4 41224.4 41344.0 42084.4 43555.0 68926.0 70857.0 72696.3 73225.0 78706.2 18298.9 18362.3 18373.9 18486.7 18533.1 20239.5 20489.0 20666.3 20723.3 20927.4 15749.3 17192.1 17578.8 17586.8 17634.0 16184.4 16196.9 16398.2 16459.3 16687.0 16733.4 17249.4 17254.1 17288.3 17664.6 12678.2 12734.5 12763.3 12951.0 13127.0 13308.9 13989.2 14023.9 14027.6 14074.6 03:44:58 INFO - PID 3547 | -------- Summary: end -------- 03:44:58 INFO - PID 3547 | 03:44:59 INFO - TEST-INFO | 3547: exit 0 03:44:59 INFO - TEST-OK | dromaeo_css | took 1114405ms 03:44:59 INFO - TEST-START | kraken 03:44:59 INFO - Initialising browser for kraken test... 03:44:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53406/getInfo.html -profile /tmp/tmpajP9JS/profile 03:44:59 INFO - TEST-INFO | started process 3980 (/builds/slave/test/build/application/firefox/firefox http://localhost:53406/getInfo.html) 03:45:05 INFO - TEST-INFO | 3980: exit 0 03:45:05 INFO - Browser initialized. 03:45:05 INFO - Running cycle 1/1 for kraken test... 03:45:05 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajP9JS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:06 INFO - PID 4156 | 03:45:06 INFO - PID 4156 | (/builds/slave/test/build/application/firefox/firefox:4206): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:06 INFO - PID 4156 | 03:45:06 INFO - PID 4156 | 03:45:06 INFO - PID 4156 | (/builds/slave/test/build/application/firefox/firefox:4259): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:06 INFO - PID 4156 | 03:45:06 INFO - PID 4156 | __metrics Screen width/height:1600/1200 03:45:06 INFO - PID 4156 | colorDepth:24 03:45:06 INFO - PID 4156 | Browser inner width/height: 1024/768 03:45:06 INFO - PID 4156 | __metrics 03:45:16 INFO - PID 4156 | RSS: Main: 171327488 03:45:16 INFO - PID 4156 | 03:45:19 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:20 INFO - PID 4156 | RSS: Main: 176541696 03:45:20 INFO - PID 4156 | 03:45:22 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-dft) 03:45:23 INFO - PID 4156 | RSS: Main: 176869376 03:45:23 INFO - PID 4156 | 03:45:26 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-fft) 03:45:27 INFO - PID 4156 | RSS: Main: 170356736 03:45:27 INFO - PID 4156 | 03:45:29 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-oscillator) 03:45:29 INFO - PID 4156 | RSS: Main: 170901504 03:45:29 INFO - PID 4156 | 03:45:32 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:32 INFO - PID 4156 | RSS: Main: 171311104 03:45:32 INFO - PID 4156 | 03:45:35 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:36 INFO - PID 4156 | RSS: Main: 172470272 03:45:36 INFO - PID 4156 | 03:45:39 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:40 INFO - PID 4156 | RSS: Main: 172761088 03:45:40 INFO - PID 4156 | 03:45:43 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53406/tests/kraken/driver.html?testName=json-parse-financial) 03:45:44 INFO - PID 4156 | RSS: Main: 172961792 03:45:44 INFO - PID 4156 | 03:45:45 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:46 INFO - PID 4156 | RSS: Main: 173166592 03:45:46 INFO - PID 4156 | 03:45:47 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:48 INFO - PID 4156 | RSS: Main: 172949504 03:45:48 INFO - PID 4156 | 03:45:50 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:51 INFO - PID 4156 | RSS: Main: 173076480 03:45:51 INFO - PID 4156 | 03:45:53 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:54 INFO - PID 4156 | RSS: Main: 173486080 03:45:54 INFO - PID 4156 | 03:45:57 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:58 INFO - PID 4156 | RSS: Main: 173805568 03:45:58 INFO - PID 4156 | 03:45:59 INFO - PID 4156 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53406/tests/kraken/driver.html?testName=ai-astar) 03:46:00 INFO - PID 4156 | RSS: Main: 175280128 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | __start_tp_report 03:46:00 INFO - PID 4156 | _x_x_mozilla_page_load 03:46:00 INFO - PID 4156 | _x_x_mozilla_page_load_details 03:46:00 INFO - PID 4156 | |i|pagename|runs| 03:46:00 INFO - PID 4156 | |0;ai-astar;104;108;95;107;107;108;110;108;108;107 03:46:00 INFO - PID 4156 | |1;audio-beat-detection;143;126;146;170;117;142;148;124;179;119 03:46:00 INFO - PID 4156 | |2;audio-dft;165;163;162;161;161;162;166;167;162;163 03:46:00 INFO - PID 4156 | |3;audio-fft;74;78;74;169;76;85;73;73;156;77 03:46:00 INFO - PID 4156 | |4;audio-oscillator;79;80;128;79;79;77;131;79;78;129 03:46:00 INFO - PID 4156 | |5;imaging-gaussian-blur;113;115;115;114;115;113;114;113;113;114 03:46:00 INFO - PID 4156 | |6;imaging-darkroom;150;151;150;149;151;148;148;148;148;147 03:46:00 INFO - PID 4156 | |7;imaging-desaturate;94;94;94;94;95;94;93;93;94;94 03:46:00 INFO - PID 4156 | |8;json-parse-financial;51;52;52;52;52;51;51;52;53;51 03:46:00 INFO - PID 4156 | |9;json-stringify-tinderbox;55;55;54;55;55;55;56;55;55;54 03:46:00 INFO - PID 4156 | |10;stanford-crypto-aes;73;78;73;72;75;73;75;74;80;75 03:46:00 INFO - PID 4156 | |11;stanford-crypto-ccm;124;122;122;115;120;123;117;118;129;154 03:46:00 INFO - PID 4156 | |12;stanford-crypto-pbkdf2;182;170;176;172;168;176;167;177;175;174 03:46:00 INFO - PID 4156 | |13;stanford-crypto-sha256-iterative;64;64;65;62;67;67;71;65;63;64 03:46:00 INFO - PID 4156 | __end_tp_report 03:46:00 INFO - PID 4156 | __start_cc_report 03:46:00 INFO - PID 4156 | _x_x_mozilla_cycle_collect,962 03:46:00 INFO - PID 4156 | __end_cc_report 03:46:00 INFO - PID 4156 | __startTimestamp1503485160220__endTimestamp 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | ------- Summary: start ------- 03:46:00 INFO - PID 4156 | Number of tests: 14 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#0] ai-astar Cycles:10 Average:106.20 Median:108.00 stddev:4.21 (3.9%) stddev-sans-first:4.39 03:46:00 INFO - PID 4156 | Values: 104.0 108.0 95.0 107.0 107.0 108.0 110.0 108.0 108.0 107.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:144.50 stddev:20.91 (14.5%) stddev-sans-first:22.17 03:46:00 INFO - PID 4156 | Values: 143.0 126.0 146.0 170.0 117.0 142.0 148.0 124.0 179.0 119.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.12 03:46:00 INFO - PID 4156 | Values: 165.0 163.0 162.0 161.0 161.0 162.0 166.0 167.0 162.0 163.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:36.66 (48.9%) stddev-sans-first:38.20 03:46:00 INFO - PID 4156 | Values: 74.0 78.0 74.0 169.0 76.0 85.0 73.0 73.0 156.0 77.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.00 stddev:24.47 (31.0%) stddev-sans-first:25.36 03:46:00 INFO - PID 4156 | Values: 79.0 80.0 128.0 79.0 79.0 77.0 131.0 79.0 78.0 129.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 03:46:00 INFO - PID 4156 | Values: 113.0 115.0 115.0 114.0 115.0 113.0 114.0 113.0 113.0 114.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 03:46:00 INFO - PID 4156 | Values: 150.0 151.0 150.0 149.0 151.0 148.0 148.0 148.0 148.0 147.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:46:00 INFO - PID 4156 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 93.0 93.0 94.0 94.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.67 03:46:00 INFO - PID 4156 | Values: 51.0 52.0 52.0 52.0 52.0 51.0 51.0 52.0 53.0 51.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:46:00 INFO - PID 4156 | Values: 55.0 55.0 54.0 55.0 55.0 55.0 56.0 55.0 55.0 54.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:2.49 (3.3%) stddev-sans-first:2.55 03:46:00 INFO - PID 4156 | Values: 73.0 78.0 73.0 72.0 75.0 73.0 75.0 74.0 80.0 75.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:122.50 stddev:11.13 (9.1%) stddev-sans-first:11.80 03:46:00 INFO - PID 4156 | Values: 124.0 122.0 122.0 115.0 120.0 123.0 117.0 118.0 129.0 154.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:175.50 stddev:4.55 (2.6%) stddev-sans-first:3.70 03:46:00 INFO - PID 4156 | Values: 182.0 170.0 176.0 172.0 168.0 176.0 167.0 177.0 175.0 174.0 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.57 (4.0%) stddev-sans-first:2.69 03:46:00 INFO - PID 4156 | Values: 64.0 64.0 65.0 62.0 67.0 67.0 71.0 65.0 63.0 64.0 03:46:00 INFO - PID 4156 | -------- Summary: end -------- 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 03:46:00 INFO - PID 4156 | 03:46:00 INFO - PID 4156 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:46:00 INFO - TEST-INFO | 4156: exit 0 03:46:00 INFO - TEST-OK | kraken | took 61498ms 03:46:00 INFO - SUITE-END | took 1175s 03:46:01 INFO - Completed test suite (00:19:36) 03:46:01 INFO - javascript benchmark 03:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8496.250682614116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.150800791795, 3272.656371081038, 3289.4901290300004, 3308.421026320393, 3330.750193735469, 6147.508199344053, 6257.71840267188, 6275.403836635518, 6287.528435367349, 6319.0, 6121.081837724343, 6209.2859321178075, 6216.813495595128, 6222.0355844844125, 6227.28386235583, 5711.971440142794, 5721.971390143064, 5729.512991395715, 5781.306243250816, 5831.650100993954, 5767.509761670263, 5784.710764461781, 5812.82561523155, 5843.5325173985975, 5845.503132233765, 5522.364928033247, 5660.85847853807, 5745.166950792132, 5868.061110222366, 5869.735861886225, 5717.028105222123, 5738.340090889559, 5792.275965504312, 5813.069908814569, 5829.446202610745, 5719.084946408555, 5723.0, 5765.250517432707, 5781.537477001872, 5804.506616937523, 6004.489618382443, 6071.362506936796, 6083.6045657032155, 6106.358832322587, 6131.172291740602, 6615.900761488581, 6652.966735166293, 6667.266600673922, 6670.299618540032, 6672.69972851218, 6704.497162712816, 6717.529772915897, 6753.392194702451, 6822.863542729117, 6823.624700641462, 6259.0, 6264.279607845065, 6314.7474101035905, 6329.335419780903, 6343.111964324999, 6887.104676392137, 6918.238993710688, 6926.965365173242, 7005.579665220103, 7023.262557431498, 6459.515536334794, 6536.607803531803, 6548.148740663683, 6560.311167327457, 6667.466602671775, 6653.866922661519, 6660.200775906826, 6667.066610674509, 6669.1330127083165, 6674.2658307586125, 6599.109120268702, 6613.537052406382, 6635.336466353326, 6642.966785166043, 6646.069550262967, 6557.082008518812, 6627.801165965029, 6656.733730650816, 6666.933330666631, 6706.329367063352, 5257.973710131425, 5270.288511051036, 5272.736363181825, 5272.815451459181, 5279.1817268323475, 4558.475775285819, 4625.861224163214, 4641.094986477672, 4682.578567928903, 4707.6233901287815, 5744.684042377626, 5749.482546570829, 5754.338251101093, 5834.504067154339, 5838.416158384212, 6633.402993730588, 6645.003249512612, 6651.368120028589, 6655.933440665628, 6656.201255849329, 5097.8215762448135, 5750.3099628044065, 5761.164631128547, 5786.942130578725, 5878.412158784173, 5778.971105144531, 5784.3926387729525, 5861.0915308127305, 5864.472197502245, 5880.529557635379, 6368.681565921685, 6494.415502604694, 6508.414242718178, 6607.537472376984, 6615.040819081206, 6700.530962832555, 6770.93229067703, 6789.422899053636, 6790.864182716219, 6797.0, 6503.0, 6519.250286217146, 6558.508111891531, 6576.0464732612545, 6587.143671322698, 6614.239362473377, 6646.368594983469, 6726.529142960141, 6738.629375384401, 6740.325967403416, 6699.296573859675, 6721.361470660279, 6746.797596072126, 6821.931780682328, 6843.076184715199, 6444.162258906312, 6446.7098980546925, 6492.707828147839, 6509.609423434609, 6527.412532871875, 6446.484281257582, 6459.257185423737, 6523.543351965507, 6526.379993900572, 6528.053432252392, 6373.267074286517, 6385.45723613498, 6456.0, 6465.159529261354, 6472.514561407819, 6375.171227740364, 6469.482441404771, 6497.740090396331, 6505.479561635152, 6510.73957041732, 6278.246610406781, 6282.183316168869, 6289.150964619901, 6300.905486417616, 6301.40136687014], "value": 6104.124200956514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.959652017399, 855.717613187648, 877.3376101043712, 880.9603567839445, 1128.1707944660668, 29453.0, 40551.18897622046, 40755.796221018856, 40786.59213407865, 40807.59192408075, 41366.0, 41777.0, 41855.79072104635, 42111.36832947508, 42114.78942605291, 7588.58262795546, 7679.769606911787, 7798.25916537928, 7807.063152421717, 7828.491148075385, 7644.120926093515, 7738.613069346538, 7756.301932826044, 7756.457048006641, 7757.0, 7743.380529557622, 7782.027246594176, 7791.065072191317, 7792.493487923295, 7810.297073263405, 7713.112992005907, 7757.5733334666575, 7775.261350171753, 7775.650095745705, 7781.027371578552, 7605.429592780563, 7626.504277221963, 7637.350825179867, 7651.693932242703, 7659.080910290745, 36240.27519449623, 36286.63713362859, 36528.26943461116, 36577.45133822995, 36586.63413365859, 3383.390989621867, 3409.9659003410143, 3411.300683359905, 3411.8294085295884, 3412.3004784019217, 30523.542146867814, 30636.234094147603, 30762.077137685905, 30828.0, 30828.2292942676, 4957.553820156203, 5131.461196574381, 5137.2037334213255, 5151.896962060775, 5156.793728250866, 186103.0, 187649.0, 187724.0, 188412.0, 188688.99999999863, 45981.310280345824, 46102.53897461049, 46118.0, 46138.0, 46145.76927115343, 48784.26823597649, 48838.26742598864, 48888.26667599989, 48891.0, 48928.75535622299, 14118.788218176736, 14329.6417589559, 14892.627684307763, 15102.093874367572, 15696.293666785023, 13224.074314798065, 13265.933670331586, 13274.203547787163, 13301.26843023643, 13312.201267923956, 13338.799918001238, 13340.19958802475, 13419.664508387174, 13505.189688618715, 13695.726085478234, 5269.762860671279, 5466.316710411199, 5483.945160548344, 5496.917546236809, 5615.634983726045, 995.1740055753708, 1007.1087087927237, 1008.1682611845257, 1019.0726438940528, 1025.702546261576, 22722.659160112613, 22821.771782282296, 22843.771562284495, 22866.771332286797, 23265.76734232636, 1102.3496137278883, 1111.3054341036852, 1112.8720197177267, 1115.5816568786704, 1127.8533790607332, 12244.81632775509, 12267.0, 12267.325297108566, 12303.876961230273, 12334.383280835922, 231591.0, 232014.0, 232427.0, 232501.0, 233788.0, 49940.25089623658, 50402.747986259834, 50409.495905041214, 50594.0, 50601.0, 1378.4072848675166, 1421.8649228323293, 1429.6783223774567, 1432.8280606327098, 1446.4214314274163, 22444.551108978056, 22553.323400298017, 22593.322200334016, 22681.319560413212, 22833.65749513792, 36541.81729091444, 36546.63453365432, 36769.26461470809, 36842.81578592197, 36879.26241475209, 193408.0, 193674.0, 193790.0, 193828.0, 194731.0, 30207.546886797154, 30346.089617311514, 30460.0, 33382.83308583441, 33760.15599610029, 42147.57852421559, 42383.15233695247, 42442.78778606087, 42592.0, 42594.787026064674, 30915.536266956464, 30945.226369340948, 30961.535576966813, 31195.0, 31339.84330078426, 31236.843815780776, 31361.52957705682, 31393.8430307847, 31439.37121257608, 31547.369052619277, 35214.64785352216, 35630.465543016355, 35701.28597428089, 35875.0, 35929.0, 30723.0, 31147.688523114477, 32962.50556241706, 33990.32019359549, 34210.14474638154, 25056.749432505443, 25151.74848251567, 25320.493590128463, 25673.229803105936, 25762.09832655848], "value": 16897.287824853967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.5674217368279, 548.6735392441501, 551.6882961126963, 553.6346011632321, 577.1285359107748, 21099.15603375865, 21804.45488862779, 21876.671849922222, 21906.45233869154, 21965.450863728416, 24223.75776242237, 24756.381090472703, 24790.628140577905, 24815.255542333758, 24817.62773558398, 6447.355264473538, 6616.900746488806, 6618.602883826961, 6633.734650613969, 6642.435392991577, 6277.183966084425, 6570.277269500351, 6896.137982752156, 6903.309669033081, 6912.412444942186, 6923.3076692330615, 6923.619200943971, 6925.134358205224, 6925.272846351136, 6926.341997510229, 6911.930880691179, 6941.930580694179, 6953.513254072217, 6954.965225173893, 6955.547889387173, 6786.3892249697765, 6792.150981127359, 6798.490113241527, 6809.421199198074, 6818.249992500821, 29726.40547189066, 30082.09753707392, 30153.547696784564, 30243.0, 30270.394592108034, 2133.6266153423244, 2163.588918105555, 2163.6538153895303, 2163.7836216378396, 2164.0910817456547, 19950.600987980306, 20917.581648366948, 20977.475563110893, 21021.894890525604, 21083.367498975054, 2241.8094461970754, 2494.276659768665, 2517.9370515737255, 2579.7549232822853, 2622.5148347555764, 141076.0, 144604.99999999895, 145461.0, 145681.0, 145988.0, 19843.503912402306, 19881.105350259273, 20716.896415517826, 20896.164153433998, 21211.363659090253, 41812.0, 41951.0, 42017.78991105025, 42264.78867605704, 42299.36550951738, 11672.299662020307, 11724.531018759324, 11906.107041971714, 11957.641270761891, 11991.700207494883, 9694.951525242328, 9777.071178238057, 9856.605735770632, 9889.357191782512, 10027.0, 10894.455277236106, 10919.727006824893, 10996.835047474295, 11156.665300041012, 11646.301221926711, 3525.7003154732133, 3708.870189543353, 3833.731638785314, 4292.463442069741, 4384.846530371486, 937.4094320577992, 962.2446379591987, 967.1537404770826, 978.0413304546025, 1016.2987538598344, 18961.24155033811, 19350.90324548368, 19496.80503194978, 19507.0, 19661.213551457782, 1034.1519953638094, 1053.8682664666917, 1059.2320567588438, 1071.4696225368336, 1075.956961721538, 10565.260431769702, 10675.0392464677, 10710.250282480307, 10775.568977240979, 10914.508847101899, 508383.0, 512385.0, 518307.0, 543230.0, 548676.0, 116618.0, 118371.40814295874, 121264.0, 121516.0, 121562.39218803849, 1176.5293882446917, 1181.2026881854713, 1205.9638210853689, 1209.625016244967, 1210.7578484303174, 16829.906056106312, 17049.203270887956, 17067.573310667332, 17332.913335433746, 17377.739333910253, 51937.48062519327, 53373.46626533685, 53658.463415365346, 53680.46319536755, 54142.458575415316, 71104.28895710976, 71363.28636713566, 71670.64164679144, 72391.63804180945, 72532.27467725256, 14164.929175354056, 14295.07082039664, 14454.855451445352, 14462.626050525183, 14477.203753793643, 22251.332460026224, 22347.0, 22718.65922011138, 22741.77258227463, 22887.42781430411, 18048.548786279924, 18337.816621833612, 18344.174512147252, 18436.63126737431, 18443.907780461013, 15014.774778378114, 15190.696186076437, 15711.292991815624, 15738.134402607966, 16015.359385624444, 18642.254309827455, 18685.719714204028, 18704.719429208846, 19040.809591903904, 19049.619007619494, 14160.150390976163, 14193.29033548339, 14284.57146285613, 14292.571222863331, 14323.14061156334, 16980.06609636482, 17082.658346833243, 17697.38059167923, 19128.8087119127, 19215.423537293904], "value": 12625.778362677818, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.4889093253632, 1366.3031853754583, 1369.678125640475, 1371.0608233360147, 1375.0786972728283, 14293.0, 14465.20441375724, 14873.330700118493, 14877.18175500347, 14935.551933442013, 14868.107913525197, 15283.92358038211, 15303.234838258099, 15315.157666328347, 15328.386864525433, 2642.9074982375573, 2677.491276657429, 2682.5439675255157, 2685.9462810743776, 2688.502627014009, 2563.6667233259745, 2667.266501712035, 2736.521108805951, 2749.7112803155583, 2749.9037533686324, 2599.155274535774, 2601.2716439396904, 2628.6582744243224, 2632.9210123696225, 2633.2626864477975, 2585.6250843627663, 2594.403287243935, 2644.920652380422, 2646.5765477523696, 2659.946801063987, 2542.6694529711203, 2572.266903932389, 2601.1026195962363, 2617.790576753874, 2625.2518032360686, 14499.855001449956, 14644.0, 14654.706905861929, 14657.70684586313, 14669.193194374306, 7848.76453706384, 8092.1503242159315, 8102.513849169069, 8113.716019939274, 8114.391420643476, 4909.754512274408, 5133.820316288912, 5230.137027390476, 5236.633435659505, 5238.973805130988, 1874.306506592556, 1906.9523261918425, 1933.1107690462404, 1951.7950615185343, 1963.8527110466773, 25536.36159096019, 25674.358141046625, 25692.48615027689, 25730.485390292277, 25735.356616084562, 6571.244306904671, 6931.2375638679705, 7207.819804504825, 7228.204897461275, 7229.457790665721, 16289.104099274653, 16736.916315418344, 16803.831961680473, 16878.0, 16887.0, 7880.369570434352, 8177.386695997824, 8189.385796065319, 8202.38482113844, 8218.137095604994, 7149.857002859913, 7302.634868256566, 7412.814679633052, 7437.070366204224, 7447.255274472509, 5100.438951715309, 5193.610479214074, 5217.2434996925995, 5224.05966925957, 5413.918791218135, 1475.1665309100324, 1493.6415260337442, 1502.5417247739545, 1502.5942995391183, 1504.292982298318, 856.5717141429285, 870.2037635563389, 879.9516026618469, 888.2716172738293, 894.1460904835866, 6918.308169183142, 6949.44404447643, 6971.825704357431, 6976.860462790817, 6998.6150761708595, 705.3933617089299, 707.9681414336264, 714.0752725220851, 715.2561336210387, 719.1693593899055, 5346.385165705994, 5378.273933019071, 5437.9939711153565, 5527.613067085265, 5646.6047376684055, 19656.0, 20473.181072756925, 20818.791812081687, 21314.14743410277, 21372.57254854925, 20404.18383264653, 20476.18095276202, 20478.385648430572, 20576.176952922015, 20670.58658826815, 10600.257981941344, 10803.729906752236, 10915.0, 11168.218224724355, 11225.101991840796, 8049.0, 8422.24199822019, 8533.35999800005, 8647.567621618768, 8655.740327790176, 17490.212940417456, 18018.0, 18056.27774889042, 18422.72365914539, 18586.814131858508, 17761.200745966722, 18327.816721832613, 18366.540836479195, 18513.722294165327, 19090.140943657847, 11405.372704501333, 11456.770864582828, 11490.080793536665, 11504.022158116319, 11542.0, 12771.61685149447, 12893.097483176087, 12921.547745828851, 12973.870261297267, 13049.739005220032, 10966.232363734462, 10975.451227438756, 11091.667249982513, 11270.94364528172, 11287.661370158909, 10201.59193632276, 10296.948515257376, 10366.68899932973, 10479.68560943173, 10701.571937122739, 9638.180754635934, 9801.607935682492, 9810.411375317504, 9816.116549510578, 9816.950915245377, 7001.159860816734, 7053.083099197277, 7070.46971477131, 7084.893726594209, 7102.928970710227, 6641.302663220292, 6705.262421133769, 6732.427743641845, 6769.864602707819, 6810.182778066664], "value": 6476.081938058915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.39443892354024, 491.5760856443364, 511.2842021170361, 513.4352212566176, 517.9637425380223, 6047.518358002285, 6076.118962750398, 6110.358412366704, 6148.477379422743, 6177.505799536038, 5886.146508756227, 5906.409359064102, 5965.910511342333, 5966.970165149168, 6018.247719035121, 4860.684055536379, 4922.606191504689, 4929.605631549485, 4938.50614938506, 4940.481249468808, 4801.2798080287885, 4943.530364615373, 4943.739346466646, 4962.354893863792, 4966.379202599675, 4891.339669144655, 4893.143699852511, 4914.459409464974, 4918.778654960535, 4967.826126085588, 4892.975535122301, 4905.3623029006, 4911.189653707134, 4918.827841025565, 4928.33467481889, 4414.602685758265, 4415.337699345092, 4421.53573874745, 4422.889427764299, 4422.977885110586, 5975.342712301644, 5988.041913293852, 6009.338972712998, 6011.1283863839935, 6032.396760323976, 5619.100943848965, 5627.831165065055, 5638.464345887134, 5649.689267090308, 5666.46168613981, 6316.1788967434395, 6380.744770209186, 6388.520860935449, 6414.262359828633, 6436.356364363573, 4697.7181369117625, 4780.139574876521, 4798.448178459452, 4805.0, 4813.542713442217, 6637.800865974028, 6768.458523318172, 6776.864462710768, 6834.965825170842, 6893.4829887758115, 4897.14299997499, 4902.926456103161, 4903.656744027955, 4904.754762261872, 4917.311576379309, 4978.77595508203, 4992.226204938168, 5003.2745251938995, 5005.249212618136, 5007.349044624249, 5563.332400112013, 5605.216478876742, 5611.0080921273175, 5613.270274864241, 5644.5484361251, 6361.586496877688, 6442.35576442352, 6457.192850893638, 6574.811216559965, 6610.834729131714, 1606.2932309783657, 1657.7927759030122, 1671.7575951486967, 1704.2927185218243, 1721.1566332496986, 1179.4928180882303, 1192.4931903940965, 1202.5430336472084, 1211.2248161176854, 1225.1179151011436, 5475.233467314579, 5559.749811258503, 5567.721613919288, 5595.356533998561, 5675.659460432387, 6360.586561873556, 6455.838604034842, 6514.413702766774, 6574.178227721535, 6652.401283884474, 5619.606627536115, 5642.153676948491, 5665.490105890407, 5699.259096317535, 5735.8566035849435, 3413.5391722117693, 3469.872291505271, 3481.547398838135, 3505.544279243733, 3523.3129539740016, 6293.590916590407, 6392.4566411854585, 6403.327650596713, 6422.0, 6465.450436712932, 6655.168103987002, 6731.1922569292, 6731.932680673229, 6790.626515541594, 6869.278725733726, 6475.870482590321, 6485.448736857231, 6494.740210391626, 6505.3819887111595, 6524.119243902012, 6597.80206593803, 6641.900371494528, 6656.437271650353, 6657.201135863727, 6683.63240021784, 6487.708053137714, 6576.013597960345, 6654.367835055662, 6654.700538475877, 6672.599644021374, 6406.0, 6416.48668106541, 6433.485321174388, 6456.289808121009, 6516.57642253271, 5317.0, 5325.227841962971, 5330.307060082319, 5395.4604539545735, 5404.5406140476925, 6373.235211774617, 6568.540202185801, 6585.275619681927, 6617.0, 6698.430633396216, 6189.659568723583, 6260.248770147611, 6271.560990730605, 6348.555601108063, 6413.294537600954, 6276.654783986742, 6310.0, 6315.842103947438, 6322.399372059647, 6395.944669129542, 6134.607797603788, 6171.753129874754, 6220.906686399617, 6232.220972378453, 6326.272478665012, 6346.50857048584, 6409.775657851953, 6413.615183089029, 6431.421172094534, 6498.220213574401, 6158.846028849135, 6173.32093469727, 6209.875802483834, 6223.101953904103, 6312.368763123651], "value": 4971.022882929193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.8729984152302, 896.4352457951492, 897.9234276385212, 905.6196397513044, 908.8273228086663, 15906.045637261757, 16388.0, 16388.918055409722, 16409.425670101533, 21469.248576299833, 19842.801571984277, 20246.89876550615, 20615.896920515377, 20684.172633094695, 20703.585928281424, 915.8214148241112, 922.8154369126169, 931.1340453378356, 933.9626414943394, 934.2245935873209, 912.6714382822179, 949.5537097564134, 950.4344914775697, 950.9619615215383, 963.3449254506933, 988.614440368257, 1000.9499525023756, 1002.5538635307291, 1003.6537394598852, 1004.70361243433, 993.0714781679153, 993.6124911284605, 995.5171741705267, 1001.3090967232623, 1001.8747656542969, 724.0008787872755, 724.8369116948644, 730.5069078372078, 731.7036600176937, 735.7314580178196, 18788.34240801579, 19039.333623323255, 19492.610147797106, 19736.01319934012, 19797.901010495, 20551.486212844648, 20741.27405540799, 20834.27080052191, 21293.467663308387, 21314.89342553293, 15321.233938303152, 15610.9219453902, 15846.128462934534, 15963.760543591856, 15973.201339933074, 3442.4319987202334, 3482.7562070655063, 3483.6342184070563, 3484.7212223022098, 3485.4771784232316, 124752.9999999991, 125160.37419812843, 127711.0, 129625.35187324097, 130279.0, 16833.747493787603, 16846.578835528966, 17123.486295411156, 17139.314427423014, 17260.74108888368, 29515.85242073776, 29791.255218619273, 30311.696883031327, 30314.242143946576, 30919.69080309213, 7650.464467487333, 8051.59742012897, 8332.541710205996, 8650.307975361957, 8889.73330800077, 4222.641075508554, 4304.418903448057, 4315.913681726348, 4317.654587632982, 4318.265894797892, 4778.1638213312535, 4864.513548645107, 4883.804647814119, 4902.4362198346935, 4904.190808516555, 1024.4570377699831, 1037.159900480613, 1042.2027149230844, 1049.994750026245, 1050.0182329521922, 669.8224970382853, 692.854500554879, 697.1390332938817, 704.2042491984025, 717.2433083097383, 11219.1585631078, 11368.261063031043, 11924.0, 12020.579279725343, 12530.561430349893, 692.6571347183177, 698.2075344483945, 699.5557820783839, 703.6341102626606, 712.9679164437613, 5349.973250133802, 5386.730663466889, 5388.030154572136, 5412.5940554458575, 5586.608937374344, 115044.0, 115212.42393787978, 116109.0, 117732.0, 122947.0, 99467.0, 100605.0, 102550.0, 104821.0, 107638.0, 78948.6052569745, 80006.0, 80329.19670803218, 87376.12623873807, 88684.5565772167, 11634.418279086181, 11723.706907327385, 11987.700307492383, 12038.128734438027, 12272.877271227173, 40749.38875916805, 41224.38163427491, 41344.0, 42084.36873446962, 43555.0, 68926.0, 70857.0, 72696.27303726895, 73225.0, 78706.21293786989, 18298.908505457388, 18362.265509379475, 18373.908130459797, 18486.722699159254, 18533.07334633236, 20239.4940126498, 20489.0, 20666.276680316118, 20723.27468538594, 20927.37217883466, 15749.291281892114, 17192.14039298005, 17578.824211757717, 17586.82413175852, 17634.0, 16184.352625895302, 16196.91901540532, 16398.180090995163, 16459.34162633481, 16687.0, 16733.414330498374, 17249.39627113045, 17254.051027193625, 17288.308467661154, 17664.646707066044, 12678.175918565265, 12734.490620375082, 12763.298018608693, 12951.0, 13127.0, 13308.866911330762, 13989.160650361011, 14023.859761402255, 14027.579172624837, 14074.577762667137], "value": 8971.806683929102, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 95.0, 107.0, 107.0, 108.0, 110.0, 108.0, 108.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 126.0, 146.0, 170.0, 117.0, 142.0, 148.0, 124.0, 179.0, 119.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 161.0, 161.0, 162.0, 166.0, 167.0, 162.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 169.0, 76.0, 85.0, 73.0, 73.0, 156.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 128.0, 79.0, 79.0, 77.0, 131.0, 79.0, 78.0, 129.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 114.0, 115.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 149.0, 151.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 52.0, 52.0, 51.0, 51.0, 52.0, 53.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 73.0, 72.0, 75.0, 73.0, 75.0, 74.0, 80.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 122.0, 115.0, 120.0, 123.0, 117.0, 118.0, 129.0, 154.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 170.0, 176.0, 172.0, 168.0, 176.0, 167.0, 177.0, 175.0, 174.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 62.0, 67.0, 67.0, 71.0, 65.0, 63.0, 64.0], "value": 65.2, "unit": "score"}]}]} 03:46:01 INFO - Return code: 0 03:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:01 INFO - # TBPL SUCCESS # 03:46:01 INFO - Running post-action listener: _package_coverage_data 03:46:01 INFO - Running post-action listener: _resource_record_post_action 03:46:01 INFO - [mozharness: 2017-08-23 10:46:01.520622Z] Finished run-tests step (success) 03:46:01 INFO - Running post-run listener: _resource_record_post_run 03:46:01 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8708096; Write bytes: 432738304; Read time: 3292; Write time: 472216 03:46:01 INFO - TinderboxPrint: CPU usage
13.1% 03:46:01 INFO - TinderboxPrint: I/O read bytes / time
8,708,096 / 3,292 03:46:01 INFO - TinderboxPrint: I/O write bytes / time
432,738,304 / 472,216 03:46:01 INFO - TinderboxPrint: CPU idle
8,266.6 (86.8%) 03:46:01 INFO - TinderboxPrint: CPU user
1,194.1 (12.5%) 03:46:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105910272; Read time: 280; Write time: 116172 03:46:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:46:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6336512; Write bytes: 282714112; Read time: 2240; Write time: 333308 03:46:02 INFO - Running post-run listener: _upload_blobber_files 03:46:02 INFO - Blob upload gear active. 03:46:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:02 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 03:46:02 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'] 03:46:02 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 03:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:03 INFO - (blobuploader) - INFO - Done attempting. 03:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:04 INFO - (blobuploader) - INFO - Done attempting. 03:46:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:05 INFO - (blobuploader) - INFO - Done attempting. 03:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:12 INFO - (blobuploader) - INFO - Done attempting. 03:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:12 INFO - Return code: 0 03:46:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbeda8b758e2159a0ebe982b183b807a41200cbe3959c96b43faf1e11c392c17819c6d086939a9b9db0ac390c3cf00ecc5f947013df5dbe4fd2f05979efb92c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812d847cb0b9ca93d241d9d7658a480781dee02b39abfb6985a0ba71b32ec8d743f67cf46b93a94dd1a9b258f062c43394a67e21d11069d76da7411994b626b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69005e2a97cbd34579c0ee8bc9a74896221c67602cb5f9797c5274990d76d0b41b55bcce067a4ba5e272523b7dcb4efe115fd277e5b0066695d75d471f36a9f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e357115695011b4a1f69f143965f8d114b39b71d3ea986fb1f52f0ee5b48cae648f2a1aace929e7850a763333eb119dd99307bd260030c31661ae8090e4f22ad"} 03:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:12 INFO - Contents: 03:46:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbeda8b758e2159a0ebe982b183b807a41200cbe3959c96b43faf1e11c392c17819c6d086939a9b9db0ac390c3cf00ecc5f947013df5dbe4fd2f05979efb92c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812d847cb0b9ca93d241d9d7658a480781dee02b39abfb6985a0ba71b32ec8d743f67cf46b93a94dd1a9b258f062c43394a67e21d11069d76da7411994b626b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69005e2a97cbd34579c0ee8bc9a74896221c67602cb5f9797c5274990d76d0b41b55bcce067a4ba5e272523b7dcb4efe115fd277e5b0066695d75d471f36a9f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e357115695011b4a1f69f143965f8d114b39b71d3ea986fb1f52f0ee5b48cae648f2a1aace929e7850a763333eb119dd99307bd260030c31661ae8090e4f22ad"} 03:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:12 INFO - Copying logs to upload dir... 03:46:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.953252 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-23 03:46:12.312826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:12.317600) ========= 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-1503483904.429060-1567837659 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/abbeda8b758e2159a0ebe982b183b807a41200cbe3959c96b43faf1e11c392c17819c6d086939a9b9db0ac390c3cf00ecc5f947013df5dbe4fd2f05979efb92c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812d847cb0b9ca93d241d9d7658a480781dee02b39abfb6985a0ba71b32ec8d743f67cf46b93a94dd1a9b258f062c43394a67e21d11069d76da7411994b626b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69005e2a97cbd34579c0ee8bc9a74896221c67602cb5f9797c5274990d76d0b41b55bcce067a4ba5e272523b7dcb4efe115fd277e5b0066695d75d471f36a9f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e357115695011b4a1f69f143965f8d114b39b71d3ea986fb1f52f0ee5b48cae648f2a1aace929e7850a763333eb119dd99307bd260030c31661ae8090e4f22ad"} build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011531 build_url: 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbeda8b758e2159a0ebe982b183b807a41200cbe3959c96b43faf1e11c392c17819c6d086939a9b9db0ac390c3cf00ecc5f947013df5dbe4fd2f05979efb92c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812d847cb0b9ca93d241d9d7658a480781dee02b39abfb6985a0ba71b32ec8d743f67cf46b93a94dd1a9b258f062c43394a67e21d11069d76da7411994b626b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69005e2a97cbd34579c0ee8bc9a74896221c67602cb5f9797c5274990d76d0b41b55bcce067a4ba5e272523b7dcb4efe115fd277e5b0066695d75d471f36a9f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e357115695011b4a1f69f143965f8d114b39b71d3ea986fb1f52f0ee5b48cae648f2a1aace929e7850a763333eb119dd99307bd260030c31661ae8090e4f22ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:12.349559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:12.350024) ========= 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-1503483904.429060-1567837659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:12.433075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:46:12.436410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:46:12.436741) ========= ========= Total master_lag: 0.39 =========