builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1503483914.14 results: success (0) revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.138534) ========= 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:14.138953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.139250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.167428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.167741) ========= 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=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 03:25:14-- 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% 34.5M=0s 2017-08-23 03:25:14 (34.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.225431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.408932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.409284) ========= 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=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047244 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.471489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:14.471827) ========= 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=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 03:25:14,717 truncating revision to first 12 chars 2017-08-23 03:25:14,717 Setting DEBUG logging. 2017-08-23 03:25:14,717 attempt 1/10 2017-08-23 03:25:14,717 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:15,215 unpacking tar archive at: mozilla-central-b911a4c97fde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.814408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:15.306435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:15.306763) ========= script_repo_revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:15.313165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:15.313465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:25:15.325706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-23 03:25:15.326047) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:15 INFO - MultiFileLogger online at 20170823 03:25:15 in /builds/slave/test 03:25:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:25:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:15 INFO - {'append_to_log': False, 03:25:15 INFO - 'base_work_dir': '/builds/slave/test', 03:25:15 INFO - 'blob_upload_branch': 'Firefox', 03:25:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:15 INFO - 'branch': 'Firefox', 03:25:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:15 INFO - 'code_coverage': False, 03:25:15 INFO - 'config_files': ('talos/linux_config.py',), 03:25:15 INFO - 'default_actions': ('clobber', 03:25:15 INFO - 'read-buildbot-config', 03:25:15 INFO - 'download-and-extract', 03:25:15 INFO - 'populate-webroot', 03:25:15 INFO - 'create-virtualenv', 03:25:15 INFO - 'install', 03:25:15 INFO - 'setup-mitmproxy', 03:25:15 INFO - 'run-tests'), 03:25:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:15 INFO - 'disable_ccov_upload': False, 03:25:15 INFO - 'download_minidump_stackwalk': True, 03:25:15 INFO - 'download_symbols': 'ondemand', 03:25:15 INFO - 'enable_stylo': False, 03:25:15 INFO - 'enable_webrender': False, 03:25:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:15 INFO - 'gecko_profile': False, 03:25:15 INFO - 'gecko_profile_interval': 0, 03:25:15 INFO - 'installer_path': 'installer.exe', 03:25:15 INFO - 'log_level': 'info', 03:25:15 INFO - 'log_name': 'talos', 03:25:15 INFO - 'log_to_console': True, 03:25:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:15 INFO - 'opt_config_files': (), 03:25:15 INFO - 'pip_index': False, 03:25:15 INFO - 'suite': 'dromaeojs-e10s', 03:25:15 INFO - 'system_bits': '32', 03:25:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:15 INFO - 'title': 'talos-linux64-ix-076', 03:25:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:15 INFO - 'use_talos_json': True, 03:25:15 INFO - 'verify': 'False', 03:25:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:15 INFO - 'work_dir': 'build'} 03:25:15 INFO - [mozharness: 2017-08-23 10:25:15.808428Z] Running clobber step. 03:25:15 INFO - Running pre-action listener: _resource_record_pre_action 03:25:15 INFO - Running main action method: clobber 03:25:15 INFO - rmtree: /builds/slave/test/build 03:25:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:16 INFO - Running post-action listener: _resource_record_post_action 03:25:16 INFO - [mozharness: 2017-08-23 10:25:16.840404Z] Finished clobber step (success) 03:25:16 INFO - [mozharness: 2017-08-23 10:25:16.840501Z] Running read-buildbot-config step. 03:25:16 INFO - Running pre-action listener: _resource_record_pre_action 03:25:16 INFO - Running main action method: read_buildbot_config 03:25:16 INFO - Using buildbot properties: 03:25:16 INFO - { 03:25:16 INFO - "project": "", 03:25:16 INFO - "product": "firefox", 03:25:16 INFO - "who": "archaeopteryx@coole-files.de", 03:25:16 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:25:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:16 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:25:16 INFO - "stage_platform": "linux64-stylosequential", 03:25:16 INFO - "basedir": "/builds/slave/test", 03:25:16 INFO - "buildnumber": 166, 03:25:16 INFO - "platform": "ubuntu64_hw_styloseq", 03:25:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:16 INFO - "slavebuilddir": "test", 03:25:16 INFO - "taskId": "J8xc7BkhRAGhWZTdGCUmdQ", 03:25:16 INFO - "branch": "mozilla-central", 03:25:16 INFO - "script_repo_revision": "production", 03:25:16 INFO - "revision": "b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2", 03:25:16 INFO - "slavename": "talos-linux64-ix-076", 03:25:16 INFO - "repo_path": "mozilla-central" 03:25:16 INFO - } 03:25:16 INFO - Finding installer, test and symbols from parent task. 03:25:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J8xc7BkhRAGhWZTdGCUmdQ'}, attempt #1 03:25:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J8xc7BkhRAGhWZTdGCUmdQ'}, attempt #1 03:25:17 INFO - Task dependencies: Fvl1I_gnToGP5nRGmDBdyw 03:25:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw'}, attempt #1 03:25:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:25:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip 03:25:18 INFO - Running post-action listener: _resource_record_post_action 03:25:18 INFO - [mozharness: 2017-08-23 10:25:18.164810Z] Finished read-buildbot-config step (success) 03:25:18 INFO - [mozharness: 2017-08-23 10:25:18.165027Z] Running download-and-extract step. 03:25:18 INFO - Running pre-action listener: _resource_record_pre_action 03:25:18 INFO - Running main action method: download_and_extract 03:25:18 INFO - mkdir: /builds/slave/test/build/tests 03:25:18 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:18 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:25:18 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:18 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:18 INFO - Downloaded 989 bytes. 03:25:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:18 INFO - Using the following test package requirements: 03:25:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:18 INFO - u'common': [u'target.common.tests.zip'], 03:25:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:18 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:18 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:18 INFO - u'target.web-platform.tests.tar.gz'], 03:25:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:25:18 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:18 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:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:25:19 INFO - Content-Length response header: 54949653 03:25:19 INFO - Bytes received: 54949653 03:25:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:25:30 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:30 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:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:25:31 INFO - Content-Length response header: 54949653 03:25:31 INFO - Bytes received: 54949653 03:25:44 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:44 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:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip into memory 03:25:45 INFO - Content-Length response header: 14496256 03:25:45 INFO - Bytes received: 14496256 03:25:45 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:45 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:45 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:45 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:46 INFO - Downloaded 61202624 bytes. 03:25:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:46 INFO - mkdir: /builds/slave/test/properties 03:25:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:46 INFO - Contents: 03:25:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:25:46 INFO - Running post-action listener: _resource_record_post_action 03:25:46 INFO - Running post-action listener: find_tests_for_verification 03:25:46 INFO - Running post-action listener: set_extra_try_arguments 03:25:46 INFO - [mozharness: 2017-08-23 10:25:46.587247Z] Finished download-and-extract step (success) 03:25:46 INFO - [mozharness: 2017-08-23 10:25:46.587394Z] Running populate-webroot step. 03:25:46 INFO - Running pre-action listener: _resource_record_pre_action 03:25:46 INFO - Running main action method: populate_webroot 03:25:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:46 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:46 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:46 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['damp', 'tps']}, 03:25:46 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['damp', 'tps']}, 03:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:46 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:25:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:46 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:46 INFO - 'ts_paint', 03:25:46 INFO - 'tpaint', 03:25:46 INFO - 'sessionrestore', 03:25:46 INFO - 'sessionrestore_many_windows', 03:25:46 INFO - 'sessionrestore_no_auto_restore', 03:25:46 INFO - 'tabpaint']}, 03:25:46 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['a11yr', 03:25:46 INFO - 'ts_paint', 03:25:46 INFO - 'tpaint', 03:25:46 INFO - 'sessionrestore', 03:25:46 INFO - 'sessionrestore_many_windows', 03:25:46 INFO - 'sessionrestore_no_auto_restore', 03:25:46 INFO - 'tabpaint']}, 03:25:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:46 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:46 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['bloom_basic']}, 03:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:46 INFO - 'tsvgr_opacity', 03:25:46 INFO - 'tart', 03:25:46 INFO - 'tscrollx', 03:25:46 INFO - 'tsvg_static']}, 03:25:46 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['tsvgx', 03:25:46 INFO - 'tsvgr_opacity', 03:25:46 INFO - 'tart', 03:25:46 INFO - 'tscrollx', 03:25:46 INFO - 'tsvg_static']}, 03:25:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:46 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--stylo'], 03:25:46 INFO - 'tests': ['tp5o']}, 03:25:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--stylo', 03:25:46 INFO - '--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--stylo', 03:25:46 INFO - '--stylo-threads=1', 03:25:46 INFO - '--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--xperf_path', 03:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:46 INFO - 'tests': ['tp5n']}, 03:25:46 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--stylo', 03:25:46 INFO - '--xperf_path', 03:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:46 INFO - 'tests': ['tp5n']}}} 03:25:46 INFO - Running post-action listener: _resource_record_post_action 03:25:46 INFO - [mozharness: 2017-08-23 10:25:46.603498Z] Finished populate-webroot step (success) 03:25:46 INFO - [mozharness: 2017-08-23 10:25:46.603598Z] Running create-virtualenv step. 03:25:46 INFO - Running pre-action listener: _resource_record_pre_action 03:25:46 INFO - Running main action method: create_virtualenv 03:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:46 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:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:47 INFO - Using real prefix '/usr' 03:25:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:50 INFO - Installing pip.................done. 03:25:50 INFO - Return code: 0 03:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:50 INFO - Reading from file tmpfile_stdout 03:25:50 INFO - Output received: 03:25:50 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:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:50 INFO - Using env: {'DISPLAY': ':0', 03:25:50 INFO - 'HOME': '/home/cltbld', 03:25:50 INFO - 'LANG': 'en_US.UTF-8', 03:25:50 INFO - 'LANGUAGE': 'en_US:en', 03:25:50 INFO - 'LOGNAME': 'cltbld', 03:25:50 INFO - 'MAIL': '/var/mail/cltbld', 03:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:50 INFO - 'MOZ_NO_REMOTE': '1', 03:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:50 INFO - 'NO_EM_RESTART': '1', 03:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:50 INFO - 'PWD': '/builds/slave/test', 03:25:50 INFO - 'SHELL': '/bin/bash', 03:25:50 INFO - 'SHLVL': '1', 03:25:50 INFO - 'TERM': 'linux', 03:25:50 INFO - 'TMOUT': '86400', 03:25:50 INFO - 'USER': 'cltbld', 03:25:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:50 INFO - '_': '/tools/buildbot/bin/python'} 03:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:50 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:50 INFO - Cleaning up... 03:25:50 INFO - Return code: 0 03:25:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:25:50 INFO - Using env: {'DISPLAY': ':0', 03:25:50 INFO - 'HOME': '/home/cltbld', 03:25:50 INFO - 'LANG': 'en_US.UTF-8', 03:25:50 INFO - 'LANGUAGE': 'en_US:en', 03:25:50 INFO - 'LOGNAME': 'cltbld', 03:25:50 INFO - 'MAIL': '/var/mail/cltbld', 03:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:50 INFO - 'MOZ_NO_REMOTE': '1', 03:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:50 INFO - 'NO_EM_RESTART': '1', 03:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:50 INFO - 'PWD': '/builds/slave/test', 03:25:50 INFO - 'SHELL': '/bin/bash', 03:25:50 INFO - 'SHLVL': '1', 03:25:50 INFO - 'TERM': 'linux', 03:25:50 INFO - 'TMOUT': '86400', 03:25:50 INFO - 'USER': 'cltbld', 03:25:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:50 INFO - '_': '/tools/buildbot/bin/python'} 03:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:50 INFO - Downloading/unpacking psutil>=3.1.1 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:52 INFO - Installing collected packages: psutil 03:25:52 INFO - Running setup.py install for psutil 03:25:52 INFO - building 'psutil._psutil_linux' extension 03:25:52 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:52 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:52 INFO - building 'psutil._psutil_posix' extension 03:25:52 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:53 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:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:53 INFO - Successfully installed psutil 03:25:53 INFO - Cleaning up... 03:25:53 INFO - Return code: 0 03:25:53 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 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 mozsystemmonitor==0.3 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 mozsystemmonitor-0.3.tar.gz 03:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:54 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:54 INFO - Installing collected packages: mozsystemmonitor 03:25:54 INFO - Running setup.py install for mozsystemmonitor 03:25:54 INFO - Successfully installed mozsystemmonitor 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing jsonschema==2.5.1 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', '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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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', 'jsonschema==2.5.1'] 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 jsonschema==2.5.1 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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:54 INFO - Downloading/unpacking 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:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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 functools32-3.2.3-2.tar.gz 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:56 INFO - warning: no files found matching '*.txt' 03:25:56 INFO - no previously-included directories found matching 'build' 03:25:56 INFO - no previously-included directories found matching 'dist' 03:25:56 INFO - no previously-included directories found matching '.git*' 03:25:56 INFO - Installing collected packages: jsonschema, functools32 03:25:56 INFO - Running setup.py install for functools32 03:25:56 INFO - warning: no files found matching '*.txt' 03:25:56 INFO - no previously-included directories found matching 'build' 03:25:56 INFO - no previously-included directories found matching 'dist' 03:25:56 INFO - no previously-included directories found matching '.git*' 03:25:56 INFO - Successfully installed jsonschema functools32 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Downloading/unpacking 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:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:58 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:58 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:58 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:58 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:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:58 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:58 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:58 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:58 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:58 INFO - Downloading docopt-0.6.1.tar.gz 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:58 INFO - Running setup.py install for blobuploader 03:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:58 INFO - Running setup.py install for requests 03:25:59 INFO - Running setup.py install for docopt 03:25:59 INFO - Successfully installed blobuploader requests docopt 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Running setup.py (path:/tmp/pip-AfEpM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Running setup.py (path:/tmp/pip-nCyMZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Running setup.py (path:/tmp/pip-dWi6hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Running setup.py (path:/tmp/pip-Wnk9kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Running setup.py (path:/tmp/pip-yfmdfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Running setup.py (path:/tmp/pip-Kk_wvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Running setup.py (path:/tmp/pip-VukhEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:59 INFO - Running setup.py (path:/tmp/pip-i90qzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:59 INFO - Running setup.py (path:/tmp/pip-Q6wEaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Running setup.py (path:/tmp/pip-LPOiUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Running setup.py (path:/tmp/pip-_LuJeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Running setup.py (path:/tmp/pip-ZdbKD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Running setup.py (path:/tmp/pip-YuQZkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Running setup.py (path:/tmp/pip-fklU8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Running setup.py (path:/tmp/pip-LuEImi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Running setup.py (path:/tmp/pip-A9R5XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Running setup.py (path:/tmp/pip-MoDfKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:00 INFO - Running setup.py install for manifestparser 03:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozcrash 03:26:00 INFO - Running setup.py install for mozdebug 03:26:00 INFO - Running setup.py install for mozdevice 03:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozfile 03:26:01 INFO - Running setup.py install for mozhttpd 03:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozinfo 03:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozInstall 03:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozleak 03:26:01 INFO - Running setup.py install for mozlog 03:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for moznetwork 03:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozprocess 03:26:01 INFO - Running setup.py install for mozprofile 03:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozrunner 03:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Running setup.py install for mozscreenshot 03:26:02 INFO - Running setup.py install for moztest 03:26:02 INFO - Running setup.py install for mozversion 03:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:02 INFO - Cleaning up... 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 03:26:02 INFO - 'HOME': '/home/cltbld', 03:26:02 INFO - 'LANG': 'en_US.UTF-8', 03:26:02 INFO - 'LANGUAGE': 'en_US:en', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MAIL': '/var/mail/cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SHLVL': '1', 03:26:02 INFO - 'TERM': 'linux', 03:26:02 INFO - 'TMOUT': '86400', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - '_': '/tools/buildbot/bin/python'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Running setup.py (path:/tmp/pip-Edcepp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Running setup.py (path:/tmp/pip-rFA7ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Running setup.py (path:/tmp/pip-YK8pS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 INFO - Running setup.py (path:/tmp/pip-eHCbAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:02 INFO - Running setup.py (path:/tmp/pip-CKiN05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:02 INFO - Running setup.py (path:/tmp/pip-CfeDF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 INFO - Running setup.py (path:/tmp/pip-PfT3Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 INFO - Running setup.py (path:/tmp/pip-uq_VR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:03 INFO - Running setup.py (path:/tmp/pip-IWgQS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:03 INFO - Running setup.py (path:/tmp/pip-9T9yqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 INFO - Running setup.py (path:/tmp/pip-Vux6ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Running setup.py (path:/tmp/pip-BrPjzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Running setup.py (path:/tmp/pip-YczlpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Running setup.py (path:/tmp/pip-v0mLTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Running setup.py (path:/tmp/pip-Qz22vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Running setup.py (path:/tmp/pip-EpCFig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Running setup.py (path:/tmp/pip-y2_xZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:03 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:03 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 - 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:03 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 - Downloading blessings-1.6.tar.gz 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:05 INFO - Installing collected packages: blessings 03:26:05 INFO - Running setup.py install for blessings 03:26:05 INFO - Successfully installed blessings 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:05 INFO - Reading from file tmpfile_stdout 03:26:05 INFO - Current package versions: 03:26:05 INFO - argparse == 1.2.1 03:26:05 INFO - blessings == 1.6 03:26:05 INFO - blobuploader == 1.2.4 03:26:05 INFO - docopt == 0.6.1 03:26:05 INFO - functools32 == 3.2.3-2 03:26:05 INFO - jsonschema == 2.5.1 03:26:05 INFO - manifestparser == 1.1 03:26:05 INFO - mozInstall == 1.13 03:26:05 INFO - mozcrash == 1.0 03:26:05 INFO - mozdebug == 0.1 03:26:05 INFO - mozdevice == 0.51 03:26:05 INFO - mozfile == 1.2 03:26:05 INFO - mozhttpd == 0.7 03:26:05 INFO - mozinfo == 0.10 03:26:05 INFO - mozleak == 0.1 03:26:05 INFO - mozlog == 3.5 03:26:05 INFO - moznetwork == 0.27 03:26:05 INFO - mozprocess == 0.25 03:26:05 INFO - mozprofile == 0.28 03:26:05 INFO - mozrunner == 6.13 03:26:05 INFO - mozscreenshot == 0.1 03:26:05 INFO - mozsystemmonitor == 0.3 03:26:05 INFO - moztest == 0.8 03:26:05 INFO - mozversion == 1.4 03:26:05 INFO - psutil == 3.1.1 03:26:05 INFO - requests == 1.2.3 03:26:05 INFO - wsgiref == 0.1.2 03:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:05 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:05 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 - 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:05 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:06 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:06 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:06 INFO - Installing collected packages: simplejson 03:26:06 INFO - Running setup.py install for simplejson 03:26:06 INFO - building 'simplejson._speedups' extension 03:26:06 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:07 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:07 INFO - Successfully installed simplejson 03:26:07 INFO - Cleaning up... 03:26:07 INFO - Return code: 0 03:26:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:07 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 0x19b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 03:26:07 INFO - 'HOME': '/home/cltbld', 03:26:07 INFO - 'LANG': 'en_US.UTF-8', 03:26:07 INFO - 'LANGUAGE': 'en_US:en', 03:26:07 INFO - 'LOGNAME': 'cltbld', 03:26:07 INFO - 'MAIL': '/var/mail/cltbld', 03:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:07 INFO - 'MOZ_NO_REMOTE': '1', 03:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:07 INFO - 'NO_EM_RESTART': '1', 03:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:07 INFO - 'PWD': '/builds/slave/test', 03:26:07 INFO - 'SHELL': '/bin/bash', 03:26:07 INFO - 'SHLVL': '1', 03:26:07 INFO - 'TERM': 'linux', 03:26:07 INFO - 'TMOUT': '86400', 03:26:07 INFO - 'USER': 'cltbld', 03:26:07 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:07 INFO - '_': '/tools/buildbot/bin/python'} 03:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Running post-action listener: _resource_record_post_action 03:26:08 INFO - Running post-action listener: _start_resource_monitoring 03:26:08 INFO - Starting resource monitoring. 03:26:08 INFO - [mozharness: 2017-08-23 10:26:08.235686Z] Finished create-virtualenv step (success) 03:26:08 INFO - [mozharness: 2017-08-23 10:26:08.236641Z] Running install step. 03:26:08 INFO - Running pre-action listener: _resource_record_pre_action 03:26:08 INFO - Running main action method: install 03:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:08 INFO - Reading from file tmpfile_stdout 03:26:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:08 INFO - Reading from file tmpfile_stdout 03:26:08 INFO - Output received: 03:26:08 INFO - Usage: mozinstall [options] installer 03:26:08 INFO - Options: 03:26:08 INFO - -h, --help show this help message and exit 03:26:08 INFO - -d DEST, --destination=DEST 03:26:08 INFO - Directory to install application into. [default: 03:26:08 INFO - "/builds/slave/test"] 03:26:08 INFO - --app=APP Application being installed. [default: firefox] 03:26:08 INFO - mkdir: /builds/slave/test/build/application 03:26:08 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:08 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:26 INFO - Reading from file tmpfile_stdout 03:26:26 INFO - Output received: 03:26:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:26 INFO - Running post-action listener: _resource_record_post_action 03:26:26 INFO - [mozharness: 2017-08-23 10:26:26.274570Z] Finished install step (success) 03:26:26 INFO - [mozharness: 2017-08-23 10:26:26.274822Z] Running setup-mitmproxy step. 03:26:26 INFO - Running pre-action listener: _resource_record_pre_action 03:26:26 INFO - Running main action method: setup_mitmproxy 03:26:26 INFO - Skipping: mitmproxy is not required 03:26:26 INFO - Running post-action listener: _resource_record_post_action 03:26:26 INFO - [mozharness: 2017-08-23 10:26:26.275958Z] Finished setup-mitmproxy step (success) 03:26:26 INFO - [mozharness: 2017-08-23 10:26:26.276176Z] Running run-tests step. 03:26:26 INFO - Running pre-action listener: _resource_record_pre_action 03:26:26 INFO - Running pre-action listener: _set_gcov_prefix 03:26:26 INFO - Running main action method: run_tests 03:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:26 INFO - Python 2.7.3 03:26:26 INFO - Return code: 0 03:26:26 INFO - grabbing minidump binary from tooltool 03:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:26 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 0x1d20130>, '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 0x1d21030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d214c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:26 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:26 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:26 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:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:26 INFO - Return code: 0 03:26:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:26 INFO - ENV: RUST_BACKTRACE is now full 03:26:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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:26 INFO - Using env: {'DISPLAY': ':0', 03:26:26 INFO - 'HOME': '/home/cltbld', 03:26:26 INFO - 'LANG': 'en_US.UTF-8', 03:26:26 INFO - 'LANGUAGE': 'en_US:en', 03:26:26 INFO - 'LOGNAME': 'cltbld', 03:26:26 INFO - 'MAIL': '/var/mail/cltbld', 03:26:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:26 INFO - 'MOZ_NO_REMOTE': '1', 03:26:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:26 INFO - 'NO_EM_RESTART': '1', 03:26:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:26 INFO - 'PWD': '/builds/slave/test', 03:26:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:26 INFO - 'RUST_BACKTRACE': 'full', 03:26:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:26 INFO - 'SHELL': '/bin/bash', 03:26:26 INFO - 'SHLVL': '1', 03:26:26 INFO - 'STYLO_FORCE_ENABLED': '1', 03:26:26 INFO - 'TERM': 'linux', 03:26:26 INFO - 'TMOUT': '86400', 03:26:26 INFO - 'USER': 'cltbld', 03:26:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893', 03:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:26 INFO - '_': '/tools/buildbot/bin/python'} 03:26:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:26 INFO - mozversion application_buildid: 20170823094126 03:26:26 INFO - mozversion application_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:26:26 INFO - mozversion application_display_name: Nightly 03:26:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:26 INFO - mozversion application_name: Firefox 03:26:26 INFO - mozversion application_remotingname: firefox 03:26:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:26 INFO - mozversion application_vendor: Mozilla 03:26:26 INFO - mozversion application_version: 57.0a1 03:26:26 INFO - mozversion platform_buildid: 20170823094126 03:26:26 INFO - mozversion platform_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:26:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:26 INFO - mozversion platform_version: 57.0a1 03:26:26 INFO - using testdate: 1503483986 03:26:26 INFO - actual date: 1503483986 03:26:26 INFO - starting webserver on 'localhost:40916' 03:26:26 INFO - SUITE-START | Running 2 tests 03:26:26 INFO - TEST-START | dromaeo_css 03:26:26 INFO - Initialising browser for dromaeo_css test... 03:26:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40916/getInfo.html -profile /tmp/tmpeMzqig/profile 03:26:26 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox http://localhost:40916/getInfo.html) 03:26:35 INFO - TEST-INFO | 3312: exit 0 03:26:36 INFO - Browser initialized. 03:26:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:36 INFO - TEST-INFO | started process 3544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMzqig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:37 INFO - PID 3544 | 03:26:37 INFO - PID 3544 | (/builds/slave/test/build/application/firefox/firefox:3593): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:37 INFO - PID 3544 | 03:26:37 INFO - PID 3544 | 03:26:37 INFO - PID 3544 | (/builds/slave/test/build/application/firefox/firefox:3651): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:37 INFO - PID 3544 | 03:26:37 INFO - PID 3544 | __metrics Screen width/height:1600/1200 03:26:37 INFO - PID 3544 | colorDepth:24 03:26:37 INFO - PID 3544 | Browser inner width/height: 1024/768 03:26:37 INFO - PID 3544 | __metrics 03:26:47 INFO - PID 3544 | RSS: Main: 174825472 03:26:47 INFO - PID 3544 | 03:29:46 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40916/tests/dromaeo/cssquery-ext.html) 03:29:47 INFO - PID 3544 | RSS: Main: 178393088 03:29:47 INFO - PID 3544 | 03:32:49 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-ext.html (next: http://localhost:40916/tests/dromaeo/cssquery-jquery.html) 03:32:50 INFO - PID 3544 | RSS: Main: 175370240 03:32:50 INFO - PID 3544 | 03:35:51 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40916/tests/dromaeo/cssquery-mootools.html) 03:35:52 INFO - PID 3544 | RSS: Main: 177328128 03:35:52 INFO - PID 3544 | 03:38:54 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40916/tests/dromaeo/cssquery-prototype.html) 03:38:55 INFO - PID 3544 | RSS: Main: 175202304 03:38:55 INFO - PID 3544 | 03:41:58 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40916/tests/dromaeo/cssquery-yui.html) 03:41:58 INFO - PID 3544 | RSS: Main: 176680960 03:41:58 INFO - PID 3544 | 03:45:00 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:40916/tests/dromaeo/cssquery-yui.html (next: http://localhost:40916/tests/dromaeo/cssquery-dojo.html) 03:45:01 INFO - PID 3544 | RSS: Main: 179052544 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | __start_tp_report 03:45:01 INFO - PID 3544 | _x_x_mozilla_page_load 03:45:01 INFO - PID 3544 | _x_x_mozilla_page_load_details 03:45:01 INFO - PID 3544 | |i|pagename|runs| 03:45:01 INFO - PID 3544 | |0;dojo.html;3230.8384580770958;3261.890957074594;3268.9019329420116;3273.705366517013;3276.1482014676176;6123.295820980588;6144.784932527363;6248.687565621712;6256.968715156418;6276.905846412296;6052.6368417894955;6160.168377269068;6164.445199932005;6169.568130230886;6180.351063138373;5725.427457254273;5728.79949201778;5738.282714660668;5759.769609215627;5833.066709326508;5687.146927960797;5809.912851307234;5835.708214589275;5841.8831623367505;5850.180974663551;5613.80351687691;5722.113072473773;5730.3123625165035;5777.971110144444;5813.709314534278;5679.602427830054;5733.226014488053;5769.538436925036;5805.332386775512;5831.562632802556;5551.306086739158;5629.831105066854;5676.545876329925;5709.914351284734;5751.511121554673;6113.541484388688;6152.907706384408;6154.199954005995;6160.414760597736;6180.783672571483;6658.201015878077;6707.631080290582;6726.932730672728;6739.989001649743;6743.932560674429;6700.463962883006;6726.529142959995;6735.629540375277;6801.523893327469;6832.248452670202;6122.173506576644;6186.133941248228;6191.2570491540855;6260.24877014752;6337.6831158442355;6905.689243984033;6926.722931082801;6968.79093627192;6997.05539752127;7003.964980175067;6572.047053177358;6589.110470086573;6687.933120668731;6694.765683201064;6697.933020669829;6688.799336019927;6705.932940670628;6724.966375168191;6787.389134977876;6833.6241506716615;6616.338366163442;6619.073329733841;6653.833654158588;6663.267040625527;6663.566868153554;6457.580257283355;6618.933810661832;6624.205095388585;6638.336166383419;6661.100751398596;5193.818216362409;5194.454582268883;5196.792128314825;5210.400803907523;5212.895742085213;4567.132244873464;4607.7004994675235;4642.883927901829;4667.789949452283;4684.180268453007;5794.275715535558;5880.294364676266;5884.205632239593;5894.764209431661;5904.7342869570975;6707.631080290631;6724.831879203059;6740.090087838079;6825.590464572141;6830.7609233676585;5839.036558967808;5842.941570584325;5846.561507886926;5846.795362162304;5846.912296315559;5762.250907382014;5835.299764028344;5846.853828654318;5849.61977471463;5862.824115276549;6471.870562588816;6476.35236476358;6498.447631951242;6561.80314590563;6603.504737144734;6492.48060155177;6614.8346291343105;6619.900701489385;6704.094947182068;6794.830129246809;6383.457406120532;6414.839629009312;6453.9354606453335;6463.935360646334;6514.54398192141;6610.876151054236;6677.565958212701;6703.564268322543;6719.4624430044505;6720.126383570105;6747.392734653708;6799.89800153008;6821.147356580427;6836;6840.042394064934;6489.221293444628;6489.935100648933;6501.927182014914;6592.077109204619;6593.472522198309;6352.968235158794;6424.93575064262;6440.806775796734;6561.737530498726;6568.967155164385;6393.552451328363;6405.03924411342;6406.135171751754;6410.839729006812;6417.1657684500715;6477.190351206099;6531.346865313621;6532.902006469812;6606.141201643755;6661.3338666132995;6255.249370075438;6282.371762823681;6352.110704501281;6357.713902874474;6386.521010924293 03:45:01 INFO - PID 3544 | |1;ext.html;805.8831469436932;852.9189726975937;880.8986966498852;886.1183122792822;1114.1755101225096;28671.426571468557;29798.702012979862;39808.402873956875;40675;40737.185256294855;40791;41272.38091428631;41279.793601032026;41285.380719289235;41386.37920431188;7087.503874728771;7520.32317091463;7671.271229233242;7716.459847810655;7724.536527808322;7551.471397002212;7663.080430348366;7664.271894170045;7666.195049519803;7668.769936901902;7650.234976502361;7672.9232707673045;7684.500507467024;7712.074551053882;7716.074071111474;7637;7675.424343174284;7677.385809135256;7680.155182929873;7692.884606730876;7529.698812047512;7583.848323033563;7587.520433515467;7588.544687318778;7589.203133670941;35793.28413431743;35830.10424739376;35847.82076089629;35976.46035309473;35997.82001089978;3471.861125554975;3493.266414053052;3493.283876805249;3499.5100685903994;3501.2997400519744;29411;29511.967081152055;29547.409051819057;29615.70384296151;29627.259318516994;4929.433115191763;4937.580305674022;4974.801007959677;4987.725675087869;5008.924866127011;183926.16073839224;184593;184669;185144.07427962907;185754;45306.77346613246;45670.314945275844;45686;45853.7707311468;45960.3105953411;46928.06143877103;46938.29592556114;46973.76513117413;47084.7645761769;47366.76316618395;15514.45699400538;15660.216989150496;15683.686326273411;15789.447369342019;15802.60493487649;11244;11451.88548114525;12487.812682809765;12713;12719.936400318124;13761.31193440324;13791.448342066406;13819.101758385672;13875.37560809766;13953.86046139546;5654.342459044325;5762.625429347079;5765.654060756368;5771.336296325892;5790.305163380422;981.2052237687496;1005.703317521333;1009.399407352624;1009.4548943570389;1021.7292417509366;22105.226317078825;22143.778562214495;22237.777622223894;22255.55488890213;22485.100595976306;1094.6292577200616;1094.8412480190327;1096.5887792077972;1103.4041617526445;1121.6578943422335;11724.389063754736;11905;15594.766078508832;15678.451254206047;16268;242287;243320;243348;243615;244608;53992.46007539874;54363.184552231745;54505.72747136239;54597.72701136548;54607.45392546103;1377.393946663465;1405.5642750747302;1417.7873319002233;1419.2832619527073;1430.7353139669403;26757;26806.59790103111;26862.59706104371;27021.729782702707;27078.593821092305;36210.094747630465;36214;36317;36360.818195908854;36389.45415818818;214394;215118;215386;215917;215986;28368.43263134767;28818.567721484615;28891.85554072216;31170;32279.677203228606;37654.058648534;39157;39209;39333.40999885061;39809.611423314695;30099.69900300969;30609.23476913095;32399;33617.49573756347;33767.83116084404;32968.175795605304;32974.34051319008;33171;33415;33535.329293414485;36935.261294773416;36963.26073478569;37000.07499812526;37177.25645487021;37197.628023719415;31514.36971260608;32274.838625806722;32310.35379292354;32317.51523727193;32341.51487727639;24073.27780166598;24883.62674559919;25097.619630920475;25371.530259784377;25440.491190176464 03:45:01 INFO - PID 3544 | |2;jquery.html;554.794725951398;564.6358099026128;568.7497501099518;568.8947544704231;576.5646936562895;21350.145994160233;22192.334229973105;22215;22237.444063898412;22265.666015009767;23804.642930356058;24287.757122428815;24378.024879004864;24467.75532244677;24504.75495245047;6414.679266036703;6580.703868325937;6586.670666466682;6587.077809106729;6589.209294884597;6295.811125666214;6381.712822922957;6424.871502569946;6465.450436712885;6588.934110658904;6530.314316996718;6530.510211734115;6549.639769812658;6551.246606640226;6561.507886908501;6566.967165164167;6569.507286953473;6576.93423065768;6584.242812076577;6584.440322572539;6055.878882422327;6068.939310606882;6081.847953801146;6082.60463069899;6096.756129754849;27636.170914872386;28428.147155585364;28950.131496055154;28997.710022899922;29299;2010.6179825833044;2057.341650671786;2057.855950083495;2061.1034200122995;2063.690446433032;18953.336633217772;19079.427617171506;19239.711404328948;19453.708194377097;19504.31734889272;2350.5886469867874;2407;2417.601095819188;2419.1895714935517;2426.3327584914114;124463.37768311192;131562.3421882894;131694.34152829176;131921.3403932984;132068.33965830205;14284.500042498463;14325.713485730226;14370;14687.559373218606;14689.41242350294;22538.774612253666;22636.660450093263;22688.88655556712;22742.431439214153;22753.544929101325;9923.851142232872;9981.45102019396;9986.900130998742;10069.748256293651;10172.643957461454;9342.252619790537;9358.39170453932;9420.434773913586;9497.862980829259;9577.856332155023;8370.748877533684;8708.651653933772;9000.784894039352;9043.819123617492;9316.394434361744;2402.327348342467;2444.743301953305;2448.3313188624484;2521.533516299454;2537.581299085667;927.7773334399695;956.4118067388645;976.8437050072097;978.7895602445508;981.2337791974418;19724.30964916221;19936;19964.101615427342;20480.897595511928;23705.881470592536;987.4914419074182;1067.2475904487317;1068.9198310126772;1080.9189310801721;1081.302559848893;10672.413017284123;11136.164787640959;11153.275037122561;11180.664580062612;11286.717832054264;531828;534738;542749;555109;563762;116535.41732291284;117314;118680;119482;119800;1230.2864338683542;1248.818921256431;1249.9812502812465;1267.2966503590412;1268.346801397281;17657.823421765617;17840;17981.550461238574;18043.458696239133;18100.275988960293;53466;53599.732001341305;54644.0231227731;54804.72597636986;56665.71667141803;68335.65832171006;72222.63888680523;72507;73130.63434682792;73926.63036684782;14274.643133921734;14794.482193123189;14818.481353152589;14852.183129927525;14945.925270373578;23442.17952371659;23564.175253866033;23741;23889.641655374835;23969.760302396753;18375;18569.071546422354;18954.24183032663;19002.714959275898;19006.144723487752;16287;16876.57808554796;16927.49217523427;16957.83042169612;17165.656686865943;18847.340343087926;19034.33379831699;19231.423057308304;19473;19493.51266218356;14067.859321406655;14710.77933830972;14722;14739;14751.188684622448;18031.819681803016;18220.271189152285;18368.724469132707;18388.632227355647;18403.17185726619 03:45:01 INFO - PID 3544 | |3;mootools.html;1275.4515558309927;1338.9062765606411;1350.9932450337747;1351.5877657314522;1365.276403506142;11988.520459181644;14526.128432294057;15145.091294522337;15163.393464261444;15169.772453413208;12109.636710898665;12260.81608775869;14453;14794.852051479482;14818.259087045632;2596.5196438658813;2639.5380808358555;2641.1152263991585;2647.272000199941;2652.9071482498116;2612.529744645963;2678.7053424123333;2690.3543149644042;2691.1657386210336;2701.986490067547;2654.137405343271;2654.721254268303;2678.263477543672;2680.9463810723773;2681.9195424137306;2584.6510721052605;2584.896604135832;2585.7802086822644;2594.987025064872;2596.9091081812235;2508.523380557688;2523.0538548044483;2542.758437948392;2547.1594373856583;2548.655931449268;14127.646808829759;14291.356888940023;14302.427902883872;14433.639159021004;14629.707405851823;7650.923490765077;7910.4462687611895;7943.761687149395;7951.04587449504;7955.602219888982;5234.685918844882;5391.829534468826;5436.456354364572;5549.972250138764;5560.110382338847;1888.6317168152216;1898.4494496595971;1921.5938619026217;1932.6521226179282;1951.1414977409895;25896.352591185183;25906.481870362677;25966.09118680837;25988.87005564979;25999.22002339914;6780.762673306411;7010.789676309719;7037.612931288828;7123.857522849514;7191.17301510333;19195.136218870186;19223.327183548787;19269.8073019268;19270.22919083221;19288.710669339973;8048.356131509465;8064.395170362246;8070.071941726659;8078.192180781874;8082.232187942253;5634.943650563524;6240.219972503437;7304.050473438419;7466.290702383265;7499.062617172854;5422.322209723785;5616.073347897633;5621.775307930114;5640.27971468706;5703.486686198262;1713.4174380710617;1742.4249997500795;1746.0920321432784;1755.7629719987895;1794.5603327184663;863.9179277968583;898.1198425542874;902.5261737587819;911.5077857956762;933.6825479337058;7534.472586918863;7565.773026809205;7568.697252109854;7576.393888488908;7581.9764331814495;707.4093132234642;721.487743701967;724.8187953011748;726.2628432141381;726.6221564786282;4499.977500112478;4533.161365147458;4546.204414227497;4558.452985641744;4567.2920697291975;19832;20378.69431958522;20586.382408527767;21479.46301342479;21593.89203054006;20208.19167233294;20238.89880550588;20314.492137696674;20399.286024989055;20412;10136.898631013742;10398.844017339747;10414.218933580012;10568.313059651251;10569.947150264199;8859.11408859109;8865.379423440298;8904.643814247358;8937.240334571634;9019;17983;18126.81873181304;18552.257909684;19049.238030478624;19210.8078919209;18955.90522047381;18969.14638841228;18978.24087036503;19210.039498024762;19320.71018934689;11883.76232475363;11904.880951190724;12182.634520964386;12188.45151968146;12194.939025304817;13751.931240344134;13874.375653095432;13928.860711392756;13937.372818223;13943.790843137158;10904.12766978624;10913.23607347478;11094.667159985212;11236.550537978716;11363.829542556703;10284.382937023802;10496.52765625564;10546.103581195684;10570.577176912837;10705.304155229886;8958.462492250224;8984.146506081912;9010.324225682969;9047.954760226157;9076.909230907871;6585.736570537125;6626.602403855784;6646.8005959821285;6715.395614394728;6716.261211266659;6759.121314229315;6859.07402500656;6877;6930.688119034757;6957.339052789976 03:45:01 INFO - PID 3544 | |4;prototype.html;494.6759872283651;499.84005118362126;511.6980981221079;512.1753976098481;512.7026324731656;6223.751049958002;6224.688765561715;6241.875162496747;6274;6275.717592708328;6117.2659280886355;6131.846703832406;6161.367237682018;6177.629342239457;6206.67942650682;4883.682560633548;4952.380952380952;4975.029869175512;4989.253761183575;5122.590192784578;4949.381327334083;4971.676841005341;4978.937953158799;4995.725235112068;5007.197408932781;4907.533784290505;4915.778789954443;4946.109700253953;4947.950520494803;4985.476524964881;4932.186189278765;4956.7025978441225;4992.653452877142;5015.172496538067;5041.949580504184;4466.508684044785;4477.6417886569;4486.327050942352;4487.3172560289895;4491.775411229458;5934.6142500737315;5958.702064896781;6004.268058033585;6096.664683442409;6143.754249830002;5589.189567512688;5601.943980560183;5639.2668953036255;5687.601867869251;5715;6548.246951600531;6593.53845230834;6596.637184954826;6605.40551350376;6614.404703576653;4769.403824521934;4824.552634209758;4827.637927155442;4864.902701945976;4878.658493905428;6590.275069742324;6662;6792.49056320773;6906.240313565504;6979.790606281819;4895.7062576245535;4923.261510773341;4966.627502937295;4982;4999.325091112653;5035.949640503548;5040.974795126001;5056.191009438472;5087.771050302671;5088.949110508922;5537.141743029837;5613.512419208913;5620.775168993195;5660.971695141498;5700.116481945305;6564.770233041821;6581.243157037002;6622.205335359788;6648.4681225501845;6656;1711.922963466647;1743.3810997095848;1749.553863764732;1750.6586215688073;1757.6641752268367;1134.6993046842592;1187.2105050141558;1197;1200.9279443233434;1213.8482689663792;5607.327120745536;5655;5715.771369145187;5763.740631671585;5794.710264486759;6550.312217217219;6588.967055164693;6612.86774264512;6650.733970641217;6721.395074443323;5735;5769.59612827098;5772.797952071657;5811.854703632358;5820.88358232833;3530.1880567469625;3534.575850897909;3548.609652938175;3557.2351944332095;3571.607123216444;6403.775867844603;6416.7433302668305;6421.5825971311715;6459.741610335534;6509.934900650933;6751.898721519181;6760.661966901635;6812.262872967362;6947.826304342432;6947.861042779217;6354;6420.555375040765;6469.805905822833;6499.180229535737;6519.934800652028;6034.456898879122;6604.603723776589;6673.933260667525;6702.564333318319;6731.730730770714;6547.181602299713;6547.377999090078;6570.901436478361;6631.734730610721;6652.2349929756765;6397.193669766481;6424.036394540856;6479.514036447191;6483.416492515507;6517.185351831021;4864.051509955525;4938.530839570235;4941.234108713155;4943.456219815889;4970.403551573834;6414.326495717883;6609.867802644017;6613.437857782143;6734.764283250062;6771.39057484809;6347.873042539216;6529.281779004211;6531.844491317948;6541.808494154511;6542.411182993554;6493.967530162319;6518.902216466662;6521.402256447201;6553.180852393451;6556.803295901131;6373.235211774617;6413.551051426355;6430.324815894263;6434.806955791334;6523.380278873499;6477.481801455967;6492.967535162483;6581.80254592363;6594.241662208908;6596.736130554916;6277.18396608438;6315.90526142099;6328.240611126695;6338.809835704937;6396.296407395276 03:45:01 INFO - PID 3544 | |5;yui.html;879.5778026547257;888.2050564744554;896.62789942174;905.239598737061;907.5416914458198;15990.760138597916;16888.240029198685;20736;21609.1356345746;21901.342959711194;19935.501612459695;20085.899570502126;21076.473088172803;21135.57728845426;21178.788212117874;911.8586619074038;930.2000279759402;936.2977766674994;940.8400571902793;941.5245301122924;674.180870242655;693;699.199416667915;701.8736627407064;936.2089034765646;949.1078386316874;973.6056896956744;973.9659111931084;978.1050338939862;978.3493976505615;970.7718686108759;977.9022097790236;978.5841017567506;978.9314747967645;979.1628157924979;711.7686751805633;712.0174159659688;715.1596873673413;715.6886754261913;716.9426445884317;18855.905720471448;19176.328828491074;19490;19634.11646475912;19795.208191672315;20725.68911466329;20974.580508389747;21246.787532124636;21293.361199163894;21460.248891288888;15880.682386352208;15971;16250.268737906823;16371.83628163727;16402.343906243736;3687.797171155585;3711.6102809205186;3711.870084547055;3723.236736469017;3723.385641369171;129729;130546;133050.6694933048;134214;135192.32403837919;16022.67954640924;16111.516654500383;16437.753433698505;16517.008979461032;16640.750388743938;28405.431891362055;29332.560011599842;29619.555706664418;29734.553981690293;29759.702402976127;8732.607032683545;8905.866412003825;8960.148785865333;8968.23769979546;8988.685396011108;3960.1881614269005;4035.8587449439715;4095.0171958730284;4104.897377565585;4143.937840932388;5072;5186.766595503212;5198.844034678966;5211.739413029409;5214.035403450373;1047.6542740895486;1072.5977758340623;1079.6599071292517;1081.259337353915;1089.7330154112294;661.2924171136838;678.4335080208082;687.9965600171967;693.7883945396602;700.4466471487569;11048.558057677763;11741.647750567497;12016.759664806656;12070.396480176132;12082.516699331929;693.6254422611734;695.266493848984;696.9337912898267;710.7015053677468;711.2602892991334;5600.383957764642;5616.887662246814;6193.194884665055;6211.2857021443115;6365.649889256136;114793.4260328693;114993;116900;118209.40895295469;123189.38405308095;103799;104463.47768261262;105151;108578;109916;85114.14885851186;90388.5480572593;91084;93728;94316;11603.941980290045;12190.02479801596;12683.556075537312;13047.151935124186;13389.799153012518;39458.4352017118;39711.602883971944;40278.39582406208;41302;42183.7890810544;67727.32272677211;71836.64081679558;72022.1191152369;74832.2516774847;75688.24311756811;18308.450746477625;18452.815471845646;18751.24995000239;19276.90361548183;19303;18172.72740908861;19293.131809068906;19435.61128777388;19531.902340488206;19635;17227.052512111954;17328;18800.52998675044;19168.329108481135;19188;19123.8087619122;19631.411057668294;19663.115159817557;19900.303489377802;20190.596188075862;17344.566385840455;17375.7393639093;17458.912705436393;17515.21181546808;19233.711494327315;12884.871151288367;13358.599242022754;13383.598492045254;13408.530701425403;13831.930840345734;13826.377812998238;13867;14048.367823447765;14375.856241437452;15166.545003649468 03:45:01 INFO - PID 3544 | __end_tp_report 03:45:01 INFO - PID 3544 | __start_cc_report 03:45:01 INFO - PID 3544 | _x_x_mozilla_cycle_collect,370 03:45:01 INFO - PID 3544 | __end_cc_report 03:45:01 INFO - PID 3544 | __startTimestamp1503485101062__endTimestamp 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | ------- Summary: start ------- 03:45:01 INFO - PID 3544 | Number of tests: 6 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#0] dojo.html Cycles:165 Average:6161.88 Median:6393.55 stddev:724.62 (11.3%) stddev-sans-first:689.40 03:45:01 INFO - PID 3544 | Values: 3230.8 3261.9 3268.9 3273.7 3276.1 6123.3 6144.8 6248.7 6257.0 6276.9 6052.6 6160.2 6164.4 6169.6 6180.4 5725.4 5728.8 5738.3 5759.8 5833.1 5687.1 5809.9 5835.7 5841.9 5850.2 5613.8 5722.1 5730.3 5778.0 5813.7 5679.6 5733.2 5769.5 5805.3 5831.6 5551.3 5629.8 5676.5 5709.9 5751.5 6113.5 6152.9 6154.2 6160.4 6180.8 6658.2 6707.6 6726.9 6740.0 6743.9 6700.5 6726.5 6735.6 6801.5 6832.2 6122.2 6186.1 6191.3 6260.2 6337.7 6905.7 6926.7 6968.8 6997.1 7004.0 6572.0 6589.1 6687.9 6694.8 6697.9 6688.8 6705.9 6725.0 6787.4 6833.6 6616.3 6619.1 6653.8 6663.3 6663.6 6457.6 6618.9 6624.2 6638.3 6661.1 5193.8 5194.5 5196.8 5210.4 5212.9 4567.1 4607.7 4642.9 4667.8 4684.2 5794.3 5880.3 5884.2 5894.8 5904.7 6707.6 6724.8 6740.1 6825.6 6830.8 5839.0 5842.9 5846.6 5846.8 5846.9 5762.3 5835.3 5846.9 5849.6 5862.8 6471.9 6476.4 6498.4 6561.8 6603.5 6492.5 6614.8 6619.9 6704.1 6794.8 6383.5 6414.8 6453.9 6463.9 6514.5 6610.9 6677.6 6703.6 6719.5 6720.1 6747.4 6799.9 6821.1 6836.0 6840.0 6489.2 6489.9 6501.9 6592.1 6593.5 6353.0 6424.9 6440.8 6561.7 6569.0 6393.6 6405.0 6406.1 6410.8 6417.2 6477.2 6531.3 6532.9 6606.1 6661.3 6255.2 6282.4 6352.1 6357.7 6386.5 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#1] ext.html Cycles:180 Average:37774.33 Median:33692.66 stddev:55971.88 (166.1%) stddev-sans-first:56060.06 03:45:01 INFO - PID 3544 | Values: 805.9 852.9 880.9 886.1 1114.2 28671.4 29798.7 39808.4 40675.0 40737.2 40791.0 41272.4 41279.8 41285.4 41386.4 7087.5 7520.3 7671.3 7716.5 7724.5 7551.5 7663.1 7664.3 7666.2 7668.8 7650.2 7672.9 7684.5 7712.1 7716.1 7637.0 7675.4 7677.4 7680.2 7692.9 7529.7 7583.8 7587.5 7588.5 7589.2 35793.3 35830.1 35847.8 35976.5 35997.8 3471.9 3493.3 3493.3 3499.5 3501.3 29411.0 29512.0 29547.4 29615.7 29627.3 4929.4 4937.6 4974.8 4987.7 5008.9 183926.2 184593.0 184669.0 185144.1 185754.0 45306.8 45670.3 45686.0 45853.8 45960.3 46928.1 46938.3 46973.8 47084.8 47366.8 15514.5 15660.2 15683.7 15789.4 15802.6 11244.0 11451.9 12487.8 12713.0 12719.9 13761.3 13791.4 13819.1 13875.4 13953.9 5654.3 5762.6 5765.7 5771.3 5790.3 981.2 1005.7 1009.4 1009.5 1021.7 22105.2 22143.8 22237.8 22255.6 22485.1 1094.6 1094.8 1096.6 1103.4 1121.7 11724.4 11905.0 15594.8 15678.5 16268.0 242287.0 243320.0 243348.0 243615.0 244608.0 53992.5 54363.2 54505.7 54597.7 54607.5 1377.4 1405.6 1417.8 1419.3 1430.7 26757.0 26806.6 26862.6 27021.7 27078.6 36210.1 36214.0 36317.0 36360.8 36389.5 214394.0 215118.0 215386.0 215917.0 215986.0 28368.4 28818.6 28891.9 31170.0 32279.7 37654.1 39157.0 39209.0 39333.4 39809.6 30099.7 30609.2 32399.0 33617.5 33767.8 32968.2 32974.3 33171.0 33415.0 33535.3 36935.3 36963.3 37000.1 37177.3 37197.6 31514.4 32274.8 32310.4 32317.5 32341.5 24073.3 24883.6 25097.6 25371.5 25440.5 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#2] jquery.html Cycles:180 Average:36101.35 Median:12896.38 stddev:91057.40 (706.1%) stddev-sans-first:91273.72 03:45:01 INFO - PID 3544 | Values: 554.8 564.6 568.7 568.9 576.6 21350.1 22192.3 22215.0 22237.4 22265.7 23804.6 24287.8 24378.0 24467.8 24504.8 6414.7 6580.7 6586.7 6587.1 6589.2 6295.8 6381.7 6424.9 6465.5 6588.9 6530.3 6530.5 6549.6 6551.2 6561.5 6567.0 6569.5 6576.9 6584.2 6584.4 6055.9 6068.9 6081.8 6082.6 6096.8 27636.2 28428.1 28950.1 28997.7 29299.0 2010.6 2057.3 2057.9 2061.1 2063.7 18953.3 19079.4 19239.7 19453.7 19504.3 2350.6 2407.0 2417.6 2419.2 2426.3 124463.4 131562.3 131694.3 131921.3 132068.3 14284.5 14325.7 14370.0 14687.6 14689.4 22538.8 22636.7 22688.9 22742.4 22753.5 9923.9 9981.5 9986.9 10069.7 10172.6 9342.3 9358.4 9420.4 9497.9 9577.9 8370.7 8708.7 9000.8 9043.8 9316.4 2402.3 2444.7 2448.3 2521.5 2537.6 927.8 956.4 976.8 978.8 981.2 19724.3 19936.0 19964.1 20480.9 23705.9 987.5 1067.2 1068.9 1080.9 1081.3 10672.4 11136.2 11153.3 11180.7 11286.7 531828.0 534738.0 542749.0 555109.0 563762.0 116535.4 117314.0 118680.0 119482.0 119800.0 1230.3 1248.8 1250.0 1267.3 1268.3 17657.8 17840.0 17981.6 18043.5 18100.3 53466.0 53599.7 54644.0 54804.7 56665.7 68335.7 72222.6 72507.0 73130.6 73926.6 14274.6 14794.5 14818.5 14852.2 14945.9 23442.2 23564.2 23741.0 23889.6 23969.8 18375.0 18569.1 18954.2 19002.7 19006.1 16287.0 16876.6 16927.5 16957.8 17165.7 18847.3 19034.3 19231.4 19473.0 19493.5 14067.9 14710.8 14722.0 14739.0 14751.2 18031.8 18220.3 18368.7 18388.6 18403.2 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#3] mootools.html Cycles:180 Average:9126.48 Median:2595.75 stddev:6568.16 (253.0%) stddev-sans-first:6560.09 03:45:01 INFO - PID 3544 | Values: 1275.5 1338.9 1351.0 1351.6 1365.3 11988.5 14526.1 15145.1 15163.4 15169.8 12109.6 12260.8 14453.0 14794.9 14818.3 2596.5 2639.5 2641.1 2647.3 2652.9 2612.5 2678.7 2690.4 2691.2 2702.0 2654.1 2654.7 2678.3 2680.9 2681.9 2584.7 2584.9 2585.8 2595.0 2596.9 2508.5 2523.1 2542.8 2547.2 2548.7 14127.6 14291.4 14302.4 14433.6 14629.7 7650.9 7910.4 7943.8 7951.0 7955.6 5234.7 5391.8 5436.5 5550.0 5560.1 1888.6 1898.4 1921.6 1932.7 1951.1 25896.4 25906.5 25966.1 25988.9 25999.2 6780.8 7010.8 7037.6 7123.9 7191.2 19195.1 19223.3 19269.8 19270.2 19288.7 8048.4 8064.4 8070.1 8078.2 8082.2 5634.9 6240.2 7304.1 7466.3 7499.1 5422.3 5616.1 5621.8 5640.3 5703.5 1713.4 1742.4 1746.1 1755.8 1794.6 863.9 898.1 902.5 911.5 933.7 7534.5 7565.8 7568.7 7576.4 7582.0 707.4 721.5 724.8 726.3 726.6 4500.0 4533.2 4546.2 4558.5 4567.3 19832.0 20378.7 20586.4 21479.5 21593.9 20208.2 20238.9 20314.5 20399.3 20412.0 10136.9 10398.8 10414.2 10568.3 10569.9 8859.1 8865.4 8904.6 8937.2 9019.0 17983.0 18126.8 18552.3 19049.2 19210.8 18955.9 18969.1 18978.2 19210.0 19320.7 11883.8 11904.9 12182.6 12188.5 12194.9 13751.9 13874.4 13928.9 13937.4 13943.8 10904.1 10913.2 11094.7 11236.6 11363.8 10284.4 10496.5 10546.1 10570.6 10705.3 8958.5 8984.1 9010.3 9048.0 9076.9 6585.7 6626.6 6646.8 6715.4 6716.3 6759.1 6859.1 6877.0 6930.7 6957.3 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#4] prototype.html Cycles:180 Average:5479.54 Median:6124.56 stddev:1537.49 (25.1%) stddev-sans-first:1495.58 03:45:01 INFO - PID 3544 | Values: 494.7 499.8 511.7 512.2 512.7 6223.8 6224.7 6241.9 6274.0 6275.7 6117.3 6131.8 6161.4 6177.6 6206.7 4883.7 4952.4 4975.0 4989.3 5122.6 4949.4 4971.7 4978.9 4995.7 5007.2 4907.5 4915.8 4946.1 4948.0 4985.5 4932.2 4956.7 4992.7 5015.2 5041.9 4466.5 4477.6 4486.3 4487.3 4491.8 5934.6 5958.7 6004.3 6096.7 6143.8 5589.2 5601.9 5639.3 5687.6 5715.0 6548.2 6593.5 6596.6 6605.4 6614.4 4769.4 4824.6 4827.6 4864.9 4878.7 6590.3 6662.0 6792.5 6906.2 6979.8 4895.7 4923.3 4966.6 4982.0 4999.3 5035.9 5041.0 5056.2 5087.8 5088.9 5537.1 5613.5 5620.8 5661.0 5700.1 6564.8 6581.2 6622.2 6648.5 6656.0 1711.9 1743.4 1749.6 1750.7 1757.7 1134.7 1187.2 1197.0 1200.9 1213.8 5607.3 5655.0 5715.8 5763.7 5794.7 6550.3 6589.0 6612.9 6650.7 6721.4 5735.0 5769.6 5772.8 5811.9 5820.9 3530.2 3534.6 3548.6 3557.2 3571.6 6403.8 6416.7 6421.6 6459.7 6509.9 6751.9 6760.7 6812.3 6947.8 6947.9 6354.0 6420.6 6469.8 6499.2 6519.9 6034.5 6604.6 6673.9 6702.6 6731.7 6547.2 6547.4 6570.9 6631.7 6652.2 6397.2 6424.0 6479.5 6483.4 6517.2 4864.1 4938.5 4941.2 4943.5 4970.4 6414.3 6609.9 6613.4 6734.8 6771.4 6347.9 6529.3 6531.8 6541.8 6542.4 6494.0 6518.9 6521.4 6553.2 6556.8 6373.2 6413.6 6430.3 6434.8 6523.4 6477.5 6493.0 6581.8 6594.2 6596.7 6277.2 6315.9 6328.2 6338.8 6396.3 03:45:01 INFO - PID 3544 | 03:45:01 INFO - PID 3544 | [#5] yui.html Cycles:180 Average:24567.54 Median:21270.07 stddev:34187.36 (160.7%) stddev-sans-first:34236.99 03:45:01 INFO - PID 3544 | Values: 879.6 888.2 896.6 905.2 907.5 15990.8 16888.2 20736.0 21609.1 21901.3 19935.5 20085.9 21076.5 21135.6 21178.8 911.9 930.2 936.3 940.8 941.5 674.2 693.0 699.2 701.9 936.2 949.1 973.6 974.0 978.1 978.3 970.8 977.9 978.6 978.9 979.2 711.8 712.0 715.2 715.7 716.9 18855.9 19176.3 19490.0 19634.1 19795.2 20725.7 20974.6 21246.8 21293.4 21460.2 15880.7 15971.0 16250.3 16371.8 16402.3 3687.8 3711.6 3711.9 3723.2 3723.4 129729.0 130546.0 133050.7 134214.0 135192.3 16022.7 16111.5 16437.8 16517.0 16640.8 28405.4 29332.6 29619.6 29734.6 29759.7 8732.6 8905.9 8960.1 8968.2 8988.7 3960.2 4035.9 4095.0 4104.9 4143.9 5072.0 5186.8 5198.8 5211.7 5214.0 1047.7 1072.6 1079.7 1081.3 1089.7 661.3 678.4 688.0 693.8 700.4 11048.6 11741.6 12016.8 12070.4 12082.5 693.6 695.3 696.9 710.7 711.3 5600.4 5616.9 6193.2 6211.3 6365.6 114793.4 114993.0 116900.0 118209.4 123189.4 103799.0 104463.5 105151.0 108578.0 109916.0 85114.1 90388.5 91084.0 93728.0 94316.0 11603.9 12190.0 12683.6 13047.2 13389.8 39458.4 39711.6 40278.4 41302.0 42183.8 67727.3 71836.6 72022.1 74832.3 75688.2 18308.5 18452.8 18751.2 19276.9 19303.0 18172.7 19293.1 19435.6 19531.9 19635.0 17227.1 17328.0 18800.5 19168.3 19188.0 19123.8 19631.4 19663.1 19900.3 20190.6 17344.6 17375.7 17458.9 17515.2 19233.7 12884.9 13358.6 13383.6 13408.5 13831.9 13826.4 13867.0 14048.4 14375.9 15166.5 03:45:01 INFO - PID 3544 | -------- Summary: end -------- 03:45:01 INFO - PID 3544 | 03:45:01 INFO - TEST-INFO | 3544: exit 0 03:45:01 INFO - TEST-OK | dromaeo_css | took 1115100ms 03:45:01 INFO - TEST-START | kraken 03:45:01 INFO - Initialising browser for kraken test... 03:45:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40916/getInfo.html -profile /tmp/tmpGAeUkN/profile 03:45:01 INFO - TEST-INFO | started process 3962 (/builds/slave/test/build/application/firefox/firefox http://localhost:40916/getInfo.html) 03:45:08 INFO - TEST-INFO | 3962: exit 0 03:45:08 INFO - Browser initialized. 03:45:08 INFO - Running cycle 1/1 for kraken test... 03:45:08 INFO - TEST-INFO | started process 4146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGAeUkN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:09 INFO - PID 4146 | 03:45:09 INFO - PID 4146 | (/builds/slave/test/build/application/firefox/firefox:4197): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:09 INFO - PID 4146 | 03:45:09 INFO - PID 4146 | 03:45:09 INFO - PID 4146 | (/builds/slave/test/build/application/firefox/firefox:4256): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:09 INFO - PID 4146 | 03:45:09 INFO - PID 4146 | __metrics Screen width/height:1600/1200 03:45:09 INFO - PID 4146 | colorDepth:24 03:45:09 INFO - PID 4146 | Browser inner width/height: 1024/768 03:45:09 INFO - PID 4146 | __metrics 03:45:19 INFO - PID 4146 | RSS: Main: 174354432 03:45:19 INFO - PID 4146 | 03:45:22 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40916/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:23 INFO - PID 4146 | RSS: Main: 179585024 03:45:23 INFO - PID 4146 | 03:45:25 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40916/tests/kraken/driver.html?testName=audio-dft) 03:45:26 INFO - PID 4146 | RSS: Main: 179851264 03:45:26 INFO - PID 4146 | 03:45:29 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40916/tests/kraken/driver.html?testName=audio-fft) 03:45:30 INFO - PID 4146 | RSS: Main: 173617152 03:45:30 INFO - PID 4146 | 03:45:32 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40916/tests/kraken/driver.html?testName=audio-oscillator) 03:45:32 INFO - PID 4146 | RSS: Main: 174014464 03:45:32 INFO - PID 4146 | 03:45:35 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:35 INFO - PID 4146 | RSS: Main: 174227456 03:45:35 INFO - PID 4146 | 03:45:38 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40916/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:39 INFO - PID 4146 | RSS: Main: 175796224 03:45:39 INFO - PID 4146 | 03:45:43 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40916/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:43 INFO - PID 4146 | RSS: Main: 175435776 03:45:43 INFO - PID 4146 | 03:45:46 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40916/tests/kraken/driver.html?testName=json-parse-financial) 03:45:47 INFO - PID 4146 | RSS: Main: 175919104 03:45:47 INFO - PID 4146 | 03:45:48 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:49 INFO - PID 4146 | RSS: Main: 175747072 03:45:49 INFO - PID 4146 | 03:45:51 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:52 INFO - PID 4146 | RSS: Main: 176414720 03:45:52 INFO - PID 4146 | 03:45:54 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:54 INFO - PID 4146 | RSS: Main: 176001024 03:45:54 INFO - PID 4146 | 03:45:57 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:58 INFO - PID 4146 | RSS: Main: 175960064 03:45:58 INFO - PID 4146 | 03:46:01 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:01 INFO - PID 4146 | RSS: Main: 176119808 03:46:01 INFO - PID 4146 | 03:46:03 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:40916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40916/tests/kraken/driver.html?testName=ai-astar) 03:46:03 INFO - PID 4146 | RSS: Main: 178049024 03:46:03 INFO - PID 4146 | 03:46:03 INFO - PID 4146 | __start_tp_report 03:46:03 INFO - PID 4146 | _x_x_mozilla_page_load 03:46:03 INFO - PID 4146 | _x_x_mozilla_page_load_details 03:46:03 INFO - PID 4146 | |i|pagename|runs| 03:46:03 INFO - PID 4146 | |0;ai-astar;96;107;99;106;108;112;107;97;107;108 03:46:03 INFO - PID 4146 | |1;audio-beat-detection;155;116;149;178;126;149;147;118;169;117 03:46:03 INFO - PID 4146 | |2;audio-dft;161;162;162;160;159;162;166;165;166;163 03:46:03 INFO - PID 4146 | |3;audio-fft;74;75;76;186;74;74;75;74;155;74 03:46:03 INFO - PID 4146 | |4;audio-oscillator;84;78;137;78;77;79;131;80;79;129 03:46:03 INFO - PID 4146 | |5;imaging-gaussian-blur;113;114;116;119;114;118;117;116;115;114 03:46:03 INFO - PID 4146 | |6;imaging-darkroom;152;149;150;151;147;151;148;148;148;147 03:46:03 INFO - PID 4146 | |7;imaging-desaturate;93;94;94;94;94;94;95;97;98;99 03:46:03 INFO - PID 4146 | |8;json-parse-financial;62;53;52;57;53;52;52;52;55;52 03:46:03 INFO - PID 4146 | |9;json-stringify-tinderbox;58;54;55;55;55;60;60;60;56;63 03:46:03 INFO - PID 4146 | |10;stanford-crypto-aes;81;77;77;74;74;74;73;74;72;73 03:46:03 INFO - PID 4146 | |11;stanford-crypto-ccm;118;120;114;115;119;114;125;120;128;150 03:46:03 INFO - PID 4146 | |12;stanford-crypto-pbkdf2;176;173;171;191;168;175;167;170;165;166 03:46:03 INFO - PID 4146 | |13;stanford-crypto-sha256-iterative;63;64;66;70;68;68;62;68;63;62 03:46:03 INFO - PID 4146 | __end_tp_report 03:46:03 INFO - PID 4146 | __start_cc_report 03:46:03 INFO - PID 4146 | _x_x_mozilla_cycle_collect,927 03:46:03 INFO - PID 4146 | __end_cc_report 03:46:03 INFO - PID 4146 | __startTimestamp1503485163987__endTimestamp 03:46:03 INFO - PID 4146 | 03:46:03 INFO - PID 4146 | ------- Summary: start ------- 03:46:03 INFO - PID 4146 | Number of tests: 14 03:46:03 INFO - PID 4146 | 03:46:03 INFO - PID 4146 | [#0] ai-astar Cycles:10 Average:104.70 Median:110.00 stddev:5.38 (4.9%) stddev-sans-first:4.69 03:46:03 INFO - PID 4146 | Values: 96.0 107.0 99.0 106.0 108.0 112.0 107.0 97.0 107.0 108.0 03:46:03 INFO - PID 4146 | 03:46:03 INFO - PID 4146 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:149.00 stddev:22.23 (14.9%) stddev-sans-first:23.11 03:46:04 INFO - PID 4146 | Values: 155.0 116.0 149.0 178.0 126.0 149.0 147.0 118.0 169.0 117.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.41 (1.5%) stddev-sans-first:2.49 03:46:04 INFO - PID 4146 | Values: 161.0 162.0 162.0 160.0 159.0 162.0 166.0 165.0 166.0 163.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#3] audio-fft Cycles:10 Average:93.70 Median:74.00 stddev:41.14 (55.6%) stddev-sans-first:43.01 03:46:04 INFO - PID 4146 | Values: 74.0 75.0 76.0 186.0 74.0 74.0 75.0 74.0 155.0 74.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:78.50 stddev:25.77 (32.8%) stddev-sans-first:27.01 03:46:04 INFO - PID 4146 | Values: 84.0 78.0 137.0 78.0 77.0 79.0 131.0 80.0 79.0 129.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:116.00 stddev:1.96 (1.7%) stddev-sans-first:1.83 03:46:04 INFO - PID 4146 | Values: 113.0 114.0 116.0 119.0 114.0 118.0 117.0 116.0 115.0 114.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.50 stddev:1.79 (1.2%) stddev-sans-first:1.56 03:46:04 INFO - PID 4146 | Values: 152.0 149.0 150.0 151.0 147.0 151.0 148.0 148.0 148.0 147.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.04 (2.2%) stddev-sans-first:2.01 03:46:04 INFO - PID 4146 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 95.0 97.0 98.0 99.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:3.27 (6.2%) stddev-sans-first:1.76 03:46:04 INFO - PID 4146 | Values: 62.0 53.0 52.0 57.0 53.0 52.0 52.0 52.0 55.0 52.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:59.00 stddev:3.03 (5.1%) stddev-sans-first:3.21 03:46:04 INFO - PID 4146 | Values: 58.0 54.0 55.0 55.0 55.0 60.0 60.0 60.0 56.0 63.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.69 (3.6%) stddev-sans-first:1.72 03:46:04 INFO - PID 4146 | Values: 81.0 77.0 77.0 74.0 74.0 74.0 73.0 74.0 72.0 73.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:120.00 stddev:10.74 (8.9%) stddev-sans-first:11.28 03:46:04 INFO - PID 4146 | Values: 118.0 120.0 114.0 115.0 119.0 114.0 125.0 120.0 128.0 150.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:7.58 (4.4%) stddev-sans-first:7.92 03:46:04 INFO - PID 4146 | Values: 176.0 173.0 171.0 191.0 168.0 175.0 167.0 170.0 165.0 166.0 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:67.00 stddev:2.95 (4.4%) stddev-sans-first:3.00 03:46:04 INFO - PID 4146 | Values: 63.0 64.0 66.0 70.0 68.0 68.0 62.0 68.0 63.0 62.0 03:46:04 INFO - PID 4146 | -------- Summary: end -------- 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 03:46:04 INFO - PID 4146 | 03:46:04 INFO - PID 4146 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:46:04 INFO - TEST-INFO | 4146: exit 0 03:46:04 INFO - TEST-OK | kraken | took 62890ms 03:46:04 INFO - SUITE-END | took 1177s 03:46:05 INFO - Completed test suite (00:19:38) 03:46:05 INFO - javascript benchmark 03:46:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8468.955114241136, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.8384580770958, 3261.890957074594, 3268.9019329420116, 3273.705366517013, 3276.1482014676176, 6123.295820980588, 6144.784932527363, 6248.687565621712, 6256.968715156418, 6276.905846412296, 6052.6368417894955, 6160.168377269068, 6164.445199932005, 6169.568130230886, 6180.351063138373, 5725.427457254273, 5728.79949201778, 5738.282714660668, 5759.769609215627, 5833.066709326508, 5687.146927960797, 5809.912851307234, 5835.708214589275, 5841.8831623367505, 5850.180974663551, 5613.80351687691, 5722.113072473773, 5730.3123625165035, 5777.971110144444, 5813.709314534278, 5679.602427830054, 5733.226014488053, 5769.538436925036, 5805.332386775512, 5831.562632802556, 5551.306086739158, 5629.831105066854, 5676.545876329925, 5709.914351284734, 5751.511121554673, 6113.541484388688, 6152.907706384408, 6154.199954005995, 6160.414760597736, 6180.783672571483, 6658.201015878077, 6707.631080290582, 6726.932730672728, 6739.989001649743, 6743.932560674429, 6700.463962883006, 6726.529142959995, 6735.629540375277, 6801.523893327469, 6832.248452670202, 6122.173506576644, 6186.133941248228, 6191.2570491540855, 6260.24877014752, 6337.6831158442355, 6905.689243984033, 6926.722931082801, 6968.79093627192, 6997.05539752127, 7003.964980175067, 6572.047053177358, 6589.110470086573, 6687.933120668731, 6694.765683201064, 6697.933020669829, 6688.799336019927, 6705.932940670628, 6724.966375168191, 6787.389134977876, 6833.6241506716615, 6616.338366163442, 6619.073329733841, 6653.833654158588, 6663.267040625527, 6663.566868153554, 6457.580257283355, 6618.933810661832, 6624.205095388585, 6638.336166383419, 6661.100751398596, 5193.818216362409, 5194.454582268883, 5196.792128314825, 5210.400803907523, 5212.895742085213, 4567.132244873464, 4607.7004994675235, 4642.883927901829, 4667.789949452283, 4684.180268453007, 5794.275715535558, 5880.294364676266, 5884.205632239593, 5894.764209431661, 5904.7342869570975, 6707.631080290631, 6724.831879203059, 6740.090087838079, 6825.590464572141, 6830.7609233676585, 5839.036558967808, 5842.941570584325, 5846.561507886926, 5846.795362162304, 5846.912296315559, 5762.250907382014, 5835.299764028344, 5846.853828654318, 5849.61977471463, 5862.824115276549, 6471.870562588816, 6476.35236476358, 6498.447631951242, 6561.80314590563, 6603.504737144734, 6492.48060155177, 6614.8346291343105, 6619.900701489385, 6704.094947182068, 6794.830129246809, 6383.457406120532, 6414.839629009312, 6453.9354606453335, 6463.935360646334, 6514.54398192141, 6610.876151054236, 6677.565958212701, 6703.564268322543, 6719.4624430044505, 6720.126383570105, 6747.392734653708, 6799.89800153008, 6821.147356580427, 6836.0, 6840.042394064934, 6489.221293444628, 6489.935100648933, 6501.927182014914, 6592.077109204619, 6593.472522198309, 6352.968235158794, 6424.93575064262, 6440.806775796734, 6561.737530498726, 6568.967155164385, 6393.552451328363, 6405.03924411342, 6406.135171751754, 6410.839729006812, 6417.1657684500715, 6477.190351206099, 6531.346865313621, 6532.902006469812, 6606.141201643755, 6661.3338666132995, 6255.249370075438, 6282.371762823681, 6352.110704501281, 6357.713902874474, 6386.521010924293], "value": 6108.803969450909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.8831469436932, 852.9189726975937, 880.8986966498852, 886.1183122792822, 1114.1755101225096, 28671.426571468557, 29798.702012979862, 39808.402873956875, 40675.0, 40737.185256294855, 40791.0, 41272.38091428631, 41279.793601032026, 41285.380719289235, 41386.37920431188, 7087.503874728771, 7520.32317091463, 7671.271229233242, 7716.459847810655, 7724.536527808322, 7551.471397002212, 7663.080430348366, 7664.271894170045, 7666.195049519803, 7668.769936901902, 7650.234976502361, 7672.9232707673045, 7684.500507467024, 7712.074551053882, 7716.074071111474, 7637.0, 7675.424343174284, 7677.385809135256, 7680.155182929873, 7692.884606730876, 7529.698812047512, 7583.848323033563, 7587.520433515467, 7588.544687318778, 7589.203133670941, 35793.28413431743, 35830.10424739376, 35847.82076089629, 35976.46035309473, 35997.82001089978, 3471.861125554975, 3493.266414053052, 3493.283876805249, 3499.5100685903994, 3501.2997400519744, 29411.0, 29511.967081152055, 29547.409051819057, 29615.70384296151, 29627.259318516994, 4929.433115191763, 4937.580305674022, 4974.801007959677, 4987.725675087869, 5008.924866127011, 183926.16073839224, 184593.0, 184669.0, 185144.07427962907, 185754.0, 45306.77346613246, 45670.314945275844, 45686.0, 45853.7707311468, 45960.3105953411, 46928.06143877103, 46938.29592556114, 46973.76513117413, 47084.7645761769, 47366.76316618395, 15514.45699400538, 15660.216989150496, 15683.686326273411, 15789.447369342019, 15802.60493487649, 11244.0, 11451.88548114525, 12487.812682809765, 12713.0, 12719.936400318124, 13761.31193440324, 13791.448342066406, 13819.101758385672, 13875.37560809766, 13953.86046139546, 5654.342459044325, 5762.625429347079, 5765.654060756368, 5771.336296325892, 5790.305163380422, 981.2052237687496, 1005.703317521333, 1009.399407352624, 1009.4548943570389, 1021.7292417509366, 22105.226317078825, 22143.778562214495, 22237.777622223894, 22255.55488890213, 22485.100595976306, 1094.6292577200616, 1094.8412480190327, 1096.5887792077972, 1103.4041617526445, 1121.6578943422335, 11724.389063754736, 11905.0, 15594.766078508832, 15678.451254206047, 16268.0, 242287.0, 243320.0, 243348.0, 243615.0, 244608.0, 53992.46007539874, 54363.184552231745, 54505.72747136239, 54597.72701136548, 54607.45392546103, 1377.393946663465, 1405.5642750747302, 1417.7873319002233, 1419.2832619527073, 1430.7353139669403, 26757.0, 26806.59790103111, 26862.59706104371, 27021.729782702707, 27078.593821092305, 36210.094747630465, 36214.0, 36317.0, 36360.818195908854, 36389.45415818818, 214394.0, 215118.0, 215386.0, 215917.0, 215986.0, 28368.43263134767, 28818.567721484615, 28891.85554072216, 31170.0, 32279.677203228606, 37654.058648534, 39157.0, 39209.0, 39333.40999885061, 39809.611423314695, 30099.69900300969, 30609.23476913095, 32399.0, 33617.49573756347, 33767.83116084404, 32968.175795605304, 32974.34051319008, 33171.0, 33415.0, 33535.329293414485, 36935.261294773416, 36963.26073478569, 37000.07499812526, 37177.25645487021, 37197.628023719415, 31514.36971260608, 32274.838625806722, 32310.35379292354, 32317.51523727193, 32341.51487727639, 24073.27780166598, 24883.62674559919, 25097.619630920475, 25371.530259784377, 25440.491190176464], "value": 16996.54179475852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.794725951398, 564.6358099026128, 568.7497501099518, 568.8947544704231, 576.5646936562895, 21350.145994160233, 22192.334229973105, 22215.0, 22237.444063898412, 22265.666015009767, 23804.642930356058, 24287.757122428815, 24378.024879004864, 24467.75532244677, 24504.75495245047, 6414.679266036703, 6580.703868325937, 6586.670666466682, 6587.077809106729, 6589.209294884597, 6295.811125666214, 6381.712822922957, 6424.871502569946, 6465.450436712885, 6588.934110658904, 6530.314316996718, 6530.510211734115, 6549.639769812658, 6551.246606640226, 6561.507886908501, 6566.967165164167, 6569.507286953473, 6576.93423065768, 6584.242812076577, 6584.440322572539, 6055.878882422327, 6068.939310606882, 6081.847953801146, 6082.60463069899, 6096.756129754849, 27636.170914872386, 28428.147155585364, 28950.131496055154, 28997.710022899922, 29299.0, 2010.6179825833044, 2057.341650671786, 2057.855950083495, 2061.1034200122995, 2063.690446433032, 18953.336633217772, 19079.427617171506, 19239.711404328948, 19453.708194377097, 19504.31734889272, 2350.5886469867874, 2407.0, 2417.601095819188, 2419.1895714935517, 2426.3327584914114, 124463.37768311192, 131562.3421882894, 131694.34152829176, 131921.3403932984, 132068.33965830205, 14284.500042498463, 14325.713485730226, 14370.0, 14687.559373218606, 14689.41242350294, 22538.774612253666, 22636.660450093263, 22688.88655556712, 22742.431439214153, 22753.544929101325, 9923.851142232872, 9981.45102019396, 9986.900130998742, 10069.748256293651, 10172.643957461454, 9342.252619790537, 9358.39170453932, 9420.434773913586, 9497.862980829259, 9577.856332155023, 8370.748877533684, 8708.651653933772, 9000.784894039352, 9043.819123617492, 9316.394434361744, 2402.327348342467, 2444.743301953305, 2448.3313188624484, 2521.533516299454, 2537.581299085667, 927.7773334399695, 956.4118067388645, 976.8437050072097, 978.7895602445508, 981.2337791974418, 19724.30964916221, 19936.0, 19964.101615427342, 20480.897595511928, 23705.881470592536, 987.4914419074182, 1067.2475904487317, 1068.9198310126772, 1080.9189310801721, 1081.302559848893, 10672.413017284123, 11136.164787640959, 11153.275037122561, 11180.664580062612, 11286.717832054264, 531828.0, 534738.0, 542749.0, 555109.0, 563762.0, 116535.41732291284, 117314.0, 118680.0, 119482.0, 119800.0, 1230.2864338683542, 1248.818921256431, 1249.9812502812465, 1267.2966503590412, 1268.346801397281, 17657.823421765617, 17840.0, 17981.550461238574, 18043.458696239133, 18100.275988960293, 53466.0, 53599.732001341305, 54644.0231227731, 54804.72597636986, 56665.71667141803, 68335.65832171006, 72222.63888680523, 72507.0, 73130.63434682792, 73926.63036684782, 14274.643133921734, 14794.482193123189, 14818.481353152589, 14852.183129927525, 14945.925270373578, 23442.17952371659, 23564.175253866033, 23741.0, 23889.641655374835, 23969.760302396753, 18375.0, 18569.071546422354, 18954.24183032663, 19002.714959275898, 19006.144723487752, 16287.0, 16876.57808554796, 16927.49217523427, 16957.83042169612, 17165.656686865943, 18847.340343087926, 19034.33379831699, 19231.423057308304, 19473.0, 19493.51266218356, 14067.859321406655, 14710.77933830972, 14722.0, 14739.0, 14751.188684622448, 18031.819681803016, 18220.271189152285, 18368.724469132707, 18388.632227355647, 18403.17185726619], "value": 11953.89721387056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.4515558309927, 1338.9062765606411, 1350.9932450337747, 1351.5877657314522, 1365.276403506142, 11988.520459181644, 14526.128432294057, 15145.091294522337, 15163.393464261444, 15169.772453413208, 12109.636710898665, 12260.81608775869, 14453.0, 14794.852051479482, 14818.259087045632, 2596.5196438658813, 2639.5380808358555, 2641.1152263991585, 2647.272000199941, 2652.9071482498116, 2612.529744645963, 2678.7053424123333, 2690.3543149644042, 2691.1657386210336, 2701.986490067547, 2654.137405343271, 2654.721254268303, 2678.263477543672, 2680.9463810723773, 2681.9195424137306, 2584.6510721052605, 2584.896604135832, 2585.7802086822644, 2594.987025064872, 2596.9091081812235, 2508.523380557688, 2523.0538548044483, 2542.758437948392, 2547.1594373856583, 2548.655931449268, 14127.646808829759, 14291.356888940023, 14302.427902883872, 14433.639159021004, 14629.707405851823, 7650.923490765077, 7910.4462687611895, 7943.761687149395, 7951.04587449504, 7955.602219888982, 5234.685918844882, 5391.829534468826, 5436.456354364572, 5549.972250138764, 5560.110382338847, 1888.6317168152216, 1898.4494496595971, 1921.5938619026217, 1932.6521226179282, 1951.1414977409895, 25896.352591185183, 25906.481870362677, 25966.09118680837, 25988.87005564979, 25999.22002339914, 6780.762673306411, 7010.789676309719, 7037.612931288828, 7123.857522849514, 7191.17301510333, 19195.136218870186, 19223.327183548787, 19269.8073019268, 19270.22919083221, 19288.710669339973, 8048.356131509465, 8064.395170362246, 8070.071941726659, 8078.192180781874, 8082.232187942253, 5634.943650563524, 6240.219972503437, 7304.050473438419, 7466.290702383265, 7499.062617172854, 5422.322209723785, 5616.073347897633, 5621.775307930114, 5640.27971468706, 5703.486686198262, 1713.4174380710617, 1742.4249997500795, 1746.0920321432784, 1755.7629719987895, 1794.5603327184663, 863.9179277968583, 898.1198425542874, 902.5261737587819, 911.5077857956762, 933.6825479337058, 7534.472586918863, 7565.773026809205, 7568.697252109854, 7576.393888488908, 7581.9764331814495, 707.4093132234642, 721.487743701967, 724.8187953011748, 726.2628432141381, 726.6221564786282, 4499.977500112478, 4533.161365147458, 4546.204414227497, 4558.452985641744, 4567.2920697291975, 19832.0, 20378.69431958522, 20586.382408527767, 21479.46301342479, 21593.89203054006, 20208.19167233294, 20238.89880550588, 20314.492137696674, 20399.286024989055, 20412.0, 10136.898631013742, 10398.844017339747, 10414.218933580012, 10568.313059651251, 10569.947150264199, 8859.11408859109, 8865.379423440298, 8904.643814247358, 8937.240334571634, 9019.0, 17983.0, 18126.81873181304, 18552.257909684, 19049.238030478624, 19210.8078919209, 18955.90522047381, 18969.14638841228, 18978.24087036503, 19210.039498024762, 19320.71018934689, 11883.76232475363, 11904.880951190724, 12182.634520964386, 12188.45151968146, 12194.939025304817, 13751.931240344134, 13874.375653095432, 13928.860711392756, 13937.372818223, 13943.790843137158, 10904.12766978624, 10913.23607347478, 11094.667159985212, 11236.550537978716, 11363.829542556703, 10284.382937023802, 10496.52765625564, 10546.103581195684, 10570.577176912837, 10705.304155229886, 8958.462492250224, 8984.146506081912, 9010.324225682969, 9047.954760226157, 9076.909230907871, 6585.736570537125, 6626.602403855784, 6646.8005959821285, 6715.395614394728, 6716.261211266659, 6759.121314229315, 6859.07402500656, 6877.0, 6930.688119034757, 6957.339052789976], "value": 6499.501548804277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.6759872283651, 499.84005118362126, 511.6980981221079, 512.1753976098481, 512.7026324731656, 6223.751049958002, 6224.688765561715, 6241.875162496747, 6274.0, 6275.717592708328, 6117.2659280886355, 6131.846703832406, 6161.367237682018, 6177.629342239457, 6206.67942650682, 4883.682560633548, 4952.380952380952, 4975.029869175512, 4989.253761183575, 5122.590192784578, 4949.381327334083, 4971.676841005341, 4978.937953158799, 4995.725235112068, 5007.197408932781, 4907.533784290505, 4915.778789954443, 4946.109700253953, 4947.950520494803, 4985.476524964881, 4932.186189278765, 4956.7025978441225, 4992.653452877142, 5015.172496538067, 5041.949580504184, 4466.508684044785, 4477.6417886569, 4486.327050942352, 4487.3172560289895, 4491.775411229458, 5934.6142500737315, 5958.702064896781, 6004.268058033585, 6096.664683442409, 6143.754249830002, 5589.189567512688, 5601.943980560183, 5639.2668953036255, 5687.601867869251, 5715.0, 6548.246951600531, 6593.53845230834, 6596.637184954826, 6605.40551350376, 6614.404703576653, 4769.403824521934, 4824.552634209758, 4827.637927155442, 4864.902701945976, 4878.658493905428, 6590.275069742324, 6662.0, 6792.49056320773, 6906.240313565504, 6979.790606281819, 4895.7062576245535, 4923.261510773341, 4966.627502937295, 4982.0, 4999.325091112653, 5035.949640503548, 5040.974795126001, 5056.191009438472, 5087.771050302671, 5088.949110508922, 5537.141743029837, 5613.512419208913, 5620.775168993195, 5660.971695141498, 5700.116481945305, 6564.770233041821, 6581.243157037002, 6622.205335359788, 6648.4681225501845, 6656.0, 1711.922963466647, 1743.3810997095848, 1749.553863764732, 1750.6586215688073, 1757.6641752268367, 1134.6993046842592, 1187.2105050141558, 1197.0, 1200.9279443233434, 1213.8482689663792, 5607.327120745536, 5655.0, 5715.771369145187, 5763.740631671585, 5794.710264486759, 6550.312217217219, 6588.967055164693, 6612.86774264512, 6650.733970641217, 6721.395074443323, 5735.0, 5769.59612827098, 5772.797952071657, 5811.854703632358, 5820.88358232833, 3530.1880567469625, 3534.575850897909, 3548.609652938175, 3557.2351944332095, 3571.607123216444, 6403.775867844603, 6416.7433302668305, 6421.5825971311715, 6459.741610335534, 6509.934900650933, 6751.898721519181, 6760.661966901635, 6812.262872967362, 6947.826304342432, 6947.861042779217, 6354.0, 6420.555375040765, 6469.805905822833, 6499.180229535737, 6519.934800652028, 6034.456898879122, 6604.603723776589, 6673.933260667525, 6702.564333318319, 6731.730730770714, 6547.181602299713, 6547.377999090078, 6570.901436478361, 6631.734730610721, 6652.2349929756765, 6397.193669766481, 6424.036394540856, 6479.514036447191, 6483.416492515507, 6517.185351831021, 4864.051509955525, 4938.530839570235, 4941.234108713155, 4943.456219815889, 4970.403551573834, 6414.326495717883, 6609.867802644017, 6613.437857782143, 6734.764283250062, 6771.39057484809, 6347.873042539216, 6529.281779004211, 6531.844491317948, 6541.808494154511, 6542.411182993554, 6493.967530162319, 6518.902216466662, 6521.402256447201, 6553.180852393451, 6556.803295901131, 6373.235211774617, 6413.551051426355, 6430.324815894263, 6434.806955791334, 6523.380278873499, 6477.481801455967, 6492.967535162483, 6581.80254592363, 6594.241662208908, 6596.736130554916, 6277.18396608438, 6315.90526142099, 6328.240611126695, 6338.809835704937, 6396.296407395276], "value": 5024.138927023772, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.5778026547257, 888.2050564744554, 896.62789942174, 905.239598737061, 907.5416914458198, 15990.760138597916, 16888.240029198685, 20736.0, 21609.1356345746, 21901.342959711194, 19935.501612459695, 20085.899570502126, 21076.473088172803, 21135.57728845426, 21178.788212117874, 911.8586619074038, 930.2000279759402, 936.2977766674994, 940.8400571902793, 941.5245301122924, 674.180870242655, 693.0, 699.199416667915, 701.8736627407064, 936.2089034765646, 949.1078386316874, 973.6056896956744, 973.9659111931084, 978.1050338939862, 978.3493976505615, 970.7718686108759, 977.9022097790236, 978.5841017567506, 978.9314747967645, 979.1628157924979, 711.7686751805633, 712.0174159659688, 715.1596873673413, 715.6886754261913, 716.9426445884317, 18855.905720471448, 19176.328828491074, 19490.0, 19634.11646475912, 19795.208191672315, 20725.68911466329, 20974.580508389747, 21246.787532124636, 21293.361199163894, 21460.248891288888, 15880.682386352208, 15971.0, 16250.268737906823, 16371.83628163727, 16402.343906243736, 3687.797171155585, 3711.6102809205186, 3711.870084547055, 3723.236736469017, 3723.385641369171, 129729.0, 130546.0, 133050.6694933048, 134214.0, 135192.32403837919, 16022.67954640924, 16111.516654500383, 16437.753433698505, 16517.008979461032, 16640.750388743938, 28405.431891362055, 29332.560011599842, 29619.555706664418, 29734.553981690293, 29759.702402976127, 8732.607032683545, 8905.866412003825, 8960.148785865333, 8968.23769979546, 8988.685396011108, 3960.1881614269005, 4035.8587449439715, 4095.0171958730284, 4104.897377565585, 4143.937840932388, 5072.0, 5186.766595503212, 5198.844034678966, 5211.739413029409, 5214.035403450373, 1047.6542740895486, 1072.5977758340623, 1079.6599071292517, 1081.259337353915, 1089.7330154112294, 661.2924171136838, 678.4335080208082, 687.9965600171967, 693.7883945396602, 700.4466471487569, 11048.558057677763, 11741.647750567497, 12016.759664806656, 12070.396480176132, 12082.516699331929, 693.6254422611734, 695.266493848984, 696.9337912898267, 710.7015053677468, 711.2602892991334, 5600.383957764642, 5616.887662246814, 6193.194884665055, 6211.2857021443115, 6365.649889256136, 114793.4260328693, 114993.0, 116900.0, 118209.40895295469, 123189.38405308095, 103799.0, 104463.47768261262, 105151.0, 108578.0, 109916.0, 85114.14885851186, 90388.5480572593, 91084.0, 93728.0, 94316.0, 11603.941980290045, 12190.02479801596, 12683.556075537312, 13047.151935124186, 13389.799153012518, 39458.4352017118, 39711.602883971944, 40278.39582406208, 41302.0, 42183.7890810544, 67727.32272677211, 71836.64081679558, 72022.1191152369, 74832.2516774847, 75688.24311756811, 18308.450746477625, 18452.815471845646, 18751.24995000239, 19276.90361548183, 19303.0, 18172.72740908861, 19293.131809068906, 19435.61128777388, 19531.902340488206, 19635.0, 17227.052512111954, 17328.0, 18800.52998675044, 19168.329108481135, 19188.0, 19123.8087619122, 19631.411057668294, 19663.115159817557, 19900.303489377802, 20190.596188075862, 17344.566385840455, 17375.7393639093, 17458.912705436393, 17515.21181546808, 19233.711494327315, 12884.871151288367, 13358.599242022754, 13383.598492045254, 13408.530701425403, 13831.930840345734, 13826.377812998238, 13867.0, 14048.367823447765, 14375.856241437452, 15166.545003649468], "value": 9103.00470398922, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 99.0, 106.0, 108.0, 112.0, 107.0, 97.0, 107.0, 108.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 149.0, 178.0, 126.0, 149.0, 147.0, 118.0, 169.0, 117.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 159.0, 162.0, 166.0, 165.0, 166.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 186.0, 74.0, 74.0, 75.0, 74.0, 155.0, 74.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 137.0, 78.0, 77.0, 79.0, 131.0, 80.0, 79.0, 129.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 116.0, 119.0, 114.0, 118.0, 117.0, 116.0, 115.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 150.0, 151.0, 147.0, 151.0, 148.0, 148.0, 148.0, 147.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 97.0, 98.0, 99.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 53.0, 52.0, 57.0, 53.0, 52.0, 52.0, 52.0, 55.0, 52.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 55.0, 55.0, 55.0, 60.0, 60.0, 60.0, 56.0, 63.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 77.0, 74.0, 74.0, 74.0, 73.0, 74.0, 72.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 114.0, 115.0, 119.0, 114.0, 125.0, 120.0, 128.0, 150.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 171.0, 191.0, 168.0, 175.0, 167.0, 170.0, 165.0, 166.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 70.0, 68.0, 68.0, 62.0, 68.0, 63.0, 62.0], "value": 65.4, "unit": "score"}]}]} 03:46:05 INFO - Return code: 0 03:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:05 INFO - # TBPL SUCCESS # 03:46:05 INFO - Running post-action listener: _package_coverage_data 03:46:05 INFO - Running post-action listener: _resource_record_post_action 03:46:05 INFO - [mozharness: 2017-08-23 10:46:05.306886Z] Finished run-tests step (success) 03:46:05 INFO - Running post-run listener: _resource_record_post_run 03:46:05 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5644288; Write bytes: 426848256; Read time: 3060; Write time: 284836 03:46:05 INFO - TinderboxPrint: CPU usage
13.1% 03:46:05 INFO - TinderboxPrint: I/O read bytes / time
5,644,288 / 3,060 03:46:05 INFO - TinderboxPrint: I/O write bytes / time
426,848,256 / 284,836 03:46:05 INFO - TinderboxPrint: CPU idle
8,288.0 (86.8%) 03:46:05 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 03:46:05 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 73728; Write bytes: 105922560; Read time: 120; Write time: 73004 03:46:05 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:05 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3203072; Write bytes: 320925696; Read time: 2356; Write time: 211832 03:46:05 INFO - Running post-run listener: _upload_blobber_files 03:46:05 INFO - Blob upload gear active. 03:46:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:07 INFO - (blobuploader) - INFO - Done attempting. 03:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:13 INFO - (blobuploader) - INFO - Done attempting. 03:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:13 INFO - (blobuploader) - INFO - Done attempting. 03:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:14 INFO - (blobuploader) - INFO - Done attempting. 03:46:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:14 INFO - Return code: 0 03:46:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5141e6bcf25de9da8086bebba057e0aeee6fcc6ae0db176c9655bff41a2f9d86601e69fa5dc18617a004f97a99c00a6786889c72ece2bf86505fefa90248c995", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43b45bb897bfb97e7bc0e7d2f6a388e76007f5a4b74e8d8ab9a0df28d6117b364319fa0d17ef237df03480f857174d229288777215faa4e78c4e0b8b28e15e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b10fcd39cc5af4284db66246625839a9da19d16593c607b78d027bf8851bc91a2bfe0bd845e5c8a351473485842d905ff1e64072d87e63fcd6cf981097a964", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b3f4c87accd408fae898d313a9bac779e63341a447e8bdbc24adaaa118c24272073d772704a6af43488b220676c2f59e80925896ccc56a6559ce38e274c96b"} 03:46:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:14 INFO - Contents: 03:46:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5141e6bcf25de9da8086bebba057e0aeee6fcc6ae0db176c9655bff41a2f9d86601e69fa5dc18617a004f97a99c00a6786889c72ece2bf86505fefa90248c995", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43b45bb897bfb97e7bc0e7d2f6a388e76007f5a4b74e8d8ab9a0df28d6117b364319fa0d17ef237df03480f857174d229288777215faa4e78c4e0b8b28e15e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b10fcd39cc5af4284db66246625839a9da19d16593c607b78d027bf8851bc91a2bfe0bd845e5c8a351473485842d905ff1e64072d87e63fcd6cf981097a964", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b3f4c87accd408fae898d313a9bac779e63341a447e8bdbc24adaaa118c24272073d772704a6af43488b220676c2f59e80925896ccc56a6559ce38e274c96b"} 03:46:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:14 INFO - Copying logs to upload dir... 03:46:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.342671 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-23 03:46:14.811752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:14.820537) ========= 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=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5141e6bcf25de9da8086bebba057e0aeee6fcc6ae0db176c9655bff41a2f9d86601e69fa5dc18617a004f97a99c00a6786889c72ece2bf86505fefa90248c995", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43b45bb897bfb97e7bc0e7d2f6a388e76007f5a4b74e8d8ab9a0df28d6117b364319fa0d17ef237df03480f857174d229288777215faa4e78c4e0b8b28e15e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b10fcd39cc5af4284db66246625839a9da19d16593c607b78d027bf8851bc91a2bfe0bd845e5c8a351473485842d905ff1e64072d87e63fcd6cf981097a964", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b3f4c87accd408fae898d313a9bac779e63341a447e8bdbc24adaaa118c24272073d772704a6af43488b220676c2f59e80925896ccc56a6559ce38e274c96b"} build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011014 build_url: 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5141e6bcf25de9da8086bebba057e0aeee6fcc6ae0db176c9655bff41a2f9d86601e69fa5dc18617a004f97a99c00a6786889c72ece2bf86505fefa90248c995", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d43b45bb897bfb97e7bc0e7d2f6a388e76007f5a4b74e8d8ab9a0df28d6117b364319fa0d17ef237df03480f857174d229288777215faa4e78c4e0b8b28e15e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b10fcd39cc5af4284db66246625839a9da19d16593c607b78d027bf8851bc91a2bfe0bd845e5c8a351473485842d905ff1e64072d87e63fcd6cf981097a964", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81b3f4c87accd408fae898d313a9bac779e63341a447e8bdbc24adaaa118c24272073d772704a6af43488b220676c2f59e80925896ccc56a6559ce38e274c96b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:14.846869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:14.849265) ========= 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=9bfb7e13875ed353a705960e000001c0-1503483912.673044-2017476893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:46:14.931957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:46:14.934322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:46:14.934648) ========= ========= Total master_lag: 0.29 =========