builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1505558801.7 results: success (0) revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.698168) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.698646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.698946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.773320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.773594) ========= 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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:46:41-- 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.9M=0s 2017-09-16 03:46:41 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093864 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.897756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.898052) ========= 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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019877 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.963672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.963962) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:46:42,023 truncating revision to first 12 chars 2017-09-16 03:46:42,023 Setting DEBUG logging. 2017-09-16 03:46:42,024 attempt 1/10 2017-09-16 03:46:42,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6c1b45e7e94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:46:42,579 unpacking tar archive at: mozilla-central-6c1b45e7e94d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.809312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.794252) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.794551) ========= script_repo_revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.794926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.795242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.807782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-16 03:46:42.808165) ========= /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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:42 INFO - MultiFileLogger online at 20170916 03:46:42 in /builds/slave/test 03:46:42 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:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:46:43 INFO - {'append_to_log': False, 03:46:43 INFO - 'base_work_dir': '/builds/slave/test', 03:46:43 INFO - 'blob_upload_branch': 'Firefox', 03:46:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:46:43 INFO - 'branch': 'Firefox', 03:46:43 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:43 INFO - 'code_coverage': False, 03:46:43 INFO - 'config_files': ('talos/linux_config.py',), 03:46:43 INFO - 'default_actions': ('clobber', 03:46:43 INFO - 'read-buildbot-config', 03:46:43 INFO - 'download-and-extract', 03:46:43 INFO - 'populate-webroot', 03:46:43 INFO - 'create-virtualenv', 03:46:43 INFO - 'install', 03:46:43 INFO - 'setup-mitmproxy', 03:46:43 INFO - 'run-tests'), 03:46:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:43 INFO - 'disable_ccov_upload': False, 03:46:43 INFO - 'disable_stylo': False, 03:46:43 INFO - 'download_minidump_stackwalk': True, 03:46:43 INFO - 'download_symbols': 'ondemand', 03:46:43 INFO - 'enable_stylo': False, 03:46:43 INFO - 'enable_webrender': False, 03:46:43 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:46:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:43 INFO - 'gecko_profile': False, 03:46:43 INFO - 'gecko_profile_interval': 0, 03:46:43 INFO - 'installer_path': 'installer.exe', 03:46:43 INFO - 'log_level': 'info', 03:46:43 INFO - 'log_name': 'talos', 03:46:43 INFO - 'log_to_console': True, 03:46:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:43 INFO - 'opt_config_files': (), 03:46:43 INFO - 'pip_index': False, 03:46:43 INFO - 'suite': 'dromaeojs-e10s', 03:46:43 INFO - 'system_bits': '32', 03:46:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:43 INFO - 'title': 'talos-linux64-ix-058', 03:46:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:43 INFO - 'use_talos_json': True, 03:46:43 INFO - 'verify': 'False', 03:46:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:46:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:43 INFO - 'work_dir': 'build'} 03:46:43 INFO - [mozharness: 2017-09-16 10:46:43.006253Z] Running clobber step. 03:46:43 INFO - Running pre-action listener: _resource_record_pre_action 03:46:43 INFO - Running main action method: clobber 03:46:43 INFO - rmtree: /builds/slave/test/build 03:46:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:46:44 INFO - Running post-action listener: _resource_record_post_action 03:46:44 INFO - [mozharness: 2017-09-16 10:46:44.510149Z] Finished clobber step (success) 03:46:44 INFO - [mozharness: 2017-09-16 10:46:44.510246Z] Running read-buildbot-config step. 03:46:44 INFO - Running pre-action listener: _resource_record_pre_action 03:46:44 INFO - Running main action method: read_buildbot_config 03:46:44 INFO - Using buildbot properties: 03:46:44 INFO - { 03:46:44 INFO - "project": "", 03:46:44 INFO - "product": "firefox", 03:46:44 INFO - "who": "archaeopteryx@coole-files.de", 03:46:44 INFO - "installer_path": "public/build/target.tar.bz2", 03:46:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:46:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:46:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:46:44 INFO - "stage_platform": "linux64-pgo", 03:46:44 INFO - "basedir": "/builds/slave/test", 03:46:44 INFO - "buildnumber": 188, 03:46:44 INFO - "platform": "ubuntu64_hw", 03:46:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:46:44 INFO - "slavebuilddir": "test", 03:46:44 INFO - "taskId": "J1p2rPvFTb-aNm3FiYJg3Q", 03:46:44 INFO - "branch": "mozilla-central", 03:46:44 INFO - "script_repo_revision": "production", 03:46:44 INFO - "revision": "6c1b45e7e94dbf343813eda03f1fd0b3259b59b1", 03:46:44 INFO - "slavename": "talos-linux64-ix-058", 03:46:44 INFO - "repo_path": "mozilla-central" 03:46:44 INFO - } 03:46:44 INFO - Finding installer, test and symbols from parent task. 03:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1p2rPvFTb-aNm3FiYJg3Q'}, attempt #1 03:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1p2rPvFTb-aNm3FiYJg3Q'}, attempt #1 03:46:45 INFO - Task dependencies: HjeSV61eTn20kZ6cmIUULA 03:46:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA'}, attempt #1 03:46:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 03:46:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.test_packages.json 03:46:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.crashreporter-symbols.zip 03:46:45 INFO - Running post-action listener: _resource_record_post_action 03:46:45 INFO - [mozharness: 2017-09-16 10:46:45.920816Z] Finished read-buildbot-config step (success) 03:46:45 INFO - [mozharness: 2017-09-16 10:46:45.921033Z] Running download-and-extract step. 03:46:45 INFO - Running pre-action listener: _resource_record_pre_action 03:46:45 INFO - Running main action method: download_and_extract 03:46:45 INFO - mkdir: /builds/slave/test/build/tests 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:45 INFO - trying https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.test_packages.json 03:46:45 INFO - Downloading https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:46:46 INFO - Downloaded 989 bytes. 03:46:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:46:46 INFO - Using the following test package requirements: 03:46:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:46:46 INFO - u'common': [u'target.common.tests.zip'], 03:46:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:46:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:46:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:46:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:46:46 INFO - u'mozbase': [u'target.common.tests.zip'], 03:46:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:46:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:46:46 INFO - u'web-platform': [u'target.common.tests.zip', 03:46:46 INFO - u'target.web-platform.tests.tar.gz'], 03:46:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:46:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.common.tests.zip 03:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.common.tests.zip into memory 03:46:47 INFO - Content-Length response header: 55325850 03:46:47 INFO - Bytes received: 55325850 03:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.talos.tests.zip 03:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.talos.tests.zip into memory 03:46:58 INFO - Content-Length response header: 14508749 03:46:58 INFO - Bytes received: 14508749 03:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:59 INFO - trying https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 03:46:59 INFO - Downloading https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:47:00 INFO - Downloaded 62140121 bytes. 03:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 03:47:00 INFO - mkdir: /builds/slave/test/properties 03:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:00 INFO - Contents: 03:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 03:47:00 INFO - Running post-action listener: _resource_record_post_action 03:47:00 INFO - Running post-action listener: find_tests_for_verification 03:47:00 INFO - Running post-action listener: set_extra_try_arguments 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.331230Z] Finished download-and-extract step (success) 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.331361Z] Running populate-webroot step. 03:47:00 INFO - Running pre-action listener: _resource_record_pre_action 03:47:00 INFO - Running main action method: populate_webroot 03:47:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:00 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['tresize', 03:47:00 INFO - 'tcanvasmark']}, 03:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:00 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['dromaeo_css', 03:47:00 INFO - 'kraken']}, 03:47:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:00 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'tests': ['damp', 'tps']}, 03:47:00 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['damp', 'tps']}, 03:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:00 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['dromaeo_dom']}, 03:47:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:47:00 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['basic_compositor_video', 03:47:00 INFO - 'glvideo']}, 03:47:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:47:00 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['ts_paint_webext', 03:47:00 INFO - 'tp5o_webext']}, 03:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:00 INFO - 'ts_paint', 03:47:00 INFO - 'tpaint', 03:47:00 INFO - 'sessionrestore', 03:47:00 INFO - 'sessionrestore_many_windows', 03:47:00 INFO - 'sessionrestore_no_auto_restore', 03:47:00 INFO - 'tabpaint']}, 03:47:00 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['a11yr', 03:47:00 INFO - 'ts_paint', 03:47:00 INFO - 'tpaint', 03:47:00 INFO - 'sessionrestore', 03:47:00 INFO - 'sessionrestore_many_windows', 03:47:00 INFO - 'sessionrestore_no_auto_restore', 03:47:00 INFO - 'tabpaint']}, 03:47:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:47:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:47:00 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['perf_reftest_singletons']}, 03:47:00 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['bloom_basic']}, 03:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:00 INFO - 'tsvgr_opacity', 03:47:00 INFO - 'tart', 03:47:00 INFO - 'tscrollx', 03:47:00 INFO - 'tsvg_static']}, 03:47:00 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['tsvgx', 03:47:00 INFO - 'tsvgr_opacity', 03:47:00 INFO - 'tart', 03:47:00 INFO - 'tscrollx', 03:47:00 INFO - 'tsvg_static']}, 03:47:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:47:00 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo'], 03:47:00 INFO - 'tests': ['tp5o']}, 03:47:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:00 INFO - 'talos_options': ['--mitmproxy', 03:47:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:00 INFO - '--firstNonBlankPaint'], 03:47:00 INFO - 'tests': ['tp6_google', 03:47:00 INFO - 'tp6_youtube', 03:47:00 INFO - 'tp6_amazon', 03:47:00 INFO - 'tp6_facebook']}, 03:47:00 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo', 03:47:00 INFO - '--mitmproxy', 03:47:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:00 INFO - '--firstNonBlankPaint'], 03:47:00 INFO - 'tests': ['tp6_google', 03:47:00 INFO - 'tp6_youtube', 03:47:00 INFO - 'tp6_amazon', 03:47:00 INFO - 'tp6_facebook']}, 03:47:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:00 INFO - 'talos_options': ['--stylo-threads=1', 03:47:00 INFO - '--mitmproxy', 03:47:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:00 INFO - '--firstNonBlankPaint'], 03:47:00 INFO - 'tests': ['tp6_google', 03:47:00 INFO - 'tp6_youtube', 03:47:00 INFO - 'tp6_amazon', 03:47:00 INFO - 'tp6_facebook']}, 03:47:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--xperf_path', 03:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:00 INFO - 'tests': ['tp5n']}, 03:47:00 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:00 INFO - 'talos_options': ['--disable-stylo', 03:47:00 INFO - '--xperf_path', 03:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:00 INFO - 'tests': ['tp5n']}}} 03:47:00 INFO - Running post-action listener: _resource_record_post_action 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.347496Z] Finished populate-webroot step (success) 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.347586Z] Running create-virtualenv step. 03:47:00 INFO - Running pre-action listener: _resource_record_pre_action 03:47:00 INFO - Running main action method: create_virtualenv 03:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:00 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:47:00 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:47:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:01 INFO - Installing pip...............done. 03:47:01 INFO - Return code: 0 03:47:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:47:01 INFO - Reading from file tmpfile_stdout 03:47:01 INFO - Output received: 03:47:01 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:47:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47:01 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:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:01 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:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:01 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:01 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:47:01 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:47:01 INFO - Using env: {'DISPLAY': ':0', 03:47:01 INFO - 'HOME': '/home/cltbld', 03:47:01 INFO - 'LANG': 'en_US.UTF-8', 03:47:01 INFO - 'LANGUAGE': 'en_US:en', 03:47:01 INFO - 'LOGNAME': 'cltbld', 03:47:01 INFO - 'MAIL': '/var/mail/cltbld', 03:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:01 INFO - 'MOZ_NO_REMOTE': '1', 03:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:01 INFO - 'NO_EM_RESTART': '1', 03:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:01 INFO - 'PWD': '/builds/slave/test', 03:47:01 INFO - 'SHELL': '/bin/bash', 03:47:01 INFO - 'SHLVL': '1', 03:47:01 INFO - 'TERM': 'linux', 03:47:01 INFO - 'TMOUT': '86400', 03:47:01 INFO - 'USER': 'cltbld', 03:47:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:01 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:47:02 INFO - Downloading/unpacking pip>=1.5 03:47:02 INFO - Running setup.py egg_info for package pip 03:47:02 INFO - warning: no files found matching 'pip/cacert.pem' 03:47:02 INFO - warning: no files found matching '*.html' under directory 'docs' 03:47:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:47:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:47:02 INFO - Installing collected packages: pip 03:47:02 INFO - Found existing installation: pip 1.1 03:47:02 INFO - Uninstalling pip: 03:47:02 INFO - Successfully uninstalled pip 03:47:02 INFO - Running setup.py install for pip 03:47:02 INFO - warning: no files found matching 'pip/cacert.pem' 03:47:02 INFO - warning: no files found matching '*.html' under directory 'docs' 03:47:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:47:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:47:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:47:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:47:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:47:02 INFO - Successfully installed pip 03:47:02 INFO - Cleaning up... 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 03:47:02 INFO - 'HOME': '/home/cltbld', 03:47:02 INFO - 'LANG': 'en_US.UTF-8', 03:47:02 INFO - 'LANGUAGE': 'en_US:en', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MAIL': '/var/mail/cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SHLVL': '1', 03:47:02 INFO - 'TERM': 'linux', 03:47:02 INFO - 'TMOUT': '86400', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Downloading/unpacking psutil>=3.1.1 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:04 INFO - Installing collected packages: psutil 03:47:04 INFO - Running setup.py install for psutil 03:47:04 INFO - building 'psutil._psutil_linux' extension 03:47:04 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:47:04 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:47:04 INFO - building 'psutil._psutil_posix' extension 03:47:04 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:47:04 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:47:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:04 INFO - Successfully installed psutil 03:47:04 INFO - Cleaning up... 03:47:05 INFO - Return code: 0 03:47:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:05 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:05 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:47:05 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:47:05 INFO - Using env: {'DISPLAY': ':0', 03:47:05 INFO - 'HOME': '/home/cltbld', 03:47:05 INFO - 'LANG': 'en_US.UTF-8', 03:47:05 INFO - 'LANGUAGE': 'en_US:en', 03:47:05 INFO - 'LOGNAME': 'cltbld', 03:47:05 INFO - 'MAIL': '/var/mail/cltbld', 03:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:05 INFO - 'MOZ_NO_REMOTE': '1', 03:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:05 INFO - 'NO_EM_RESTART': '1', 03:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:05 INFO - 'PWD': '/builds/slave/test', 03:47:05 INFO - 'SHELL': '/bin/bash', 03:47:05 INFO - 'SHLVL': '1', 03:47:05 INFO - 'TERM': 'linux', 03:47:05 INFO - 'TMOUT': '86400', 03:47:05 INFO - 'USER': 'cltbld', 03:47:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:05 INFO - '_': '/tools/buildbot/bin/python'} 03:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:47:06 INFO - Installing collected packages: mozsystemmonitor 03:47:06 INFO - Running setup.py install for mozsystemmonitor 03:47:06 INFO - Successfully installed mozsystemmonitor 03:47:06 INFO - Cleaning up... 03:47:06 INFO - Return code: 0 03:47:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:47:06 INFO - Using env: {'DISPLAY': ':0', 03:47:06 INFO - 'HOME': '/home/cltbld', 03:47:06 INFO - 'LANG': 'en_US.UTF-8', 03:47:06 INFO - 'LANGUAGE': 'en_US:en', 03:47:06 INFO - 'LOGNAME': 'cltbld', 03:47:06 INFO - 'MAIL': '/var/mail/cltbld', 03:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:06 INFO - 'MOZ_NO_REMOTE': '1', 03:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:06 INFO - 'NO_EM_RESTART': '1', 03:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:06 INFO - 'PWD': '/builds/slave/test', 03:47:06 INFO - 'SHELL': '/bin/bash', 03:47:06 INFO - 'SHLVL': '1', 03:47:06 INFO - 'TERM': 'linux', 03:47:06 INFO - 'TMOUT': '86400', 03:47:06 INFO - 'USER': 'cltbld', 03:47:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:06 INFO - '_': '/tools/buildbot/bin/python'} 03:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:07 INFO - Downloading/unpacking jsonschema==2.5.1 03:47:07 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:47:07 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:47:07 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:47:07 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:47:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:47:08 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:47:08 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:47:08 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:47:08 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:47:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:08 INFO - warning: no files found matching '*.txt' 03:47:08 INFO - no previously-included directories found matching 'build' 03:47:08 INFO - no previously-included directories found matching 'dist' 03:47:08 INFO - no previously-included directories found matching '.git*' 03:47:08 INFO - Installing collected packages: jsonschema, functools32 03:47:08 INFO - Running setup.py install for functools32 03:47:08 INFO - warning: no files found matching '*.txt' 03:47:08 INFO - no previously-included directories found matching 'build' 03:47:08 INFO - no previously-included directories found matching 'dist' 03:47:08 INFO - no previously-included directories found matching '.git*' 03:47:08 INFO - Successfully installed jsonschema functools32 03:47:08 INFO - Cleaning up... 03:47:08 INFO - Return code: 0 03:47:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:47: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:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47: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:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:08 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:08 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:47:08 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:47:08 INFO - Using env: {'DISPLAY': ':0', 03:47:08 INFO - 'HOME': '/home/cltbld', 03:47:08 INFO - 'LANG': 'en_US.UTF-8', 03:47:08 INFO - 'LANGUAGE': 'en_US:en', 03:47:08 INFO - 'LOGNAME': 'cltbld', 03:47:08 INFO - 'MAIL': '/var/mail/cltbld', 03:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:08 INFO - 'MOZ_NO_REMOTE': '1', 03:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:08 INFO - 'NO_EM_RESTART': '1', 03:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:08 INFO - 'PWD': '/builds/slave/test', 03:47:08 INFO - 'SHELL': '/bin/bash', 03:47:08 INFO - 'SHLVL': '1', 03:47:08 INFO - 'TERM': 'linux', 03:47:08 INFO - 'TMOUT': '86400', 03:47:08 INFO - 'USER': 'cltbld', 03:47:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:08 INFO - '_': '/tools/buildbot/bin/python'} 03:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:47:08 INFO - Cleaning up... 03:47:08 INFO - Return code: 0 03:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47: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:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47: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:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:08 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:08 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:47:08 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:47:08 INFO - Using env: {'DISPLAY': ':0', 03:47:08 INFO - 'HOME': '/home/cltbld', 03:47:08 INFO - 'LANG': 'en_US.UTF-8', 03:47:08 INFO - 'LANGUAGE': 'en_US:en', 03:47:08 INFO - 'LOGNAME': 'cltbld', 03:47:08 INFO - 'MAIL': '/var/mail/cltbld', 03:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:08 INFO - 'MOZ_NO_REMOTE': '1', 03:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:08 INFO - 'NO_EM_RESTART': '1', 03:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:08 INFO - 'PWD': '/builds/slave/test', 03:47:08 INFO - 'SHELL': '/bin/bash', 03:47:08 INFO - 'SHLVL': '1', 03:47:08 INFO - 'TERM': 'linux', 03:47:08 INFO - 'TMOUT': '86400', 03:47:08 INFO - 'USER': 'cltbld', 03:47:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:08 INFO - '_': '/tools/buildbot/bin/python'} 03:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:09 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:47:09 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:47:09 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:47:09 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:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Downloading docopt-0.6.1.tar.gz 03:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:10 INFO - Running setup.py install for blobuploader 03:47:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:11 INFO - Running setup.py install for requests 03:47:11 INFO - Running setup.py install for docopt 03:47:11 INFO - Successfully installed blobuploader requests docopt 03:47:11 INFO - Cleaning up... 03:47:11 INFO - Return code: 0 03:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:11 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:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:11 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:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:11 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:11 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:47:11 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:47:11 INFO - Using env: {'DISPLAY': ':0', 03:47:11 INFO - 'HOME': '/home/cltbld', 03:47:11 INFO - 'LANG': 'en_US.UTF-8', 03:47:11 INFO - 'LANGUAGE': 'en_US:en', 03:47:11 INFO - 'LOGNAME': 'cltbld', 03:47:11 INFO - 'MAIL': '/var/mail/cltbld', 03:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:11 INFO - 'MOZ_NO_REMOTE': '1', 03:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:11 INFO - 'NO_EM_RESTART': '1', 03:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:11 INFO - 'PWD': '/builds/slave/test', 03:47:11 INFO - 'SHELL': '/bin/bash', 03:47:11 INFO - 'SHLVL': '1', 03:47:11 INFO - 'TERM': 'linux', 03:47:11 INFO - 'TMOUT': '86400', 03:47:11 INFO - 'USER': 'cltbld', 03:47:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:11 INFO - '_': '/tools/buildbot/bin/python'} 03:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:11 INFO - Running setup.py (path:/tmp/pip-t6Ccfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:11 INFO - Running setup.py (path:/tmp/pip-Ta0ky6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:11 INFO - Running setup.py (path:/tmp/pip-ZdIYPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:11 INFO - Running setup.py (path:/tmp/pip-RqG5tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:12 INFO - Running setup.py (path:/tmp/pip-0a95Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:12 INFO - Running setup.py (path:/tmp/pip-S1Lk0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:12 INFO - Running setup.py (path:/tmp/pip-ODzw71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:12 INFO - Running setup.py (path:/tmp/pip-nyLVqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:12 INFO - Running setup.py (path:/tmp/pip-a8Pak6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:12 INFO - Running setup.py (path:/tmp/pip-Eob3t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:12 INFO - Running setup.py (path:/tmp/pip-wuPbGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:12 INFO - Running setup.py (path:/tmp/pip-EHGSYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:12 INFO - Running setup.py (path:/tmp/pip-yP2xoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:12 INFO - Running setup.py (path:/tmp/pip-TUaPTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:12 INFO - Running setup.py (path:/tmp/pip-lEEDAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:12 INFO - Running setup.py (path:/tmp/pip-2Db5hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:12 INFO - Running setup.py (path:/tmp/pip-OPPePu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:12 INFO - Running setup.py install for manifestparser 03:47:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozcrash 03:47:13 INFO - Running setup.py install for mozdebug 03:47:13 INFO - Running setup.py install for mozdevice 03:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozfile 03:47:13 INFO - Running setup.py install for mozhttpd 03:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozinfo 03:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozInstall 03:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozleak 03:47:13 INFO - Running setup.py install for mozlog 03:47:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for moznetwork 03:47:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Running setup.py install for mozprocess 03:47:14 INFO - Running setup.py install for mozprofile 03:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Running setup.py install for mozrunner 03:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Running setup.py install for mozscreenshot 03:47:14 INFO - Running setup.py install for moztest 03:47:14 INFO - Running setup.py install for mozversion 03:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:14 INFO - Cleaning up... 03:47:14 INFO - Return code: 0 03:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:14 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:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:14 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:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:14 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:14 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:47:14 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:47:14 INFO - Using env: {'DISPLAY': ':0', 03:47:14 INFO - 'HOME': '/home/cltbld', 03:47:14 INFO - 'LANG': 'en_US.UTF-8', 03:47:14 INFO - 'LANGUAGE': 'en_US:en', 03:47:14 INFO - 'LOGNAME': 'cltbld', 03:47:14 INFO - 'MAIL': '/var/mail/cltbld', 03:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:14 INFO - 'MOZ_NO_REMOTE': '1', 03:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:14 INFO - 'NO_EM_RESTART': '1', 03:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:14 INFO - 'PWD': '/builds/slave/test', 03:47:14 INFO - 'SHELL': '/bin/bash', 03:47:14 INFO - 'SHLVL': '1', 03:47:14 INFO - 'TERM': 'linux', 03:47:14 INFO - 'TMOUT': '86400', 03:47:14 INFO - 'USER': 'cltbld', 03:47:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:14 INFO - '_': '/tools/buildbot/bin/python'} 03:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:14 INFO - Running setup.py (path:/tmp/pip-AlZ5ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:15 INFO - Running setup.py (path:/tmp/pip-WhqKDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:15 INFO - Running setup.py (path:/tmp/pip-G5xa2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:15 INFO - Running setup.py (path:/tmp/pip-6jAY8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:15 INFO - Running setup.py (path:/tmp/pip-uf0jGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:15 INFO - Running setup.py (path:/tmp/pip-QrxqV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:15 INFO - Running setup.py (path:/tmp/pip-UxfzWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:15 INFO - Running setup.py (path:/tmp/pip-F0Ii_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:15 INFO - Running setup.py (path:/tmp/pip-rBM_O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:15 INFO - Running setup.py (path:/tmp/pip-p2DpgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:15 INFO - Running setup.py (path:/tmp/pip-aLlFbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:15 INFO - Running setup.py (path:/tmp/pip-F7qDN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:15 INFO - Running setup.py (path:/tmp/pip-mylkak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:15 INFO - Running setup.py (path:/tmp/pip-fJhscp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:15 INFO - Running setup.py (path:/tmp/pip-PmiJoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:16 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:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:16 INFO - Running setup.py (path:/tmp/pip-yaQGqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:16 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:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:16 INFO - Running setup.py (path:/tmp/pip-qIFvY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:16 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:47:16 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:47:16 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:47:16 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:47:16 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:47:16 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:47:16 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:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:17 INFO - Downloading blessings-1.6.tar.gz 03:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:17 INFO - Installing collected packages: blessings 03:47:17 INFO - Running setup.py install for blessings 03:47:17 INFO - Successfully installed blessings 03:47:17 INFO - Cleaning up... 03:47:17 INFO - Return code: 0 03:47:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:17 INFO - Reading from file tmpfile_stdout 03:47:17 INFO - Current package versions: 03:47:17 INFO - argparse == 1.2.1 03:47:17 INFO - blessings == 1.6 03:47:17 INFO - blobuploader == 1.2.4 03:47:17 INFO - docopt == 0.6.1 03:47:17 INFO - functools32 == 3.2.3-2 03:47:17 INFO - jsonschema == 2.5.1 03:47:17 INFO - manifestparser == 1.1 03:47:17 INFO - mozInstall == 1.13 03:47:17 INFO - mozcrash == 1.0 03:47:17 INFO - mozdebug == 0.1 03:47:17 INFO - mozdevice == 0.51 03:47:17 INFO - mozfile == 1.2 03:47:17 INFO - mozhttpd == 0.7 03:47:17 INFO - mozinfo == 0.10 03:47:17 INFO - mozleak == 0.1 03:47:17 INFO - mozlog == 3.5 03:47:17 INFO - moznetwork == 0.27 03:47:17 INFO - mozprocess == 0.25 03:47:17 INFO - mozprofile == 0.28 03:47:17 INFO - mozrunner == 6.13 03:47:17 INFO - mozscreenshot == 0.1 03:47:17 INFO - mozsystemmonitor == 0.3 03:47:17 INFO - moztest == 0.8 03:47:17 INFO - mozversion == 1.4 03:47:17 INFO - psutil == 3.1.1 03:47:17 INFO - requests == 1.2.3 03:47:17 INFO - wsgiref == 0.1.2 03:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:17 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 03:47:17 INFO - 'HOME': '/home/cltbld', 03:47:17 INFO - 'LANG': 'en_US.UTF-8', 03:47:17 INFO - 'LANGUAGE': 'en_US:en', 03:47:17 INFO - 'LOGNAME': 'cltbld', 03:47:17 INFO - 'MAIL': '/var/mail/cltbld', 03:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:17 INFO - 'MOZ_NO_REMOTE': '1', 03:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:17 INFO - 'NO_EM_RESTART': '1', 03:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:17 INFO - 'PWD': '/builds/slave/test', 03:47:17 INFO - 'SHELL': '/bin/bash', 03:47:17 INFO - 'SHLVL': '1', 03:47:17 INFO - 'TERM': 'linux', 03:47:17 INFO - 'TMOUT': '86400', 03:47:17 INFO - 'USER': 'cltbld', 03:47:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:17 INFO - '_': '/tools/buildbot/bin/python'} 03:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:47:19 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:47:19 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:47:19 INFO - Installing collected packages: simplejson 03:47:19 INFO - Running setup.py install for simplejson 03:47:19 INFO - building 'simplejson._speedups' extension 03:47:19 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:47:20 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:47:20 INFO - Successfully installed simplejson 03:47:20 INFO - Cleaning up... 03:47:20 INFO - Return code: 0 03:47:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:20 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 0x1cf31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, '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': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', '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:47:20 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:47:20 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:47:20 INFO - Using env: {'DISPLAY': ':0', 03:47:20 INFO - 'HOME': '/home/cltbld', 03:47:20 INFO - 'LANG': 'en_US.UTF-8', 03:47:20 INFO - 'LANGUAGE': 'en_US:en', 03:47:20 INFO - 'LOGNAME': 'cltbld', 03:47:20 INFO - 'MAIL': '/var/mail/cltbld', 03:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:20 INFO - 'MOZ_NO_REMOTE': '1', 03:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:20 INFO - 'NO_EM_RESTART': '1', 03:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:20 INFO - 'PWD': '/builds/slave/test', 03:47:20 INFO - 'SHELL': '/bin/bash', 03:47:20 INFO - 'SHLVL': '1', 03:47:20 INFO - 'TERM': 'linux', 03:47:20 INFO - 'TMOUT': '86400', 03:47:20 INFO - 'USER': 'cltbld', 03:47:20 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:20 INFO - '_': '/tools/buildbot/bin/python'} 03:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:47:20 INFO - Cleaning up... 03:47:20 INFO - Return code: 0 03:47:20 INFO - Running post-action listener: _resource_record_post_action 03:47:20 INFO - Running post-action listener: _start_resource_monitoring 03:47:20 INFO - Starting resource monitoring. 03:47:20 INFO - [mozharness: 2017-09-16 10:47:20.443012Z] Finished create-virtualenv step (success) 03:47:20 INFO - [mozharness: 2017-09-16 10:47:20.443530Z] Running install step. 03:47:20 INFO - Running pre-action listener: _resource_record_pre_action 03:47:20 INFO - Running main action method: install 03:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:20 INFO - Reading from file tmpfile_stdout 03:47:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:47:20 INFO - Reading from file tmpfile_stdout 03:47:20 INFO - Output received: 03:47:20 INFO - Usage: mozinstall [options] installer 03:47:20 INFO - Options: 03:47:20 INFO - -h, --help show this help message and exit 03:47:20 INFO - -d DEST, --destination=DEST 03:47:20 INFO - Directory to install application into. [default: 03:47:20 INFO - "/builds/slave/test"] 03:47:20 INFO - --app=APP Application being installed. [default: firefox] 03:47:20 INFO - mkdir: /builds/slave/test/build/application 03:47:20 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:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:47:38 INFO - Reading from file tmpfile_stdout 03:47:38 INFO - Output received: 03:47:38 INFO - /builds/slave/test/build/application/firefox/firefox 03:47:38 INFO - Running post-action listener: _resource_record_post_action 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.361513Z] Finished install step (success) 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.361766Z] Running setup-mitmproxy step. 03:47:38 INFO - Running pre-action listener: _resource_record_pre_action 03:47:38 INFO - Running main action method: setup_mitmproxy 03:47:38 INFO - Skipping: mitmproxy is not required 03:47:38 INFO - Running post-action listener: _resource_record_post_action 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.362899Z] Finished setup-mitmproxy step (success) 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.363190Z] Running run-tests step. 03:47:38 INFO - Running pre-action listener: _resource_record_pre_action 03:47:38 INFO - Running pre-action listener: _set_gcov_prefix 03:47:38 INFO - Running main action method: run_tests 03:47:38 WARNING - Try message not found. 03:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:47:38 INFO - Python 2.7.3 03:47:38 INFO - Return code: 0 03:47:38 INFO - grabbing minidump binary from tooltool 03:47: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:47:38 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 0x2063090>, '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 0x2063d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:47:38 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:47:38 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:47:38 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:47:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:38 INFO - Return code: 0 03:47:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:47:38 INFO - ENV: RUST_BACKTRACE is now full 03:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:47:38 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/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:47:38 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/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:47:38 INFO - Using env: {'DISPLAY': ':0', 03:47:38 INFO - 'HOME': '/home/cltbld', 03:47:38 INFO - 'LANG': 'en_US.UTF-8', 03:47:38 INFO - 'LANGUAGE': 'en_US:en', 03:47:38 INFO - 'LOGNAME': 'cltbld', 03:47:38 INFO - 'MAIL': '/var/mail/cltbld', 03:47:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:38 INFO - 'MOZ_NO_REMOTE': '1', 03:47:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:38 INFO - 'NO_EM_RESTART': '1', 03:47:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:38 INFO - 'PWD': '/builds/slave/test', 03:47:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:38 INFO - 'RUST_BACKTRACE': 'full', 03:47:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:47:38 INFO - 'SHELL': '/bin/bash', 03:47:38 INFO - 'SHLVL': '1', 03:47:38 INFO - 'TERM': 'linux', 03:47:38 INFO - 'TMOUT': '86400', 03:47:38 INFO - 'USER': 'cltbld', 03:47:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:38 INFO - '_': '/tools/buildbot/bin/python'} 03:47:38 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/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:47:38 INFO - mozversion application_buildid: 20170916093032 03:47:38 INFO - mozversion application_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:47:38 INFO - mozversion application_display_name: Nightly 03:47:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:38 INFO - mozversion application_name: Firefox 03:47:38 INFO - mozversion application_remotingname: firefox 03:47:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:47:38 INFO - mozversion application_vendor: Mozilla 03:47:38 INFO - mozversion application_version: 57.0a1 03:47:38 INFO - mozversion platform_buildid: 20170916093032 03:47:38 INFO - mozversion platform_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:47:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:47:38 INFO - mozversion platform_version: 57.0a1 03:47:38 INFO - using testdate: 1505558858 03:47:38 INFO - actual date: 1505558858 03:47:38 INFO - starting webserver on 'localhost:44460' 03:47:38 INFO - SUITE-START | Running 2 tests 03:47:38 INFO - TEST-START | dromaeo_css 03:47:38 INFO - Initialising browser for dromaeo_css test... 03:47:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44460/getInfo.html -profile /tmp/tmp1ALI39/profile 03:47:38 INFO - TEST-INFO | started process 15466 (/builds/slave/test/build/application/firefox/firefox http://localhost:44460/getInfo.html) 03:47:44 INFO - TEST-INFO | 15466: exit 0 03:47:44 INFO - Browser initialized. 03:47:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:47:44 INFO - Using env: {'DISPLAY': ':0', 03:47:44 INFO - 'HOME': '/home/cltbld', 03:47:44 INFO - 'JSGC_DISABLE_POISONING': '1', 03:47:44 INFO - 'LANG': 'en_US.UTF-8', 03:47:44 INFO - 'LANGUAGE': 'en_US:en', 03:47:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:47:44 INFO - 'LOGNAME': 'cltbld', 03:47:44 INFO - 'MAIL': '/var/mail/cltbld', 03:47:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:47:44 INFO - 'MOZ_CRASHREPORTER': '1', 03:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:47:44 INFO - 'MOZ_NO_REMOTE': '1', 03:47:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:44 INFO - 'NO_EM_RESTART': '1', 03:47:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:44 INFO - 'PWD': '/builds/slave/test', 03:47:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:44 INFO - 'RUST_BACKTRACE': 'full', 03:47:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:47:44 INFO - 'SHELL': '/bin/bash', 03:47:44 INFO - 'SHLVL': '1', 03:47:44 INFO - 'TERM': 'linux', 03:47:44 INFO - 'TMOUT': '86400', 03:47:44 INFO - 'USER': 'cltbld', 03:47:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 03:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:44 INFO - '_': '/tools/buildbot/bin/python'} 03:47:44 INFO - TEST-INFO | started process 15703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ALI39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:44 INFO - PID 15703 | 03:47:44 INFO - PID 15703 | (/builds/slave/test/build/application/firefox/firefox:15753): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:47:44 INFO - PID 15703 | 03:47:55 INFO - PID 15703 | RSS: Main: 148275200 03:47:55 INFO - PID 15703 | 03:50:51 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44460/tests/dromaeo/cssquery-ext.html) 03:50:52 INFO - PID 15703 | RSS: Main: 151236608 03:50:52 INFO - PID 15703 | 03:53:54 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-ext.html (next: http://localhost:44460/tests/dromaeo/cssquery-jquery.html) 03:53:54 INFO - PID 15703 | RSS: Main: 148766720 03:53:54 INFO - PID 15703 | 03:56:56 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44460/tests/dromaeo/cssquery-mootools.html) 03:56:56 INFO - PID 15703 | RSS: Main: 150896640 03:56:56 INFO - PID 15703 | 03:59:58 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44460/tests/dromaeo/cssquery-prototype.html) 03:59:59 INFO - PID 15703 | RSS: Main: 149299200 03:59:59 INFO - PID 15703 | 04:03:02 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44460/tests/dromaeo/cssquery-yui.html) 04:03:02 INFO - PID 15703 | RSS: Main: 150810624 04:03:02 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | Cycle 1(1): loaded http://localhost:44460/tests/dromaeo/cssquery-yui.html (next: http://localhost:44460/tests/dromaeo/cssquery-dojo.html) 04:06:04 INFO - PID 15703 | RSS: Main: 152965120 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | __start_tp_report 04:06:04 INFO - PID 15703 | _x_x_mozilla_page_load 04:06:04 INFO - PID 15703 | _x_x_mozilla_page_load_details 04:06:04 INFO - PID 15703 | |i|pagename|runs| 04:06:04 INFO - PID 15703 | |0;dojo.html;3769.3592089344806;3788.924221515568;3811.10439046824;3841.846326146954;3848.4996950396453;6145.078238264263;6173.7961097585985;6177.907331390033;6188.876222475547;6382.744690212386;6245.7813976510715;6308.621482711041;6319;6326.177596912395;6351.968240158804;5641.323041235037;5663.5186009189065;5682.857928551788;5689.715514224272;5692.0608099663505;5693.174489699012;5724.398938111501;5754.280714910637;5755.2230448889495;5756.510696590794;104.80738854923536;5316.601254905898;5604.747786349624;5631.155326700987;5712.857178570527;5580.162975553659;5615.438456154393;5631.1271752878365;5640.435956404327;5643.322801263875;5549.834534747708;5566.916496252559;5627.521660658849;5638.126090455986;5648.887022259573;6217.6891155442045;6220.1602783624085;6264.59280146789;6279;6326.398992095744;6838.658067096675;6841.555298905555;6872.347127022925;6889.552179108342;6949;6755.22314933779;6842.4868134890085;6847.794566163023;6860.382565569123;6861.416779573742;6263.498920086382;6314.368563143695;6343.904841427382;6412.679366031726;6447.806565803034;6926.168859736763;6930.341617546325;6992.440604751608;6994.4404447644065;7013.123359580052;6674.098996635392;6679.833004174838;6680;6755.93244067553;6764.526483146231;6670.966645166744;6772.8984065239065;6803.65981700913;6809.761658341934;6866.485013623898;6687.565308254948;6774.525783195129;6781;6787.355201255873;6790.456763458911;6772.69522871472;6786.185657721105;6799.218089919624;6807.047013418125;6901.585904845625;4882.438519570223;4944.480829512921;4956.776945037482;4970.527799859007;4973.179425394842;4425.291953287523;4453.398791163151;4457.4205353304515;4464.196444639931;4472.373867658531;6211.472024877846;6243.469305109026;6246.063090536365;6297.307296197415;6310.05349197624;6866.416354609914;6879.6560171991205;6883.518153729291;6885.036094946711;6892.758753443605;6319.557630965788;6349.619022858643;6354;6361.2048493938255;6373.52198585108;5372.677639341652;5412.323459567554;5458.372287186945;5517.44825517445;5571.972140139354;6870.175578930461;6985.825354366079;7003.2296447390745;7032.6132062736015;7074.504784665024;6746.4940129489505;6801.727930882709;6814.488913331421;6832.863342733018;6841.692123854538;6982;7024.648767561704;7149.14210294768;7158.248383919614;7173.856522869409;6723.865522689616;6746.426553742791;6760.830979225362;6834.282400347892;6841.042254084532;6732.293109223461;6776.254611992776;6854.10896583441;6857.142857142857;6900.896486552806;6560.803175904731;6571.441427478718;6628.105205797156;6628.469722422291;6632.303608121078;6515.609063456208;6660.200775906922;6663.800085997428;6671.6330601815425;6686.7993960181275;6484;6501.674916254074;6509.251436084911;6632.734690612321;6635.435987940886;6561.212654481493;6582.901256481061;6623.072769812326;6706.731730730716;6736.427403670743;6399.904001440075;6473.902891456726;6487.286398496068;6490.545661803629;6493.805185844432 04:06:04 INFO - PID 15703 | |1;ext.html;922.2161163011441;965.0638880286125;968.85467179923;1011.9544620492077;1012.696191142657;44474;45290.54709452912;45501.77249113758;45586.77206613962;45665.771671141636;45258.09483810322;46075;46133.7693311533;46155.769221153845;46209.075818483696;7933.286004259601;8023.39824513161;8052.235037671412;8093.5143891366415;8094.716684916029;7830.29527342539;7984.720534781284;7985;7989.840203195932;7990;8001.5199088054615;8024.358051355877;8025.197480251986;8051.758447246592;8055.395845311596;7950.721724739664;7975.042994840627;8014.358851291911;8016.198380161937;8044.637991290348;7899.684012639487;7911.5253084815095;7938.801529961739;7943.841123177504;7961.243681850215;41461.58538414608;41711.582884171075;41722.791386042874;41743.7912810434;41754.1649167015;3656.9268614627827;3657.2319812839337;3690.022144131807;3694.538182727159;3705.2033812730124;33727.15682107942;33728.14495202763;33756.324873502635;33947.660523394945;33968.49047264293;5278.841634750964;5371.221172929903;5416.539594134503;5441.755121019524;5531.861703457445;214255;217587;218630;220553;220710;51909.740451298254;52884.471155288724;52892.73553632284;52928.47071529312;53025.734871325396;56175;56227;56284.718576406856;56302.71848640813;56337.43662563322;17028.574285642957;17175.484735457958;17189.914050429918;17211;17463.388781392845;14296.928515357356;14314.785278220836;14322.713545729235;14330.85669143316;14342.354594043292;13718.519851805138;13848.515301964382;13898.930505347611;13905.513307034407;14081.08472949255;5626.352969408488;5719.28508936383;5748.166515855178;5775.16260142277;5775.191473193756;1102.685734565645;1112.4159816096615;1121.7980763462492;1127.6335191062938;1134.0247387246961;25643;25823.74176258251;25834.35414114662;25875;25907.870460647577;1194.988050119505;1229.877012298763;1244.0607341457142;1251.7121062155754;1259.389196239823;13772.173669579857;13855.861441385458;13896.722065558632;14004.439822407194;14113.435462581381;277276;278822;278856;279134;279296;57313.426865730806;57386.13920791192;57553.424465754804;57569.42430575641;57662.42337576654;1522.216058729755;1550.7286224910595;1574.1656921831448;1583.4141367694026;1593.2670971353075;24349.75650243475;24477;24490.14284500034;24491.26526204217;24650.87674561616;40291.597084028785;40301.1939761209;40348.596514034485;40444.59555404526;40494.59505404908;222629;222771;223500;224288;224672;35405.82297088498;35732.82133589315;35984.460233096004;36030.45954310635;36132.81933590315;46125.538744612124;46723;46919.061618768115;46931.53068469408;47719.76140119277;34369.14077148091;34628.21639763481;34736.82631586826;34917;34968.475472867416;34074.14814629654;34398.656013440544;34866.47700284447;34910.301793963474;34916.47625285572;39625.603743962194;40893.795531023345;41024.58975410327;41277;41537.16925661409;33549.16127096842;33575.16062098467;33661.83169084139;33685.83157084199;34349.82825085858;24868.875655621607;25296.873515632305;25696.357591060372;25877;26333.34166645849 04:06:04 INFO - PID 15703 | |2;jquery.html;609.4119174996125;610.1793088296242;610.6519284008117;614.7725341623599;626.3329554024963;23043.539129217406;24004.279871603838;24049.75950240497;24070.75929240705;24081.759182408172;24615.75384246157;26156.738432615668;26237.73762262377;26262.474750504978;26302.342441438926;6596.142501474802;6695.029220762986;6712.731490740364;6725.2602213756445;6748.696308666097;6252.406021427957;6530.836729081787;6532.052852336432;6555.70499327529;6565.080888675589;6480.57876238043;6484.0598113273545;6488.28628850826;6491.7078731457195;6495.447886929616;6153.938460615382;6525.0864878916755;6545.476361891037;6546.410823025927;6548;6100.23747031621;6121.724522396503;6138.508919286446;6145.754169833202;6147.170132032164;29565.408691826044;30167.245818854484;30251.394972100654;30292.394152117056;30315.393692126254;2276.84062115652;2279.202279202266;2286.8399212055165;2309.884505774721;2315.583195024895;20095.799042009687;20906;20909.581808363746;20915.16339346424;20966.16135354584;2328.988355058231;2458.188797696756;2518.25711415133;2549.3626593351664;2612.333854867016;150061;152347.2382638091;152522;152555;152682.9999999989;15148.242587870562;15417.537473875802;15631.531054068397;16100.597485062734;16167.353305867633;25052.87473562657;25180.74819251784;25210.243692689248;25242.873785630953;25305.367365816;10416.166706663449;10696.34206697963;10850.945745271381;10893.455327233607;11034.503447344889;9767.16979056774;9875.506224688737;9973.351732137387;10059.195264378832;10067.496625168713;9539.52302384878;9807.803843923082;9910.30627856043;9956.452395118193;10110.24173187014;2980.821150730963;3008.9097327079785;3033.6966303369486;3037.8734885580184;3043.6195475565555;1037.3361048928691;1051.9105876000472;1058.5606973106076;1060.6075751971666;1063.2450959818616;21537;21550.137994480046;21619.56760864774;21674.133034678438;22308.776912230995;1105.309181761399;1111.3165403277087;1114.8550688410617;1115.5036008975928;1124.5333186727416;11586.88413115858;11881.762364752656;11959.880401196051;12003.819942700866;12005.579804706967;582781;585900;604788;607656;608369;127011;128518.35740821237;128830;129715;133570;1231.901447884167;1252.5490823303603;1277.9680507987189;1281.5770795637418;1285.2673975833873;18836.717449238;19141.90429047846;19163.904180479567;19323;19533.316333928244;60053.39946600653;60404.39595603988;60780.08829867467;62315;63355.049674254;77818;79464.60267698625;80976;81517.18482815096;81794;15022.549323520312;15325.157116358707;15468.458603948808;15553.455629052929;15564.844351556792;23364.53270934606;23474;23477.76522234824;23630.881845590662;23776.762232378147;19177.712334314718;19225.615487690447;19256.133473993985;19418.223271069;19732.210711571377;17280.13599320054;17526.123693815513;17677.646447071245;17779.28882844672;17854.732179017064;19708.901455492633;19712.225899669098;19773.802261977195;19901.203951841766;20058.799412005694;15315.61710957235;15371;15377.231138442809;15403.383864645288;15412.612864842218;18806.811931880507;19152.61694766069;19218.903905480383;19386.4184074478;19401 04:06:04 INFO - PID 15703 | |3;mootools.html;1419.2619837684404;1478.7264356094117;1483.859033391828;1488.218685190275;1491.7762335649652;16458.17709114544;17306.221220045096;17324.220410081543;17346.913265433654;17370.73943890841;16530.42143524977;16720.665586688257;16754.16229188542;16769;16825.663486730256;2786.5541513357816;2839.772818174541;2853.514902466575;2862.0698273061234;2862.313044869227;2749.1477641930965;2826.4488424757183;2826.689064202936;2831.2497188245134;2846.8291902485917;2750.6286651302116;2798.6361772969485;2800.7619352354973;2800.80394372394;2809.339805145789;2677.3708178578017;2709.417475242832;2721.5917612358107;2722.823016503921;2727.3727042780074;2619.096411737947;2640.5379058664657;2658.3752818087733;2664;2666.066876593177;15950.361985520565;16068.43760468378;16217.189140543043;16221.756673649905;16373.672526549402;7899.407544434133;8187.918120818775;8213.096559378464;8246.628901699438;8286.917130828675;5275.314209152785;5462.071447853875;5465.371482279549;5489.1217405214975;5986;1925.4512463947708;1992.163291417608;2020.1818263603263;2020.40398082566;2045.3863840847687;27209.45581088387;27988;28002.859985700146;30447.543286850716;31108.688913110804;7521.135069467081;7553.773386798405;7616.619169041636;7733.226677332222;7760.34037106841;22330.330090097;22369;22427.551448970928;22467.550648987257;22569.548609028057;8595.527246001406;8668.479891206422;8677.349198810114;8703.39076264668;8733.432326898732;7661.310482056641;7829.765107046797;7871.0554733432355;7874.527528348203;7946.364290856717;5721.885562288814;5968.104784282393;6020.518358531394;6043.305019922677;6069.8770727414685;1784.6787578236042;1826.2694922031294;1845.3264558436074;1847.224165850346;1864.7296142059326;931.9394239374419;955.3408148377736;956.9617215311449;959.0361686505157;959.8560215967522;8642.870356944652;9030.277577793891;9055.275577953747;9174.357794954289;9202.81594368109;771.413725568572;779.84193472693;784.2471227621434;799.192815256595;800.771780042685;4732.503087175865;4788.688735232268;4817.156997525419;4828.37231159954;4866.489018653061;23884.52230955371;24826.37934051627;25013.874930625232;25018.749812501643;25067;23181.188658396874;24270.723452334063;24432.633510497355;24438.755612444005;24651.260462186165;10311.48442577868;10566.471676415995;10679.946600266949;12250;12418.192817467016;8124.796880078045;9130.452172869649;9176.908230917605;9221.49281789508;9272.490013049348;19205.231790728216;20490.487737806674;20574.588508230052;20899.8955005224;21369.252076177258;21410.57178856383;21432.892835535724;21929.451763706034;21989.340319790434;22027.118915243853;13181.934090329487;13185.142965707199;13413.530526431528;13559.389827457591;13571.321433928066;15362.30869610848;15520.456784012506;15539.611509712347;15588.14265215424;15599.532014039596;12484.687882803002;12719.300438475973;12760.553380632005;12804.61586152417;12839.229646221256;11945.701357466132;12483.500659973499;12515.749685006067;12524.436400361823;12543.93728031354;10261.846072308772;10481.37111773296;10530.736731581772;10544;10546.841797372892;7915.84168316642;8054.758357249292;8079.676812927417;8211.83576328482;8213.753587392388;8178.100408955129;8232.472140322918;8236.917630823615;8275.751727447945;8366.87449688243 04:06:04 INFO - PID 15703 | |4;prototype.html;525.3774277481185;542.8262955854127;561.7893290016244;571.3800526428824;571.7398583644441;6056.424639659236;6138.8336216118905;6151.41561551653;6182.319944806073;6261.624302541851;6001.129836173752;6007.519398448125;6025.3070896846875;6067.787627433041;6083.78706745264;4865.5134486551415;4878.268259761029;4885.975570122145;4906.852794416155;4935.877572643762;4763.404574428197;4855.611551075923;4896.43690975537;4909.803607855682;4920.409550853902;4863.662492814469;4894.975525122387;4902.681325713835;4919.803207871681;4934.605231581483;4817.156997525419;4879.463259041502;4880.853574392774;4894.559489645949;4899.485554016813;4401.405810215612;4410.3825464435;4460.553944605546;4469.776511174461;4471.105778844211;6107.7556897724035;6117.510599152057;6151.784687535915;6152.600080994721;6155;5732.541396688297;5749.137629355589;5761.732418867842;5782.190493330937;5838.182654428383;6413.262474815363;6496.480281577463;6534.803955881332;6547.9345206547805;6568;4909.975450122763;4961.776720047606;4975.676581022222;4983.327250821165;4991.925121123149;6813.977903314493;6868.484863635247;6870.20992585854;6873.621950792654;6891.207511136234;5030.84907452777;5080.74596270185;5095.643304968691;5098.923516147261;5111.642185047085;5170.224466330081;5177.275181474596;5177.482251774868;5211.817586384458;5213.296205012351;5567.888642227133;5640.5487560995025;5704.942950570524;5734.627249228787;5747.195392645033;6189.6286222826775;6508.707108180143;6514.218293804679;6554.7378104876225;6554.787364337612;1680.8739344549208;1692.6445446456137;1742.3988723890238;1748.641528486657;1756.8682348823634;1214.174361434233;1251.7795149729122;1260.6785269756338;1267.4043199696127;1278.1564167649492;5901.852453688693;5956.791512297135;5969.492593129546;6010.3689112643415;6090.756369745161;6506.121673574102;6590.275069742324;6601.834954126185;6608.86782264352;6717.798466046026;6021.892337681777;6029.3970602940235;6098.786542470993;6108.450239478379;6182.814515564541;3337.4493208620793;3443.3816106429936;3486.6861982421706;3512.121969507623;3533.2226910080253;6837.324855410357;6900.482463815234;6918.481113916477;6923.430535846317;6965.477589180831;6878.7248510059035;6916.619585922823;6938.548994315353;6955.234924158339;6969.23338432772;6898.931010689929;6941.514094013371;6949.3745562899585;6962.23415424313;6982.067531636623;6643.56816806906;6671.799846004627;6676.298988606127;6722.798316050526;6727.8990815138795;6544.934550654623;6551.70517326731;6685.231198412245;6701.229358623626;6724.966375168093;6815.182178138655;6859.828504287433;6878.38094571491;6909.343612356818;6917.688704008432;5008.192135549767;5017.57350625201;5030.949690503048;5066.620003499678;5091.363579552556;6489.1888513935755;6629.303923088007;6653.168353955755;6665.633390163587;6747.325267473213;6188.969055154876;6402;6462.4183823456115;6463.547551671338;6504.674766261763;6354.841128971812;6423.935760642334;6442.8389290268115;6495.610263384212;6500.772472963424;6065.72704228302;6242.188515492957;6242.719077641426;6360.363963603602;6433.970564709624;6491.851452045659;6539.934600654123;6544.574602650812;6575.178102737158;6628.171478565179;6250.968745156427;6255.53083518747;6272.655003974825;6304.338044505261;6310.400511951358 04:06:04 INFO - PID 15703 | |5;yui.html;937.634322614181;966.7099870038987;992.5186284651943;994.5922171909514;997.4414327976332;20334.796652033474;21021.894890525564;21074.157033718653;21102.577948441023;21104.788952110473;19026.61946761064;19172.520686982833;19512.90243548784;20052.298169564066;20057.699134512994;1052.7210289273348;1070.0262760887595;1070.4166229404955;1071.4214324264888;1072.3780207479642;1044.2742294105599;1049.4333060147512;1055.5566662001977;1059.2796898109282;1059.4332032362688;1141.8344340070685;1144;1148.5291030677424;1159.802833518304;1160.2516376936871;1130.9321440713584;1134.863816342036;1141.61185197033;1142.4002398740686;1148.087270619855;792.9484583502111;820.327331588098;820.9671613135528;821.0188824354898;821.572782153277;19006.049697515067;19216.327428539935;19363.61272774551;19366.4190074298;19399.127039283267;23344.29967100973;23445.17941872026;23999;24154;24189;18325.908370458197;18447.631047379113;18658.25366985319;18735.81264187368;19007.1446784895;3975.8807235782974;4064.1465292288653;4066.3290557058344;4075.9592404075875;4078.4290199372113;165259;165646;167295.1635241828;169254;169516;18094.5476363092;18189.54526136857;18419.631607367777;18643.90678046628;18699.906500467412;35202;35385.64614353875;35497.64502354995;35769.284614307566;36027.63972360243;9336.06639336061;9460.195883349854;9489.572969216402;9491.288153388523;9496.572654230577;4411.18393097278;4569.840055598038;4614.97692511542;4649.883752906205;4654.301854721751;6091.116788065706;6229.937700622936;6252.5935814171935;6262.780802671885;6262.966610509215;1089.6186334782763;1114.5931734916696;1124.0614087237248;1129.0233947635236;1130.7964566377966;725.6915810780503;729.4747781597241;748.6780684305692;753.9246075392417;755.0788038592908;12826.23042617446;12832.486700531874;13015.633358497222;13215;13228.470861165639;705.5555000349747;708.2386434582844;708.5075872268724;710.1407297170379;728.1298847876736;6224.968875155595;6264.279607845065;6372.840678983062;6389.520785941073;6458.903116453257;154217;156811;156931;157037;157053;134475.32762336126;135104;135841;136743;141293;114538.4273078646;114752;114837;115594.422027891;115720;11465.713357166138;11587.362695051854;11645.184837061324;11799.292042477478;11855.644330670093;53133.734331328094;53496.197557037456;54015.91968160693;54332.45667543274;55307;68495.31504684889;70295.29704702887;70903;71603;71819.64090179515;17292.654146917244;17367.47897563075;17380.565485862448;17520.737188941923;17521.299148033937;18426.078696064877;18698.34555790541;18703;18769.1553880073;18832.717509237646;17450.04024778649;17470.126493675518;17517.737233941247;17710.645787084442;17720.291188352836;16188.919055405118;16258.430954916521;16379.59051023734;16506.669866602362;16542.66914661724;16860.156992150587;16979.49061528156;17103.914480427517;17176.141192940053;17252.654946901243;12999.1550549214;13066.150700204456;13081.163125100205;13228.933855331046;13385.86614133885;12233;12607.99136069094;12720.936395317964;12747.87252127504;12850.357482126043 04:06:04 INFO - PID 15703 | __end_tp_report 04:06:04 INFO - PID 15703 | __start_cc_report 04:06:04 INFO - PID 15703 | _x_x_mozilla_cycle_collect,253 04:06:04 INFO - PID 15703 | __end_cc_report 04:06:04 INFO - PID 15703 | __startTimestamp1505559964443__endTimestamp 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | ------- Summary: start ------- 04:06:04 INFO - PID 15703 | Number of tests: 6 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#0] dojo.html Cycles:165 Average:6230.17 Median:6509.25 stddev:897.46 (13.8%) stddev-sans-first:879.20 04:06:04 INFO - PID 15703 | Values: 3769.4 3788.9 3811.1 3841.8 3848.5 6145.1 6173.8 6177.9 6188.9 6382.7 6245.8 6308.6 6319.0 6326.2 6352.0 5641.3 5663.5 5682.9 5689.7 5692.1 5693.2 5724.4 5754.3 5755.2 5756.5 104.8 5316.6 5604.7 5631.2 5712.9 5580.2 5615.4 5631.1 5640.4 5643.3 5549.8 5566.9 5627.5 5638.1 5648.9 6217.7 6220.2 6264.6 6279.0 6326.4 6838.7 6841.6 6872.3 6889.6 6949.0 6755.2 6842.5 6847.8 6860.4 6861.4 6263.5 6314.4 6343.9 6412.7 6447.8 6926.2 6930.3 6992.4 6994.4 7013.1 6674.1 6679.8 6680.0 6755.9 6764.5 6671.0 6772.9 6803.7 6809.8 6866.5 6687.6 6774.5 6781.0 6787.4 6790.5 6772.7 6786.2 6799.2 6807.0 6901.6 4882.4 4944.5 4956.8 4970.5 4973.2 4425.3 4453.4 4457.4 4464.2 4472.4 6211.5 6243.5 6246.1 6297.3 6310.1 6866.4 6879.7 6883.5 6885.0 6892.8 6319.6 6349.6 6354.0 6361.2 6373.5 5372.7 5412.3 5458.4 5517.4 5572.0 6870.2 6985.8 7003.2 7032.6 7074.5 6746.5 6801.7 6814.5 6832.9 6841.7 6982.0 7024.6 7149.1 7158.2 7173.9 6723.9 6746.4 6760.8 6834.3 6841.0 6732.3 6776.3 6854.1 6857.1 6900.9 6560.8 6571.4 6628.1 6628.5 6632.3 6515.6 6660.2 6663.8 6671.6 6686.8 6484.0 6501.7 6509.3 6632.7 6635.4 6561.2 6582.9 6623.1 6706.7 6736.4 6399.9 6473.9 6487.3 6490.5 6493.8 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#1] ext.html Cycles:180 Average:42108.92 Median:36081.64 stddev:62832.53 (174.1%) stddev-sans-first:62932.69 04:06:04 INFO - PID 15703 | Values: 922.2 965.1 968.9 1012.0 1012.7 44474.0 45290.5 45501.8 45586.8 45665.8 45258.1 46075.0 46133.8 46155.8 46209.1 7933.3 8023.4 8052.2 8093.5 8094.7 7830.3 7984.7 7985.0 7989.8 7990.0 8001.5 8024.4 8025.2 8051.8 8055.4 7950.7 7975.0 8014.4 8016.2 8044.6 7899.7 7911.5 7938.8 7943.8 7961.2 41461.6 41711.6 41722.8 41743.8 41754.2 3656.9 3657.2 3690.0 3694.5 3705.2 33727.2 33728.1 33756.3 33947.7 33968.5 5278.8 5371.2 5416.5 5441.8 5531.9 214255.0 217587.0 218630.0 220553.0 220710.0 51909.7 52884.5 52892.7 52928.5 53025.7 56175.0 56227.0 56284.7 56302.7 56337.4 17028.6 17175.5 17189.9 17211.0 17463.4 14296.9 14314.8 14322.7 14330.9 14342.4 13718.5 13848.5 13898.9 13905.5 14081.1 5626.4 5719.3 5748.2 5775.2 5775.2 1102.7 1112.4 1121.8 1127.6 1134.0 25643.0 25823.7 25834.4 25875.0 25907.9 1195.0 1229.9 1244.1 1251.7 1259.4 13772.2 13855.9 13896.7 14004.4 14113.4 277276.0 278822.0 278856.0 279134.0 279296.0 57313.4 57386.1 57553.4 57569.4 57662.4 1522.2 1550.7 1574.2 1583.4 1593.3 24349.8 24477.0 24490.1 24491.3 24650.9 40291.6 40301.2 40348.6 40444.6 40494.6 222629.0 222771.0 223500.0 224288.0 224672.0 35405.8 35732.8 35984.5 36030.5 36132.8 46125.5 46723.0 46919.1 46931.5 47719.8 34369.1 34628.2 34736.8 34917.0 34968.5 34074.1 34398.7 34866.5 34910.3 34916.5 39625.6 40893.8 41024.6 41277.0 41537.2 33549.2 33575.2 33661.8 33685.8 34349.8 24868.9 25296.9 25696.4 25877.0 26333.3 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#2] jquery.html Cycles:180 Average:39459.63 Median:12665.19 stddev:100158.72 (790.8%) stddev-sans-first:100397.21 04:06:04 INFO - PID 15703 | Values: 609.4 610.2 610.7 614.8 626.3 23043.5 24004.3 24049.8 24070.8 24081.8 24615.8 26156.7 26237.7 26262.5 26302.3 6596.1 6695.0 6712.7 6725.3 6748.7 6252.4 6530.8 6532.1 6555.7 6565.1 6480.6 6484.1 6488.3 6491.7 6495.4 6153.9 6525.1 6545.5 6546.4 6548.0 6100.2 6121.7 6138.5 6145.8 6147.2 29565.4 30167.2 30251.4 30292.4 30315.4 2276.8 2279.2 2286.8 2309.9 2315.6 20095.8 20906.0 20909.6 20915.2 20966.2 2329.0 2458.2 2518.3 2549.4 2612.3 150061.0 152347.2 152522.0 152555.0 152683.0 15148.2 15417.5 15631.5 16100.6 16167.4 25052.9 25180.7 25210.2 25242.9 25305.4 10416.2 10696.3 10850.9 10893.5 11034.5 9767.2 9875.5 9973.4 10059.2 10067.5 9539.5 9807.8 9910.3 9956.5 10110.2 2980.8 3008.9 3033.7 3037.9 3043.6 1037.3 1051.9 1058.6 1060.6 1063.2 21537.0 21550.1 21619.6 21674.1 22308.8 1105.3 1111.3 1114.9 1115.5 1124.5 11586.9 11881.8 11959.9 12003.8 12005.6 582781.0 585900.0 604788.0 607656.0 608369.0 127011.0 128518.4 128830.0 129715.0 133570.0 1231.9 1252.5 1278.0 1281.6 1285.3 18836.7 19141.9 19163.9 19323.0 19533.3 60053.4 60404.4 60780.1 62315.0 63355.0 77818.0 79464.6 80976.0 81517.2 81794.0 15022.5 15325.2 15468.5 15553.5 15564.8 23364.5 23474.0 23477.8 23630.9 23776.8 19177.7 19225.6 19256.1 19418.2 19732.2 17280.1 17526.1 17677.6 17779.3 17854.7 19708.9 19712.2 19773.8 19901.2 20058.8 15315.6 15371.0 15377.2 15403.4 15412.6 18806.8 19152.6 19218.9 19386.4 19401.0 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#3] mootools.html Cycles:180 Average:10340.01 Median:2693.39 stddev:7646.47 (283.9%) stddev-sans-first:7638.55 04:06:04 INFO - PID 15703 | Values: 1419.3 1478.7 1483.9 1488.2 1491.8 16458.2 17306.2 17324.2 17346.9 17370.7 16530.4 16720.7 16754.2 16769.0 16825.7 2786.6 2839.8 2853.5 2862.1 2862.3 2749.1 2826.4 2826.7 2831.2 2846.8 2750.6 2798.6 2800.8 2800.8 2809.3 2677.4 2709.4 2721.6 2722.8 2727.4 2619.1 2640.5 2658.4 2664.0 2666.1 15950.4 16068.4 16217.2 16221.8 16373.7 7899.4 8187.9 8213.1 8246.6 8286.9 5275.3 5462.1 5465.4 5489.1 5986.0 1925.5 1992.2 2020.2 2020.4 2045.4 27209.5 27988.0 28002.9 30447.5 31108.7 7521.1 7553.8 7616.6 7733.2 7760.3 22330.3 22369.0 22427.6 22467.6 22569.5 8595.5 8668.5 8677.3 8703.4 8733.4 7661.3 7829.8 7871.1 7874.5 7946.4 5721.9 5968.1 6020.5 6043.3 6069.9 1784.7 1826.3 1845.3 1847.2 1864.7 931.9 955.3 957.0 959.0 959.9 8642.9 9030.3 9055.3 9174.4 9202.8 771.4 779.8 784.2 799.2 800.8 4732.5 4788.7 4817.2 4828.4 4866.5 23884.5 24826.4 25013.9 25018.7 25067.0 23181.2 24270.7 24432.6 24438.8 24651.3 10311.5 10566.5 10679.9 12250.0 12418.2 8124.8 9130.5 9176.9 9221.5 9272.5 19205.2 20490.5 20574.6 20899.9 21369.3 21410.6 21432.9 21929.5 21989.3 22027.1 13181.9 13185.1 13413.5 13559.4 13571.3 15362.3 15520.5 15539.6 15588.1 15599.5 12484.7 12719.3 12760.6 12804.6 12839.2 11945.7 12483.5 12515.7 12524.4 12543.9 10261.8 10481.4 10530.7 10544.0 10546.8 7915.8 8054.8 8079.7 8211.8 8213.8 8178.1 8232.5 8236.9 8275.8 8366.9 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#4] prototype.html Cycles:180 Average:5531.83 Median:6108.10 stddev:1561.27 (25.6%) stddev-sans-first:1519.75 04:06:04 INFO - PID 15703 | Values: 525.4 542.8 561.8 571.4 571.7 6056.4 6138.8 6151.4 6182.3 6261.6 6001.1 6007.5 6025.3 6067.8 6083.8 4865.5 4878.3 4886.0 4906.9 4935.9 4763.4 4855.6 4896.4 4909.8 4920.4 4863.7 4895.0 4902.7 4919.8 4934.6 4817.2 4879.5 4880.9 4894.6 4899.5 4401.4 4410.4 4460.6 4469.8 4471.1 6107.8 6117.5 6151.8 6152.6 6155.0 5732.5 5749.1 5761.7 5782.2 5838.2 6413.3 6496.5 6534.8 6547.9 6568.0 4910.0 4961.8 4975.7 4983.3 4991.9 6814.0 6868.5 6870.2 6873.6 6891.2 5030.8 5080.7 5095.6 5098.9 5111.6 5170.2 5177.3 5177.5 5211.8 5213.3 5567.9 5640.5 5704.9 5734.6 5747.2 6189.6 6508.7 6514.2 6554.7 6554.8 1680.9 1692.6 1742.4 1748.6 1756.9 1214.2 1251.8 1260.7 1267.4 1278.2 5901.9 5956.8 5969.5 6010.4 6090.8 6506.1 6590.3 6601.8 6608.9 6717.8 6021.9 6029.4 6098.8 6108.5 6182.8 3337.4 3443.4 3486.7 3512.1 3533.2 6837.3 6900.5 6918.5 6923.4 6965.5 6878.7 6916.6 6938.5 6955.2 6969.2 6898.9 6941.5 6949.4 6962.2 6982.1 6643.6 6671.8 6676.3 6722.8 6727.9 6544.9 6551.7 6685.2 6701.2 6725.0 6815.2 6859.8 6878.4 6909.3 6917.7 5008.2 5017.6 5030.9 5066.6 5091.4 6489.2 6629.3 6653.2 6665.6 6747.3 6189.0 6402.0 6462.4 6463.5 6504.7 6354.8 6423.9 6442.8 6495.6 6500.8 6065.7 6242.2 6242.7 6360.4 6434.0 6491.9 6539.9 6544.6 6575.2 6628.2 6251.0 6255.5 6272.7 6304.3 6310.4 04:06:04 INFO - PID 15703 | 04:06:04 INFO - PID 15703 | [#5] yui.html Cycles:180 Average:28708.43 Median:18545.77 stddev:43823.20 (236.3%) stddev-sans-first:43896.53 04:06:04 INFO - PID 15703 | Values: 937.6 966.7 992.5 994.6 997.4 20334.8 21021.9 21074.2 21102.6 21104.8 19026.6 19172.5 19512.9 20052.3 20057.7 1052.7 1070.0 1070.4 1071.4 1072.4 1044.3 1049.4 1055.6 1059.3 1059.4 1141.8 1144.0 1148.5 1159.8 1160.3 1130.9 1134.9 1141.6 1142.4 1148.1 792.9 820.3 821.0 821.0 821.6 19006.0 19216.3 19363.6 19366.4 19399.1 23344.3 23445.2 23999.0 24154.0 24189.0 18325.9 18447.6 18658.3 18735.8 19007.1 3975.9 4064.1 4066.3 4076.0 4078.4 165259.0 165646.0 167295.2 169254.0 169516.0 18094.5 18189.5 18419.6 18643.9 18699.9 35202.0 35385.6 35497.6 35769.3 36027.6 9336.1 9460.2 9489.6 9491.3 9496.6 4411.2 4569.8 4615.0 4649.9 4654.3 6091.1 6229.9 6252.6 6262.8 6263.0 1089.6 1114.6 1124.1 1129.0 1130.8 725.7 729.5 748.7 753.9 755.1 12826.2 12832.5 13015.6 13215.0 13228.5 705.6 708.2 708.5 710.1 728.1 6225.0 6264.3 6372.8 6389.5 6458.9 154217.0 156811.0 156931.0 157037.0 157053.0 134475.3 135104.0 135841.0 136743.0 141293.0 114538.4 114752.0 114837.0 115594.4 115720.0 11465.7 11587.4 11645.2 11799.3 11855.6 53133.7 53496.2 54015.9 54332.5 55307.0 68495.3 70295.3 70903.0 71603.0 71819.6 17292.7 17367.5 17380.6 17520.7 17521.3 18426.1 18698.3 18703.0 18769.2 18832.7 17450.0 17470.1 17517.7 17710.6 17720.3 16188.9 16258.4 16379.6 16506.7 16542.7 16860.2 16979.5 17103.9 17176.1 17252.7 12999.2 13066.2 13081.2 13228.9 13385.9 12233.0 12608.0 12720.9 12747.9 12850.4 04:06:04 INFO - PID 15703 | -------- Summary: end -------- 04:06:04 INFO - PID 15703 | 04:06:05 INFO - TEST-INFO | 15703: exit 0 04:06:05 INFO - TEST-OK | dromaeo_css | took 1106337ms 04:06:05 INFO - TEST-START | kraken 04:06:05 INFO - Initialising browser for kraken test... 04:06:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44460/getInfo.html -profile /tmp/tmpWluBVz/profile 04:06:05 INFO - TEST-INFO | started process 16077 (/builds/slave/test/build/application/firefox/firefox http://localhost:44460/getInfo.html) 04:06:10 INFO - TEST-INFO | 16077: exit 0 04:06:10 INFO - Browser initialized. 04:06:10 INFO - Running cycle 1/1 for kraken test... 04:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:10 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:10 INFO - 'RUST_BACKTRACE': 'full', 04:06:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - TEST-INFO | started process 16319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWluBVz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:10 INFO - PID 16319 | 04:06:10 INFO - PID 16319 | (/builds/slave/test/build/application/firefox/firefox:16368): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:10 INFO - PID 16319 | 04:06:21 INFO - PID 16319 | RSS: Main: 148312064 04:06:21 INFO - PID 16319 | 04:06:23 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44460/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:24 INFO - PID 16319 | RSS: Main: 153939968 04:06:24 INFO - PID 16319 | 04:06:27 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44460/tests/kraken/driver.html?testName=audio-dft) 04:06:27 INFO - PID 16319 | RSS: Main: 153919488 04:06:27 INFO - PID 16319 | 04:06:30 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44460/tests/kraken/driver.html?testName=audio-fft) 04:06:31 INFO - PID 16319 | RSS: Main: 150011904 04:06:31 INFO - PID 16319 | 04:06:33 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44460/tests/kraken/driver.html?testName=audio-oscillator) 04:06:33 INFO - PID 16319 | RSS: Main: 151236608 04:06:33 INFO - PID 16319 | 04:06:36 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:36 INFO - PID 16319 | RSS: Main: 151388160 04:06:36 INFO - PID 16319 | 04:06:39 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44460/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:40 INFO - PID 16319 | RSS: Main: 151605248 04:06:40 INFO - PID 16319 | 04:06:43 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44460/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:44 INFO - PID 16319 | RSS: Main: 152657920 04:06:44 INFO - PID 16319 | 04:06:47 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44460/tests/kraken/driver.html?testName=json-parse-financial) 04:06:48 INFO - PID 16319 | RSS: Main: 153997312 04:06:48 INFO - PID 16319 | 04:06:49 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:50 INFO - PID 16319 | RSS: Main: 153780224 04:06:50 INFO - PID 16319 | 04:06:51 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:52 INFO - PID 16319 | RSS: Main: 153849856 04:06:52 INFO - PID 16319 | 04:06:54 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:55 INFO - PID 16319 | RSS: Main: 150949888 04:06:55 INFO - PID 16319 | 04:06:57 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:58 INFO - PID 16319 | RSS: Main: 151011328 04:06:58 INFO - PID 16319 | 04:07:00 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:01 INFO - PID 16319 | RSS: Main: 151293952 04:07:01 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | Cycle 1(1): loaded http://localhost:44460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44460/tests/kraken/driver.html?testName=ai-astar) 04:07:03 INFO - PID 16319 | RSS: Main: 153104384 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | __start_tp_report 04:07:03 INFO - PID 16319 | _x_x_mozilla_page_load 04:07:03 INFO - PID 16319 | _x_x_mozilla_page_load_details 04:07:03 INFO - PID 16319 | |i|pagename|runs| 04:07:03 INFO - PID 16319 | |0;ai-astar;108;107;104;107;105;106;105;105;104;104 04:07:03 INFO - PID 16319 | |1;audio-beat-detection;120;112;112;112;117;138;113;115;111;112 04:07:03 INFO - PID 16319 | |2;audio-dft;163;165;162;161;162;163;162;161;176;169 04:07:03 INFO - PID 16319 | |3;audio-fft;74;73;73;72;73;74;73;73;73;74 04:07:03 INFO - PID 16319 | |4;audio-oscillator;78;77;77;78;77;77;78;78;78;79 04:07:03 INFO - PID 16319 | |5;imaging-gaussian-blur;113;114;113;113;115;115;113;114;115;115 04:07:03 INFO - PID 16319 | |6;imaging-darkroom;149;149;151;149;154;150;151;150;152;152 04:07:03 INFO - PID 16319 | |7;imaging-desaturate;94;95;94;95;94;99;95;93;99;95 04:07:03 INFO - PID 16319 | |8;json-parse-financial;44;44;44;56;47;45;47;44;43;44 04:07:03 INFO - PID 16319 | |9;json-stringify-tinderbox;39;39;38;39;38;38;38;39;40;39 04:07:03 INFO - PID 16319 | |10;stanford-crypto-aes;71;72;72;73;71;70;71;71;74;71 04:07:03 INFO - PID 16319 | |11;stanford-crypto-ccm;106;102;104;105;116;117;113;106;109;101 04:07:03 INFO - PID 16319 | |12;stanford-crypto-pbkdf2;159;163;154;152;157;158;151;150;151;162 04:07:03 INFO - PID 16319 | |13;stanford-crypto-sha256-iterative;62;61;59;59;60;62;62;58;59;59 04:07:03 INFO - PID 16319 | __end_tp_report 04:07:03 INFO - PID 16319 | __start_cc_report 04:07:03 INFO - PID 16319 | _x_x_mozilla_cycle_collect,727 04:07:03 INFO - PID 16319 | __end_cc_report 04:07:03 INFO - PID 16319 | __startTimestamp1505560023349__endTimestamp 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | ------- Summary: start ------- 04:07:03 INFO - PID 16319 | Number of tests: 14 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.50 stddev:1.43 (1.4%) stddev-sans-first:1.20 04:07:03 INFO - PID 16319 | Values: 108.0 107.0 104.0 107.0 105.0 106.0 105.0 105.0 104.0 104.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#1] audio-beat-detection Cycles:10 Average:116.20 Median:114.00 stddev:8.16 (7.2%) stddev-sans-first:8.54 04:07:03 INFO - PID 16319 | Values: 120.0 112.0 112.0 112.0 117.0 138.0 113.0 115.0 111.0 112.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.72 (2.9%) stddev-sans-first:4.98 04:07:03 INFO - PID 16319 | Values: 163.0 165.0 162.0 161.0 162.0 163.0 162.0 161.0 176.0 169.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 04:07:03 INFO - PID 16319 | Values: 74.0 73.0 73.0 72.0 73.0 74.0 73.0 73.0 73.0 74.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 04:07:03 INFO - PID 16319 | Values: 78.0 77.0 77.0 78.0 77.0 77.0 78.0 78.0 78.0 79.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.50 stddev:0.94 (0.8%) stddev-sans-first:0.93 04:07:03 INFO - PID 16319 | Values: 113.0 114.0 113.0 113.0 115.0 115.0 113.0 114.0 115.0 115.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:1.64 (1.1%) stddev-sans-first:1.62 04:07:03 INFO - PID 16319 | Values: 149.0 149.0 151.0 149.0 154.0 150.0 151.0 150.0 152.0 152.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:2.06 (2.2%) stddev-sans-first:2.13 04:07:03 INFO - PID 16319 | Values: 94.0 95.0 94.0 95.0 94.0 99.0 95.0 93.0 99.0 95.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:44.50 stddev:3.82 (8.6%) stddev-sans-first:4.00 04:07:03 INFO - PID 16319 | Values: 44.0 44.0 44.0 56.0 47.0 45.0 47.0 44.0 43.0 44.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.67 (1.7%) stddev-sans-first:0.71 04:07:03 INFO - PID 16319 | Values: 39.0 39.0 38.0 39.0 38.0 38.0 38.0 39.0 40.0 39.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:71.50 stddev:1.17 (1.6%) stddev-sans-first:1.22 04:07:03 INFO - PID 16319 | Values: 71.0 72.0 72.0 73.0 71.0 70.0 71.0 71.0 74.0 71.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#11] stanford-crypto-ccm Cycles:10 Average:107.90 Median:107.50 stddev:5.67 (5.3%) stddev-sans-first:5.97 04:07:03 INFO - PID 16319 | Values: 106.0 102.0 104.0 105.0 116.0 117.0 113.0 106.0 109.0 101.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:157.50 stddev:4.76 (3.0%) stddev-sans-first:4.90 04:07:03 INFO - PID 16319 | Values: 159.0 163.0 154.0 152.0 157.0 158.0 151.0 150.0 151.0 162.0 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:1.52 (2.5%) stddev-sans-first:1.45 04:07:03 INFO - PID 16319 | Values: 62.0 61.0 59.0 59.0 60.0 62.0 62.0 58.0 59.0 59.0 04:07:03 INFO - PID 16319 | -------- Summary: end -------- 04:07:03 INFO - PID 16319 | 04:07:03 INFO - PID 16319 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:07:03 INFO - TEST-INFO | 16319: exit 0 04:07:03 INFO - TEST-OK | kraken | took 58907ms 04:07:03 INFO - SUITE-END | took 1165s 04:07:04 INFO - Completed test suite (00:19:25) 04:07:04 INFO - javascript benchmark 04:07:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8991.392265274986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3769.3592089344806, 3788.924221515568, 3811.10439046824, 3841.846326146954, 3848.4996950396453, 6145.078238264263, 6173.7961097585985, 6177.907331390033, 6188.876222475547, 6382.744690212386, 6245.7813976510715, 6308.621482711041, 6319.0, 6326.177596912395, 6351.968240158804, 5641.323041235037, 5663.5186009189065, 5682.857928551788, 5689.715514224272, 5692.0608099663505, 5693.174489699012, 5724.398938111501, 5754.280714910637, 5755.2230448889495, 5756.510696590794, 104.80738854923536, 5316.601254905898, 5604.747786349624, 5631.155326700987, 5712.857178570527, 5580.162975553659, 5615.438456154393, 5631.1271752878365, 5640.435956404327, 5643.322801263875, 5549.834534747708, 5566.916496252559, 5627.521660658849, 5638.126090455986, 5648.887022259573, 6217.6891155442045, 6220.1602783624085, 6264.59280146789, 6279.0, 6326.398992095744, 6838.658067096675, 6841.555298905555, 6872.347127022925, 6889.552179108342, 6949.0, 6755.22314933779, 6842.4868134890085, 6847.794566163023, 6860.382565569123, 6861.416779573742, 6263.498920086382, 6314.368563143695, 6343.904841427382, 6412.679366031726, 6447.806565803034, 6926.168859736763, 6930.341617546325, 6992.440604751608, 6994.4404447644065, 7013.123359580052, 6674.098996635392, 6679.833004174838, 6680.0, 6755.93244067553, 6764.526483146231, 6670.966645166744, 6772.8984065239065, 6803.65981700913, 6809.761658341934, 6866.485013623898, 6687.565308254948, 6774.525783195129, 6781.0, 6787.355201255873, 6790.456763458911, 6772.69522871472, 6786.185657721105, 6799.218089919624, 6807.047013418125, 6901.585904845625, 4882.438519570223, 4944.480829512921, 4956.776945037482, 4970.527799859007, 4973.179425394842, 4425.291953287523, 4453.398791163151, 4457.4205353304515, 4464.196444639931, 4472.373867658531, 6211.472024877846, 6243.469305109026, 6246.063090536365, 6297.307296197415, 6310.05349197624, 6866.416354609914, 6879.6560171991205, 6883.518153729291, 6885.036094946711, 6892.758753443605, 6319.557630965788, 6349.619022858643, 6354.0, 6361.2048493938255, 6373.52198585108, 5372.677639341652, 5412.323459567554, 5458.372287186945, 5517.44825517445, 5571.972140139354, 6870.175578930461, 6985.825354366079, 7003.2296447390745, 7032.6132062736015, 7074.504784665024, 6746.4940129489505, 6801.727930882709, 6814.488913331421, 6832.863342733018, 6841.692123854538, 6982.0, 7024.648767561704, 7149.14210294768, 7158.248383919614, 7173.856522869409, 6723.865522689616, 6746.426553742791, 6760.830979225362, 6834.282400347892, 6841.042254084532, 6732.293109223461, 6776.254611992776, 6854.10896583441, 6857.142857142857, 6900.896486552806, 6560.803175904731, 6571.441427478718, 6628.105205797156, 6628.469722422291, 6632.303608121078, 6515.609063456208, 6660.200775906922, 6663.800085997428, 6671.6330601815425, 6686.7993960181275, 6484.0, 6501.674916254074, 6509.251436084911, 6632.734690612321, 6635.435987940886, 6561.212654481493, 6582.901256481061, 6623.072769812326, 6706.731730730716, 6736.427403670743, 6399.904001440075, 6473.902891456726, 6487.286398496068, 6490.545661803629, 6493.805185844432], "value": 6169.068677157009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.2161163011441, 965.0638880286125, 968.85467179923, 1011.9544620492077, 1012.696191142657, 44474.0, 45290.54709452912, 45501.77249113758, 45586.77206613962, 45665.771671141636, 45258.09483810322, 46075.0, 46133.7693311533, 46155.769221153845, 46209.075818483696, 7933.286004259601, 8023.39824513161, 8052.235037671412, 8093.5143891366415, 8094.716684916029, 7830.29527342539, 7984.720534781284, 7985.0, 7989.840203195932, 7990.0, 8001.5199088054615, 8024.358051355877, 8025.197480251986, 8051.758447246592, 8055.395845311596, 7950.721724739664, 7975.042994840627, 8014.358851291911, 8016.198380161937, 8044.637991290348, 7899.684012639487, 7911.5253084815095, 7938.801529961739, 7943.841123177504, 7961.243681850215, 41461.58538414608, 41711.582884171075, 41722.791386042874, 41743.7912810434, 41754.1649167015, 3656.9268614627827, 3657.2319812839337, 3690.022144131807, 3694.538182727159, 3705.2033812730124, 33727.15682107942, 33728.14495202763, 33756.324873502635, 33947.660523394945, 33968.49047264293, 5278.841634750964, 5371.221172929903, 5416.539594134503, 5441.755121019524, 5531.861703457445, 214255.0, 217587.0, 218630.0, 220553.0, 220710.0, 51909.740451298254, 52884.471155288724, 52892.73553632284, 52928.47071529312, 53025.734871325396, 56175.0, 56227.0, 56284.718576406856, 56302.71848640813, 56337.43662563322, 17028.574285642957, 17175.484735457958, 17189.914050429918, 17211.0, 17463.388781392845, 14296.928515357356, 14314.785278220836, 14322.713545729235, 14330.85669143316, 14342.354594043292, 13718.519851805138, 13848.515301964382, 13898.930505347611, 13905.513307034407, 14081.08472949255, 5626.352969408488, 5719.28508936383, 5748.166515855178, 5775.16260142277, 5775.191473193756, 1102.685734565645, 1112.4159816096615, 1121.7980763462492, 1127.6335191062938, 1134.0247387246961, 25643.0, 25823.74176258251, 25834.35414114662, 25875.0, 25907.870460647577, 1194.988050119505, 1229.877012298763, 1244.0607341457142, 1251.7121062155754, 1259.389196239823, 13772.173669579857, 13855.861441385458, 13896.722065558632, 14004.439822407194, 14113.435462581381, 277276.0, 278822.0, 278856.0, 279134.0, 279296.0, 57313.426865730806, 57386.13920791192, 57553.424465754804, 57569.42430575641, 57662.42337576654, 1522.216058729755, 1550.7286224910595, 1574.1656921831448, 1583.4141367694026, 1593.2670971353075, 24349.75650243475, 24477.0, 24490.14284500034, 24491.26526204217, 24650.87674561616, 40291.597084028785, 40301.1939761209, 40348.596514034485, 40444.59555404526, 40494.59505404908, 222629.0, 222771.0, 223500.0, 224288.0, 224672.0, 35405.82297088498, 35732.82133589315, 35984.460233096004, 36030.45954310635, 36132.81933590315, 46125.538744612124, 46723.0, 46919.061618768115, 46931.53068469408, 47719.76140119277, 34369.14077148091, 34628.21639763481, 34736.82631586826, 34917.0, 34968.475472867416, 34074.14814629654, 34398.656013440544, 34866.47700284447, 34910.301793963474, 34916.47625285572, 39625.603743962194, 40893.795531023345, 41024.58975410327, 41277.0, 41537.16925661409, 33549.16127096842, 33575.16062098467, 33661.83169084139, 33685.83157084199, 34349.82825085858, 24868.875655621607, 25296.873515632305, 25696.357591060372, 25877.0, 26333.34166645849], "value": 18561.09518093035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4119174996125, 610.1793088296242, 610.6519284008117, 614.7725341623599, 626.3329554024963, 23043.539129217406, 24004.279871603838, 24049.75950240497, 24070.75929240705, 24081.759182408172, 24615.75384246157, 26156.738432615668, 26237.73762262377, 26262.474750504978, 26302.342441438926, 6596.142501474802, 6695.029220762986, 6712.731490740364, 6725.2602213756445, 6748.696308666097, 6252.406021427957, 6530.836729081787, 6532.052852336432, 6555.70499327529, 6565.080888675589, 6480.57876238043, 6484.0598113273545, 6488.28628850826, 6491.7078731457195, 6495.447886929616, 6153.938460615382, 6525.0864878916755, 6545.476361891037, 6546.410823025927, 6548.0, 6100.23747031621, 6121.724522396503, 6138.508919286446, 6145.754169833202, 6147.170132032164, 29565.408691826044, 30167.245818854484, 30251.394972100654, 30292.394152117056, 30315.393692126254, 2276.84062115652, 2279.202279202266, 2286.8399212055165, 2309.884505774721, 2315.583195024895, 20095.799042009687, 20906.0, 20909.581808363746, 20915.16339346424, 20966.16135354584, 2328.988355058231, 2458.188797696756, 2518.25711415133, 2549.3626593351664, 2612.333854867016, 150061.0, 152347.2382638091, 152522.0, 152555.0, 152682.9999999989, 15148.242587870562, 15417.537473875802, 15631.531054068397, 16100.597485062734, 16167.353305867633, 25052.87473562657, 25180.74819251784, 25210.243692689248, 25242.873785630953, 25305.367365816, 10416.166706663449, 10696.34206697963, 10850.945745271381, 10893.455327233607, 11034.503447344889, 9767.16979056774, 9875.506224688737, 9973.351732137387, 10059.195264378832, 10067.496625168713, 9539.52302384878, 9807.803843923082, 9910.30627856043, 9956.452395118193, 10110.24173187014, 2980.821150730963, 3008.9097327079785, 3033.6966303369486, 3037.8734885580184, 3043.6195475565555, 1037.3361048928691, 1051.9105876000472, 1058.5606973106076, 1060.6075751971666, 1063.2450959818616, 21537.0, 21550.137994480046, 21619.56760864774, 21674.133034678438, 22308.776912230995, 1105.309181761399, 1111.3165403277087, 1114.8550688410617, 1115.5036008975928, 1124.5333186727416, 11586.88413115858, 11881.762364752656, 11959.880401196051, 12003.819942700866, 12005.579804706967, 582781.0, 585900.0, 604788.0, 607656.0, 608369.0, 127011.0, 128518.35740821237, 128830.0, 129715.0, 133570.0, 1231.901447884167, 1252.5490823303603, 1277.9680507987189, 1281.5770795637418, 1285.2673975833873, 18836.717449238, 19141.90429047846, 19163.904180479567, 19323.0, 19533.316333928244, 60053.39946600653, 60404.39595603988, 60780.08829867467, 62315.0, 63355.049674254, 77818.0, 79464.60267698625, 80976.0, 81517.18482815096, 81794.0, 15022.549323520312, 15325.157116358707, 15468.458603948808, 15553.455629052929, 15564.844351556792, 23364.53270934606, 23474.0, 23477.76522234824, 23630.881845590662, 23776.762232378147, 19177.712334314718, 19225.615487690447, 19256.133473993985, 19418.223271069, 19732.210711571377, 17280.13599320054, 17526.123693815513, 17677.646447071245, 17779.28882844672, 17854.732179017064, 19708.901455492633, 19712.225899669098, 19773.802261977195, 19901.203951841766, 20058.799412005694, 15315.61710957235, 15371.0, 15377.231138442809, 15403.383864645288, 15412.612864842218, 18806.811931880507, 19152.61694766069, 19218.903905480383, 19386.4184074478, 19401.0], "value": 12731.341642252763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.2619837684404, 1478.7264356094117, 1483.859033391828, 1488.218685190275, 1491.7762335649652, 16458.17709114544, 17306.221220045096, 17324.220410081543, 17346.913265433654, 17370.73943890841, 16530.42143524977, 16720.665586688257, 16754.16229188542, 16769.0, 16825.663486730256, 2786.5541513357816, 2839.772818174541, 2853.514902466575, 2862.0698273061234, 2862.313044869227, 2749.1477641930965, 2826.4488424757183, 2826.689064202936, 2831.2497188245134, 2846.8291902485917, 2750.6286651302116, 2798.6361772969485, 2800.7619352354973, 2800.80394372394, 2809.339805145789, 2677.3708178578017, 2709.417475242832, 2721.5917612358107, 2722.823016503921, 2727.3727042780074, 2619.096411737947, 2640.5379058664657, 2658.3752818087733, 2664.0, 2666.066876593177, 15950.361985520565, 16068.43760468378, 16217.189140543043, 16221.756673649905, 16373.672526549402, 7899.407544434133, 8187.918120818775, 8213.096559378464, 8246.628901699438, 8286.917130828675, 5275.314209152785, 5462.071447853875, 5465.371482279549, 5489.1217405214975, 5986.0, 1925.4512463947708, 1992.163291417608, 2020.1818263603263, 2020.40398082566, 2045.3863840847687, 27209.45581088387, 27988.0, 28002.859985700146, 30447.543286850716, 31108.688913110804, 7521.135069467081, 7553.773386798405, 7616.619169041636, 7733.226677332222, 7760.34037106841, 22330.330090097, 22369.0, 22427.551448970928, 22467.550648987257, 22569.548609028057, 8595.527246001406, 8668.479891206422, 8677.349198810114, 8703.39076264668, 8733.432326898732, 7661.310482056641, 7829.765107046797, 7871.0554733432355, 7874.527528348203, 7946.364290856717, 5721.885562288814, 5968.104784282393, 6020.518358531394, 6043.305019922677, 6069.8770727414685, 1784.6787578236042, 1826.2694922031294, 1845.3264558436074, 1847.224165850346, 1864.7296142059326, 931.9394239374419, 955.3408148377736, 956.9617215311449, 959.0361686505157, 959.8560215967522, 8642.870356944652, 9030.277577793891, 9055.275577953747, 9174.357794954289, 9202.81594368109, 771.413725568572, 779.84193472693, 784.2471227621434, 799.192815256595, 800.771780042685, 4732.503087175865, 4788.688735232268, 4817.156997525419, 4828.37231159954, 4866.489018653061, 23884.52230955371, 24826.37934051627, 25013.874930625232, 25018.749812501643, 25067.0, 23181.188658396874, 24270.723452334063, 24432.633510497355, 24438.755612444005, 24651.260462186165, 10311.48442577868, 10566.471676415995, 10679.946600266949, 12250.0, 12418.192817467016, 8124.796880078045, 9130.452172869649, 9176.908230917605, 9221.49281789508, 9272.490013049348, 19205.231790728216, 20490.487737806674, 20574.588508230052, 20899.8955005224, 21369.252076177258, 21410.57178856383, 21432.892835535724, 21929.451763706034, 21989.340319790434, 22027.118915243853, 13181.934090329487, 13185.142965707199, 13413.530526431528, 13559.389827457591, 13571.321433928066, 15362.30869610848, 15520.456784012506, 15539.611509712347, 15588.14265215424, 15599.532014039596, 12484.687882803002, 12719.300438475973, 12760.553380632005, 12804.61586152417, 12839.229646221256, 11945.701357466132, 12483.500659973499, 12515.749685006067, 12524.436400361823, 12543.93728031354, 10261.846072308772, 10481.37111773296, 10530.736731581772, 10544.0, 10546.841797372892, 7915.84168316642, 8054.758357249292, 8079.676812927417, 8211.83576328482, 8213.753587392388, 8178.100408955129, 8232.472140322918, 8236.917630823615, 8275.751727447945, 8366.87449688243], "value": 7202.224042344553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.3774277481185, 542.8262955854127, 561.7893290016244, 571.3800526428824, 571.7398583644441, 6056.424639659236, 6138.8336216118905, 6151.41561551653, 6182.319944806073, 6261.624302541851, 6001.129836173752, 6007.519398448125, 6025.3070896846875, 6067.787627433041, 6083.78706745264, 4865.5134486551415, 4878.268259761029, 4885.975570122145, 4906.852794416155, 4935.877572643762, 4763.404574428197, 4855.611551075923, 4896.43690975537, 4909.803607855682, 4920.409550853902, 4863.662492814469, 4894.975525122387, 4902.681325713835, 4919.803207871681, 4934.605231581483, 4817.156997525419, 4879.463259041502, 4880.853574392774, 4894.559489645949, 4899.485554016813, 4401.405810215612, 4410.3825464435, 4460.553944605546, 4469.776511174461, 4471.105778844211, 6107.7556897724035, 6117.510599152057, 6151.784687535915, 6152.600080994721, 6155.0, 5732.541396688297, 5749.137629355589, 5761.732418867842, 5782.190493330937, 5838.182654428383, 6413.262474815363, 6496.480281577463, 6534.803955881332, 6547.9345206547805, 6568.0, 4909.975450122763, 4961.776720047606, 4975.676581022222, 4983.327250821165, 4991.925121123149, 6813.977903314493, 6868.484863635247, 6870.20992585854, 6873.621950792654, 6891.207511136234, 5030.84907452777, 5080.74596270185, 5095.643304968691, 5098.923516147261, 5111.642185047085, 5170.224466330081, 5177.275181474596, 5177.482251774868, 5211.817586384458, 5213.296205012351, 5567.888642227133, 5640.5487560995025, 5704.942950570524, 5734.627249228787, 5747.195392645033, 6189.6286222826775, 6508.707108180143, 6514.218293804679, 6554.7378104876225, 6554.787364337612, 1680.8739344549208, 1692.6445446456137, 1742.3988723890238, 1748.641528486657, 1756.8682348823634, 1214.174361434233, 1251.7795149729122, 1260.6785269756338, 1267.4043199696127, 1278.1564167649492, 5901.852453688693, 5956.791512297135, 5969.492593129546, 6010.3689112643415, 6090.756369745161, 6506.121673574102, 6590.275069742324, 6601.834954126185, 6608.86782264352, 6717.798466046026, 6021.892337681777, 6029.3970602940235, 6098.786542470993, 6108.450239478379, 6182.814515564541, 3337.4493208620793, 3443.3816106429936, 3486.6861982421706, 3512.121969507623, 3533.2226910080253, 6837.324855410357, 6900.482463815234, 6918.481113916477, 6923.430535846317, 6965.477589180831, 6878.7248510059035, 6916.619585922823, 6938.548994315353, 6955.234924158339, 6969.23338432772, 6898.931010689929, 6941.514094013371, 6949.3745562899585, 6962.23415424313, 6982.067531636623, 6643.56816806906, 6671.799846004627, 6676.298988606127, 6722.798316050526, 6727.8990815138795, 6544.934550654623, 6551.70517326731, 6685.231198412245, 6701.229358623626, 6724.966375168093, 6815.182178138655, 6859.828504287433, 6878.38094571491, 6909.343612356818, 6917.688704008432, 5008.192135549767, 5017.57350625201, 5030.949690503048, 5066.620003499678, 5091.363579552556, 6489.1888513935755, 6629.303923088007, 6653.168353955755, 6665.633390163587, 6747.325267473213, 6188.969055154876, 6402.0, 6462.4183823456115, 6463.547551671338, 6504.674766261763, 6354.841128971812, 6423.935760642334, 6442.8389290268115, 6495.610263384212, 6500.772472963424, 6065.72704228302, 6242.188515492957, 6242.719077641426, 6360.363963603602, 6433.970564709624, 6491.851452045659, 6539.934600654123, 6544.574602650812, 6575.178102737158, 6628.171478565179, 6250.968745156427, 6255.53083518747, 6272.655003974825, 6304.338044505261, 6310.400511951358], "value": 5081.191640792176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.634322614181, 966.7099870038987, 992.5186284651943, 994.5922171909514, 997.4414327976332, 20334.796652033474, 21021.894890525564, 21074.157033718653, 21102.577948441023, 21104.788952110473, 19026.61946761064, 19172.520686982833, 19512.90243548784, 20052.298169564066, 20057.699134512994, 1052.7210289273348, 1070.0262760887595, 1070.4166229404955, 1071.4214324264888, 1072.3780207479642, 1044.2742294105599, 1049.4333060147512, 1055.5566662001977, 1059.2796898109282, 1059.4332032362688, 1141.8344340070685, 1144.0, 1148.5291030677424, 1159.802833518304, 1160.2516376936871, 1130.9321440713584, 1134.863816342036, 1141.61185197033, 1142.4002398740686, 1148.087270619855, 792.9484583502111, 820.327331588098, 820.9671613135528, 821.0188824354898, 821.572782153277, 19006.049697515067, 19216.327428539935, 19363.61272774551, 19366.4190074298, 19399.127039283267, 23344.29967100973, 23445.17941872026, 23999.0, 24154.0, 24189.0, 18325.908370458197, 18447.631047379113, 18658.25366985319, 18735.81264187368, 19007.1446784895, 3975.8807235782974, 4064.1465292288653, 4066.3290557058344, 4075.9592404075875, 4078.4290199372113, 165259.0, 165646.0, 167295.1635241828, 169254.0, 169516.0, 18094.5476363092, 18189.54526136857, 18419.631607367777, 18643.90678046628, 18699.906500467412, 35202.0, 35385.64614353875, 35497.64502354995, 35769.284614307566, 36027.63972360243, 9336.06639336061, 9460.195883349854, 9489.572969216402, 9491.288153388523, 9496.572654230577, 4411.18393097278, 4569.840055598038, 4614.97692511542, 4649.883752906205, 4654.301854721751, 6091.116788065706, 6229.937700622936, 6252.5935814171935, 6262.780802671885, 6262.966610509215, 1089.6186334782763, 1114.5931734916696, 1124.0614087237248, 1129.0233947635236, 1130.7964566377966, 725.6915810780503, 729.4747781597241, 748.6780684305692, 753.9246075392417, 755.0788038592908, 12826.23042617446, 12832.486700531874, 13015.633358497222, 13215.0, 13228.470861165639, 705.5555000349747, 708.2386434582844, 708.5075872268724, 710.1407297170379, 728.1298847876736, 6224.968875155595, 6264.279607845065, 6372.840678983062, 6389.520785941073, 6458.903116453257, 154217.0, 156811.0, 156931.0, 157037.0, 157053.0, 134475.32762336126, 135104.0, 135841.0, 136743.0, 141293.0, 114538.4273078646, 114752.0, 114837.0, 115594.422027891, 115720.0, 11465.713357166138, 11587.362695051854, 11645.184837061324, 11799.292042477478, 11855.644330670093, 53133.734331328094, 53496.197557037456, 54015.91968160693, 54332.45667543274, 55307.0, 68495.31504684889, 70295.29704702887, 70903.0, 71603.0, 71819.64090179515, 17292.654146917244, 17367.47897563075, 17380.565485862448, 17520.737188941923, 17521.299148033937, 18426.078696064877, 18698.34555790541, 18703.0, 18769.1553880073, 18832.717509237646, 17450.04024778649, 17470.126493675518, 17517.737233941247, 17710.645787084442, 17720.291188352836, 16188.919055405118, 16258.430954916521, 16379.59051023734, 16506.669866602362, 16542.66914661724, 16860.156992150587, 16979.49061528156, 17103.914480427517, 17176.141192940053, 17252.654946901243, 12999.1550549214, 13066.150700204456, 13081.163125100205, 13228.933855331046, 13385.86614133885, 12233.0, 12607.99136069094, 12720.936395317964, 12747.87252127504, 12850.357482126043], "value": 9903.857305160465, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 104.0, 107.0, 105.0, 106.0, 105.0, 105.0, 104.0, 104.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 112.0, 112.0, 112.0, 117.0, 138.0, 113.0, 115.0, 111.0, 112.0], "value": 116.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 161.0, 162.0, 163.0, 162.0, 161.0, 176.0, 169.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 72.0, 73.0, 74.0, 73.0, 73.0, 73.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 77.0, 77.0, 78.0, 78.0, 78.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 115.0, 115.0, 113.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 149.0, 154.0, 150.0, 151.0, 150.0, 152.0, 152.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 99.0, 95.0, 93.0, 99.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 56.0, 47.0, 45.0, 47.0, 44.0, 43.0, 44.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0, 40.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 73.0, 71.0, 70.0, 71.0, 71.0, 74.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 104.0, 105.0, 116.0, 117.0, 113.0, 106.0, 109.0, 101.0], "value": 107.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 154.0, 152.0, 157.0, 158.0, 151.0, 150.0, 151.0, 162.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 59.0, 60.0, 62.0, 62.0, 58.0, 59.0, 59.0], "value": 60.1, "unit": "score"}]}]} 04:07:04 INFO - Return code: 0 04:07:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:07:04 INFO - # TBPL SUCCESS # 04:07:04 INFO - Running post-action listener: _package_coverage_data 04:07:04 INFO - Running post-action listener: _resource_record_post_action 04:07:04 INFO - [mozharness: 2017-09-16 11:07:04.155732Z] Finished run-tests step (success) 04:07:04 INFO - Running post-run listener: _resource_record_post_run 04:07:04 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 24576; Write bytes: 426840064; Read time: 244; Write time: 231960 04:07:04 INFO - TinderboxPrint: CPU usage
13.1% 04:07:04 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 244 04:07:04 INFO - TinderboxPrint: I/O write bytes / time
426,840,064 / 231,960 04:07:04 INFO - TinderboxPrint: CPU idle
8,200.2 (86.9%) 04:07:04 INFO - TinderboxPrint: CPU user
1,185.3 (12.6%) 04:07:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:07:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120434688; Read time: 28; Write time: 79196 04:07:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:07:04 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 20480; Write bytes: 306405376; Read time: 216; Write time: 152764 04:07:04 INFO - Running post-run listener: _upload_blobber_files 04:07:04 INFO - Blob upload gear active. 04:07:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:04 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 04:07:04 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'] 04:07:04 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 04:07:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:06 INFO - (blobuploader) - INFO - Done attempting. 04:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:13 INFO - (blobuploader) - INFO - Done attempting. 04:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:14 INFO - (blobuploader) - INFO - Done attempting. 04:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:15 INFO - (blobuploader) - INFO - Done attempting. 04:07:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:15 INFO - Return code: 0 04:07:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a2a68d7ac27b5b2346b7b63f867986e1e03e554889e2704f34324cc35b60f256c44ea77f4f7a73d4b786b1b58d583a07250905a32fedb2f60477530b9335143", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9a40fd74feaf8557680f214f7ad4e2c7c17cda444eb4ce56710fac32cbd9b145c2d53a578350882b5be0d33077a4a5ce621bceac93cb68dfc3bd204f2cbdfd2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbca7b371ad3c132f3b2b18bdab5cc8f2873da086e605f743289e2c76b8198bfaba2ecdeca779748752c338fab931186d1483675babdccd8bbf7e43dd210b87f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45de19c19ef4c355a553485e730f3a283dbcfb0c4fec30b027dcced40aa61622e53c31bb25d9178cd6b25e47bbfed917f45585899aee34d85962dc53ffc2e9ab"} 04:07:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:15 INFO - Contents: 04:07:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a2a68d7ac27b5b2346b7b63f867986e1e03e554889e2704f34324cc35b60f256c44ea77f4f7a73d4b786b1b58d583a07250905a32fedb2f60477530b9335143", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9a40fd74feaf8557680f214f7ad4e2c7c17cda444eb4ce56710fac32cbd9b145c2d53a578350882b5be0d33077a4a5ce621bceac93cb68dfc3bd204f2cbdfd2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbca7b371ad3c132f3b2b18bdab5cc8f2873da086e605f743289e2c76b8198bfaba2ecdeca779748752c338fab931186d1483675babdccd8bbf7e43dd210b87f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45de19c19ef4c355a553485e730f3a283dbcfb0c4fec30b027dcced40aa61622e53c31bb25d9178cd6b25e47bbfed917f45585899aee34d85962dc53ffc2e9ab"} 04:07:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:15 INFO - Copying logs to upload dir... 04:07:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.613147 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-16 04:07:15.456653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:15.460077) ========= 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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 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/1a2a68d7ac27b5b2346b7b63f867986e1e03e554889e2704f34324cc35b60f256c44ea77f4f7a73d4b786b1b58d583a07250905a32fedb2f60477530b9335143", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9a40fd74feaf8557680f214f7ad4e2c7c17cda444eb4ce56710fac32cbd9b145c2d53a578350882b5be0d33077a4a5ce621bceac93cb68dfc3bd204f2cbdfd2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbca7b371ad3c132f3b2b18bdab5cc8f2873da086e605f743289e2c76b8198bfaba2ecdeca779748752c338fab931186d1483675babdccd8bbf7e43dd210b87f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45de19c19ef4c355a553485e730f3a283dbcfb0c4fec30b027dcced40aa61622e53c31bb25d9178cd6b25e47bbfed917f45585899aee34d85962dc53ffc2e9ab"} build_url:https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a2a68d7ac27b5b2346b7b63f867986e1e03e554889e2704f34324cc35b60f256c44ea77f4f7a73d4b786b1b58d583a07250905a32fedb2f60477530b9335143", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9a40fd74feaf8557680f214f7ad4e2c7c17cda444eb4ce56710fac32cbd9b145c2d53a578350882b5be0d33077a4a5ce621bceac93cb68dfc3bd204f2cbdfd2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbca7b371ad3c132f3b2b18bdab5cc8f2873da086e605f743289e2c76b8198bfaba2ecdeca779748752c338fab931186d1483675babdccd8bbf7e43dd210b87f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45de19c19ef4c355a553485e730f3a283dbcfb0c4fec30b027dcced40aa61622e53c31bb25d9178cd6b25e47bbfed917f45585899aee34d85962dc53ffc2e9ab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:15.488350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:15.488702) ========= 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=0e2a256762fed810e2f0f810000001b3-1505558752.269730-1243054133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:15.573872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 04:07:15.574190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 04:07:15.574506) ========= ========= Total master_lag: 0.23 =========