builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1504866193.32 results: success (0) revision: 50857982881ae7803ceb438fee90650a282f7f05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.321699) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.322205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.322519) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.340158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.340469) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 03:23:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.4M=0s 2017-09-08 03:23:13 (41.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.451750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.452082) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021067 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:13.502153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 03:23:13.502497) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 50857982881ae7803ceb438fee90650a282f7f05 --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 50857982881ae7803ceb438fee90650a282f7f05 --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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 03:23:13,554 truncating revision to first 12 chars 2017-09-08 03:23:13,554 Setting DEBUG logging. 2017-09-08 03:23:13,554 attempt 1/10 2017-09-08 03:23:13,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/50857982881a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 03:23:14,260 unpacking tar archive at: mozilla-central-50857982881a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.010040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 03:23:14.529040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:14.529370) ========= script_repo_revision: 50857982881ae7803ceb438fee90650a282f7f05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:14.529818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:14.530112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 03:23:14.543647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-08 03:23:14.543989) ========= /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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:14 INFO - MultiFileLogger online at 20170908 03:23:14 in /builds/slave/test 03:23:14 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:23:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:14 INFO - {'append_to_log': False, 03:23:14 INFO - 'base_work_dir': '/builds/slave/test', 03:23:14 INFO - 'blob_upload_branch': 'Firefox', 03:23:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:14 INFO - 'branch': 'Firefox', 03:23:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:14 INFO - 'code_coverage': False, 03:23:14 INFO - 'config_files': ('talos/linux_config.py',), 03:23:14 INFO - 'default_actions': ('clobber', 03:23:14 INFO - 'read-buildbot-config', 03:23:14 INFO - 'download-and-extract', 03:23:14 INFO - 'populate-webroot', 03:23:14 INFO - 'create-virtualenv', 03:23:14 INFO - 'install', 03:23:14 INFO - 'setup-mitmproxy', 03:23:14 INFO - 'run-tests'), 03:23:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:14 INFO - 'disable_ccov_upload': False, 03:23:14 INFO - 'disable_stylo': False, 03:23:14 INFO - 'download_minidump_stackwalk': True, 03:23:14 INFO - 'download_symbols': 'ondemand', 03:23:14 INFO - 'enable_stylo': False, 03:23:14 INFO - 'enable_webrender': False, 03:23:14 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:23:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:14 INFO - 'gecko_profile': False, 03:23:14 INFO - 'gecko_profile_interval': 0, 03:23:14 INFO - 'installer_path': 'installer.exe', 03:23:14 INFO - 'log_level': 'info', 03:23:14 INFO - 'log_name': 'talos', 03:23:14 INFO - 'log_to_console': True, 03:23:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:14 INFO - 'opt_config_files': (), 03:23:14 INFO - 'pip_index': False, 03:23:14 INFO - 'suite': 'dromaeojs-e10s', 03:23:14 INFO - 'system_bits': '32', 03:23:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:14 INFO - 'title': 'talos-linux64-ix-014', 03:23:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:14 INFO - 'use_talos_json': True, 03:23:14 INFO - 'verify': 'False', 03:23:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:14 INFO - 'work_dir': 'build'} 03:23:14 INFO - [mozharness: 2017-09-08 10:23:14.737098Z] Running clobber step. 03:23:14 INFO - Running pre-action listener: _resource_record_pre_action 03:23:14 INFO - Running main action method: clobber 03:23:14 INFO - rmtree: /builds/slave/test/build 03:23:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:15 INFO - Running post-action listener: _resource_record_post_action 03:23:15 INFO - [mozharness: 2017-09-08 10:23:15.858096Z] Finished clobber step (success) 03:23:15 INFO - [mozharness: 2017-09-08 10:23:15.858195Z] Running read-buildbot-config step. 03:23:15 INFO - Running pre-action listener: _resource_record_pre_action 03:23:15 INFO - Running main action method: read_buildbot_config 03:23:15 INFO - Using buildbot properties: 03:23:15 INFO - { 03:23:15 INFO - "project": "", 03:23:15 INFO - "product": "firefox", 03:23:15 INFO - "who": "archaeopteryx@coole-files.de", 03:23:15 INFO - "installer_path": "public/build/target.tar.bz2", 03:23:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:23:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:23:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:23:15 INFO - "stage_platform": "linux64-pgo", 03:23:15 INFO - "basedir": "/builds/slave/test", 03:23:15 INFO - "buildnumber": 167, 03:23:15 INFO - "platform": "ubuntu64_hw", 03:23:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:23:15 INFO - "slavebuilddir": "test", 03:23:15 INFO - "taskId": "GdjW-2CRQKyO0-3sAmfGUA", 03:23:15 INFO - "branch": "mozilla-central", 03:23:15 INFO - "script_repo_revision": "production", 03:23:15 INFO - "revision": "50857982881ae7803ceb438fee90650a282f7f05", 03:23:15 INFO - "slavename": "talos-linux64-ix-014", 03:23:15 INFO - "repo_path": "mozilla-central" 03:23:15 INFO - } 03:23:15 INFO - Finding installer, test and symbols from parent task. 03:23:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdjW-2CRQKyO0-3sAmfGUA'}, attempt #1 03:23:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdjW-2CRQKyO0-3sAmfGUA'}, attempt #1 03:23:16 INFO - Task dependencies: dEKpo6HVSlahaV5oZkm5zA 03:23:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA'}, attempt #1 03:23:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 03:23:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.test_packages.json 03:23:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.crashreporter-symbols.zip 03:23:17 INFO - Running post-action listener: _resource_record_post_action 03:23:17 INFO - [mozharness: 2017-09-08 10:23:17.307708Z] Finished read-buildbot-config step (success) 03:23:17 INFO - [mozharness: 2017-09-08 10:23:17.307925Z] Running download-and-extract step. 03:23:17 INFO - Running pre-action listener: _resource_record_pre_action 03:23:17 INFO - Running main action method: download_and_extract 03:23:17 INFO - mkdir: /builds/slave/test/build/tests 03:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:17 INFO - trying https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.test_packages.json 03:23:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:23:17 INFO - Downloaded 989 bytes. 03:23:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:23:17 INFO - Using the following test package requirements: 03:23:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:23:17 INFO - u'common': [u'target.common.tests.zip'], 03:23:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:23:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:23:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:23:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:23:17 INFO - u'mozbase': [u'target.common.tests.zip'], 03:23:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:23:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:23:17 INFO - u'web-platform': [u'target.common.tests.zip', 03:23:17 INFO - u'target.web-platform.tests.tar.gz'], 03:23:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:23:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.common.tests.zip 03:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.common.tests.zip into memory 03:23:18 INFO - Content-Length response header: 55689916 03:23:18 INFO - Bytes received: 55689916 03:23:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.talos.tests.zip 03:23:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:23:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.talos.tests.zip into memory 03:23:30 INFO - Content-Length response header: 14496665 03:23:30 INFO - Bytes received: 14496665 03:23:31 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:23:31 INFO - trying https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 03:23:31 INFO - Downloading https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:23:32 INFO - Downloaded 63558053 bytes. 03:23:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 03:23:32 INFO - mkdir: /builds/slave/test/properties 03:23:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:32 INFO - Contents: 03:23:32 INFO - build_url:https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 03:23:32 INFO - Running post-action listener: _resource_record_post_action 03:23:32 INFO - Running post-action listener: find_tests_for_verification 03:23:32 INFO - Running post-action listener: set_extra_try_arguments 03:23:32 INFO - [mozharness: 2017-09-08 10:23:32.164528Z] Finished download-and-extract step (success) 03:23:32 INFO - [mozharness: 2017-09-08 10:23:32.164762Z] Running populate-webroot step. 03:23:32 INFO - Running pre-action listener: _resource_record_pre_action 03:23:32 INFO - Running main action method: populate_webroot 03:23:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:32 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['tresize', 03:23:32 INFO - 'tcanvasmark']}, 03:23:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:32 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['dromaeo_css', 03:23:32 INFO - 'kraken']}, 03:23:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:32 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'tests': ['damp', 'tps']}, 03:23:32 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['damp', 'tps']}, 03:23:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:32 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['dromaeo_dom']}, 03:23:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:23:32 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['basic_compositor_video', 03:23:32 INFO - 'glvideo']}, 03:23:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:23:32 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['ts_paint_webext', 03:23:32 INFO - 'tp5o_webext']}, 03:23:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:32 INFO - 'ts_paint', 03:23:32 INFO - 'tpaint', 03:23:32 INFO - 'sessionrestore', 03:23:32 INFO - 'sessionrestore_many_windows', 03:23:32 INFO - 'sessionrestore_no_auto_restore', 03:23:32 INFO - 'tabpaint']}, 03:23:32 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['a11yr', 03:23:32 INFO - 'ts_paint', 03:23:32 INFO - 'tpaint', 03:23:32 INFO - 'sessionrestore', 03:23:32 INFO - 'sessionrestore_many_windows', 03:23:32 INFO - 'sessionrestore_no_auto_restore', 03:23:32 INFO - 'tabpaint']}, 03:23:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:23:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:23:32 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['bloom_basic_singleton']}, 03:23:32 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['bloom_basic']}, 03:23:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:32 INFO - 'tsvgr_opacity', 03:23:32 INFO - 'tart', 03:23:32 INFO - 'tscrollx', 03:23:32 INFO - 'tsvg_static']}, 03:23:32 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['tsvgx', 03:23:32 INFO - 'tsvgr_opacity', 03:23:32 INFO - 'tart', 03:23:32 INFO - 'tscrollx', 03:23:32 INFO - 'tsvg_static']}, 03:23:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:23:32 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo'], 03:23:32 INFO - 'tests': ['tp5o']}, 03:23:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:32 INFO - 'talos_options': ['--mitmproxy', 03:23:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:32 INFO - '--firstNonBlankPaint'], 03:23:32 INFO - 'tests': ['tp6_google', 03:23:32 INFO - 'tp6_youtube', 03:23:32 INFO - 'tp6_amazon', 03:23:32 INFO - 'tp6_facebook']}, 03:23:32 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo', 03:23:32 INFO - '--mitmproxy', 03:23:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:32 INFO - '--firstNonBlankPaint'], 03:23:32 INFO - 'tests': ['tp6_google', 03:23:32 INFO - 'tp6_youtube', 03:23:32 INFO - 'tp6_amazon', 03:23:32 INFO - 'tp6_facebook']}, 03:23:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:32 INFO - 'talos_options': ['--stylo-threads=1', 03:23:32 INFO - '--mitmproxy', 03:23:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:32 INFO - '--firstNonBlankPaint'], 03:23:32 INFO - 'tests': ['tp6_google', 03:23:32 INFO - 'tp6_youtube', 03:23:32 INFO - 'tp6_amazon', 03:23:32 INFO - 'tp6_facebook']}, 03:23:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--xperf_path', 03:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:32 INFO - 'tests': ['tp5n']}, 03:23:32 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:32 INFO - 'talos_options': ['--disable-stylo', 03:23:32 INFO - '--xperf_path', 03:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:32 INFO - 'tests': ['tp5n']}}} 03:23:32 INFO - Running post-action listener: _resource_record_post_action 03:23:32 INFO - [mozharness: 2017-09-08 10:23:32.181688Z] Finished populate-webroot step (success) 03:23:32 INFO - [mozharness: 2017-09-08 10:23:32.181794Z] Running create-virtualenv step. 03:23:32 INFO - Running pre-action listener: _resource_record_pre_action 03:23:32 INFO - Running main action method: create_virtualenv 03:23:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:32 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:32 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:23:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:23:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:33 INFO - Installing pip...............done. 03:23:33 INFO - Return code: 0 03:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:33 INFO - Reading from file tmpfile_stdout 03:23:33 INFO - Output received: 03:23:33 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:23:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:33 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:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:33 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:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:33 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:33 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:23:33 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:23:33 INFO - Using env: {'DISPLAY': ':0', 03:23:33 INFO - 'HOME': '/home/cltbld', 03:23:33 INFO - 'LANG': 'en_US.UTF-8', 03:23:33 INFO - 'LANGUAGE': 'en_US:en', 03:23:33 INFO - 'LOGNAME': 'cltbld', 03:23:33 INFO - 'MAIL': '/var/mail/cltbld', 03:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:33 INFO - 'MOZ_NO_REMOTE': '1', 03:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:33 INFO - 'NO_EM_RESTART': '1', 03:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:33 INFO - 'PWD': '/builds/slave/test', 03:23:33 INFO - 'SHELL': '/bin/bash', 03:23:33 INFO - 'SHLVL': '1', 03:23:33 INFO - 'TERM': 'linux', 03:23:33 INFO - 'TMOUT': '86400', 03:23:33 INFO - 'USER': 'cltbld', 03:23:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:33 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:23:34 INFO - Downloading/unpacking pip>=1.5 03:23:34 INFO - Running setup.py egg_info for package pip 03:23:34 INFO - warning: no files found matching 'pip/cacert.pem' 03:23:34 INFO - warning: no files found matching '*.html' under directory 'docs' 03:23:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:23:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:23:34 INFO - Installing collected packages: pip 03:23:34 INFO - Found existing installation: pip 1.1 03:23:34 INFO - Uninstalling pip: 03:23:34 INFO - Successfully uninstalled pip 03:23:34 INFO - Running setup.py install for pip 03:23:34 INFO - warning: no files found matching 'pip/cacert.pem' 03:23:34 INFO - warning: no files found matching '*.html' under directory 'docs' 03:23:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:23:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:23:34 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:23:34 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:23:34 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:23:34 INFO - Successfully installed pip 03:23:34 INFO - Cleaning up... 03:23:34 INFO - Return code: 0 03:23:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:34 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:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:34 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:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:34 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:34 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:23:34 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:23:34 INFO - Using env: {'DISPLAY': ':0', 03:23:34 INFO - 'HOME': '/home/cltbld', 03:23:34 INFO - 'LANG': 'en_US.UTF-8', 03:23:34 INFO - 'LANGUAGE': 'en_US:en', 03:23:34 INFO - 'LOGNAME': 'cltbld', 03:23:34 INFO - 'MAIL': '/var/mail/cltbld', 03:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:34 INFO - 'MOZ_NO_REMOTE': '1', 03:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:34 INFO - 'NO_EM_RESTART': '1', 03:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:34 INFO - 'PWD': '/builds/slave/test', 03:23:34 INFO - 'SHELL': '/bin/bash', 03:23:34 INFO - 'SHLVL': '1', 03:23:34 INFO - 'TERM': 'linux', 03:23:34 INFO - 'TMOUT': '86400', 03:23:34 INFO - 'USER': 'cltbld', 03:23:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:34 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:34 INFO - Downloading/unpacking psutil>=3.1.1 03:23:34 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:23:34 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:23:34 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:23:34 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:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:35 INFO - Installing collected packages: psutil 03:23:35 INFO - Running setup.py install for psutil 03:23:35 INFO - building 'psutil._psutil_linux' extension 03:23:35 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:23:36 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:23:36 INFO - building 'psutil._psutil_posix' extension 03:23:36 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:23:36 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:23:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:36 INFO - Successfully installed psutil 03:23:36 INFO - Cleaning up... 03:23:36 INFO - Return code: 0 03:23:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:36 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:36 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:23:36 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:23:36 INFO - Using env: {'DISPLAY': ':0', 03:23:36 INFO - 'HOME': '/home/cltbld', 03:23:36 INFO - 'LANG': 'en_US.UTF-8', 03:23:36 INFO - 'LANGUAGE': 'en_US:en', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MAIL': '/var/mail/cltbld', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SHLVL': '1', 03:23:36 INFO - 'TERM': 'linux', 03:23:36 INFO - 'TMOUT': '86400', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - '_': '/tools/buildbot/bin/python'} 03:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:36 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:23:36 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:23:36 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:23:36 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:23:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:37 INFO - Installing collected packages: mozsystemmonitor 03:23:37 INFO - Running setup.py install for mozsystemmonitor 03:23:37 INFO - Successfully installed mozsystemmonitor 03:23:37 INFO - Cleaning up... 03:23:38 INFO - Return code: 0 03:23:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:38 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:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:38 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:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:38 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:38 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:23:38 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:23:38 INFO - Using env: {'DISPLAY': ':0', 03:23:38 INFO - 'HOME': '/home/cltbld', 03:23:38 INFO - 'LANG': 'en_US.UTF-8', 03:23:38 INFO - 'LANGUAGE': 'en_US:en', 03:23:38 INFO - 'LOGNAME': 'cltbld', 03:23:38 INFO - 'MAIL': '/var/mail/cltbld', 03:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:38 INFO - 'MOZ_NO_REMOTE': '1', 03:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:38 INFO - 'NO_EM_RESTART': '1', 03:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:38 INFO - 'PWD': '/builds/slave/test', 03:23:38 INFO - 'SHELL': '/bin/bash', 03:23:38 INFO - 'SHLVL': '1', 03:23:38 INFO - 'TERM': 'linux', 03:23:38 INFO - 'TMOUT': '86400', 03:23:38 INFO - 'USER': 'cltbld', 03:23:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:38 INFO - '_': '/tools/buildbot/bin/python'} 03:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:38 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:23:38 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:23:38 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:23:38 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:23:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:39 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:23:39 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:23:39 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:23:39 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:23:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:39 INFO - warning: no files found matching '*.txt' 03:23:39 INFO - no previously-included directories found matching 'build' 03:23:39 INFO - no previously-included directories found matching 'dist' 03:23:39 INFO - no previously-included directories found matching '.git*' 03:23:39 INFO - Installing collected packages: jsonschema, functools32 03:23:39 INFO - Running setup.py install for functools32 03:23:40 INFO - warning: no files found matching '*.txt' 03:23:40 INFO - no previously-included directories found matching 'build' 03:23:40 INFO - no previously-included directories found matching 'dist' 03:23:40 INFO - no previously-included directories found matching '.git*' 03:23:40 INFO - Successfully installed jsonschema functools32 03:23:40 INFO - Cleaning up... 03:23:40 INFO - Return code: 0 03:23:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23:40 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:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:40 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:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:40 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:40 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:23:40 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:23:40 INFO - Using env: {'DISPLAY': ':0', 03:23:40 INFO - 'HOME': '/home/cltbld', 03:23:40 INFO - 'LANG': 'en_US.UTF-8', 03:23:40 INFO - 'LANGUAGE': 'en_US:en', 03:23:40 INFO - 'LOGNAME': 'cltbld', 03:23:40 INFO - 'MAIL': '/var/mail/cltbld', 03:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:40 INFO - 'MOZ_NO_REMOTE': '1', 03:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:40 INFO - 'NO_EM_RESTART': '1', 03:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:40 INFO - 'PWD': '/builds/slave/test', 03:23:40 INFO - 'SHELL': '/bin/bash', 03:23:40 INFO - 'SHLVL': '1', 03:23:40 INFO - 'TERM': 'linux', 03:23:40 INFO - 'TMOUT': '86400', 03:23:40 INFO - 'USER': 'cltbld', 03:23:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:40 INFO - '_': '/tools/buildbot/bin/python'} 03:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:40 INFO - Cleaning up... 03:23:40 INFO - Return code: 0 03:23:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:40 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:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:40 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:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:40 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:40 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:23:40 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:23:40 INFO - Using env: {'DISPLAY': ':0', 03:23:40 INFO - 'HOME': '/home/cltbld', 03:23:40 INFO - 'LANG': 'en_US.UTF-8', 03:23:40 INFO - 'LANGUAGE': 'en_US:en', 03:23:40 INFO - 'LOGNAME': 'cltbld', 03:23:40 INFO - 'MAIL': '/var/mail/cltbld', 03:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:40 INFO - 'MOZ_NO_REMOTE': '1', 03:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:40 INFO - 'NO_EM_RESTART': '1', 03:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:40 INFO - 'PWD': '/builds/slave/test', 03:23:40 INFO - 'SHELL': '/bin/bash', 03:23:40 INFO - 'SHLVL': '1', 03:23:40 INFO - 'TERM': 'linux', 03:23:40 INFO - 'TMOUT': '86400', 03:23:40 INFO - 'USER': 'cltbld', 03:23:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:40 INFO - '_': '/tools/buildbot/bin/python'} 03:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:40 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:23:40 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:23:40 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:23:40 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:23:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:42 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:23:42 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:23:42 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:23:42 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:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:42 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:23:42 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:23:42 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:23:42 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:23:42 INFO - Downloading docopt-0.6.1.tar.gz 03:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:42 INFO - Running setup.py install for blobuploader 03:23:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:42 INFO - Running setup.py install for requests 03:23:43 INFO - Running setup.py install for docopt 03:23:43 INFO - Successfully installed blobuploader requests docopt 03:23:43 INFO - Cleaning up... 03:23:43 INFO - Return code: 0 03:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:43 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:43 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:23:43 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:23:43 INFO - Using env: {'DISPLAY': ':0', 03:23:43 INFO - 'HOME': '/home/cltbld', 03:23:43 INFO - 'LANG': 'en_US.UTF-8', 03:23:43 INFO - 'LANGUAGE': 'en_US:en', 03:23:43 INFO - 'LOGNAME': 'cltbld', 03:23:43 INFO - 'MAIL': '/var/mail/cltbld', 03:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:43 INFO - 'MOZ_NO_REMOTE': '1', 03:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:43 INFO - 'NO_EM_RESTART': '1', 03:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:43 INFO - 'PWD': '/builds/slave/test', 03:23:43 INFO - 'SHELL': '/bin/bash', 03:23:43 INFO - 'SHLVL': '1', 03:23:43 INFO - 'TERM': 'linux', 03:23:43 INFO - 'TMOUT': '86400', 03:23:43 INFO - 'USER': 'cltbld', 03:23:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:43 INFO - '_': '/tools/buildbot/bin/python'} 03:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:43 INFO - Running setup.py (path:/tmp/pip-5Re2kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:43 INFO - Running setup.py (path:/tmp/pip-UUyaU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:43 INFO - Running setup.py (path:/tmp/pip-T2rn5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:43 INFO - Running setup.py (path:/tmp/pip-4i_AIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:43 INFO - Running setup.py (path:/tmp/pip-tbPnkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:43 INFO - Running setup.py (path:/tmp/pip-f00wsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:43 INFO - Running setup.py (path:/tmp/pip-2qBUKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:43 INFO - Running setup.py (path:/tmp/pip-e68920-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:44 INFO - Running setup.py (path:/tmp/pip-GAygRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:44 INFO - Running setup.py (path:/tmp/pip-hopaXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:44 INFO - Running setup.py (path:/tmp/pip-1WgsCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:44 INFO - Running setup.py (path:/tmp/pip-6GsVJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:44 INFO - Running setup.py (path:/tmp/pip-ehHEIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:44 INFO - Running setup.py (path:/tmp/pip-z3xhY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:44 INFO - Running setup.py (path:/tmp/pip-SzOAlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:44 INFO - Running setup.py (path:/tmp/pip-nCy7v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:44 INFO - Running setup.py (path:/tmp/pip-r1aq1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:44 INFO - Running setup.py install for manifestparser 03:23:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:44 INFO - Running setup.py install for mozcrash 03:23:44 INFO - Running setup.py install for mozdebug 03:23:44 INFO - Running setup.py install for mozdevice 03:23:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozfile 03:23:45 INFO - Running setup.py install for mozhttpd 03:23:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozinfo 03:23:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozInstall 03:23:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozleak 03:23:45 INFO - Running setup.py install for mozlog 03:23:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for moznetwork 03:23:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozprocess 03:23:45 INFO - Running setup.py install for mozprofile 03:23:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozrunner 03:23:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozscreenshot 03:23:46 INFO - Running setup.py install for moztest 03:23:46 INFO - Running setup.py install for mozversion 03:23:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:46 INFO - Cleaning up... 03:23:46 INFO - Return code: 0 03:23:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:46 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:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:46 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:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:46 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:46 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:23:46 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:23:46 INFO - Using env: {'DISPLAY': ':0', 03:23:46 INFO - 'HOME': '/home/cltbld', 03:23:46 INFO - 'LANG': 'en_US.UTF-8', 03:23:46 INFO - 'LANGUAGE': 'en_US:en', 03:23:46 INFO - 'LOGNAME': 'cltbld', 03:23:46 INFO - 'MAIL': '/var/mail/cltbld', 03:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:46 INFO - 'MOZ_NO_REMOTE': '1', 03:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:46 INFO - 'NO_EM_RESTART': '1', 03:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:46 INFO - 'PWD': '/builds/slave/test', 03:23:46 INFO - 'SHELL': '/bin/bash', 03:23:46 INFO - 'SHLVL': '1', 03:23:46 INFO - 'TERM': 'linux', 03:23:46 INFO - 'TMOUT': '86400', 03:23:46 INFO - 'USER': 'cltbld', 03:23:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:46 INFO - '_': '/tools/buildbot/bin/python'} 03:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:46 INFO - Running setup.py (path:/tmp/pip-E6o6gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:46 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:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:46 INFO - Running setup.py (path:/tmp/pip-6r6dby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:46 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:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:46 INFO - Running setup.py (path:/tmp/pip-7PvVuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:46 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:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:46 INFO - Running setup.py (path:/tmp/pip-ie7UUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:46 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:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:46 INFO - Running setup.py (path:/tmp/pip-B68nID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:46 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:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:47 INFO - Running setup.py (path:/tmp/pip-dDU8ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:47 INFO - Running setup.py (path:/tmp/pip-yue7O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:47 INFO - Running setup.py (path:/tmp/pip-Bx2CfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:47 INFO - Running setup.py (path:/tmp/pip-F4ZBFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:47 INFO - Running setup.py (path:/tmp/pip-X_PNMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:47 INFO - Running setup.py (path:/tmp/pip-USTZXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:47 INFO - Running setup.py (path:/tmp/pip-A9ndqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:47 INFO - Running setup.py (path:/tmp/pip-JT92Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:47 INFO - Running setup.py (path:/tmp/pip-dRJj0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:47 INFO - Running setup.py (path:/tmp/pip-5YXDLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:47 INFO - Running setup.py (path:/tmp/pip-xfexdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:47 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:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:47 INFO - Running setup.py (path:/tmp/pip-ASjFOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:47 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:23:47 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:23:47 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:23:47 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:23:47 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:23:47 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:23:47 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:23:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:47 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:23:47 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:23:47 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:23:47 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:23:48 INFO - Downloading blessings-1.6.tar.gz 03:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:49 INFO - Installing collected packages: blessings 03:23:49 INFO - Running setup.py install for blessings 03:23:49 INFO - Successfully installed blessings 03:23:49 INFO - Cleaning up... 03:23:49 INFO - Return code: 0 03:23:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:49 INFO - Reading from file tmpfile_stdout 03:23:49 INFO - Current package versions: 03:23:49 INFO - argparse == 1.2.1 03:23:49 INFO - blessings == 1.6 03:23:49 INFO - blobuploader == 1.2.4 03:23:49 INFO - docopt == 0.6.1 03:23:49 INFO - functools32 == 3.2.3-2 03:23:49 INFO - jsonschema == 2.5.1 03:23:49 INFO - manifestparser == 1.1 03:23:49 INFO - mozInstall == 1.13 03:23:49 INFO - mozcrash == 1.0 03:23:49 INFO - mozdebug == 0.1 03:23:49 INFO - mozdevice == 0.51 03:23:49 INFO - mozfile == 1.2 03:23:49 INFO - mozhttpd == 0.7 03:23:49 INFO - mozinfo == 0.10 03:23:49 INFO - mozleak == 0.1 03:23:49 INFO - mozlog == 3.5 03:23:49 INFO - moznetwork == 0.27 03:23:49 INFO - mozprocess == 0.25 03:23:49 INFO - mozprofile == 0.28 03:23:49 INFO - mozrunner == 6.13 03:23:49 INFO - mozscreenshot == 0.1 03:23:49 INFO - mozsystemmonitor == 0.3 03:23:49 INFO - moztest == 0.8 03:23:49 INFO - mozversion == 1.4 03:23:49 INFO - psutil == 3.1.1 03:23:49 INFO - requests == 1.2.3 03:23:49 INFO - wsgiref == 0.1.2 03:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:49 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:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:49 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:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:49 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 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:49 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:23:49 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:23:49 INFO - Using env: {'DISPLAY': ':0', 03:23:49 INFO - 'HOME': '/home/cltbld', 03:23:49 INFO - 'LANG': 'en_US.UTF-8', 03:23:49 INFO - 'LANGUAGE': 'en_US:en', 03:23:49 INFO - 'LOGNAME': 'cltbld', 03:23:49 INFO - 'MAIL': '/var/mail/cltbld', 03:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:49 INFO - 'MOZ_NO_REMOTE': '1', 03:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:49 INFO - 'NO_EM_RESTART': '1', 03:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:49 INFO - 'PWD': '/builds/slave/test', 03:23:49 INFO - 'SHELL': '/bin/bash', 03:23:49 INFO - 'SHLVL': '1', 03:23:49 INFO - 'TERM': 'linux', 03:23:49 INFO - 'TMOUT': '86400', 03:23:49 INFO - 'USER': 'cltbld', 03:23:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:49 INFO - '_': '/tools/buildbot/bin/python'} 03:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:49 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:23:49 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:23:49 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:23:49 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:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:23:50 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:23:50 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:23:50 INFO - Installing collected packages: simplejson 03:23:50 INFO - Running setup.py install for simplejson 03:23:50 INFO - building 'simplejson._speedups' extension 03:23:50 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:23:51 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:23:51 INFO - Successfully installed simplejson 03:23:51 INFO - Cleaning up... 03:23:51 INFO - Return code: 0 03:23:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1688a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', '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:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:51 INFO - Using env: {'DISPLAY': ':0', 03:23:51 INFO - 'HOME': '/home/cltbld', 03:23:51 INFO - 'LANG': 'en_US.UTF-8', 03:23:51 INFO - 'LANGUAGE': 'en_US:en', 03:23:51 INFO - 'LOGNAME': 'cltbld', 03:23:51 INFO - 'MAIL': '/var/mail/cltbld', 03:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:51 INFO - 'MOZ_NO_REMOTE': '1', 03:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:51 INFO - 'NO_EM_RESTART': '1', 03:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:51 INFO - 'PWD': '/builds/slave/test', 03:23:51 INFO - 'SHELL': '/bin/bash', 03:23:51 INFO - 'SHLVL': '1', 03:23:51 INFO - 'TERM': 'linux', 03:23:51 INFO - 'TMOUT': '86400', 03:23:51 INFO - 'USER': 'cltbld', 03:23:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:51 INFO - '_': '/tools/buildbot/bin/python'} 03:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:52 INFO - Cleaning up... 03:23:52 INFO - Return code: 0 03:23:52 INFO - Running post-action listener: _resource_record_post_action 03:23:52 INFO - Running post-action listener: _start_resource_monitoring 03:23:52 INFO - Starting resource monitoring. 03:23:52 INFO - [mozharness: 2017-09-08 10:23:52.088863Z] Finished create-virtualenv step (success) 03:23:52 INFO - [mozharness: 2017-09-08 10:23:52.089378Z] Running install step. 03:23:52 INFO - Running pre-action listener: _resource_record_pre_action 03:23:52 INFO - Running main action method: install 03:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:52 INFO - Reading from file tmpfile_stdout 03:23:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:52 INFO - Reading from file tmpfile_stdout 03:23:52 INFO - Output received: 03:23:52 INFO - Usage: mozinstall [options] installer 03:23:52 INFO - Options: 03:23:52 INFO - -h, --help show this help message and exit 03:23:52 INFO - -d DEST, --destination=DEST 03:23:52 INFO - Directory to install application into. [default: 03:23:52 INFO - "/builds/slave/test"] 03:23:52 INFO - --app=APP Application being installed. [default: firefox] 03:23:52 INFO - mkdir: /builds/slave/test/build/application 03:23:52 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:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:24:08 INFO - Reading from file tmpfile_stdout 03:24:08 INFO - Output received: 03:24:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:08 INFO - Running post-action listener: _resource_record_post_action 03:24:08 INFO - [mozharness: 2017-09-08 10:24:08.822425Z] Finished install step (success) 03:24:08 INFO - [mozharness: 2017-09-08 10:24:08.822571Z] Running setup-mitmproxy step. 03:24:08 INFO - Running pre-action listener: _resource_record_pre_action 03:24:08 INFO - Running main action method: setup_mitmproxy 03:24:08 INFO - Skipping: mitmproxy is not required 03:24:08 INFO - Running post-action listener: _resource_record_post_action 03:24:08 INFO - [mozharness: 2017-09-08 10:24:08.823625Z] Finished setup-mitmproxy step (success) 03:24:08 INFO - [mozharness: 2017-09-08 10:24:08.823850Z] Running run-tests step. 03:24:08 INFO - Running pre-action listener: _resource_record_pre_action 03:24:08 INFO - Running pre-action listener: _set_gcov_prefix 03:24:08 INFO - Running main action method: run_tests 03:24:08 WARNING - Try message not found. 03:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:08 INFO - Python 2.7.3 03:24:08 INFO - Return code: 0 03:24:08 INFO - grabbing minidump binary from tooltool 03:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x182f090>, '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 0x182fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1829f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:24:08 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:24:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:08 INFO - Return code: 0 03:24:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:08 INFO - ENV: RUST_BACKTRACE is now full 03:24:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:08 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/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:24:08 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/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --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:24:08 INFO - Using env: {'DISPLAY': ':0', 03:24:08 INFO - 'HOME': '/home/cltbld', 03:24:08 INFO - 'LANG': 'en_US.UTF-8', 03:24:08 INFO - 'LANGUAGE': 'en_US:en', 03:24:08 INFO - 'LOGNAME': 'cltbld', 03:24:08 INFO - 'MAIL': '/var/mail/cltbld', 03:24:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:08 INFO - 'MOZ_NO_REMOTE': '1', 03:24:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:08 INFO - 'NO_EM_RESTART': '1', 03:24:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:08 INFO - 'PWD': '/builds/slave/test', 03:24:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:08 INFO - 'RUST_BACKTRACE': 'full', 03:24:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:24:08 INFO - 'SHELL': '/bin/bash', 03:24:08 INFO - 'SHLVL': '1', 03:24:08 INFO - 'TERM': 'linux', 03:24:08 INFO - 'TMOUT': '86400', 03:24:08 INFO - 'USER': 'cltbld', 03:24:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:08 INFO - '_': '/tools/buildbot/bin/python'} 03:24:08 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/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:24:09 INFO - mozversion application_buildid: 20170908090235 03:24:09 INFO - mozversion application_changeset: 50857982881ae7803ceb438fee90650a282f7f05 03:24:09 INFO - mozversion application_display_name: Nightly 03:24:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:09 INFO - mozversion application_name: Firefox 03:24:09 INFO - mozversion application_remotingname: firefox 03:24:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:24:09 INFO - mozversion application_vendor: Mozilla 03:24:09 INFO - mozversion application_version: 57.0a1 03:24:09 INFO - mozversion platform_buildid: 20170908090235 03:24:09 INFO - mozversion platform_changeset: 50857982881ae7803ceb438fee90650a282f7f05 03:24:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:24:09 INFO - mozversion platform_version: 57.0a1 03:24:09 INFO - using testdate: 1504866249 03:24:09 INFO - actual date: 1504866249 03:24:09 INFO - starting webserver on 'localhost:39417' 03:24:09 INFO - SUITE-START | Running 2 tests 03:24:09 INFO - TEST-START | dromaeo_css 03:24:09 INFO - Initialising browser for dromaeo_css test... 03:24:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39417/getInfo.html -profile /tmp/tmpkL_bIE/profile 03:24:09 INFO - TEST-INFO | started process 5194 (/builds/slave/test/build/application/firefox/firefox http://localhost:39417/getInfo.html) 03:24:14 INFO - TEST-INFO | 5194: exit 0 03:24:14 INFO - Browser initialized. 03:24:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:14 INFO - Using env: {'DISPLAY': ':0', 03:24:14 INFO - 'HOME': '/home/cltbld', 03:24:14 INFO - 'JSGC_DISABLE_POISONING': '1', 03:24:14 INFO - 'LANG': 'en_US.UTF-8', 03:24:14 INFO - 'LANGUAGE': 'en_US:en', 03:24:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:24:14 INFO - 'LOGNAME': 'cltbld', 03:24:14 INFO - 'MAIL': '/var/mail/cltbld', 03:24:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:14 INFO - 'MOZ_CRASHREPORTER': '1', 03:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:24:14 INFO - 'MOZ_NO_REMOTE': '1', 03:24:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:14 INFO - 'NO_EM_RESTART': '1', 03:24:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:14 INFO - 'PWD': '/builds/slave/test', 03:24:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:14 INFO - 'RUST_BACKTRACE': 'full', 03:24:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:24:14 INFO - 'SHELL': '/bin/bash', 03:24:14 INFO - 'SHLVL': '1', 03:24:14 INFO - 'TERM': 'linux', 03:24:14 INFO - 'TMOUT': '86400', 03:24:14 INFO - 'USER': 'cltbld', 03:24:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:14 INFO - '_': '/tools/buildbot/bin/python'} 03:24:14 INFO - TEST-INFO | started process 5393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkL_bIE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:15 INFO - PID 5393 | 03:24:15 INFO - PID 5393 | (/builds/slave/test/build/application/firefox/firefox:5445): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:24:15 INFO - PID 5393 | 03:24:25 INFO - PID 5393 | RSS: Main: 166064128 03:24:25 INFO - PID 5393 | 03:27:22 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39417/tests/dromaeo/cssquery-ext.html) 03:27:23 INFO - PID 5393 | RSS: Main: 168091648 03:27:23 INFO - PID 5393 | 03:30:24 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-ext.html (next: http://localhost:39417/tests/dromaeo/cssquery-jquery.html) 03:30:25 INFO - PID 5393 | RSS: Main: 164552704 03:30:25 INFO - PID 5393 | 03:33:26 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39417/tests/dromaeo/cssquery-mootools.html) 03:33:27 INFO - PID 5393 | RSS: Main: 166944768 03:33:27 INFO - PID 5393 | 03:36:29 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39417/tests/dromaeo/cssquery-prototype.html) 03:36:29 INFO - PID 5393 | RSS: Main: 165289984 03:36:29 INFO - PID 5393 | 03:39:32 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39417/tests/dromaeo/cssquery-yui.html) 03:39:33 INFO - PID 5393 | RSS: Main: 166887424 03:39:33 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | Cycle 1(1): loaded http://localhost:39417/tests/dromaeo/cssquery-yui.html (next: http://localhost:39417/tests/dromaeo/cssquery-dojo.html) 03:42:34 INFO - PID 5393 | RSS: Main: 169619456 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | __start_tp_report 03:42:34 INFO - PID 5393 | _x_x_mozilla_page_load 03:42:34 INFO - PID 5393 | _x_x_mozilla_page_load_details 03:42:34 INFO - PID 5393 | |i|pagename|runs| 03:42:34 INFO - PID 5393 | |0;dojo.html;3787.356149454593;3796.6013568575318;3811.733178677493;3814.6757525610324;3838.9424158637626;6147.1701320321745;6219.751209951596;6224.502039836813;6274.403931626493;6284.402981716741;6316.368363163681;6324.3043265240785;6342.778002769893;6365.777197798078;6416.679166041691;5576.498115169634;5720.513756330717;5736.4550367715;5786.074228123501;5787.47912687858;206.6872248157358;5462.0987537056335;5615.831525054255;5748.109043098306;5753.769849206027;5659.1511273309125;5663.886722265553;5737.454941780524;5737.569682273805;5759.769609215627;5654.886902261973;5665.631733937281;5739.626924249952;5742;5743.741531631045;5662.320521537442;5664.2636457260705;5744.540436765049;5749.741261643236;5750.539956803445;6288.465480434169;6308.2430108386825;6314.431701146918;6338.112664227012;6406.167198264196;6856.074429951943;6878.931210687879;6905;6907.309269073103;6929.029935808991;6923.446124310043;6924;6986.40615547679;7001.194862590816;7023.508354415193;6305.96847015762;6388.872222555523;6396.904046439307;6410.61536307823;6487.902681459782;6997.650117494105;7024.2273349931465;7036.542624729376;7097.077379940574;7168.856622867514;6784.830379240559;6788.728450862009;6802.489813264025;6812.897806532906;6831.04365388846;6833.760818371333;6838.179418469816;6855.383015528626;6858.451323894076;6945.513814032969;6701.698423570951;6763.560368576027;6823.737608542436;6834.931650683529;6913.619750913748;6801.761938332134;6819.318068193141;6828.2488926218075;6828.7268509259075;6834.624095674686;4951.554360107536;4982.850514484571;4993.975030124899;5000.549950504472;5095.006473737586;4598.88502787433;4622.422197225347;4635.768211589407;4646.767661616906;4649.116667833101;6321.3678632137335;6322.178116844872;6324.019776934582;6399.328070552618;6409.359064093554;6715.294894036154;6813.523053386215;6813.965930170318;6819.283975182534;6916.861662766817;6352.809415717444;6394.8721025579225;6396.680165991682;6407.038944158414;6417.582857114366;5531.778728850882;5569.66582005081;5618.85952851182;5620.831375058755;5628.155776633538;7122.715091396286;7140.5358651687475;7202.639868006579;7219.278072192738;7231.855362892713;6726.091977582963;6844.828879278058;6847.520673552903;6914.066601009001;6940.9652951734915;7033.120859892513;7077.398421134261;7146.7493188692815;7149.892751608626;7152.356287934111;6746.763863264959;6852.862942741217;6860.348266914635;6890.586564806128;6899.793006209822;6882.655867206519;6901.723931042702;6944.444444444332;6994.125734283215;7000.54496457749;6556.606603603799;6578.079068930258;6607.603543787388;6625.536212465274;6674.26583075871;6612.140421745143;6633.1045308882685;6645.933540664531;6659.134312539339;6676.9666151668935;6486.189226346707;6579.243387010555;6638.867222655616;6644.036614690939;6678.165229346332;6578.309277525982;6626.933730662825;6654;6723.630200339028;6773.593584384953;6491.740330386731;6515.381038801306;6516.869662606816;6521.902171467526;6526.314736952741 03:42:34 INFO - PID 5393 | |1;ext.html;923.385948344351;948.9715308540747;955.6464108279937;996;1002.0330381182158;43507.78246108769;44246;44260.114797704024;44267.55732442674;44418.55581444188;41242;43450.56549434505;43768.562314376846;43892.78053609736;44049.339259911125;7778.533288002724;7802.414818888577;7804.843903121934;7822.452428330019;7831.334336581397;8091.757247282591;8215.671373145067;8219.95890020552;8220.958895205546;8222.465539739927;8223.21879421454;8252.46358986664;8288.378371622153;8288.70989515367;8299.211574900375;8217.424780265384;8278.58607069647;8290.41967062306;8294.294984926288;8303.211194936532;8043.919560804434;8089.878651820228;8100.351971842298;8104.1085480597085;8108.108108108162;40561.391579126044;40745.18509629791;40815.387769183486;40916;40968.38547421791;3749.9625003749884;3791.071187559038;3791.184895247535;3792.051987003249;3792.791396473193;33062.50406243908;33247.6675233247;33315.500267496005;33355.499667504766;33365.16587085318;5387.218853266255;5508.614396992212;5525.530329921961;5612;5633.267675202238;214852;216630;216836;219908;226648.99999999834;52681.473185267656;52965.7351713239;53183.73408133012;53351;53399.19901201485;55347;55394.676319420156;55461.44538554563;55522;55623;14818.777718334233;14947.551573452596;14956.551303460914;14996.400143994118;15021.549353519413;11958.222715523463;11988.820167697491;11993.940030299967;11994.88005119955;11999.760004799855;13565.864341356657;13570.59288221355;13576.660583485493;13612.387442565108;13635.045546811629;5414.29614150158;5466.1527463243265;5540.833774986757;5618.52242559387;5648.446677163813;1100.5047728522197;1101.8677758669012;1102.399192440122;1106.446776611694;1113.6547670222094;24890;25046.624300635503;25049.24852254399;25089.74910250874;25293.620595691078;1165.609520810521;1179.8643156036994;1183.4910988274953;1184.496588949693;1185.7984142695761;13251.801222981663;13318.66703332405;13358;13368.465261389436;13531.45874165042;283276;284098;284111;285955;286251;58048;58053.4194658048;58372.416275837546;58387.66449341979;58391.416085839446;1490.3293517916982;1491.947781827631;1507.4271776724775;1518.5444366689949;1541.0599534284079;24724.13465528698;24845.87577062103;24855.87572062128;24856.254312370656;24898;37394.252114957;40904;40951;41038.589614103475;41090.38364424596;237987;238914;239229;239276;239930;33575.83212083924;34083.82958085293;35693.643063569034;35949;36571.71998980023;46479;46936.7653161732;47368.28947565858;47402.28896566623;47582.762086189345;33711.15722106967;33893.32213355768;34001.31997359989;34083;34582.82708586441;33875.15312117217;34342.31315373728;34488.310233794684;34798;34808.30383392369;39688.80155599204;39707.60292397154;39936.80031599823;40078.79960600178;40115;32485;33036.834815826725;33182.5022624656;33189.50215746718;33840.66159338375;24514.63228051545;24535.50928981446;25140.24579262625;25343.873280634216;25498.362540935883 03:42:34 INFO - PID 5393 | |2;jquery.html;578.1154833105351;587.7707693999341;589.5313225985341;593.3473179502548;595.5473839881689;22795.31614051579;23270.30189094328;23583.5283294334;23595.17416890409;23624.173153939573;24768.50462990739;25512.489750204986;25572.74427255727;25672.358191045187;25756.871215643896;6531.967340163293;6733.225679046899;6736;6736.05695202672;6740.460763138937;6461.256955450113;6557.082008518812;6567.310432404601;6783.491238157133;6811.897821532656;6803.387695107439;6804.353586409283;6805.115335006442;6810.931890681104;6813;6436.324185960453;6681.164854393225;6681.398674119304;6684.030815531769;6810.421114205298;6204.5967012144065;6209.96895015522;6221.626702397871;6229.065640154013;6241.563090583661;30316.393672126655;30911.536326955113;30950.226244343845;30961.845190773904;30984.53523197154;2173.413178441812;2223.444138965259;2239.1379318962154;2250.4036430345973;2251.122062395667;19213.423597292105;19905.303314384073;19918.00409979495;19931;19962.401127966183;2545.7963362930923;2546.5161619292276;2583.870806459688;2588.1588483742858;2607.15267538049;139372;145659;152578;161469.19265403715;161493;15402.460913868184;15593.766093508606;16003.439879604159;16032.599185020468;16205.351785928431;24819.5036099277;24915.5016899661;24927.5014499709;24939.376515586893;24945.251642450756;9372.5313734313;9460.668876589287;9496.050394960448;9530.618775248913;9666.516674166263;8305.584720763938;8311.210435008665;8367.665293388196;8419.70531031411;8450.957745211357;9406.858897116548;9420.811583768424;9613.807723845484;9744.951275243578;9848.803023939481;2754.6969833318317;2766.764824989858;2813.6904940456534;2834.6173266609158;2900.883964641391;1020.1736593359254;1038.5067093130854;1043.8956104389652;1050;1063.0963680871198;20295.59408811845;20505.692414613794;20810.79189208119;20970.37088887336;21201.575968480545;1090.8200146975819;1094.2559059839227;1099.4008265495324;1112.2825777373548;1123.0566324287638;11249.850041988257;11560.76878462426;11636.24364416327;11720.238184517979;11726.94136529312;547127;559658;566331;588752;599122;131978;135113;136637.99999999802;140236;140533.2973335127;1094.4746521669642;1139.9772004559863;1208.2750349790056;1211.6425654431964;1263.8736126387287;21559.35321940344;21932;21981.890090549445;22131.446713832283;22172.128490422016;63087.047562070366;63135;64470;64968.35031649623;68559.31440685729;79483;82847.5857620708;83478;83505;85106.57446712974;14840.10959342443;15010.324535395715;15058.849411506182;15112.622184445478;15150.772738409154;23323.06707731672;23540.76459235386;23693.289201323987;23772;23802.52394952126;18959.90520047391;19453.319133830813;19579.216831326587;19624.41126766199;19690.901545492754;17081.74377384365;17181.91409042947;17402.73895891537;17652.658914303494;17903.10484475797;18955.14701838393;19856.90071549633;20121.698174527686;20146.59706805885;20277.087531060843;14701.92649036748;14726.852731472549;14788.482403115839;14805.481808136663;14839.92580037093;19116.52208694738;19256;19280.807191927903;19287.324943626907;19299.710504342165 03:42:34 INFO - PID 5393 | |3;mootools.html;1442.5023366938406;1473.975586967057;1484.6140003599069;1492.4850926430377;1498.1086253679064;16393.426230081936;16987.91506042468;17035.48893533193;17045;17063.06153161577;16024;16040.438584649539;16044.278007489662;16052.43816466424;16073.115978621172;2694.9056783012647;2744.4922689302443;2744.931376715578;2749.766269867064;2752;2631.2500937232894;2724.4142509360486;2727.7954153438473;2731.3444773254373;2733.384988377619;2558.974410255892;2757.7793776497833;2759.4756996170763;2760.4479104179145;2768.6262354582077;2685.6508653875067;2689.1260340389454;2697.9730202698115;2707.891684332624;2710.864456777163;2523.4448421347274;2723.6323096381934;2724.91825245241;2734.343757498206;2736.329599248197;16907.408240711517;17030.318787248496;17049.7442538362;17052.062136582485;17063.317467301295;8016.759497215093;8310.83378332436;8316.750497485085;8317.625706843206;8329.167083291683;5312.92030619541;5400.108982017962;5505.146702261156;5513.8345849624575;5531.25328080708;2081.438011736838;2089.341857314941;2097.0877668214375;2105.5683584865064;2148.452144703106;29947.850260748557;30128.397432051457;30177.396452071054;30190;30201.69798302011;6527.151470308924;6536.346365363425;6559.376859198369;6658.83352916181;6734.966325168343;19217.61564768697;19307.710384344246;19332.130054147598;19371.225150994083;19377.031148442522;7744.535327880345;7970.083440404428;7974.122846486882;7974.322182614426;7976.960115199387;7320.890186647204;7352.89706544012;7396.260373962561;7421.666025028779;7423.9257607424315;5439.5104440600535;5643.604947653707;5649.796579334063;5676.858078548069;5686.857828554236;1606.4216881922498;1608.260200307848;1612.5404259785905;1617.7896873406617;1635.5665748576637;922.4373132389237;942.7831598732192;947.4788866123605;953.2516974175239;954.9809003820023;8075.313598344206;8126.634301456449;8135.79660508492;8149.796255093552;8229.25936665703;769.3114662377141;778.5562229529228;781.6912319633713;785.1794874356198;787.0751866556773;5520.751566179531;5822.941770582324;5895.882082358415;5965.492933100648;6094.238220222473;24380.26859194227;24770.628440573044;25393;25406.491870162492;25497.745022549538;23605.88197059004;23915.52168956611;24185.7581424187;24856.627150592394;24864.751352486244;12063.879361206276;12164.14850960442;12518.374081295899;12521.436535355748;12552.309622970643;9065.909340906506;9431.198348140484;9553.331266811534;9573.377730447499;9613.807723845624;20781.792182077985;21291.46771330729;21382.144714211256;21451.570968580854;21595.892020539795;21890;22197;22256.77743222547;22257.666135007665;22560.774392255866;13423.194608323533;13500.729985400041;13668.52160174389;13767.931160344135;13768.65578360549;15576.29906654226;15707.607309817346;15727.528174154793;15736;15749.68500629958;12418.627441176779;12578.811317830057;12649.114561980941;12772.233665979698;12805.743885122432;12054.09594280415;12250.509979600716;12381.876181238073;12482.375881206084;12492.750144996868;10939.726506837074;11180.10559155282;11187.944060279646;11192.21654484211;11199.552017919192;8331;8392;8471.322294216325;8493.702720404755;8534.957325213334;8031.237032481905;8181.509109453452;8182.427230093836;8229.25936665703;8240.21717936795 03:42:34 INFO - PID 5393 | |4;prototype.html;527.1012922966343;537.8816660334727;548.6406403805504;558.7876606889381;572.5391060196542;6168.501756788497;6231;6250.406146432653;6254.498200719714;6275.341089185638;6169.5989760665525;6182.474489668372;6203.875922481548;6224.564280500355;6229.221347331583;5095.439501654815;5102.234664800291;5103.41310749263;5107.361579802525;5121.923171152435;4828.879278018043;4909.263610458442;5057;5103.744812759366;5104.872378190538;4864.586510146624;4911.533404326583;4922.532359425867;4937.185364414867;4938.925916111261;4908.116539022974;4935.605151587864;4939.160342741725;4948.925766113512;4964.131277026524;4351.891202719926;4424.225760491901;4424.977875110604;4447.955520444786;4462.1968045751755;6003.559145805019;6034.396560343975;6059.667028194133;6073.301570319381;6095.878082438371;5790.392008839053;5799.333076696192;5803.9709801451145;5825.300963884361;5827.4650527020885;6614.636195009272;6633.237177724575;6634.303398143174;6639.76760813374;6647;4950.826721064782;4961.131801934647;5001.824936127255;5009.5491405773655;5012.172991456406;6675.232348279913;6792.830179245509;6836.897446538306;6872.209695884987;6882.380585747307;5111.718855462986;5124.385073791169;5125.641704948117;5146.485351464824;5150.922736158961;5176.559992400613;5198.870028249324;5210.192420174879;5215.400228973716;5218.712970786643;5763.510101641324;5775.556110972257;5783.306003279633;5791.276090488689;5794.8551286217335;6631;6641.501887358468;6665.866682666319;6670.366315200048;6695.631740254333;1765.2762367429293;1778.1287169286957;1791.9462416127537;1795.3895675470403;1795.5870149865605;1235.6972541727155;1279.9488020479262;1288.7937929931165;1289.071868254855;1291.8256035435284;6206.162168107338;6212.689365531705;6257.593256438408;6265.780697675559;6301.054841773679;6742.797716068526;6774.491913106537;6777.93222067773;6778.932210677929;6830.556013859084;6021.638701677914;6157.1072194532435;6174.8147555573405;6207.689615519206;6220.7511699531515;3506.526618906466;3531.29374125176;3541.9645803541634;3572.982135089308;3576.603675537396;6962.199347075151;6967.721291148398;6977.81377165883;7005.583073839517;7015.228324884259;6776.220734615484;6794.830129246809;6824.897626535606;6881.311868813179;6887.173539175231;6812.659367031728;6852.794416167523;6884.827879303058;6894.276101009422;6907.516473846783;6439.871202575829;6556.606603603799;6567.934320656732;6635.137432133792;6694.129763130956;6536.7712130075215;6574.145361103026;6630.403263706289;6651.0355998379;6661;6889.483288753263;6908.723651053901;6947.513674042769;6986.510944233854;6995.236881431704;5053.545180933734;5099.470158952374;5100.974495127501;5103.489651034867;5140.665856719302;6469.320721324381;6590.934090659032;6649.102371179829;6691.5315927884585;6770.6614669265355;6513.73945042193;6518.380753828379;6519.445847103049;6525.282218956006;6539.280679125388;6448.45188158993;6459.157970492968;6460.580062295936;6469.676516174267;6503.447206987459;6288.528360373082;6420.6468644225015;6425.518086143465;6437.678116094083;6468.773592924225;6536.444402225864;6540.640264785482;6588.670566471561;6593.901091483535;6600.702968366339;6345;6361;6394;6397.904031439439;6403.711832967434 03:42:34 INFO - PID 5393 | |5;yui.html;944.140831843023;995.2436148527117;997.4937843855778;998.2213873178923;1025.0313453786173;20571.794282057173;20966;20985.16059357628;21030.89484552579;21086.472838179016;17322.13389330535;17468.21393037313;18417.907910460428;18502.259909603632;18507.259709611633;966.5988614724898;989.2382865193797;991.1179050644931;991.2763682511735;997.2221667099637;1029.4183786160795;1054.8892366301504;1056.3028401255174;1070.2294348069377;1071.9732006699817;1106.4301884529473;1110.0398155595392;1112.5549780087988;1113.0427832064458;1113.6881673131536;1060.2843080920386;1094.518411898762;1105.309181761399;1109.4840898981972;1110.4947249001725;804.3967024731452;806.3267171911461;806.9515829050217;807.0154411617817;807.2049031703767;19943.202271909107;20054.699179512318;20105.899470502554;20264.290749823835;20297.797022029885;21927.342179734635;22978.54042919149;23050;23099.3070207894;23120.884395578083;17987.73018404725;18527;18612.34856780006;18644.067796610252;18787.906060469748;3964.32606456903;3974.125692347679;3976.8210430530694;3983.5817239190046;3986.142979259473;159232;159916;161684;161744;162500.18749906294;15929.601759955862;16067.196640167946;16287.429939952044;16460.588485287964;16597.751033734505;33925.15187120292;33931.151721206676;33933.490997635054;34129.31741365159;34160.31679366399;9700.708978730649;9810.31327807061;9823.852642210373;9828.262880284008;9836.655717049869;4643.3963584733765;4820.060088282751;4892.804287828518;4922.286268491049;4925.310456536088;5946.4053594641055;6096.329403765582;6098.1157732128595;6114.57197996136;6125.632462052202;1058.222206678091;1086.983695244572;1095.2059756676347;1097.5829184909683;1099.719571509276;737.6938570493185;749.4828568287863;753.4838635534676;765.689895592286;770.3452065744185;12207.755844883053;12387.19483233587;12505.06212034101;12983.805242921175;12984.935075324753;743.2938708227206;743.3012967810349;751.9699212031567;754.901862757838;772.0658003815334;5559;5598.832035038955;5660.688662123541;5669.971650141723;5784.305883294031;145228;146510;148222;148883.2555837214;151446;94820;97610.51194743981;113253.4337328308;120828.3958580219;128105;105358;109822.9999999984;110002.44998774955;111999.4400028011;112247.43876280566;13776;13859.653508662364;14271.928640356731;14284;14345.713085738436;52442;55929;56308.43691563032;57096.18439588686;58601;69263.65368173127;69572.34130770288;70482;71494;71512;20043.398698039084;20585.07367168451;20615.484612884196;20625.58748825045;20670.276540321018;22078.66881996739;22273;22427.21504747326;22437.775622243567;22469.887650561643;21571.460713482287;21838.126474940826;21917.12331506722;22026.88986555057;22032.44918876977;20994.895025524776;21177.470563236042;21206.893965530075;21330.78669213288;21409.357719267824;20369.592608147457;20417.285395011102;20522.281720139723;20539.38381848547;20616;15719.292631831824;15861.920690396935;15871.761923570924;16058.277377517807;16344.427945021867;15194.924025379802;15471.5358539244;15490.457833976208;15524.14617196065;15611.375544978073 03:42:34 INFO - PID 5393 | __end_tp_report 03:42:34 INFO - PID 5393 | __start_cc_report 03:42:34 INFO - PID 5393 | _x_x_mozilla_cycle_collect,391 03:42:34 INFO - PID 5393 | __end_cc_report 03:42:34 INFO - PID 5393 | __startTimestamp1504867354951__endTimestamp 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | ------- Summary: start ------- 03:42:34 INFO - PID 5393 | Number of tests: 6 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#0] dojo.html Cycles:165 Average:6289.45 Median:6578.08 stddev:892.60 (13.6%) stddev-sans-first:873.49 03:42:34 INFO - PID 5393 | Values: 3787.4 3796.6 3811.7 3814.7 3838.9 6147.2 6219.8 6224.5 6274.4 6284.4 6316.4 6324.3 6342.8 6365.8 6416.7 5576.5 5720.5 5736.5 5786.1 5787.5 206.7 5462.1 5615.8 5748.1 5753.8 5659.2 5663.9 5737.5 5737.6 5759.8 5654.9 5665.6 5739.6 5742.0 5743.7 5662.3 5664.3 5744.5 5749.7 5750.5 6288.5 6308.2 6314.4 6338.1 6406.2 6856.1 6878.9 6905.0 6907.3 6929.0 6923.4 6924.0 6986.4 7001.2 7023.5 6306.0 6388.9 6396.9 6410.6 6487.9 6997.7 7024.2 7036.5 7097.1 7168.9 6784.8 6788.7 6802.5 6812.9 6831.0 6833.8 6838.2 6855.4 6858.5 6945.5 6701.7 6763.6 6823.7 6834.9 6913.6 6801.8 6819.3 6828.2 6828.7 6834.6 4951.6 4982.9 4994.0 5000.5 5095.0 4598.9 4622.4 4635.8 4646.8 4649.1 6321.4 6322.2 6324.0 6399.3 6409.4 6715.3 6813.5 6814.0 6819.3 6916.9 6352.8 6394.9 6396.7 6407.0 6417.6 5531.8 5569.7 5618.9 5620.8 5628.2 7122.7 7140.5 7202.6 7219.3 7231.9 6726.1 6844.8 6847.5 6914.1 6941.0 7033.1 7077.4 7146.7 7149.9 7152.4 6746.8 6852.9 6860.3 6890.6 6899.8 6882.7 6901.7 6944.4 6994.1 7000.5 6556.6 6578.1 6607.6 6625.5 6674.3 6612.1 6633.1 6645.9 6659.1 6677.0 6486.2 6579.2 6638.9 6644.0 6678.2 6578.3 6626.9 6654.0 6723.6 6773.6 6491.7 6515.4 6516.9 6521.9 6526.3 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#1] ext.html Cycles:180 Average:42342.88 Median:36982.99 stddev:64875.83 (175.4%) stddev-sans-first:64983.28 03:42:34 INFO - PID 5393 | Values: 923.4 949.0 955.6 996.0 1002.0 43507.8 44246.0 44260.1 44267.6 44418.6 41242.0 43450.6 43768.6 43892.8 44049.3 7778.5 7802.4 7804.8 7822.5 7831.3 8091.8 8215.7 8220.0 8221.0 8222.5 8223.2 8252.5 8288.4 8288.7 8299.2 8217.4 8278.6 8290.4 8294.3 8303.2 8043.9 8089.9 8100.4 8104.1 8108.1 40561.4 40745.2 40815.4 40916.0 40968.4 3750.0 3791.1 3791.2 3792.1 3792.8 33062.5 33247.7 33315.5 33355.5 33365.2 5387.2 5508.6 5525.5 5612.0 5633.3 214852.0 216630.0 216836.0 219908.0 226649.0 52681.5 52965.7 53183.7 53351.0 53399.2 55347.0 55394.7 55461.4 55522.0 55623.0 14818.8 14947.6 14956.6 14996.4 15021.5 11958.2 11988.8 11993.9 11994.9 11999.8 13565.9 13570.6 13576.7 13612.4 13635.0 5414.3 5466.2 5540.8 5618.5 5648.4 1100.5 1101.9 1102.4 1106.4 1113.7 24890.0 25046.6 25049.2 25089.7 25293.6 1165.6 1179.9 1183.5 1184.5 1185.8 13251.8 13318.7 13358.0 13368.5 13531.5 283276.0 284098.0 284111.0 285955.0 286251.0 58048.0 58053.4 58372.4 58387.7 58391.4 1490.3 1491.9 1507.4 1518.5 1541.1 24724.1 24845.9 24855.9 24856.3 24898.0 37394.3 40904.0 40951.0 41038.6 41090.4 237987.0 238914.0 239229.0 239276.0 239930.0 33575.8 34083.8 35693.6 35949.0 36571.7 46479.0 46936.8 47368.3 47402.3 47582.8 33711.2 33893.3 34001.3 34083.0 34582.8 33875.2 34342.3 34488.3 34798.0 34808.3 39688.8 39707.6 39936.8 40078.8 40115.0 32485.0 33036.8 33182.5 33189.5 33840.7 24514.6 24535.5 25140.2 25343.9 25498.4 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#2] jquery.html Cycles:180 Average:39025.72 Median:23609.67 stddev:96502.50 (408.7%) stddev-sans-first:96730.04 03:42:34 INFO - PID 5393 | Values: 578.1 587.8 589.5 593.3 595.5 22795.3 23270.3 23583.5 23595.2 23624.2 24768.5 25512.5 25572.7 25672.4 25756.9 6532.0 6733.2 6736.0 6736.1 6740.5 6461.3 6557.1 6567.3 6783.5 6811.9 6803.4 6804.4 6805.1 6810.9 6813.0 6436.3 6681.2 6681.4 6684.0 6810.4 6204.6 6210.0 6221.6 6229.1 6241.6 30316.4 30911.5 30950.2 30961.8 30984.5 2173.4 2223.4 2239.1 2250.4 2251.1 19213.4 19905.3 19918.0 19931.0 19962.4 2545.8 2546.5 2583.9 2588.2 2607.2 139372.0 145659.0 152578.0 161469.2 161493.0 15402.5 15593.8 16003.4 16032.6 16205.4 24819.5 24915.5 24927.5 24939.4 24945.3 9372.5 9460.7 9496.1 9530.6 9666.5 8305.6 8311.2 8367.7 8419.7 8451.0 9406.9 9420.8 9613.8 9745.0 9848.8 2754.7 2766.8 2813.7 2834.6 2900.9 1020.2 1038.5 1043.9 1050.0 1063.1 20295.6 20505.7 20810.8 20970.4 21201.6 1090.8 1094.3 1099.4 1112.3 1123.1 11249.9 11560.8 11636.2 11720.2 11726.9 547127.0 559658.0 566331.0 588752.0 599122.0 131978.0 135113.0 136638.0 140236.0 140533.3 1094.5 1140.0 1208.3 1211.6 1263.9 21559.4 21932.0 21981.9 22131.4 22172.1 63087.0 63135.0 64470.0 64968.4 68559.3 79483.0 82847.6 83478.0 83505.0 85106.6 14840.1 15010.3 15058.8 15112.6 15150.8 23323.1 23540.8 23693.3 23772.0 23802.5 18959.9 19453.3 19579.2 19624.4 19690.9 17081.7 17181.9 17402.7 17652.7 17903.1 18955.1 19856.9 20121.7 20146.6 20277.1 14701.9 14726.9 14788.5 14805.5 14839.9 19116.5 19256.0 19280.8 19287.3 19299.7 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#3] mootools.html Cycles:180 Average:10331.35 Median:2696.44 stddev:7707.61 (285.8%) stddev-sans-first:7700.30 03:42:34 INFO - PID 5393 | Values: 1442.5 1474.0 1484.6 1492.5 1498.1 16393.4 16987.9 17035.5 17045.0 17063.1 16024.0 16040.4 16044.3 16052.4 16073.1 2694.9 2744.5 2744.9 2749.8 2752.0 2631.3 2724.4 2727.8 2731.3 2733.4 2559.0 2757.8 2759.5 2760.4 2768.6 2685.7 2689.1 2698.0 2707.9 2710.9 2523.4 2723.6 2724.9 2734.3 2736.3 16907.4 17030.3 17049.7 17052.1 17063.3 8016.8 8310.8 8316.8 8317.6 8329.2 5312.9 5400.1 5505.1 5513.8 5531.3 2081.4 2089.3 2097.1 2105.6 2148.5 29947.9 30128.4 30177.4 30190.0 30201.7 6527.2 6536.3 6559.4 6658.8 6735.0 19217.6 19307.7 19332.1 19371.2 19377.0 7744.5 7970.1 7974.1 7974.3 7977.0 7320.9 7352.9 7396.3 7421.7 7423.9 5439.5 5643.6 5649.8 5676.9 5686.9 1606.4 1608.3 1612.5 1617.8 1635.6 922.4 942.8 947.5 953.3 955.0 8075.3 8126.6 8135.8 8149.8 8229.3 769.3 778.6 781.7 785.2 787.1 5520.8 5822.9 5895.9 5965.5 6094.2 24380.3 24770.6 25393.0 25406.5 25497.7 23605.9 23915.5 24185.8 24856.6 24864.8 12063.9 12164.1 12518.4 12521.4 12552.3 9065.9 9431.2 9553.3 9573.4 9613.8 20781.8 21291.5 21382.1 21451.6 21595.9 21890.0 22197.0 22256.8 22257.7 22560.8 13423.2 13500.7 13668.5 13767.9 13768.7 15576.3 15707.6 15727.5 15736.0 15749.7 12418.6 12578.8 12649.1 12772.2 12805.7 12054.1 12250.5 12381.9 12482.4 12492.8 10939.7 11180.1 11187.9 11192.2 11199.6 8331.0 8392.0 8471.3 8493.7 8535.0 8031.2 8181.5 8182.4 8229.3 8240.2 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#4] prototype.html Cycles:180 Average:5587.45 Median:6222.66 stddev:1563.32 (25.1%) stddev-sans-first:1520.87 03:42:34 INFO - PID 5393 | Values: 527.1 537.9 548.6 558.8 572.5 6168.5 6231.0 6250.4 6254.5 6275.3 6169.6 6182.5 6203.9 6224.6 6229.2 5095.4 5102.2 5103.4 5107.4 5121.9 4828.9 4909.3 5057.0 5103.7 5104.9 4864.6 4911.5 4922.5 4937.2 4938.9 4908.1 4935.6 4939.2 4948.9 4964.1 4351.9 4424.2 4425.0 4448.0 4462.2 6003.6 6034.4 6059.7 6073.3 6095.9 5790.4 5799.3 5804.0 5825.3 5827.5 6614.6 6633.2 6634.3 6639.8 6647.0 4950.8 4961.1 5001.8 5009.5 5012.2 6675.2 6792.8 6836.9 6872.2 6882.4 5111.7 5124.4 5125.6 5146.5 5150.9 5176.6 5198.9 5210.2 5215.4 5218.7 5763.5 5775.6 5783.3 5791.3 5794.9 6631.0 6641.5 6665.9 6670.4 6695.6 1765.3 1778.1 1791.9 1795.4 1795.6 1235.7 1279.9 1288.8 1289.1 1291.8 6206.2 6212.7 6257.6 6265.8 6301.1 6742.8 6774.5 6777.9 6778.9 6830.6 6021.6 6157.1 6174.8 6207.7 6220.8 3506.5 3531.3 3542.0 3573.0 3576.6 6962.2 6967.7 6977.8 7005.6 7015.2 6776.2 6794.8 6824.9 6881.3 6887.2 6812.7 6852.8 6884.8 6894.3 6907.5 6439.9 6556.6 6567.9 6635.1 6694.1 6536.8 6574.1 6630.4 6651.0 6661.0 6889.5 6908.7 6947.5 6986.5 6995.2 5053.5 5099.5 5101.0 5103.5 5140.7 6469.3 6590.9 6649.1 6691.5 6770.7 6513.7 6518.4 6519.4 6525.3 6539.3 6448.5 6459.2 6460.6 6469.7 6503.4 6288.5 6420.6 6425.5 6437.7 6468.8 6536.4 6540.6 6588.7 6593.9 6600.7 6345.0 6361.0 6394.0 6397.9 6403.7 03:42:34 INFO - PID 5393 | 03:42:34 INFO - PID 5393 | [#5] yui.html Cycles:180 Average:28076.19 Median:20975.58 stddev:40572.50 (193.4%) stddev-sans-first:40635.17 03:42:34 INFO - PID 5393 | Values: 944.1 995.2 997.5 998.2 1025.0 20571.8 20966.0 20985.2 21030.9 21086.5 17322.1 17468.2 18417.9 18502.3 18507.3 966.6 989.2 991.1 991.3 997.2 1029.4 1054.9 1056.3 1070.2 1072.0 1106.4 1110.0 1112.6 1113.0 1113.7 1060.3 1094.5 1105.3 1109.5 1110.5 804.4 806.3 807.0 807.0 807.2 19943.2 20054.7 20105.9 20264.3 20297.8 21927.3 22978.5 23050.0 23099.3 23120.9 17987.7 18527.0 18612.3 18644.1 18787.9 3964.3 3974.1 3976.8 3983.6 3986.1 159232.0 159916.0 161684.0 161744.0 162500.2 15929.6 16067.2 16287.4 16460.6 16597.8 33925.2 33931.2 33933.5 34129.3 34160.3 9700.7 9810.3 9823.9 9828.3 9836.7 4643.4 4820.1 4892.8 4922.3 4925.3 5946.4 6096.3 6098.1 6114.6 6125.6 1058.2 1087.0 1095.2 1097.6 1099.7 737.7 749.5 753.5 765.7 770.3 12207.8 12387.2 12505.1 12983.8 12984.9 743.3 743.3 752.0 754.9 772.1 5559.0 5598.8 5660.7 5670.0 5784.3 145228.0 146510.0 148222.0 148883.3 151446.0 94820.0 97610.5 113253.4 120828.4 128105.0 105358.0 109823.0 110002.4 111999.4 112247.4 13776.0 13859.7 14271.9 14284.0 14345.7 52442.0 55929.0 56308.4 57096.2 58601.0 69263.7 69572.3 70482.0 71494.0 71512.0 20043.4 20585.1 20615.5 20625.6 20670.3 22078.7 22273.0 22427.2 22437.8 22469.9 21571.5 21838.1 21917.1 22026.9 22032.4 20994.9 21177.5 21206.9 21330.8 21409.4 20369.6 20417.3 20522.3 20539.4 20616.0 15719.3 15861.9 15871.8 16058.3 16344.4 15194.9 15471.5 15490.5 15524.1 15611.4 03:42:34 INFO - PID 5393 | -------- Summary: end -------- 03:42:34 INFO - PID 5393 | 03:42:35 INFO - TEST-INFO | 5393: exit 0 03:42:35 INFO - TEST-OK | dromaeo_css | took 1106400ms 03:42:35 INFO - TEST-START | kraken 03:42:35 INFO - Initialising browser for kraken test... 03:42:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39417/getInfo.html -profile /tmp/tmpG1aLcx/profile 03:42:35 INFO - TEST-INFO | started process 5770 (/builds/slave/test/build/application/firefox/firefox http://localhost:39417/getInfo.html) 03:42:40 INFO - TEST-INFO | 5770: exit 0 03:42:40 INFO - Browser initialized. 03:42:40 INFO - Running cycle 1/1 for kraken test... 03:42:40 INFO - Using env: {'DISPLAY': ':0', 03:42:40 INFO - 'HOME': '/home/cltbld', 03:42:40 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:40 INFO - 'LANG': 'en_US.UTF-8', 03:42:40 INFO - 'LANGUAGE': 'en_US:en', 03:42:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:40 INFO - 'LOGNAME': 'cltbld', 03:42:40 INFO - 'MAIL': '/var/mail/cltbld', 03:42:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:40 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:40 INFO - 'MOZ_NO_REMOTE': '1', 03:42:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:40 INFO - 'NO_EM_RESTART': '1', 03:42:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:40 INFO - 'PWD': '/builds/slave/test', 03:42:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:40 INFO - 'RUST_BACKTRACE': 'full', 03:42:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:40 INFO - 'SHELL': '/bin/bash', 03:42:40 INFO - 'SHLVL': '1', 03:42:40 INFO - 'TERM': 'linux', 03:42:40 INFO - 'TMOUT': '86400', 03:42:40 INFO - 'USER': 'cltbld', 03:42:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962', 03:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:40 INFO - '_': '/tools/buildbot/bin/python'} 03:42:40 INFO - TEST-INFO | started process 5970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1aLcx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:41 INFO - PID 5970 | 03:42:41 INFO - PID 5970 | (/builds/slave/test/build/application/firefox/firefox:6021): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:41 INFO - PID 5970 | 03:42:52 INFO - PID 5970 | RSS: Main: 163958784 03:42:52 INFO - PID 5970 | 03:42:54 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39417/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:55 INFO - PID 5970 | RSS: Main: 170016768 03:42:55 INFO - PID 5970 | 03:42:58 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39417/tests/kraken/driver.html?testName=audio-dft) 03:42:58 INFO - PID 5970 | RSS: Main: 170528768 03:42:58 INFO - PID 5970 | 03:43:01 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39417/tests/kraken/driver.html?testName=audio-fft) 03:43:02 INFO - PID 5970 | RSS: Main: 164982784 03:43:02 INFO - PID 5970 | 03:43:04 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39417/tests/kraken/driver.html?testName=audio-oscillator) 03:43:04 INFO - PID 5970 | RSS: Main: 166166528 03:43:04 INFO - PID 5970 | 03:43:07 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:07 INFO - PID 5970 | RSS: Main: 166039552 03:43:07 INFO - PID 5970 | 03:43:10 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39417/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:11 INFO - PID 5970 | RSS: Main: 169684992 03:43:11 INFO - PID 5970 | 03:43:14 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39417/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:15 INFO - PID 5970 | RSS: Main: 168529920 03:43:15 INFO - PID 5970 | 03:43:18 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39417/tests/kraken/driver.html?testName=json-parse-financial) 03:43:18 INFO - PID 5970 | RSS: Main: 168624128 03:43:18 INFO - PID 5970 | 03:43:20 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:21 INFO - PID 5970 | RSS: Main: 168599552 03:43:21 INFO - PID 5970 | 03:43:22 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:23 INFO - PID 5970 | RSS: Main: 168955904 03:43:23 INFO - PID 5970 | 03:43:25 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:25 INFO - PID 5970 | RSS: Main: 166338560 03:43:25 INFO - PID 5970 | 03:43:28 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:29 INFO - PID 5970 | RSS: Main: 166256640 03:43:29 INFO - PID 5970 | 03:43:31 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:32 INFO - PID 5970 | RSS: Main: 166674432 03:43:32 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | Cycle 1(1): loaded http://localhost:39417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39417/tests/kraken/driver.html?testName=ai-astar) 03:43:34 INFO - PID 5970 | RSS: Main: 168357888 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | __start_tp_report 03:43:34 INFO - PID 5970 | _x_x_mozilla_page_load 03:43:34 INFO - PID 5970 | _x_x_mozilla_page_load_details 03:43:34 INFO - PID 5970 | |i|pagename|runs| 03:43:34 INFO - PID 5970 | |0;ai-astar;106;105;106;105;106;109;108;105;106;105 03:43:34 INFO - PID 5970 | |1;audio-beat-detection;117;112;112;110;114;114;114;136;111;115 03:43:34 INFO - PID 5970 | |2;audio-dft;162;162;162;163;162;163;165;164;166;171 03:43:34 INFO - PID 5970 | |3;audio-fft;73;74;73;73;75;74;76;74;74;72 03:43:34 INFO - PID 5970 | |4;audio-oscillator;78;80;80;80;80;77;77;77;77;78 03:43:34 INFO - PID 5970 | |5;imaging-gaussian-blur;114;113;113;113;113;114;114;114;118;117 03:43:34 INFO - PID 5970 | |6;imaging-darkroom;150;150;150;150;149;151;150;151;149;152 03:43:34 INFO - PID 5970 | |7;imaging-desaturate;94;93;94;94;94;94;94;94;95;95 03:43:34 INFO - PID 5970 | |8;json-parse-financial;46;44;43;43;42;44;43;43;43;44 03:43:34 INFO - PID 5970 | |9;json-stringify-tinderbox;37;38;37;37;38;36;37;38;37;37 03:43:34 INFO - PID 5970 | |10;stanford-crypto-aes;73;72;70;75;72;75;72;76;72;73 03:43:34 INFO - PID 5970 | |11;stanford-crypto-ccm;117;116;108;112;112;117;114;125;114;113 03:43:34 INFO - PID 5970 | |12;stanford-crypto-pbkdf2;156;160;159;154;163;155;153;154;162;168 03:43:34 INFO - PID 5970 | |13;stanford-crypto-sha256-iterative;59;62;59;58;64;58;60;61;59;59 03:43:34 INFO - PID 5970 | __end_tp_report 03:43:34 INFO - PID 5970 | __start_cc_report 03:43:34 INFO - PID 5970 | _x_x_mozilla_cycle_collect,917 03:43:34 INFO - PID 5970 | __end_cc_report 03:43:34 INFO - PID 5970 | __startTimestamp1504867414450__endTimestamp 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | ------- Summary: start ------- 03:43:34 INFO - PID 5970 | Number of tests: 14 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.00 stddev:1.37 (1.3%) stddev-sans-first:1.45 03:43:34 INFO - PID 5970 | Values: 106.0 105.0 106.0 105.0 106.0 109.0 108.0 105.0 106.0 105.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:114.00 stddev:7.49 (6.6%) stddev-sans-first:7.92 03:43:34 INFO - PID 5970 | Values: 117.0 112.0 112.0 110.0 114.0 114.0 114.0 136.0 111.0 115.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.83 (1.7%) stddev-sans-first:2.91 03:43:34 INFO - PID 5970 | Values: 162.0 162.0 162.0 163.0 162.0 163.0 165.0 164.0 166.0 171.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:1.17 03:43:34 INFO - PID 5970 | Values: 73.0 74.0 73.0 73.0 75.0 74.0 76.0 74.0 74.0 72.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.51 03:43:34 INFO - PID 5970 | Values: 78.0 80.0 80.0 80.0 80.0 77.0 77.0 77.0 77.0 78.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.77 (1.5%) stddev-sans-first:1.87 03:43:34 INFO - PID 5970 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 118.0 117.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:43:34 INFO - PID 5970 | Values: 150.0 150.0 150.0 150.0 149.0 151.0 150.0 151.0 149.0 152.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:43:34 INFO - PID 5970 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:43.50 stddev:1.08 (2.5%) stddev-sans-first:0.67 03:43:34 INFO - PID 5970 | Values: 46.0 44.0 43.0 43.0 42.0 44.0 43.0 43.0 43.0 44.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 03:43:34 INFO - PID 5970 | Values: 37.0 38.0 37.0 37.0 38.0 36.0 37.0 38.0 37.0 37.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:1.83 (2.5%) stddev-sans-first:1.94 03:43:34 INFO - PID 5970 | Values: 73.0 72.0 70.0 75.0 72.0 75.0 72.0 76.0 72.0 73.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.00 stddev:4.49 (3.9%) stddev-sans-first:4.69 03:43:34 INFO - PID 5970 | Values: 117.0 116.0 108.0 112.0 112.0 117.0 114.0 125.0 114.0 113.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.50 stddev:4.88 (3.1%) stddev-sans-first:5.10 03:43:34 INFO - PID 5970 | Values: 156.0 160.0 159.0 154.0 163.0 155.0 153.0 154.0 162.0 168.0 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:59.50 stddev:1.91 (3.2%) stddev-sans-first:2.00 03:43:34 INFO - PID 5970 | Values: 59.0 62.0 59.0 58.0 64.0 58.0 60.0 61.0 59.0 59.0 03:43:34 INFO - PID 5970 | -------- Summary: end -------- 03:43:34 INFO - PID 5970 | 03:43:34 INFO - PID 5970 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:35 INFO - TEST-INFO | 5970: exit 0 03:43:35 INFO - TEST-OK | kraken | took 59538ms 03:43:35 INFO - SUITE-END | took 1165s 03:43:35 INFO - Completed test suite (00:19:26) 03:43:35 INFO - javascript benchmark 03:43:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9008.916094968477, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3787.356149454593, 3796.6013568575318, 3811.733178677493, 3814.6757525610324, 3838.9424158637626, 6147.1701320321745, 6219.751209951596, 6224.502039836813, 6274.403931626493, 6284.402981716741, 6316.368363163681, 6324.3043265240785, 6342.778002769893, 6365.777197798078, 6416.679166041691, 5576.498115169634, 5720.513756330717, 5736.4550367715, 5786.074228123501, 5787.47912687858, 206.6872248157358, 5462.0987537056335, 5615.831525054255, 5748.109043098306, 5753.769849206027, 5659.1511273309125, 5663.886722265553, 5737.454941780524, 5737.569682273805, 5759.769609215627, 5654.886902261973, 5665.631733937281, 5739.626924249952, 5742.0, 5743.741531631045, 5662.320521537442, 5664.2636457260705, 5744.540436765049, 5749.741261643236, 5750.539956803445, 6288.465480434169, 6308.2430108386825, 6314.431701146918, 6338.112664227012, 6406.167198264196, 6856.074429951943, 6878.931210687879, 6905.0, 6907.309269073103, 6929.029935808991, 6923.446124310043, 6924.0, 6986.40615547679, 7001.194862590816, 7023.508354415193, 6305.96847015762, 6388.872222555523, 6396.904046439307, 6410.61536307823, 6487.902681459782, 6997.650117494105, 7024.2273349931465, 7036.542624729376, 7097.077379940574, 7168.856622867514, 6784.830379240559, 6788.728450862009, 6802.489813264025, 6812.897806532906, 6831.04365388846, 6833.760818371333, 6838.179418469816, 6855.383015528626, 6858.451323894076, 6945.513814032969, 6701.698423570951, 6763.560368576027, 6823.737608542436, 6834.931650683529, 6913.619750913748, 6801.761938332134, 6819.318068193141, 6828.2488926218075, 6828.7268509259075, 6834.624095674686, 4951.554360107536, 4982.850514484571, 4993.975030124899, 5000.549950504472, 5095.006473737586, 4598.88502787433, 4622.422197225347, 4635.768211589407, 4646.767661616906, 4649.116667833101, 6321.3678632137335, 6322.178116844872, 6324.019776934582, 6399.328070552618, 6409.359064093554, 6715.294894036154, 6813.523053386215, 6813.965930170318, 6819.283975182534, 6916.861662766817, 6352.809415717444, 6394.8721025579225, 6396.680165991682, 6407.038944158414, 6417.582857114366, 5531.778728850882, 5569.66582005081, 5618.85952851182, 5620.831375058755, 5628.155776633538, 7122.715091396286, 7140.5358651687475, 7202.639868006579, 7219.278072192738, 7231.855362892713, 6726.091977582963, 6844.828879278058, 6847.520673552903, 6914.066601009001, 6940.9652951734915, 7033.120859892513, 7077.398421134261, 7146.7493188692815, 7149.892751608626, 7152.356287934111, 6746.763863264959, 6852.862942741217, 6860.348266914635, 6890.586564806128, 6899.793006209822, 6882.655867206519, 6901.723931042702, 6944.444444444332, 6994.125734283215, 7000.54496457749, 6556.606603603799, 6578.079068930258, 6607.603543787388, 6625.536212465274, 6674.26583075871, 6612.140421745143, 6633.1045308882685, 6645.933540664531, 6659.134312539339, 6676.9666151668935, 6486.189226346707, 6579.243387010555, 6638.867222655616, 6644.036614690939, 6678.165229346332, 6578.309277525982, 6626.933730662825, 6654.0, 6723.630200339028, 6773.593584384953, 6491.740330386731, 6515.381038801306, 6516.869662606816, 6521.902171467526, 6526.314736952741], "value": 6229.6295977025475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.385948344351, 948.9715308540747, 955.6464108279937, 996.0, 1002.0330381182158, 43507.78246108769, 44246.0, 44260.114797704024, 44267.55732442674, 44418.55581444188, 41242.0, 43450.56549434505, 43768.562314376846, 43892.78053609736, 44049.339259911125, 7778.533288002724, 7802.414818888577, 7804.843903121934, 7822.452428330019, 7831.334336581397, 8091.757247282591, 8215.671373145067, 8219.95890020552, 8220.958895205546, 8222.465539739927, 8223.21879421454, 8252.46358986664, 8288.378371622153, 8288.70989515367, 8299.211574900375, 8217.424780265384, 8278.58607069647, 8290.41967062306, 8294.294984926288, 8303.211194936532, 8043.919560804434, 8089.878651820228, 8100.351971842298, 8104.1085480597085, 8108.108108108162, 40561.391579126044, 40745.18509629791, 40815.387769183486, 40916.0, 40968.38547421791, 3749.9625003749884, 3791.071187559038, 3791.184895247535, 3792.051987003249, 3792.791396473193, 33062.50406243908, 33247.6675233247, 33315.500267496005, 33355.499667504766, 33365.16587085318, 5387.218853266255, 5508.614396992212, 5525.530329921961, 5612.0, 5633.267675202238, 214852.0, 216630.0, 216836.0, 219908.0, 226648.99999999834, 52681.473185267656, 52965.7351713239, 53183.73408133012, 53351.0, 53399.19901201485, 55347.0, 55394.676319420156, 55461.44538554563, 55522.0, 55623.0, 14818.777718334233, 14947.551573452596, 14956.551303460914, 14996.400143994118, 15021.549353519413, 11958.222715523463, 11988.820167697491, 11993.940030299967, 11994.88005119955, 11999.760004799855, 13565.864341356657, 13570.59288221355, 13576.660583485493, 13612.387442565108, 13635.045546811629, 5414.29614150158, 5466.1527463243265, 5540.833774986757, 5618.52242559387, 5648.446677163813, 1100.5047728522197, 1101.8677758669012, 1102.399192440122, 1106.446776611694, 1113.6547670222094, 24890.0, 25046.624300635503, 25049.24852254399, 25089.74910250874, 25293.620595691078, 1165.609520810521, 1179.8643156036994, 1183.4910988274953, 1184.496588949693, 1185.7984142695761, 13251.801222981663, 13318.66703332405, 13358.0, 13368.465261389436, 13531.45874165042, 283276.0, 284098.0, 284111.0, 285955.0, 286251.0, 58048.0, 58053.4194658048, 58372.416275837546, 58387.66449341979, 58391.416085839446, 1490.3293517916982, 1491.947781827631, 1507.4271776724775, 1518.5444366689949, 1541.0599534284079, 24724.13465528698, 24845.87577062103, 24855.87572062128, 24856.254312370656, 24898.0, 37394.252114957, 40904.0, 40951.0, 41038.589614103475, 41090.38364424596, 237987.0, 238914.0, 239229.0, 239276.0, 239930.0, 33575.83212083924, 34083.82958085293, 35693.643063569034, 35949.0, 36571.71998980023, 46479.0, 46936.7653161732, 47368.28947565858, 47402.28896566623, 47582.762086189345, 33711.15722106967, 33893.32213355768, 34001.31997359989, 34083.0, 34582.82708586441, 33875.15312117217, 34342.31315373728, 34488.310233794684, 34798.0, 34808.30383392369, 39688.80155599204, 39707.60292397154, 39936.80031599823, 40078.79960600178, 40115.0, 32485.0, 33036.834815826725, 33182.5022624656, 33189.50215746718, 33840.66159338375, 24514.63228051545, 24535.50928981446, 25140.24579262625, 25343.873280634216, 25498.362540935883], "value": 18286.025396041412, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1154833105351, 587.7707693999341, 589.5313225985341, 593.3473179502548, 595.5473839881689, 22795.31614051579, 23270.30189094328, 23583.5283294334, 23595.17416890409, 23624.173153939573, 24768.50462990739, 25512.489750204986, 25572.74427255727, 25672.358191045187, 25756.871215643896, 6531.967340163293, 6733.225679046899, 6736.0, 6736.05695202672, 6740.460763138937, 6461.256955450113, 6557.082008518812, 6567.310432404601, 6783.491238157133, 6811.897821532656, 6803.387695107439, 6804.353586409283, 6805.115335006442, 6810.931890681104, 6813.0, 6436.324185960453, 6681.164854393225, 6681.398674119304, 6684.030815531769, 6810.421114205298, 6204.5967012144065, 6209.96895015522, 6221.626702397871, 6229.065640154013, 6241.563090583661, 30316.393672126655, 30911.536326955113, 30950.226244343845, 30961.845190773904, 30984.53523197154, 2173.413178441812, 2223.444138965259, 2239.1379318962154, 2250.4036430345973, 2251.122062395667, 19213.423597292105, 19905.303314384073, 19918.00409979495, 19931.0, 19962.401127966183, 2545.7963362930923, 2546.5161619292276, 2583.870806459688, 2588.1588483742858, 2607.15267538049, 139372.0, 145659.0, 152578.0, 161469.19265403715, 161493.0, 15402.460913868184, 15593.766093508606, 16003.439879604159, 16032.599185020468, 16205.351785928431, 24819.5036099277, 24915.5016899661, 24927.5014499709, 24939.376515586893, 24945.251642450756, 9372.5313734313, 9460.668876589287, 9496.050394960448, 9530.618775248913, 9666.516674166263, 8305.584720763938, 8311.210435008665, 8367.665293388196, 8419.70531031411, 8450.957745211357, 9406.858897116548, 9420.811583768424, 9613.807723845484, 9744.951275243578, 9848.803023939481, 2754.6969833318317, 2766.764824989858, 2813.6904940456534, 2834.6173266609158, 2900.883964641391, 1020.1736593359254, 1038.5067093130854, 1043.8956104389652, 1050.0, 1063.0963680871198, 20295.59408811845, 20505.692414613794, 20810.79189208119, 20970.37088887336, 21201.575968480545, 1090.8200146975819, 1094.2559059839227, 1099.4008265495324, 1112.2825777373548, 1123.0566324287638, 11249.850041988257, 11560.76878462426, 11636.24364416327, 11720.238184517979, 11726.94136529312, 547127.0, 559658.0, 566331.0, 588752.0, 599122.0, 131978.0, 135113.0, 136637.99999999802, 140236.0, 140533.2973335127, 1094.4746521669642, 1139.9772004559863, 1208.2750349790056, 1211.6425654431964, 1263.8736126387287, 21559.35321940344, 21932.0, 21981.890090549445, 22131.446713832283, 22172.128490422016, 63087.047562070366, 63135.0, 64470.0, 64968.35031649623, 68559.31440685729, 79483.0, 82847.5857620708, 83478.0, 83505.0, 85106.57446712974, 14840.10959342443, 15010.324535395715, 15058.849411506182, 15112.622184445478, 15150.772738409154, 23323.06707731672, 23540.76459235386, 23693.289201323987, 23772.0, 23802.52394952126, 18959.90520047391, 19453.319133830813, 19579.216831326587, 19624.41126766199, 19690.901545492754, 17081.74377384365, 17181.91409042947, 17402.73895891537, 17652.658914303494, 17903.10484475797, 18955.14701838393, 19856.90071549633, 20121.698174527686, 20146.59706805885, 20277.087531060843, 14701.92649036748, 14726.852731472549, 14788.482403115839, 14805.481808136663, 14839.92580037093, 19116.52208694738, 19256.0, 19280.807191927903, 19287.324943626907, 19299.710504342165], "value": 12600.546658578432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5023366938406, 1473.975586967057, 1484.6140003599069, 1492.4850926430377, 1498.1086253679064, 16393.426230081936, 16987.91506042468, 17035.48893533193, 17045.0, 17063.06153161577, 16024.0, 16040.438584649539, 16044.278007489662, 16052.43816466424, 16073.115978621172, 2694.9056783012647, 2744.4922689302443, 2744.931376715578, 2749.766269867064, 2752.0, 2631.2500937232894, 2724.4142509360486, 2727.7954153438473, 2731.3444773254373, 2733.384988377619, 2558.974410255892, 2757.7793776497833, 2759.4756996170763, 2760.4479104179145, 2768.6262354582077, 2685.6508653875067, 2689.1260340389454, 2697.9730202698115, 2707.891684332624, 2710.864456777163, 2523.4448421347274, 2723.6323096381934, 2724.91825245241, 2734.343757498206, 2736.329599248197, 16907.408240711517, 17030.318787248496, 17049.7442538362, 17052.062136582485, 17063.317467301295, 8016.759497215093, 8310.83378332436, 8316.750497485085, 8317.625706843206, 8329.167083291683, 5312.92030619541, 5400.108982017962, 5505.146702261156, 5513.8345849624575, 5531.25328080708, 2081.438011736838, 2089.341857314941, 2097.0877668214375, 2105.5683584865064, 2148.452144703106, 29947.850260748557, 30128.397432051457, 30177.396452071054, 30190.0, 30201.69798302011, 6527.151470308924, 6536.346365363425, 6559.376859198369, 6658.83352916181, 6734.966325168343, 19217.61564768697, 19307.710384344246, 19332.130054147598, 19371.225150994083, 19377.031148442522, 7744.535327880345, 7970.083440404428, 7974.122846486882, 7974.322182614426, 7976.960115199387, 7320.890186647204, 7352.89706544012, 7396.260373962561, 7421.666025028779, 7423.9257607424315, 5439.5104440600535, 5643.604947653707, 5649.796579334063, 5676.858078548069, 5686.857828554236, 1606.4216881922498, 1608.260200307848, 1612.5404259785905, 1617.7896873406617, 1635.5665748576637, 922.4373132389237, 942.7831598732192, 947.4788866123605, 953.2516974175239, 954.9809003820023, 8075.313598344206, 8126.634301456449, 8135.79660508492, 8149.796255093552, 8229.25936665703, 769.3114662377141, 778.5562229529228, 781.6912319633713, 785.1794874356198, 787.0751866556773, 5520.751566179531, 5822.941770582324, 5895.882082358415, 5965.492933100648, 6094.238220222473, 24380.26859194227, 24770.628440573044, 25393.0, 25406.491870162492, 25497.745022549538, 23605.88197059004, 23915.52168956611, 24185.7581424187, 24856.627150592394, 24864.751352486244, 12063.879361206276, 12164.14850960442, 12518.374081295899, 12521.436535355748, 12552.309622970643, 9065.909340906506, 9431.198348140484, 9553.331266811534, 9573.377730447499, 9613.807723845624, 20781.792182077985, 21291.46771330729, 21382.144714211256, 21451.570968580854, 21595.892020539795, 21890.0, 22197.0, 22256.77743222547, 22257.666135007665, 22560.774392255866, 13423.194608323533, 13500.729985400041, 13668.52160174389, 13767.931160344135, 13768.65578360549, 15576.29906654226, 15707.607309817346, 15727.528174154793, 15736.0, 15749.68500629958, 12418.627441176779, 12578.811317830057, 12649.114561980941, 12772.233665979698, 12805.743885122432, 12054.09594280415, 12250.509979600716, 12381.876181238073, 12482.375881206084, 12492.750144996868, 10939.726506837074, 11180.10559155282, 11187.944060279646, 11192.21654484211, 11199.552017919192, 8331.0, 8392.0, 8471.322294216325, 8493.702720404755, 8534.957325213334, 8031.237032481905, 8181.509109453452, 8182.427230093836, 8229.25936665703, 8240.21717936795], "value": 7157.281311863806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.1012922966343, 537.8816660334727, 548.6406403805504, 558.7876606889381, 572.5391060196542, 6168.501756788497, 6231.0, 6250.406146432653, 6254.498200719714, 6275.341089185638, 6169.5989760665525, 6182.474489668372, 6203.875922481548, 6224.564280500355, 6229.221347331583, 5095.439501654815, 5102.234664800291, 5103.41310749263, 5107.361579802525, 5121.923171152435, 4828.879278018043, 4909.263610458442, 5057.0, 5103.744812759366, 5104.872378190538, 4864.586510146624, 4911.533404326583, 4922.532359425867, 4937.185364414867, 4938.925916111261, 4908.116539022974, 4935.605151587864, 4939.160342741725, 4948.925766113512, 4964.131277026524, 4351.891202719926, 4424.225760491901, 4424.977875110604, 4447.955520444786, 4462.1968045751755, 6003.559145805019, 6034.396560343975, 6059.667028194133, 6073.301570319381, 6095.878082438371, 5790.392008839053, 5799.333076696192, 5803.9709801451145, 5825.300963884361, 5827.4650527020885, 6614.636195009272, 6633.237177724575, 6634.303398143174, 6639.76760813374, 6647.0, 4950.826721064782, 4961.131801934647, 5001.824936127255, 5009.5491405773655, 5012.172991456406, 6675.232348279913, 6792.830179245509, 6836.897446538306, 6872.209695884987, 6882.380585747307, 5111.718855462986, 5124.385073791169, 5125.641704948117, 5146.485351464824, 5150.922736158961, 5176.559992400613, 5198.870028249324, 5210.192420174879, 5215.400228973716, 5218.712970786643, 5763.510101641324, 5775.556110972257, 5783.306003279633, 5791.276090488689, 5794.8551286217335, 6631.0, 6641.501887358468, 6665.866682666319, 6670.366315200048, 6695.631740254333, 1765.2762367429293, 1778.1287169286957, 1791.9462416127537, 1795.3895675470403, 1795.5870149865605, 1235.6972541727155, 1279.9488020479262, 1288.7937929931165, 1289.071868254855, 1291.8256035435284, 6206.162168107338, 6212.689365531705, 6257.593256438408, 6265.780697675559, 6301.054841773679, 6742.797716068526, 6774.491913106537, 6777.93222067773, 6778.932210677929, 6830.556013859084, 6021.638701677914, 6157.1072194532435, 6174.8147555573405, 6207.689615519206, 6220.7511699531515, 3506.526618906466, 3531.29374125176, 3541.9645803541634, 3572.982135089308, 3576.603675537396, 6962.199347075151, 6967.721291148398, 6977.81377165883, 7005.583073839517, 7015.228324884259, 6776.220734615484, 6794.830129246809, 6824.897626535606, 6881.311868813179, 6887.173539175231, 6812.659367031728, 6852.794416167523, 6884.827879303058, 6894.276101009422, 6907.516473846783, 6439.871202575829, 6556.606603603799, 6567.934320656732, 6635.137432133792, 6694.129763130956, 6536.7712130075215, 6574.145361103026, 6630.403263706289, 6651.0355998379, 6661.0, 6889.483288753263, 6908.723651053901, 6947.513674042769, 6986.510944233854, 6995.236881431704, 5053.545180933734, 5099.470158952374, 5100.974495127501, 5103.489651034867, 5140.665856719302, 6469.320721324381, 6590.934090659032, 6649.102371179829, 6691.5315927884585, 6770.6614669265355, 6513.73945042193, 6518.380753828379, 6519.445847103049, 6525.282218956006, 6539.280679125388, 6448.45188158993, 6459.157970492968, 6460.580062295936, 6469.676516174267, 6503.447206987459, 6288.528360373082, 6420.6468644225015, 6425.518086143465, 6437.678116094083, 6468.773592924225, 6536.444402225864, 6540.640264785482, 6588.670566471561, 6593.901091483535, 6600.702968366339, 6345.0, 6361.0, 6394.0, 6397.904031439439, 6403.711832967434], "value": 5135.411274881324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.140831843023, 995.2436148527117, 997.4937843855778, 998.2213873178923, 1025.0313453786173, 20571.794282057173, 20966.0, 20985.16059357628, 21030.89484552579, 21086.472838179016, 17322.13389330535, 17468.21393037313, 18417.907910460428, 18502.259909603632, 18507.259709611633, 966.5988614724898, 989.2382865193797, 991.1179050644931, 991.2763682511735, 997.2221667099637, 1029.4183786160795, 1054.8892366301504, 1056.3028401255174, 1070.2294348069377, 1071.9732006699817, 1106.4301884529473, 1110.0398155595392, 1112.5549780087988, 1113.0427832064458, 1113.6881673131536, 1060.2843080920386, 1094.518411898762, 1105.309181761399, 1109.4840898981972, 1110.4947249001725, 804.3967024731452, 806.3267171911461, 806.9515829050217, 807.0154411617817, 807.2049031703767, 19943.202271909107, 20054.699179512318, 20105.899470502554, 20264.290749823835, 20297.797022029885, 21927.342179734635, 22978.54042919149, 23050.0, 23099.3070207894, 23120.884395578083, 17987.73018404725, 18527.0, 18612.34856780006, 18644.067796610252, 18787.906060469748, 3964.32606456903, 3974.125692347679, 3976.8210430530694, 3983.5817239190046, 3986.142979259473, 159232.0, 159916.0, 161684.0, 161744.0, 162500.18749906294, 15929.601759955862, 16067.196640167946, 16287.429939952044, 16460.588485287964, 16597.751033734505, 33925.15187120292, 33931.151721206676, 33933.490997635054, 34129.31741365159, 34160.31679366399, 9700.708978730649, 9810.31327807061, 9823.852642210373, 9828.262880284008, 9836.655717049869, 4643.3963584733765, 4820.060088282751, 4892.804287828518, 4922.286268491049, 4925.310456536088, 5946.4053594641055, 6096.329403765582, 6098.1157732128595, 6114.57197996136, 6125.632462052202, 1058.222206678091, 1086.983695244572, 1095.2059756676347, 1097.5829184909683, 1099.719571509276, 737.6938570493185, 749.4828568287863, 753.4838635534676, 765.689895592286, 770.3452065744185, 12207.755844883053, 12387.19483233587, 12505.06212034101, 12983.805242921175, 12984.935075324753, 743.2938708227206, 743.3012967810349, 751.9699212031567, 754.901862757838, 772.0658003815334, 5559.0, 5598.832035038955, 5660.688662123541, 5669.971650141723, 5784.305883294031, 145228.0, 146510.0, 148222.0, 148883.2555837214, 151446.0, 94820.0, 97610.51194743981, 113253.4337328308, 120828.3958580219, 128105.0, 105358.0, 109822.9999999984, 110002.44998774955, 111999.4400028011, 112247.43876280566, 13776.0, 13859.653508662364, 14271.928640356731, 14284.0, 14345.713085738436, 52442.0, 55929.0, 56308.43691563032, 57096.18439588686, 58601.0, 69263.65368173127, 69572.34130770288, 70482.0, 71494.0, 71512.0, 20043.398698039084, 20585.07367168451, 20615.484612884196, 20625.58748825045, 20670.276540321018, 22078.66881996739, 22273.0, 22427.21504747326, 22437.775622243567, 22469.887650561643, 21571.460713482287, 21838.126474940826, 21917.12331506722, 22026.88986555057, 22032.44918876977, 20994.895025524776, 21177.470563236042, 21206.893965530075, 21330.78669213288, 21409.357719267824, 20369.592608147457, 20417.285395011102, 20522.281720139723, 20539.38381848547, 20616.0, 15719.292631831824, 15861.920690396935, 15871.761923570924, 16058.277377517807, 16344.427945021867, 15194.924025379802, 15471.5358539244, 15490.457833976208, 15524.14617196065, 15611.375544978073], "value": 10132.44404739978, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1383.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 105.0, 106.0, 109.0, 108.0, 105.0, 106.0, 105.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 112.0, 110.0, 114.0, 114.0, 114.0, 136.0, 111.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 165.0, 164.0, 166.0, 171.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 73.0, 75.0, 74.0, 76.0, 74.0, 74.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 80.0, 80.0, 80.0, 77.0, 77.0, 77.0, 77.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 118.0, 117.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 149.0, 151.0, 150.0, 151.0, 149.0, 152.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 43.0, 43.0, 42.0, 44.0, 43.0, 43.0, 43.0, 44.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 38.0, 36.0, 37.0, 38.0, 37.0, 37.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 70.0, 75.0, 72.0, 75.0, 72.0, 76.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 108.0, 112.0, 112.0, 117.0, 114.0, 125.0, 114.0, 113.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 159.0, 154.0, 163.0, 155.0, 153.0, 154.0, 162.0, 168.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 59.0, 58.0, 64.0, 58.0, 60.0, 61.0, 59.0, 59.0], "value": 59.9, "unit": "score"}]}]} 03:43:35 INFO - Return code: 0 03:43:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:35 INFO - # TBPL SUCCESS # 03:43:35 INFO - Running post-action listener: _package_coverage_data 03:43:35 INFO - Running post-action listener: _resource_record_post_action 03:43:35 INFO - [mozharness: 2017-09-08 10:43:35.758629Z] Finished run-tests step (success) 03:43:35 INFO - Running post-run listener: _resource_record_post_run 03:43:35 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 300621824; Read time: 120; Write time: 168876 03:43:35 INFO - TinderboxPrint: CPU usage
13.1% 03:43:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 120 03:43:35 INFO - TinderboxPrint: I/O write bytes / time
300,621,824 / 168,876 03:43:35 INFO - TinderboxPrint: CPU idle
8,198.6 (86.9%) 03:43:35 INFO - TinderboxPrint: CPU user
1,183.8 (12.6%) 03:43:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12660736; Read time: 0; Write time: 1188 03:43:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:35 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287961088; Read time: 120; Write time: 167688 03:43:36 INFO - Running post-run listener: _upload_blobber_files 03:43:36 INFO - Blob upload gear active. 03:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:36 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:43:36 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:43:36 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:43:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:40 INFO - (blobuploader) - INFO - Done attempting. 03:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:41 INFO - (blobuploader) - INFO - Done attempting. 03:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:42 INFO - (blobuploader) - INFO - Done attempting. 03:43:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:43 INFO - (blobuploader) - INFO - Done attempting. 03:43:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:43 INFO - Return code: 0 03:43:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eab71b033f4a7b81c1e784a80b1c55c56eb533d258c7a179abce2b6bb9add6f4001cec26136b3abf2e14de3c55d221839962a5bea8a49e38c8f896f6ee25b31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fb5bb848179fc564930a127dcd46b5c269d6f9f0535399042be732275432409a7bdff8395c11fb950824439847766c13ed2b732123fb92c8f5812adf62d08b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39802bc7f33814a6899033d7252c4c1cf3b59ecb3d0953a9c47ffce32ae9079d4aa6575363ae4ebd84479806835404480c8d22b41873d154cee5e173a5b99b53", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b83d257c6ad2550258a3d1dff8c2cf0142f53caafcea4b9b54d712017aeba3baa8715b0b6cfcf6d6cb3dbb5970e22f7b74c35b2e1549517db0dbf77bf2683332"} 03:43:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:43 INFO - Contents: 03:43:43 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eab71b033f4a7b81c1e784a80b1c55c56eb533d258c7a179abce2b6bb9add6f4001cec26136b3abf2e14de3c55d221839962a5bea8a49e38c8f896f6ee25b31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fb5bb848179fc564930a127dcd46b5c269d6f9f0535399042be732275432409a7bdff8395c11fb950824439847766c13ed2b732123fb92c8f5812adf62d08b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39802bc7f33814a6899033d7252c4c1cf3b59ecb3d0953a9c47ffce32ae9079d4aa6575363ae4ebd84479806835404480c8d22b41873d154cee5e173a5b99b53", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b83d257c6ad2550258a3d1dff8c2cf0142f53caafcea4b9b54d712017aeba3baa8715b0b6cfcf6d6cb3dbb5970e22f7b74c35b2e1549517db0dbf77bf2683332"} 03:43:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:43 INFO - Copying logs to upload dir... 03:43:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.971692 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-08 03:43:43.547568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:43:43.551570) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eab71b033f4a7b81c1e784a80b1c55c56eb533d258c7a179abce2b6bb9add6f4001cec26136b3abf2e14de3c55d221839962a5bea8a49e38c8f896f6ee25b31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fb5bb848179fc564930a127dcd46b5c269d6f9f0535399042be732275432409a7bdff8395c11fb950824439847766c13ed2b732123fb92c8f5812adf62d08b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39802bc7f33814a6899033d7252c4c1cf3b59ecb3d0953a9c47ffce32ae9079d4aa6575363ae4ebd84479806835404480c8d22b41873d154cee5e173a5b99b53", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b83d257c6ad2550258a3d1dff8c2cf0142f53caafcea4b9b54d712017aeba3baa8715b0b6cfcf6d6cb3dbb5970e22f7b74c35b2e1549517db0dbf77bf2683332"} build_url:https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/dEKpo6HVSlahaV5oZkm5zA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eab71b033f4a7b81c1e784a80b1c55c56eb533d258c7a179abce2b6bb9add6f4001cec26136b3abf2e14de3c55d221839962a5bea8a49e38c8f896f6ee25b31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fb5bb848179fc564930a127dcd46b5c269d6f9f0535399042be732275432409a7bdff8395c11fb950824439847766c13ed2b732123fb92c8f5812adf62d08b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39802bc7f33814a6899033d7252c4c1cf3b59ecb3d0953a9c47ffce32ae9079d4aa6575363ae4ebd84479806835404480c8d22b41873d154cee5e173a5b99b53", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b83d257c6ad2550258a3d1dff8c2cf0142f53caafcea4b9b54d712017aeba3baa8715b0b6cfcf6d6cb3dbb5970e22f7b74c35b2e1549517db0dbf77bf2683332"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:43:43.580620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:43:43.580957) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504866192.523017-478903962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:43:43.663157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:43:43.663465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:43:43.663770) ========= ========= Total master_lag: 0.19 =========