builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-016 starttime: 1505558801.63 results: success (0) revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.635158) ========= 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.635861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.636161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.689983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.690305) ========= 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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.0M=0s 2017-09-16 03:46:41 (50.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136131 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.856692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.856999) ========= 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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020692 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.920333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:41.920657) ========= 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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:46:41,982 truncating revision to first 12 chars 2017-09-16 03:46:41,982 Setting DEBUG logging. 2017-09-16 03:46:41,982 attempt 1/10 2017-09-16 03:46:41,982 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,343 unpacking tar archive at: mozilla-central-6c1b45e7e94d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.581845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.582146) ========= script_repo_revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.582509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.582792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:42.596019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-16 03:46:42.596403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 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-stylo-disabled-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:42 INFO - {'append_to_log': False, 03:46:42 INFO - 'base_work_dir': '/builds/slave/test', 03:46:42 INFO - 'blob_upload_branch': 'Firefox', 03:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:46:42 INFO - 'branch': 'Firefox', 03:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:42 INFO - 'code_coverage': False, 03:46:42 INFO - 'config_files': ('talos/linux_config.py',), 03:46:42 INFO - 'default_actions': ('clobber', 03:46:42 INFO - 'read-buildbot-config', 03:46:42 INFO - 'download-and-extract', 03:46:42 INFO - 'populate-webroot', 03:46:42 INFO - 'create-virtualenv', 03:46:42 INFO - 'install', 03:46:42 INFO - 'setup-mitmproxy', 03:46:42 INFO - 'run-tests'), 03:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:42 INFO - 'disable_ccov_upload': False, 03:46:42 INFO - 'disable_stylo': False, 03:46:42 INFO - 'download_minidump_stackwalk': True, 03:46:42 INFO - 'download_symbols': 'ondemand', 03:46:42 INFO - 'enable_stylo': False, 03:46:42 INFO - 'enable_webrender': False, 03:46:42 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:42 INFO - 'gecko_profile': False, 03:46:42 INFO - 'gecko_profile_interval': 0, 03:46:42 INFO - 'installer_path': 'installer.exe', 03:46:42 INFO - 'log_level': 'info', 03:46:42 INFO - 'log_name': 'talos', 03:46:42 INFO - 'log_to_console': True, 03:46:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:42 INFO - 'opt_config_files': (), 03:46:42 INFO - 'pip_index': False, 03:46:42 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:46:42 INFO - 'system_bits': '32', 03:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:42 INFO - 'title': 'talos-linux64-ix-016', 03:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:42 INFO - 'use_talos_json': True, 03:46:42 INFO - 'verify': 'False', 03:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:42 INFO - 'work_dir': 'build'} 03:46:42 INFO - [mozharness: 2017-09-16 10:46:42.801989Z] Running clobber step. 03:46:42 INFO - Running pre-action listener: _resource_record_pre_action 03:46:42 INFO - Running main action method: clobber 03:46:42 INFO - rmtree: /builds/slave/test/build 03:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:46:43 INFO - Running post-action listener: _resource_record_post_action 03:46:43 INFO - [mozharness: 2017-09-16 10:46:43.788274Z] Finished clobber step (success) 03:46:43 INFO - [mozharness: 2017-09-16 10:46:43.788370Z] Running read-buildbot-config step. 03:46:43 INFO - Running pre-action listener: _resource_record_pre_action 03:46:43 INFO - Running main action method: read_buildbot_config 03:46:43 INFO - Using buildbot properties: 03:46:43 INFO - { 03:46:43 INFO - "project": "", 03:46:43 INFO - "product": "firefox", 03:46:43 INFO - "who": "archaeopteryx@coole-files.de", 03:46:43 INFO - "installer_path": "public/build/target.tar.bz2", 03:46:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:46:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:46:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:46:43 INFO - "stage_platform": "linux64-pgo", 03:46:43 INFO - "basedir": "/builds/slave/test", 03:46:43 INFO - "buildnumber": 21, 03:46:43 INFO - "platform": "ubuntu64_hw", 03:46:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:46:43 INFO - "slavebuilddir": "test", 03:46:43 INFO - "taskId": "YC1G1qUVRTuVXNnomPsfpA", 03:46:43 INFO - "branch": "mozilla-central", 03:46:43 INFO - "script_repo_revision": "production", 03:46:43 INFO - "revision": "6c1b45e7e94dbf343813eda03f1fd0b3259b59b1", 03:46:43 INFO - "slavename": "talos-linux64-ix-016", 03:46:43 INFO - "repo_path": "mozilla-central" 03:46:43 INFO - } 03:46:43 INFO - Finding installer, test and symbols from parent task. 03:46:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC1G1qUVRTuVXNnomPsfpA'}, attempt #1 03:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YC1G1qUVRTuVXNnomPsfpA'}, attempt #1 03:46:44 INFO - Task dependencies: HjeSV61eTn20kZ6cmIUULA 03:46:44 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.183272Z] Finished read-buildbot-config step (success) 03:46:45 INFO - [mozharness: 2017-09-16 10:46:45.183489Z] 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:45 INFO - Downloaded 989 bytes. 03:46:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:46:45 INFO - Using the following test package requirements: 03:46:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:46:45 INFO - u'common': [u'target.common.tests.zip'], 03:46:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:46:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:46:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:46:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:46:45 INFO - u'mozbase': [u'target.common.tests.zip'], 03:46:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:46:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:46:45 INFO - u'web-platform': [u'target.common.tests.zip', 03:46:45 INFO - u'target.web-platform.tests.tar.gz'], 03:46:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:46:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:46:45 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:45 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:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.common.tests.zip into memory 03:46:46 INFO - Content-Length response header: 55325850 03:46:46 INFO - Bytes received: 55325850 03:46:57 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:57 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:57 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:58 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:58 INFO - trying https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 03:46:58 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:58 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.024027Z] Finished download-and-extract step (success) 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.024124Z] 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.039071Z] Finished populate-webroot step (success) 03:47:00 INFO - [mozharness: 2017-09-16 10:47:00.039160Z] 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:00 INFO - Installing pip...............done. 03:47:00 INFO - Return code: 0 03:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:47:00 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:03 INFO - Downloading/unpacking psutil>=3.1.1 03:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - 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:04 INFO - Return code: 0 03:47:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:04 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 03:47:04 INFO - 'HOME': '/home/cltbld', 03:47:04 INFO - 'LANG': 'en_US.UTF-8', 03:47:04 INFO - 'LANGUAGE': 'en_US:en', 03:47:04 INFO - 'LOGNAME': 'cltbld', 03:47:04 INFO - 'MAIL': '/var/mail/cltbld', 03:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:04 INFO - 'MOZ_NO_REMOTE': '1', 03:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:04 INFO - 'NO_EM_RESTART': '1', 03:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:04 INFO - 'PWD': '/builds/slave/test', 03:47:04 INFO - 'SHELL': '/bin/bash', 03:47:04 INFO - 'SHLVL': '1', 03:47:04 INFO - 'TERM': 'linux', 03:47:04 INFO - 'TMOUT': '86400', 03:47:04 INFO - 'USER': 'cltbld', 03:47:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 03:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:04 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 03:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:06 INFO - '_': '/tools/buildbot/bin/python'} 03:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:06 INFO - Downloading/unpacking jsonschema==2.5.1 03:47:06 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:06 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 - 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:06 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:07 INFO - Downloading/unpacking functools32 (from 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:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:07 INFO - warning: no files found matching '*.txt' 03:47:07 INFO - no previously-included directories found matching 'build' 03:47:07 INFO - no previously-included directories found matching 'dist' 03:47:07 INFO - no previously-included directories found matching '.git*' 03:47:07 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:10 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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-z8q0FP-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-EfbiU_-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-zA7JJJ-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-31Pi1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:11 INFO - Running setup.py (path:/tmp/pip-_S5cmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:11 INFO - Running setup.py (path:/tmp/pip-YAgPVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:11 INFO - Running setup.py (path:/tmp/pip-DQjmRz-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-7bouNc-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-DVsBGM-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-ygRoHU-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-Zerza9-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-u2e_Vt-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-WCNbhZ-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-f54VlC-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-9Pmxk3-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-hKjkuH-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-QgnsE6-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:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:12 INFO - Running setup.py install for mozcrash 03:47:12 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:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:47:13 INFO - Running setup.py install for mozprocess 03:47:13 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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-AfI64o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:14 INFO - Running setup.py (path:/tmp/pip-yjRhwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:14 INFO - Running setup.py (path:/tmp/pip-epSwy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:14 INFO - Running setup.py (path:/tmp/pip-uWTlMo-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-o3dgQP-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-e9mQDi-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-GG3hYE-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-tebf3d-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-dDTWWw-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-IJvTW1-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-0zSoaf-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-FT_9S7-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-qBotmv-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-r3nfVB-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-i_Yth5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:15 INFO - Running setup.py (path:/tmp/pip-Sx1I0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:15 INFO - Running setup.py (path:/tmp/pip-1Pu9Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:47:18 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:18 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:18 INFO - Installing collected packages: simplejson 03:47:18 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:19 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:19 INFO - Successfully installed simplejson 03:47:19 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 0x11a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', '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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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.268747Z] Finished create-virtualenv step (success) 03:47:20 INFO - [mozharness: 2017-09-16 10:47:20.269324Z] 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.171794Z] Finished install step (success) 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.172043Z] 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.173159Z] Finished setup-mitmproxy step (success) 03:47:38 INFO - [mozharness: 2017-09-16 10:47:38.173444Z] 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 0x1514090>, '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 0x1514d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150ef90>, '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-stylo-disabled-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-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-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-stylo-disabled-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-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-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': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 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-stylo-disabled-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-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-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:43399' 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:43399/getInfo.html -profile /tmp/tmptkBIcd/profile 03:47:38 INFO - TEST-INFO | started process 7287 (/builds/slave/test/build/application/firefox/firefox http://localhost:43399/getInfo.html) 03:47:43 INFO - TEST-INFO | 7287: exit 0 03:47:43 INFO - Browser initialized. 03:47:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:47:43 INFO - Using env: {'DISPLAY': ':0', 03:47:43 INFO - 'HOME': '/home/cltbld', 03:47:43 INFO - 'JSGC_DISABLE_POISONING': '1', 03:47:43 INFO - 'LANG': 'en_US.UTF-8', 03:47:43 INFO - 'LANGUAGE': 'en_US:en', 03:47:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:47:43 INFO - 'LOGNAME': 'cltbld', 03:47:43 INFO - 'MAIL': '/var/mail/cltbld', 03:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:47:43 INFO - 'MOZ_CRASHREPORTER': '1', 03:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:47:43 INFO - 'MOZ_NO_REMOTE': '1', 03:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:43 INFO - 'NO_EM_RESTART': '1', 03:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:43 INFO - 'PWD': '/builds/slave/test', 03:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:43 INFO - 'RUST_BACKTRACE': 'full', 03:47:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:47:43 INFO - 'SHELL': '/bin/bash', 03:47:43 INFO - 'SHLVL': '1', 03:47:43 INFO - 'STYLO_FORCE_DISABLED': '1', 03:47:43 INFO - 'TERM': 'linux', 03:47:43 INFO - 'TMOUT': '86400', 03:47:43 INFO - 'USER': 'cltbld', 03:47:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 03:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:43 INFO - '_': '/tools/buildbot/bin/python'} 03:47:43 INFO - TEST-INFO | started process 7517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptkBIcd/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 7517 | 03:47:44 INFO - PID 7517 | (/builds/slave/test/build/application/firefox/firefox:7566): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:47:44 INFO - PID 7517 | 03:47:54 INFO - PID 7517 | RSS: Main: 150138880 03:47:54 INFO - PID 7517 | 03:50:51 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43399/tests/dromaeo/cssquery-ext.html) 03:50:52 INFO - PID 7517 | RSS: Main: 151527424 03:50:52 INFO - PID 7517 | 03:53:54 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-ext.html (next: http://localhost:43399/tests/dromaeo/cssquery-jquery.html) 03:53:55 INFO - PID 7517 | RSS: Main: 149774336 03:53:55 INFO - PID 7517 | 03:56:56 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43399/tests/dromaeo/cssquery-mootools.html) 03:56:57 INFO - PID 7517 | RSS: Main: 151482368 03:56:57 INFO - PID 7517 | 03:59:59 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43399/tests/dromaeo/cssquery-prototype.html) 03:59:59 INFO - PID 7517 | RSS: Main: 149712896 03:59:59 INFO - PID 7517 | 04:03:02 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43399/tests/dromaeo/cssquery-yui.html) 04:03:03 INFO - PID 7517 | RSS: Main: 151678976 04:03:03 INFO - PID 7517 | 04:06:04 INFO - PID 7517 | Cycle 1(1): loaded http://localhost:43399/tests/dromaeo/cssquery-yui.html (next: http://localhost:43399/tests/dromaeo/cssquery-dojo.html) 04:06:05 INFO - PID 7517 | RSS: Main: 153411584 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | __start_tp_report 04:06:05 INFO - PID 7517 | _x_x_mozilla_page_load 04:06:05 INFO - PID 7517 | _x_x_mozilla_page_load_details 04:06:05 INFO - PID 7517 | |i|pagename|runs| 04:06:05 INFO - PID 7517 | |0;dojo.html;3817.999999999999;3830.214805964777;3843.9615603843954;3854.113553882605;3860.034991252187;6210.130581718563;6265.655388953605;6293;6320.431161195492;6335.904961425571;6273.623582585048;6347.746090156388;6368.968155159229;6372.8725425491575;6390.329015453381;5629.4652008059165;5640.3795582486;5660.094384898417;5670.773169073233;5734.967705812952;5718.399568045337;5727.169560413738;5795.2466179396615;5795.536357091443;5800.593958422891;5534.640248383883;5664.660120392789;5713.514351280125;5725.513331366838;5760.36635970043;5653.4911857932575;5707.686077265748;5725.885482290331;5735.856603584902;5742.770289188427;5596.104623260299;5669.6314739541795;5671.546276297886;5726.341470730836;5749;6284.214473190851;6299.6850157491945;6320.905186422207;6321.1150438938585;6338.841528961767;6828.283030281848;6905.827354316132;6910.44716422685;6912.965435172842;6936.410405115571;6891.3797758202;6907.930920690779;6928.16861976561;7019.6490175491535;7026;6332.778352757631;6386.616802991789;6413.230412350501;6431.292557818683;6460.28936816945;7048.224695283515;7104.183018952886;7119.074520312326;7145.606991615407;7150.070490836262;6671.33286671329;6751.392374686302;6773.93226067733;6843.247242803288;6857.9657101715175;6873.518853680194;6878.965605171942;6952.443804495628;6972.755953541703;6988.93011069893;6646.700898459581;6694.698738556776;6730.966345168243;6737.191537015589;6761.0872532208505;6643.833904152435;6654.933450665529;6718.328167183243;6739.191297044386;6756.560823546453;4859.927101093486;4929.926051109236;4936.827211047596;4937.9012419752125;4942.950570494321;4483.529229430928;4508.41390619224;4523.434570678665;4555.2711566149255;4566.748828814447;6327.240731112296;6327.620342779448;6394.26465956421;6394.392532709385;6398.360163983564;6860.897086543706;6875.690593923286;6955.582665040114;6964.477664175207;6966.79099627012;6248.156498872594;6310.1481300024825;6311.211098612674;6317;6384.138141350858;5466.781328746885;5477.534409575231;5481.561475081984;5581.10702287632;5587.022271102541;7051.1186101737285;7074.327938845801;7158.785236442915;7164.140303163654;7179.964100179465;6764.864702706017;6784.08414863987;6816.556923799937;6903.965480172567;6918.827029324307;7099.680514376762;7112.786616401516;7164.534305270141;7183.8563228736175;7189.964050179925;6692.531522793358;6782.491313151632;6783.05037294789;6813.89779153323;6835.897461537981;6785.1518560179975;6793.252742198255;6800.489963252875;6897.103376561015;6902;6469.935300646934;6541.901871472027;6553.901691474727;6632.071509988509;6639.535232533676;6592.439642630238;6617.569857959217;6618.338166183343;6618.867622647616;6623.801285961429;6455.741770329322;6541.8691626168165;6542.705578248895;6611.933880661132;6635.23694775107;6681.1314529110905;6686.398224159654;6691.0967019451755;6717.026031225542;6739.224989126314;6403.039544068427;6414.262359828493;6429.678516074271;6514.120593719977;6535.183102112236 04:06:05 INFO - PID 7517 | |1;ext.html;960.5149399553225;980.7940332530168;985.7141428985599;990.2325697584373;992.8907820139788;44387.55612443874;44935.77532112339;45170.548294517044;45228.54771452293;45235;42318.78840605792;42653.57346426535;42804.35793463101;42839.785801071026;42936;7351.191368949398;7453.627318634047;7461.030066091427;7469.47713660044;7474.140473845496;7417.072865891763;7480.925190748105;7488.663010164529;7493.138289096742;7496.700131994741;8005.799855003614;8178.754637360888;8190.385721070914;8193.7132200373;8198.057223419293;8047.839043219132;8082.353411727047;8097.595120243965;8116.1072282048635;8117.0259568851825;7688.5386876787015;7821.139674635842;7843.294103530652;7908.881366779503;7976.242256985577;43229.35155972663;43540.564594354284;43575.34636980448;43660.78169609132;43736.78131609353;3754.2679177560385;3768.0768211788013;3784.697224222083;3789.2800367930004;3800.5439347278502;34136.82931585326;34220.48669269963;34271.14322141966;34425;34443.65556344429;5558.832645144525;5567.2762540869835;5589.245451863987;5619.325680918275;5682.886342273131;221755;222491;223700;224549;224727;49211;49442;53854.19218711644;54083.45916540863;55296.17055744167;57775.711121444125;57778.422215777304;57823.13265301024;57913.71043144842;58345;16134;16194.433194838124;16199.109049002418;16232;16263.918680406523;12833.614991550268;12870.67823304425;12903.483860645469;13091.476340946447;13145.277009764555;15699.843001570067;15749.763753543706;15766;15781.763273550905;15869.920650396674;6194.256689197326;6240.625562466266;6251.812445626639;6367.331430199855;6392;1112.3270421395102;1127.312339472921;1127.520803658442;1136.0797753819434;1142.2404101272562;26083.869580652354;26356.868215659182;26558.33604159873;26616.467670646478;26768.464630707276;1188.2276520261726;1229.3238718704856;1235.4440501774238;1246.7942789439642;1260.0990291941123;13598.592042238748;13696.452141914411;13785.862141378659;14089.295535223198;14226.85773142276;282487;284957;286466;287345;287569;61264.38735612676;61419;61700.38299617036;61901.38098619046;61956.69021654863;1517.9924100379428;1521.6652336486177;1561.6486290584755;1562.9452969146025;1575.6060984753813;24959.251222463354;25202.74797252004;25421.364465888502;25656.61515077238;25672.229833105037;43140.352894707234;43199.784001079795;43206.135877282904;43232.78383608062;43355;250196;251470;252598;252719;253038;37512.624873750916;39007.41488877726;39771.80114099411;39778;39792;52440;52837.735811322236;53115.4688453126;53222.4677753233;54040.729796350766;37804.24391512099;38175.42736859005;38443.42334865035;38575.807120964215;39027.609723902395;37450;37463.25073498569;37606.435903462014;37615.81192094022;37661.623383765815;43439.56560434355;43837.56162438335;44353.77823110864;44675.55324446714;44793.77603112094;35880.282394352485;35969;36046.63953360433;36423;36652.26695466023;28003.51943689;28273.57589636116;28283;28371.716282836907;28493.715062849937 04:06:05 INFO - PID 7517 | |2;jquery.html;584.7018020809386;592.8310431527016;593.9376365481625;598.5899658733767;602.6414283501316;22829.42926426838;23420.76579234207;23446.882765586168;23466.29601111965;23473;24001;25217.117400890973;25449.87275063622;25658.74341256587;25700.100496482628;6594.571352862061;6705.463562914955;6716.429103526181;6716.563423377489;6724.361185687377;6376.521760867953;6621.073049773036;6628.304028077055;6651.800445986604;6728.226253980782;6546.279909209983;6566.737330506774;6577.901331480031;6579.638119903403;6612.239592446882;6360.9045864312075;6579.80260592183;6604.900926486107;6616.768413105518;6646.501512386591;6147.354527774564;6206.813795586095;6210.689465526705;6234.064890266496;6236.844078898019;29322.266943326587;30023;30245.546316805267;30246.54630180549;30321;2267.7278726552754;2276.8975396107217;2279.361778701966;2283.2237039406514;2292.6790249365104;19091.61816763671;19682.704759428478;20140.597188056305;20337.8983105085;20368.490787730276;2471.8269721119527;2475.725001624165;2542.0467324753217;2545.7581529754643;2556.9105081322064;138711;146625;155039;161290;161567;15160.924195378953;15193.696126077417;15587.454439094805;15897.28462219203;16214.270357833926;25085.37286567814;25304.493910122063;25318.36704082376;25354.239372818844;25459.490810184063;10609.9469502652;10659.4137322448;10810.459477026117;10827.484152218696;10862.837057444145;9814.803703926023;9857.162141218078;9870.358426702242;10023.198144148451;10051.547680354402;9387.57755900986;9417.576209070608;9617.807643847083;9627.229821614254;9743.756406089904;2711.701712811589;2753.8072334936764;2795.55271156614;2890.8265504069823;3009.6689364169924;1000.0399616368222;1009.1018993096151;1033.0805583031108;1038.2057725839738;1049.4700176411015;20726.58546829055;20730.58538829215;20984.370468885958;21013.789862101185;21063;1083.6532309660834;1086.0388556127884;1089.84742136101;1099.0767755085606;1104.8508451358964;11286.435678216056;11427.08583313333;11446.14153938458;11545.422728863523;11570.652880413601;549410;558070;563633;564919;583273;123069;125111.3744431272;127225;127969;128357;1051.818249794378;1140.0480598700012;1142.6229344316355;1201.1891972918245;1242.490578862662;20301.59396812085;20595.8970205148;20655.483612909797;20687.586248275253;20890.373288801362;63080.36919630745;63860.3613963873;64683;64880.67559662172;65110.348896510426;79668.20331796608;79816.20183798087;80015.59992200235;80212;80302.1969780318;14582.562523124323;14977.850221498082;14978.625534361729;14978.775318370452;15003.099814010757;23283.534329313658;23416.414589635395;23429.648555271342;23468.76531234666;23555.76444235604;19380.127894245074;19401.126949287034;19410.320638777575;19516.60966780685;19687.40937771869;16580.336786528405;17001.659966800347;17177.31290748356;17284.04937728437;17399.652006960045;17770.466885993443;18281.08594570293;18673.813261867206;19379.51551211231;19688.803111968697;14678.559643210721;14706.044107133002;14799.92600036993;14805.96358254955;14830;18895.6220875579;19096.71354929705;19118.426447206606;19194.616107678048;19354.61290774205 04:06:05 INFO - PID 7517 | |3;mootools.html;1407.2611878763648;1448.9275536223186;1478.0614309913208;1482.5330021043367;1487.6801487680148;16716.33134674613;17254;17337.73993390097;17398.21708023139;17406.39077632283;16749.497515074567;16753.497395078168;16835.32658693651;16842.24209910554;16862.747058794128;2807;2855.657321121468;2855.7858160637984;2887.4369497947805;2893.0597555794347;2760.806743527954;2793.1620513845864;2805.7755379569585;2806.1721792071285;2814.760745336649;2722.2649884531165;2753.421781425903;2879.280179955011;2884.697106803787;2887.6534815822024;2770.2104900103577;2817.197098826835;2826.1380279014893;2840.2757296889163;2841.5737639354056;2730.4539092181644;2740.1779466160074;2747.120921305183;2751.7660998815127;2753.366725653091;16458.588535286595;16909.7463538047;17020.659586808317;17029.489115326436;17046.74429883553;8674.826503469958;8889.555522223927;8929.910700893039;8955.820883582292;8970.50662213578;5671.63134396267;5858.531317494633;5944;6002.399760024006;6034.215551978258;2103.316422162803;2139.3368055902565;2150.354893531934;2163.697082408464;2195.297504798465;30522.08433746969;30691.999999999778;30845.691543084507;30848.8457557713;30876;7161.971970582971;7212.574027336973;7294.489385743053;7340.889886651705;7411.184769675439;19717.408477745692;19739.703904441445;19745.605087898162;19846.908420036747;19880.70178947317;8367.372447066495;8529.360297977677;8530;8534.573271336409;8549.230569248797;7718.266764657348;7757.612119394008;7773.805654858674;7802.804929876798;7812.1016083150025;5604.747786349542;5782.537397008229;5849.736761845727;5965.492933100648;6050.304215015241;1499.917504537261;1522.72590933633;1644.8930819496934;1651.587103224194;1664.4756901575965;957.2389949989774;958.1759686669459;967.0661358062707;987.9407235565889;994.2046362909643;8940.792992945999;8947.239484643747;9011.819763604823;9082.40964337316;9136.314776391797;1007.6372505897871;1014.6600888702368;1026.3892983674702;1030.3766221436074;1045.926785125034;4521.819127234874;4573.199690054294;4702.623790096784;5105.642605017613;5903.291605007426;24428.145014924394;24819.751802481744;25314;25548.23355299344;25557.977680892556;24910;25216.873915630305;25229.495410091695;25422.110226141995;25620.8718956404;12508.562200323127;12681.30252836103;12750.234985900875;12792;12798.16811907223;8833.381663283766;8897.688580899638;8945.821083578161;8965.058668839678;9031.729048128567;20896.268630597857;21274;21413.036413361126;21810.454738631663;21825.56348872982;21785.455363616038;22357.77642223557;22836.31491055271;22898.313050608507;22964.770352296262;12327.815082773945;12364.19632723906;12373.072019598387;12465.189762665397;12526;15598.9220053899;15650.530484085495;15675.92162039228;15701.685966280838;15725.21373931276;12650.557230496888;12771.425285862344;12793.936030319788;12796.808047879103;12990.415431305424;12244;12523.185992910796;12622;12720.173188742701;12794.104412691395;10828.350298982086;10872.67381978542;10899.073578745896;10928.672139835817;10934.398608076313;7872.094709108525;7941.801454963441;8087.433879628369;8108.554029528196;8146.592670366576;7703.576303303372;7806.219378062376;7815.179406162271;7921.366290696846;7921.564313962787 04:06:05 INFO - PID 7517 | |4;prototype.html;533.7971570803097;534.9197620356947;556.8357334586296;563.4027930393783;573.9512141467975;6174.228221472316;6201.348858369874;6224.28420731616;6274.717637706302;6274.968625156874;6197.163382943301;6238.251409830816;6260.280067792205;6283.528735344845;6290.087937249107;4864.246041863516;5002.324686167357;5194.272801807731;5195.116830138866;5203.739813009353;4984.825531106412;5048.091343558158;5048.899022019576;5066.84799456015;5078.542931136197;4914.410270767513;4979;5004.099262132815;5005.54950054495;5016.974915125437;4939.431965323998;4940.950590494085;4961.776720047606;4978.128827455199;5006.674566153189;4484.654603618934;4529.343245229456;4564.5435456454425;4577.130345234395;4597.7241365518175;6080.14877917092;6114.571979961404;6125.754969801203;6137.41694539018;6165.445109940127;5824.650520968756;5837.416258374171;5901.3803550627;5910.822675319747;5912.526997840162;6586.341365863424;6590;6615.569987950816;6638.236602790693;6642.601443913332;5026.497350264981;5065.265536497224;5080.13637681595;5097.7960881564695;5128.538431541142;6938.791836244921;6998.335158159966;7024.859502809966;7027.8594428111155;7075.610841403773;5225.686458812484;5250.028744682246;5250.947490525123;5253.6603166193145;5267.420583735786;5285.312909321764;5292.708901010481;5309.761060752276;5327.520523152857;5369.7583608737705;5793.797217097382;5804.564657650693;5833.533317334603;5836.431969933215;5858.297004359504;6366.904496432558;6497.15536980199;6631.204255489372;6635.270120286765;6766.28953959837;1791.2834866053684;1795.3895675470403;1815.2013114229696;1823.972640410395;1824.4344253281524;1118.798616249083;1264.6395777203452;1272.1603741530546;1284.6659868434274;1291.8966482681362;6151.231096112986;6161.25824008321;6255.218097737783;6339.175907132136;6354.332795056453;6878.65606719662;6904.620245886525;6908.309169083152;6943.472436064058;6956;6291.716872740738;6297.622142671363;6314.494840412756;6353.142325786052;6383.265924418658;3641.9817900910325;3647.252313275772;3659.8902032939054;3666.944995825065;3671.9449208261362;7030.894536581955;7140.428765698835;7144;7157.4274058075225;7183.317584829433;6891.862162756817;6951.08054617062;6971.233164351917;6995.860082798417;7024.71696698575;6838.316168383122;6919.965400172967;6995.8600827983155;7002.159740831133;7101.254368291255;6753.2909044549615;6770.796876093528;6771.255161932282;6808.38724514796;6817.727290908507;6711.530192886451;6712.630805305755;6733.831654208488;6778.3221677831825;6886.586804791728;6829.556078854858;6836.453083753388;6892.070220338313;6915.170179578483;7100.573965561876;5582;5596.356419011703;5600.915986260128;5621.831345059655;5646.9152962704775;6759.425448836904;6760;6818.249992500921;6820.35206655367;6822.761203357859;6599.340065993554;6601.768938087144;6647.700853461509;6652.800415987528;6653.434458071119;6535.673216339259;6568.507361947777;6568.6058836469965;6654.600723956578;6657.367550082734;6387.425131738166;6410.519211059096;6419.871602568016;6437.935620643921;6521.804345869631;6251.249850018027;6555.836104097436;6584.176977877765;6641.435477984232;6644.302348253364;6413.551051426355;6418.133551970424;6478.805635830932;6508.023796430384;6570.211574611078 04:06:05 INFO - PID 7517 | |5;yui.html;948.4309414351386;975.1711045611229;984.9753756156096;985.1133979418527;1023.0715102032668;18622.348217812378;19210.615787684237;19226.903865480686;19251;19278.228870845185;18116.36592719255;18521.629567408643;18624.81375186248;18640.813591864076;18763.718544221814;1065.2649671726504;1071.9464026798628;1072.0673014477416;1072.394097335007;1073.1522097542932;1047.2669131607868;1074.4520294649706;1078.946052697362;1102.9779404411906;1103.189155970361;1162.4013632979022;1162.4710756605723;1162.581470670558;1163.2090178678495;1164.0222213340792;1100.6918062942389;1151.395517353392;1157.9478923448464;1158.7856246594365;1158.9188756787028;812.5937031484258;817.9468334558235;819.1317203764029;819.7171975668444;821.0311832038193;20784.688229676565;20812.47968800792;20900;20959.790402095936;20971.161153553992;23388.53222935549;23889.641655375184;23925.282241532783;23982;24014.519709605884;17971.550711232194;18502.53743656406;18603.81396186034;18621.813781862278;18669;3982.362821948503;3989.142334398089;3989.4215338776007;3993.480847489837;4014.5383280922483;159826.4017359823;164604;164876;168956;169528;17868.28526858937;18210.36263730763;18514.537136571424;18572;18630.347937822382;34420.13949651279;35491.4676279856;35512.822435887654;35532.28935421277;35669.46495802565;9470.431774093577;9491.525423728786;9529.571169297398;9566.378185417925;9573.138417542455;4603.861884143481;4615.769211539409;4671.556202160789;4686.133065382915;4729.55069268419;6015.789447369321;6109.7861574844665;6118.60229085108;6144.324124346318;6166.414190651881;1068.3750006246278;1101.9283746556448;1109.2235435195396;1112.777444511101;1120.137494129532;705.842418433769;707.4552594502204;707.6214225389392;708.8121647763347;717.2504732554493;12080;12358.62924112278;12602.243865368107;13151.736965260641;13385.799213011813;732.1726449112468;736.8342123022385;743.1119811824817;744.6314074533141;758.3061498728712;6295.748170073146;6307.684615769193;6317.084022816666;6346.2067241594805;6372.84067898297;154105.22947385415;154415;155825;157772;159077;134877;135797.3210133943;137569;138036.30981845027;142744;115604;116984.41507792406;117242.41378793222;117592.41203793927;118826.40586797183;11333.206675532963;11416.543338266376;11618.94190529042;11627;11635.127365447455;56053.719731401085;56436.435635643116;56761;57984.4201557979;58731.412685872594;71154;73009;74304.25695742974;75194.62402687952;75693.6215318942;16184.67630647404;16708.916455417646;16745;16787.412440564523;16904;19135.8086419134;19192.13635386383;19397.127129278935;19418.61162776765;19427.028648567233;18365.3572124975;18622.906885465487;18658.90670546693;18761.249550018394;18831.811681883006;16921.492355229362;16947;17069.91465042667;17157.399491017753;17202;17761.289548418434;17797.911010444866;17826.732599011284;17881;18025.369112081014;11509.136814739095;11782.823257651313;11897.167198296036;11913.166078374777;12310.81533777012;12200.267983920992;12379.257244565355;12444.813327800272;12572.434240459019;12618.810717839424 04:06:05 INFO - PID 7517 | __end_tp_report 04:06:05 INFO - PID 7517 | __start_cc_report 04:06:05 INFO - PID 7517 | _x_x_mozilla_cycle_collect,294 04:06:05 INFO - PID 7517 | __end_cc_report 04:06:05 INFO - PID 7517 | __startTimestamp1505559965114__endTimestamp 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | ------- Summary: start ------- 04:06:05 INFO - PID 7517 | Number of tests: 6 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#0] dojo.html Cycles:165 Average:6303.28 Median:6541.87 stddev:761.52 (11.6%) stddev-sans-first:738.47 04:06:05 INFO - PID 7517 | Values: 3818.0 3830.2 3844.0 3854.1 3860.0 6210.1 6265.7 6293.0 6320.4 6335.9 6273.6 6347.7 6369.0 6372.9 6390.3 5629.5 5640.4 5660.1 5670.8 5735.0 5718.4 5727.2 5795.2 5795.5 5800.6 5534.6 5664.7 5713.5 5725.5 5760.4 5653.5 5707.7 5725.9 5735.9 5742.8 5596.1 5669.6 5671.5 5726.3 5749.0 6284.2 6299.7 6320.9 6321.1 6338.8 6828.3 6905.8 6910.4 6913.0 6936.4 6891.4 6907.9 6928.2 7019.6 7026.0 6332.8 6386.6 6413.2 6431.3 6460.3 7048.2 7104.2 7119.1 7145.6 7150.1 6671.3 6751.4 6773.9 6843.2 6858.0 6873.5 6879.0 6952.4 6972.8 6988.9 6646.7 6694.7 6731.0 6737.2 6761.1 6643.8 6654.9 6718.3 6739.2 6756.6 4859.9 4929.9 4936.8 4937.9 4943.0 4483.5 4508.4 4523.4 4555.3 4566.7 6327.2 6327.6 6394.3 6394.4 6398.4 6860.9 6875.7 6955.6 6964.5 6966.8 6248.2 6310.1 6311.2 6317.0 6384.1 5466.8 5477.5 5481.6 5581.1 5587.0 7051.1 7074.3 7158.8 7164.1 7180.0 6764.9 6784.1 6816.6 6904.0 6918.8 7099.7 7112.8 7164.5 7183.9 7190.0 6692.5 6782.5 6783.1 6813.9 6835.9 6785.2 6793.3 6800.5 6897.1 6902.0 6469.9 6541.9 6553.9 6632.1 6639.5 6592.4 6617.6 6618.3 6618.9 6623.8 6455.7 6541.9 6542.7 6611.9 6635.2 6681.1 6686.4 6691.1 6717.0 6739.2 6403.0 6414.3 6429.7 6514.1 6535.2 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#1] ext.html Cycles:180 Average:44143.61 Median:39017.51 stddev:66342.93 (170.0%) stddev-sans-first:66449.80 04:06:05 INFO - PID 7517 | Values: 960.5 980.8 985.7 990.2 992.9 44387.6 44935.8 45170.5 45228.5 45235.0 42318.8 42653.6 42804.4 42839.8 42936.0 7351.2 7453.6 7461.0 7469.5 7474.1 7417.1 7480.9 7488.7 7493.1 7496.7 8005.8 8178.8 8190.4 8193.7 8198.1 8047.8 8082.4 8097.6 8116.1 8117.0 7688.5 7821.1 7843.3 7908.9 7976.2 43229.4 43540.6 43575.3 43660.8 43736.8 3754.3 3768.1 3784.7 3789.3 3800.5 34136.8 34220.5 34271.1 34425.0 34443.7 5558.8 5567.3 5589.2 5619.3 5682.9 221755.0 222491.0 223700.0 224549.0 224727.0 49211.0 49442.0 53854.2 54083.5 55296.2 57775.7 57778.4 57823.1 57913.7 58345.0 16134.0 16194.4 16199.1 16232.0 16263.9 12833.6 12870.7 12903.5 13091.5 13145.3 15699.8 15749.8 15766.0 15781.8 15869.9 6194.3 6240.6 6251.8 6367.3 6392.0 1112.3 1127.3 1127.5 1136.1 1142.2 26083.9 26356.9 26558.3 26616.5 26768.5 1188.2 1229.3 1235.4 1246.8 1260.1 13598.6 13696.5 13785.9 14089.3 14226.9 282487.0 284957.0 286466.0 287345.0 287569.0 61264.4 61419.0 61700.4 61901.4 61956.7 1518.0 1521.7 1561.6 1562.9 1575.6 24959.3 25202.7 25421.4 25656.6 25672.2 43140.4 43199.8 43206.1 43232.8 43355.0 250196.0 251470.0 252598.0 252719.0 253038.0 37512.6 39007.4 39771.8 39778.0 39792.0 52440.0 52837.7 53115.5 53222.5 54040.7 37804.2 38175.4 38443.4 38575.8 39027.6 37450.0 37463.3 37606.4 37615.8 37661.6 43439.6 43837.6 44353.8 44675.6 44793.8 35880.3 35969.0 36046.6 36423.0 36652.3 28003.5 28273.6 28283.0 28371.7 28493.7 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#2] jquery.html Cycles:180 Average:38374.99 Median:12556.33 stddev:94870.03 (755.6%) stddev-sans-first:95093.74 04:06:05 INFO - PID 7517 | Values: 584.7 592.8 593.9 598.6 602.6 22829.4 23420.8 23446.9 23466.3 23473.0 24001.0 25217.1 25449.9 25658.7 25700.1 6594.6 6705.5 6716.4 6716.6 6724.4 6376.5 6621.1 6628.3 6651.8 6728.2 6546.3 6566.7 6577.9 6579.6 6612.2 6360.9 6579.8 6604.9 6616.8 6646.5 6147.4 6206.8 6210.7 6234.1 6236.8 29322.3 30023.0 30245.5 30246.5 30321.0 2267.7 2276.9 2279.4 2283.2 2292.7 19091.6 19682.7 20140.6 20337.9 20368.5 2471.8 2475.7 2542.0 2545.8 2556.9 138711.0 146625.0 155039.0 161290.0 161567.0 15160.9 15193.7 15587.5 15897.3 16214.3 25085.4 25304.5 25318.4 25354.2 25459.5 10609.9 10659.4 10810.5 10827.5 10862.8 9814.8 9857.2 9870.4 10023.2 10051.5 9387.6 9417.6 9617.8 9627.2 9743.8 2711.7 2753.8 2795.6 2890.8 3009.7 1000.0 1009.1 1033.1 1038.2 1049.5 20726.6 20730.6 20984.4 21013.8 21063.0 1083.7 1086.0 1089.8 1099.1 1104.9 11286.4 11427.1 11446.1 11545.4 11570.7 549410.0 558070.0 563633.0 564919.0 583273.0 123069.0 125111.4 127225.0 127969.0 128357.0 1051.8 1140.0 1142.6 1201.2 1242.5 20301.6 20595.9 20655.5 20687.6 20890.4 63080.4 63860.4 64683.0 64880.7 65110.3 79668.2 79816.2 80015.6 80212.0 80302.2 14582.6 14977.9 14978.6 14978.8 15003.1 23283.5 23416.4 23429.6 23468.8 23555.8 19380.1 19401.1 19410.3 19516.6 19687.4 16580.3 17001.7 17177.3 17284.0 17399.7 17770.5 18281.1 18673.8 19379.5 19688.8 14678.6 14706.0 14799.9 14806.0 14830.0 18895.6 19096.7 19118.4 19194.6 19354.6 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#3] mootools.html Cycles:180 Average:10477.40 Median:2726.36 stddev:7819.99 (286.8%) stddev-sans-first:7812.24 04:06:05 INFO - PID 7517 | Values: 1407.3 1448.9 1478.1 1482.5 1487.7 16716.3 17254.0 17337.7 17398.2 17406.4 16749.5 16753.5 16835.3 16842.2 16862.7 2807.0 2855.7 2855.8 2887.4 2893.1 2760.8 2793.2 2805.8 2806.2 2814.8 2722.3 2753.4 2879.3 2884.7 2887.7 2770.2 2817.2 2826.1 2840.3 2841.6 2730.5 2740.2 2747.1 2751.8 2753.4 16458.6 16909.7 17020.7 17029.5 17046.7 8674.8 8889.6 8929.9 8955.8 8970.5 5671.6 5858.5 5944.0 6002.4 6034.2 2103.3 2139.3 2150.4 2163.7 2195.3 30522.1 30692.0 30845.7 30848.8 30876.0 7162.0 7212.6 7294.5 7340.9 7411.2 19717.4 19739.7 19745.6 19846.9 19880.7 8367.4 8529.4 8530.0 8534.6 8549.2 7718.3 7757.6 7773.8 7802.8 7812.1 5604.7 5782.5 5849.7 5965.5 6050.3 1499.9 1522.7 1644.9 1651.6 1664.5 957.2 958.2 967.1 987.9 994.2 8940.8 8947.2 9011.8 9082.4 9136.3 1007.6 1014.7 1026.4 1030.4 1045.9 4521.8 4573.2 4702.6 5105.6 5903.3 24428.1 24819.8 25314.0 25548.2 25558.0 24910.0 25216.9 25229.5 25422.1 25620.9 12508.6 12681.3 12750.2 12792.0 12798.2 8833.4 8897.7 8945.8 8965.1 9031.7 20896.3 21274.0 21413.0 21810.5 21825.6 21785.5 22357.8 22836.3 22898.3 22964.8 12327.8 12364.2 12373.1 12465.2 12526.0 15598.9 15650.5 15675.9 15701.7 15725.2 12650.6 12771.4 12793.9 12796.8 12990.4 12244.0 12523.2 12622.0 12720.2 12794.1 10828.4 10872.7 10899.1 10928.7 10934.4 7872.1 7941.8 8087.4 8108.6 8146.6 7703.6 7806.2 7815.2 7921.4 7921.6 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#4] prototype.html Cycles:180 Average:5671.74 Median:6274.84 stddev:1583.32 (25.2%) stddev-sans-first:1540.08 04:06:05 INFO - PID 7517 | Values: 533.8 534.9 556.8 563.4 574.0 6174.2 6201.3 6224.3 6274.7 6275.0 6197.2 6238.3 6260.3 6283.5 6290.1 4864.2 5002.3 5194.3 5195.1 5203.7 4984.8 5048.1 5048.9 5066.8 5078.5 4914.4 4979.0 5004.1 5005.5 5017.0 4939.4 4941.0 4961.8 4978.1 5006.7 4484.7 4529.3 4564.5 4577.1 4597.7 6080.1 6114.6 6125.8 6137.4 6165.4 5824.7 5837.4 5901.4 5910.8 5912.5 6586.3 6590.0 6615.6 6638.2 6642.6 5026.5 5065.3 5080.1 5097.8 5128.5 6938.8 6998.3 7024.9 7027.9 7075.6 5225.7 5250.0 5250.9 5253.7 5267.4 5285.3 5292.7 5309.8 5327.5 5369.8 5793.8 5804.6 5833.5 5836.4 5858.3 6366.9 6497.2 6631.2 6635.3 6766.3 1791.3 1795.4 1815.2 1824.0 1824.4 1118.8 1264.6 1272.2 1284.7 1291.9 6151.2 6161.3 6255.2 6339.2 6354.3 6878.7 6904.6 6908.3 6943.5 6956.0 6291.7 6297.6 6314.5 6353.1 6383.3 3642.0 3647.3 3659.9 3666.9 3671.9 7030.9 7140.4 7144.0 7157.4 7183.3 6891.9 6951.1 6971.2 6995.9 7024.7 6838.3 6920.0 6995.9 7002.2 7101.3 6753.3 6770.8 6771.3 6808.4 6817.7 6711.5 6712.6 6733.8 6778.3 6886.6 6829.6 6836.5 6892.1 6915.2 7100.6 5582.0 5596.4 5600.9 5621.8 5646.9 6759.4 6760.0 6818.2 6820.4 6822.8 6599.3 6601.8 6647.7 6652.8 6653.4 6535.7 6568.5 6568.6 6654.6 6657.4 6387.4 6410.5 6419.9 6437.9 6521.8 6251.2 6555.8 6584.2 6641.4 6644.3 6413.6 6418.1 6478.8 6508.0 6570.2 04:06:05 INFO - PID 7517 | 04:06:05 INFO - PID 7517 | [#5] yui.html Cycles:180 Average:28888.95 Median:18612.81 stddev:44004.79 (236.4%) stddev-sans-first:44078.22 04:06:05 INFO - PID 7517 | Values: 948.4 975.2 985.0 985.1 1023.1 18622.3 19210.6 19226.9 19251.0 19278.2 18116.4 18521.6 18624.8 18640.8 18763.7 1065.3 1071.9 1072.1 1072.4 1073.2 1047.3 1074.5 1078.9 1103.0 1103.2 1162.4 1162.5 1162.6 1163.2 1164.0 1100.7 1151.4 1157.9 1158.8 1158.9 812.6 817.9 819.1 819.7 821.0 20784.7 20812.5 20900.0 20959.8 20971.2 23388.5 23889.6 23925.3 23982.0 24014.5 17971.6 18502.5 18603.8 18621.8 18669.0 3982.4 3989.1 3989.4 3993.5 4014.5 159826.4 164604.0 164876.0 168956.0 169528.0 17868.3 18210.4 18514.5 18572.0 18630.3 34420.1 35491.5 35512.8 35532.3 35669.5 9470.4 9491.5 9529.6 9566.4 9573.1 4603.9 4615.8 4671.6 4686.1 4729.6 6015.8 6109.8 6118.6 6144.3 6166.4 1068.4 1101.9 1109.2 1112.8 1120.1 705.8 707.5 707.6 708.8 717.3 12080.0 12358.6 12602.2 13151.7 13385.8 732.2 736.8 743.1 744.6 758.3 6295.7 6307.7 6317.1 6346.2 6372.8 154105.2 154415.0 155825.0 157772.0 159077.0 134877.0 135797.3 137569.0 138036.3 142744.0 115604.0 116984.4 117242.4 117592.4 118826.4 11333.2 11416.5 11618.9 11627.0 11635.1 56053.7 56436.4 56761.0 57984.4 58731.4 71154.0 73009.0 74304.3 75194.6 75693.6 16184.7 16708.9 16745.0 16787.4 16904.0 19135.8 19192.1 19397.1 19418.6 19427.0 18365.4 18622.9 18658.9 18761.2 18831.8 16921.5 16947.0 17069.9 17157.4 17202.0 17761.3 17797.9 17826.7 17881.0 18025.4 11509.1 11782.8 11897.2 11913.2 12310.8 12200.3 12379.3 12444.8 12572.4 12618.8 04:06:05 INFO - PID 7517 | -------- Summary: end -------- 04:06:05 INFO - PID 7517 | 04:06:05 INFO - TEST-INFO | 7517: exit 0 04:06:05 INFO - TEST-OK | dromaeo_css | took 1107238ms 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:43399/getInfo.html -profile /tmp/tmpplTP73/profile 04:06:05 INFO - TEST-INFO | started process 7882 (/builds/slave/test/build/application/firefox/firefox http://localhost:43399/getInfo.html) 04:06:11 INFO - TEST-INFO | 7882: exit 0 04:06:11 INFO - Browser initialized. 04:06:11 INFO - Running cycle 1/1 for kraken test... 04:06:11 INFO - Using env: {'DISPLAY': ':0', 04:06:11 INFO - 'HOME': '/home/cltbld', 04:06:11 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:11 INFO - 'LANG': 'en_US.UTF-8', 04:06:11 INFO - 'LANGUAGE': 'en_US:en', 04:06:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:11 INFO - 'LOGNAME': 'cltbld', 04:06:11 INFO - 'MAIL': '/var/mail/cltbld', 04:06:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:11 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:11 INFO - 'MOZ_NO_REMOTE': '1', 04:06:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:11 INFO - 'NO_EM_RESTART': '1', 04:06:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:11 INFO - 'PWD': '/builds/slave/test', 04:06:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:11 INFO - 'RUST_BACKTRACE': 'full', 04:06:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:11 INFO - 'SHELL': '/bin/bash', 04:06:11 INFO - 'SHLVL': '1', 04:06:11 INFO - 'STYLO_FORCE_DISABLED': '1', 04:06:11 INFO - 'TERM': 'linux', 04:06:11 INFO - 'TMOUT': '86400', 04:06:11 INFO - 'USER': 'cltbld', 04:06:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505558508.629424-385956466', 04:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:11 INFO - '_': '/tools/buildbot/bin/python'} 04:06:11 INFO - TEST-INFO | started process 8120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplTP73/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:11 INFO - PID 8120 | 04:06:11 INFO - PID 8120 | (/builds/slave/test/build/application/firefox/firefox:8169): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:11 INFO - PID 8120 | 04:06:22 INFO - PID 8120 | RSS: Main: 148443136 04:06:22 INFO - PID 8120 | 04:06:24 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43399/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:25 INFO - PID 8120 | RSS: Main: 153468928 04:06:25 INFO - PID 8120 | 04:06:28 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43399/tests/kraken/driver.html?testName=audio-dft) 04:06:28 INFO - PID 8120 | RSS: Main: 154091520 04:06:28 INFO - PID 8120 | 04:06:31 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43399/tests/kraken/driver.html?testName=audio-fft) 04:06:32 INFO - PID 8120 | RSS: Main: 150016000 04:06:32 INFO - PID 8120 | 04:06:34 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43399/tests/kraken/driver.html?testName=audio-oscillator) 04:06:34 INFO - PID 8120 | RSS: Main: 151347200 04:06:34 INFO - PID 8120 | 04:06:37 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:37 INFO - PID 8120 | RSS: Main: 151744512 04:06:37 INFO - PID 8120 | 04:06:40 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43399/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:41 INFO - PID 8120 | RSS: Main: 151613440 04:06:41 INFO - PID 8120 | 04:06:44 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43399/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:45 INFO - PID 8120 | RSS: Main: 152535040 04:06:45 INFO - PID 8120 | 04:06:48 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43399/tests/kraken/driver.html?testName=json-parse-financial) 04:06:49 INFO - PID 8120 | RSS: Main: 153997312 04:06:49 INFO - PID 8120 | 04:06:50 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:51 INFO - PID 8120 | RSS: Main: 153509888 04:06:51 INFO - PID 8120 | 04:06:52 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:53 INFO - PID 8120 | RSS: Main: 153833472 04:06:53 INFO - PID 8120 | 04:06:55 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:56 INFO - PID 8120 | RSS: Main: 150618112 04:06:56 INFO - PID 8120 | 04:06:58 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:59 INFO - PID 8120 | RSS: Main: 150900736 04:06:59 INFO - PID 8120 | 04:07:01 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:02 INFO - PID 8120 | RSS: Main: 151535616 04:07:02 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | Cycle 1(1): loaded http://localhost:43399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43399/tests/kraken/driver.html?testName=ai-astar) 04:07:04 INFO - PID 8120 | RSS: Main: 153202688 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | __start_tp_report 04:07:04 INFO - PID 8120 | _x_x_mozilla_page_load 04:07:04 INFO - PID 8120 | _x_x_mozilla_page_load_details 04:07:04 INFO - PID 8120 | |i|pagename|runs| 04:07:04 INFO - PID 8120 | |0;ai-astar;107;104;105;105;106;105;107;105;104;106 04:07:04 INFO - PID 8120 | |1;audio-beat-detection;113;115;114;120;112;111;112;123;112;114 04:07:04 INFO - PID 8120 | |2;audio-dft;163;162;164;162;162;161;159;161;165;166 04:07:04 INFO - PID 8120 | |3;audio-fft;74;73;73;75;73;75;73;73;75;73 04:07:04 INFO - PID 8120 | |4;audio-oscillator;79;80;78;79;77;77;79;78;77;86 04:07:04 INFO - PID 8120 | |5;imaging-gaussian-blur;113;114;110;114;113;113;115;115;114;114 04:07:04 INFO - PID 8120 | |6;imaging-darkroom;148;149;149;149;149;152;152;152;151;149 04:07:04 INFO - PID 8120 | |7;imaging-desaturate;95;94;94;95;95;93;95;95;94;96 04:07:04 INFO - PID 8120 | |8;json-parse-financial;45;42;49;43;46;44;43;46;43;46 04:07:04 INFO - PID 8120 | |9;json-stringify-tinderbox;38;39;38;38;38;38;38;38;38;38 04:07:04 INFO - PID 8120 | |10;stanford-crypto-aes;75;70;70;72;74;71;72;71;82;70 04:07:04 INFO - PID 8120 | |11;stanford-crypto-ccm;106;107;105;111;108;108;112;102;105;107 04:07:04 INFO - PID 8120 | |12;stanford-crypto-pbkdf2;162;155;157;156;160;160;157;155;157;160 04:07:04 INFO - PID 8120 | |13;stanford-crypto-sha256-iterative;65;59;60;60;61;66;62;58;61;60 04:07:04 INFO - PID 8120 | __end_tp_report 04:07:04 INFO - PID 8120 | __start_cc_report 04:07:04 INFO - PID 8120 | _x_x_mozilla_cycle_collect,764 04:07:04 INFO - PID 8120 | __end_cc_report 04:07:04 INFO - PID 8120 | __startTimestamp1505560024358__endTimestamp 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | ------- Summary: start ------- 04:07:04 INFO - PID 8120 | Number of tests: 14 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.50 stddev:1.07 (1.0%) stddev-sans-first:0.97 04:07:04 INFO - PID 8120 | Values: 107.0 104.0 105.0 105.0 106.0 105.0 107.0 105.0 104.0 106.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#1] audio-beat-detection Cycles:10 Average:114.60 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:4.09 04:07:04 INFO - PID 8120 | Values: 113.0 115.0 114.0 120.0 112.0 111.0 112.0 123.0 112.0 114.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 04:07:04 INFO - PID 8120 | Values: 163.0 162.0 164.0 162.0 162.0 161.0 159.0 161.0 165.0 166.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#3] audio-fft Cycles:10 Average:73.70 Median:73.50 stddev:0.95 (1.3%) stddev-sans-first:1.00 04:07:04 INFO - PID 8120 | Values: 74.0 73.0 73.0 75.0 73.0 75.0 73.0 73.0 75.0 73.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:2.67 (3.4%) stddev-sans-first:2.83 04:07:04 INFO - PID 8120 | Values: 79.0 80.0 78.0 79.0 77.0 77.0 79.0 78.0 77.0 86.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 04:07:04 INFO - PID 8120 | Values: 113.0 114.0 110.0 114.0 113.0 113.0 115.0 115.0 114.0 114.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.56 (1.0%) stddev-sans-first:1.48 04:07:04 INFO - PID 8120 | Values: 148.0 149.0 149.0 149.0 149.0 152.0 152.0 152.0 151.0 149.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 04:07:04 INFO - PID 8120 | Values: 95.0 94.0 94.0 95.0 95.0 93.0 95.0 95.0 94.0 96.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:45.50 stddev:2.11 (4.6%) stddev-sans-first:2.24 04:07:04 INFO - PID 8120 | Values: 45.0 42.0 49.0 43.0 46.0 44.0 43.0 46.0 43.0 46.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 04:07:04 INFO - PID 8120 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.00 stddev:3.68 (5.1%) stddev-sans-first:3.81 04:07:04 INFO - PID 8120 | Values: 75.0 70.0 70.0 72.0 74.0 71.0 72.0 71.0 82.0 70.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#11] stanford-crypto-ccm Cycles:10 Average:107.10 Median:107.50 stddev:2.92 (2.7%) stddev-sans-first:3.07 04:07:04 INFO - PID 8120 | Values: 106.0 107.0 105.0 111.0 108.0 108.0 112.0 102.0 105.0 107.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.50 stddev:2.42 (1.5%) stddev-sans-first:2.07 04:07:04 INFO - PID 8120 | Values: 162.0 155.0 157.0 156.0 160.0 160.0 157.0 155.0 157.0 160.0 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:2.53 (4.1%) stddev-sans-first:2.28 04:07:04 INFO - PID 8120 | Values: 65.0 59.0 60.0 60.0 61.0 66.0 62.0 58.0 61.0 60.0 04:07:04 INFO - PID 8120 | -------- Summary: end -------- 04:07:04 INFO - PID 8120 | 04:07:04 INFO - PID 8120 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:07:04 INFO - TEST-INFO | 8120: exit 0 04:07:04 INFO - TEST-OK | kraken | took 59162ms 04:07:04 INFO - SUITE-END | took 1166s 04:07:05 INFO - Completed test suite (00:19:26) 04:07:05 INFO - javascript benchmark 04:07:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9094.858257142916, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3817.999999999999, 3830.214805964777, 3843.9615603843954, 3854.113553882605, 3860.034991252187, 6210.130581718563, 6265.655388953605, 6293.0, 6320.431161195492, 6335.904961425571, 6273.623582585048, 6347.746090156388, 6368.968155159229, 6372.8725425491575, 6390.329015453381, 5629.4652008059165, 5640.3795582486, 5660.094384898417, 5670.773169073233, 5734.967705812952, 5718.399568045337, 5727.169560413738, 5795.2466179396615, 5795.536357091443, 5800.593958422891, 5534.640248383883, 5664.660120392789, 5713.514351280125, 5725.513331366838, 5760.36635970043, 5653.4911857932575, 5707.686077265748, 5725.885482290331, 5735.856603584902, 5742.770289188427, 5596.104623260299, 5669.6314739541795, 5671.546276297886, 5726.341470730836, 5749.0, 6284.214473190851, 6299.6850157491945, 6320.905186422207, 6321.1150438938585, 6338.841528961767, 6828.283030281848, 6905.827354316132, 6910.44716422685, 6912.965435172842, 6936.410405115571, 6891.3797758202, 6907.930920690779, 6928.16861976561, 7019.6490175491535, 7026.0, 6332.778352757631, 6386.616802991789, 6413.230412350501, 6431.292557818683, 6460.28936816945, 7048.224695283515, 7104.183018952886, 7119.074520312326, 7145.606991615407, 7150.070490836262, 6671.33286671329, 6751.392374686302, 6773.93226067733, 6843.247242803288, 6857.9657101715175, 6873.518853680194, 6878.965605171942, 6952.443804495628, 6972.755953541703, 6988.93011069893, 6646.700898459581, 6694.698738556776, 6730.966345168243, 6737.191537015589, 6761.0872532208505, 6643.833904152435, 6654.933450665529, 6718.328167183243, 6739.191297044386, 6756.560823546453, 4859.927101093486, 4929.926051109236, 4936.827211047596, 4937.9012419752125, 4942.950570494321, 4483.529229430928, 4508.41390619224, 4523.434570678665, 4555.2711566149255, 4566.748828814447, 6327.240731112296, 6327.620342779448, 6394.26465956421, 6394.392532709385, 6398.360163983564, 6860.897086543706, 6875.690593923286, 6955.582665040114, 6964.477664175207, 6966.79099627012, 6248.156498872594, 6310.1481300024825, 6311.211098612674, 6317.0, 6384.138141350858, 5466.781328746885, 5477.534409575231, 5481.561475081984, 5581.10702287632, 5587.022271102541, 7051.1186101737285, 7074.327938845801, 7158.785236442915, 7164.140303163654, 7179.964100179465, 6764.864702706017, 6784.08414863987, 6816.556923799937, 6903.965480172567, 6918.827029324307, 7099.680514376762, 7112.786616401516, 7164.534305270141, 7183.8563228736175, 7189.964050179925, 6692.531522793358, 6782.491313151632, 6783.05037294789, 6813.89779153323, 6835.897461537981, 6785.1518560179975, 6793.252742198255, 6800.489963252875, 6897.103376561015, 6902.0, 6469.935300646934, 6541.901871472027, 6553.901691474727, 6632.071509988509, 6639.535232533676, 6592.439642630238, 6617.569857959217, 6618.338166183343, 6618.867622647616, 6623.801285961429, 6455.741770329322, 6541.8691626168165, 6542.705578248895, 6611.933880661132, 6635.23694775107, 6681.1314529110905, 6686.398224159654, 6691.0967019451755, 6717.026031225542, 6739.224989126314, 6403.039544068427, 6414.262359828493, 6429.678516074271, 6514.120593719977, 6535.183102112236], "value": 6250.294946285917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.5149399553225, 980.7940332530168, 985.7141428985599, 990.2325697584373, 992.8907820139788, 44387.55612443874, 44935.77532112339, 45170.548294517044, 45228.54771452293, 45235.0, 42318.78840605792, 42653.57346426535, 42804.35793463101, 42839.785801071026, 42936.0, 7351.191368949398, 7453.627318634047, 7461.030066091427, 7469.47713660044, 7474.140473845496, 7417.072865891763, 7480.925190748105, 7488.663010164529, 7493.138289096742, 7496.700131994741, 8005.799855003614, 8178.754637360888, 8190.385721070914, 8193.7132200373, 8198.057223419293, 8047.839043219132, 8082.353411727047, 8097.595120243965, 8116.1072282048635, 8117.0259568851825, 7688.5386876787015, 7821.139674635842, 7843.294103530652, 7908.881366779503, 7976.242256985577, 43229.35155972663, 43540.564594354284, 43575.34636980448, 43660.78169609132, 43736.78131609353, 3754.2679177560385, 3768.0768211788013, 3784.697224222083, 3789.2800367930004, 3800.5439347278502, 34136.82931585326, 34220.48669269963, 34271.14322141966, 34425.0, 34443.65556344429, 5558.832645144525, 5567.2762540869835, 5589.245451863987, 5619.325680918275, 5682.886342273131, 221755.0, 222491.0, 223700.0, 224549.0, 224727.0, 49211.0, 49442.0, 53854.19218711644, 54083.45916540863, 55296.17055744167, 57775.711121444125, 57778.422215777304, 57823.13265301024, 57913.71043144842, 58345.0, 16134.0, 16194.433194838124, 16199.109049002418, 16232.0, 16263.918680406523, 12833.614991550268, 12870.67823304425, 12903.483860645469, 13091.476340946447, 13145.277009764555, 15699.843001570067, 15749.763753543706, 15766.0, 15781.763273550905, 15869.920650396674, 6194.256689197326, 6240.625562466266, 6251.812445626639, 6367.331430199855, 6392.0, 1112.3270421395102, 1127.312339472921, 1127.520803658442, 1136.0797753819434, 1142.2404101272562, 26083.869580652354, 26356.868215659182, 26558.33604159873, 26616.467670646478, 26768.464630707276, 1188.2276520261726, 1229.3238718704856, 1235.4440501774238, 1246.7942789439642, 1260.0990291941123, 13598.592042238748, 13696.452141914411, 13785.862141378659, 14089.295535223198, 14226.85773142276, 282487.0, 284957.0, 286466.0, 287345.0, 287569.0, 61264.38735612676, 61419.0, 61700.38299617036, 61901.38098619046, 61956.69021654863, 1517.9924100379428, 1521.6652336486177, 1561.6486290584755, 1562.9452969146025, 1575.6060984753813, 24959.251222463354, 25202.74797252004, 25421.364465888502, 25656.61515077238, 25672.229833105037, 43140.352894707234, 43199.784001079795, 43206.135877282904, 43232.78383608062, 43355.0, 250196.0, 251470.0, 252598.0, 252719.0, 253038.0, 37512.624873750916, 39007.41488877726, 39771.80114099411, 39778.0, 39792.0, 52440.0, 52837.735811322236, 53115.4688453126, 53222.4677753233, 54040.729796350766, 37804.24391512099, 38175.42736859005, 38443.42334865035, 38575.807120964215, 39027.609723902395, 37450.0, 37463.25073498569, 37606.435903462014, 37615.81192094022, 37661.623383765815, 43439.56560434355, 43837.56162438335, 44353.77823110864, 44675.55324446714, 44793.77603112094, 35880.282394352485, 35969.0, 36046.63953360433, 36423.0, 36652.26695466023, 28003.51943689, 28273.57589636116, 28283.0, 28371.716282836907, 28493.715062849937], "value": 19086.75018980252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.7018020809386, 592.8310431527016, 593.9376365481625, 598.5899658733767, 602.6414283501316, 22829.42926426838, 23420.76579234207, 23446.882765586168, 23466.29601111965, 23473.0, 24001.0, 25217.117400890973, 25449.87275063622, 25658.74341256587, 25700.100496482628, 6594.571352862061, 6705.463562914955, 6716.429103526181, 6716.563423377489, 6724.361185687377, 6376.521760867953, 6621.073049773036, 6628.304028077055, 6651.800445986604, 6728.226253980782, 6546.279909209983, 6566.737330506774, 6577.901331480031, 6579.638119903403, 6612.239592446882, 6360.9045864312075, 6579.80260592183, 6604.900926486107, 6616.768413105518, 6646.501512386591, 6147.354527774564, 6206.813795586095, 6210.689465526705, 6234.064890266496, 6236.844078898019, 29322.266943326587, 30023.0, 30245.546316805267, 30246.54630180549, 30321.0, 2267.7278726552754, 2276.8975396107217, 2279.361778701966, 2283.2237039406514, 2292.6790249365104, 19091.61816763671, 19682.704759428478, 20140.597188056305, 20337.8983105085, 20368.490787730276, 2471.8269721119527, 2475.725001624165, 2542.0467324753217, 2545.7581529754643, 2556.9105081322064, 138711.0, 146625.0, 155039.0, 161290.0, 161567.0, 15160.924195378953, 15193.696126077417, 15587.454439094805, 15897.28462219203, 16214.270357833926, 25085.37286567814, 25304.493910122063, 25318.36704082376, 25354.239372818844, 25459.490810184063, 10609.9469502652, 10659.4137322448, 10810.459477026117, 10827.484152218696, 10862.837057444145, 9814.803703926023, 9857.162141218078, 9870.358426702242, 10023.198144148451, 10051.547680354402, 9387.57755900986, 9417.576209070608, 9617.807643847083, 9627.229821614254, 9743.756406089904, 2711.701712811589, 2753.8072334936764, 2795.55271156614, 2890.8265504069823, 3009.6689364169924, 1000.0399616368222, 1009.1018993096151, 1033.0805583031108, 1038.2057725839738, 1049.4700176411015, 20726.58546829055, 20730.58538829215, 20984.370468885958, 21013.789862101185, 21063.0, 1083.6532309660834, 1086.0388556127884, 1089.84742136101, 1099.0767755085606, 1104.8508451358964, 11286.435678216056, 11427.08583313333, 11446.14153938458, 11545.422728863523, 11570.652880413601, 549410.0, 558070.0, 563633.0, 564919.0, 583273.0, 123069.0, 125111.3744431272, 127225.0, 127969.0, 128357.0, 1051.818249794378, 1140.0480598700012, 1142.6229344316355, 1201.1891972918245, 1242.490578862662, 20301.59396812085, 20595.8970205148, 20655.483612909797, 20687.586248275253, 20890.373288801362, 63080.36919630745, 63860.3613963873, 64683.0, 64880.67559662172, 65110.348896510426, 79668.20331796608, 79816.20183798087, 80015.59992200235, 80212.0, 80302.1969780318, 14582.562523124323, 14977.850221498082, 14978.625534361729, 14978.775318370452, 15003.099814010757, 23283.534329313658, 23416.414589635395, 23429.648555271342, 23468.76531234666, 23555.76444235604, 19380.127894245074, 19401.126949287034, 19410.320638777575, 19516.60966780685, 19687.40937771869, 16580.336786528405, 17001.659966800347, 17177.31290748356, 17284.04937728437, 17399.652006960045, 17770.466885993443, 18281.08594570293, 18673.813261867206, 19379.51551211231, 19688.803111968697, 14678.559643210721, 14706.044107133002, 14799.92600036993, 14805.96358254955, 14830.0, 18895.6220875579, 19096.71354929705, 19118.426447206606, 19194.616107678048, 19354.61290774205], "value": 12553.550413225026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.2611878763648, 1448.9275536223186, 1478.0614309913208, 1482.5330021043367, 1487.6801487680148, 16716.33134674613, 17254.0, 17337.73993390097, 17398.21708023139, 17406.39077632283, 16749.497515074567, 16753.497395078168, 16835.32658693651, 16842.24209910554, 16862.747058794128, 2807.0, 2855.657321121468, 2855.7858160637984, 2887.4369497947805, 2893.0597555794347, 2760.806743527954, 2793.1620513845864, 2805.7755379569585, 2806.1721792071285, 2814.760745336649, 2722.2649884531165, 2753.421781425903, 2879.280179955011, 2884.697106803787, 2887.6534815822024, 2770.2104900103577, 2817.197098826835, 2826.1380279014893, 2840.2757296889163, 2841.5737639354056, 2730.4539092181644, 2740.1779466160074, 2747.120921305183, 2751.7660998815127, 2753.366725653091, 16458.588535286595, 16909.7463538047, 17020.659586808317, 17029.489115326436, 17046.74429883553, 8674.826503469958, 8889.555522223927, 8929.910700893039, 8955.820883582292, 8970.50662213578, 5671.63134396267, 5858.531317494633, 5944.0, 6002.399760024006, 6034.215551978258, 2103.316422162803, 2139.3368055902565, 2150.354893531934, 2163.697082408464, 2195.297504798465, 30522.08433746969, 30691.999999999778, 30845.691543084507, 30848.8457557713, 30876.0, 7161.971970582971, 7212.574027336973, 7294.489385743053, 7340.889886651705, 7411.184769675439, 19717.408477745692, 19739.703904441445, 19745.605087898162, 19846.908420036747, 19880.70178947317, 8367.372447066495, 8529.360297977677, 8530.0, 8534.573271336409, 8549.230569248797, 7718.266764657348, 7757.612119394008, 7773.805654858674, 7802.804929876798, 7812.1016083150025, 5604.747786349542, 5782.537397008229, 5849.736761845727, 5965.492933100648, 6050.304215015241, 1499.917504537261, 1522.72590933633, 1644.8930819496934, 1651.587103224194, 1664.4756901575965, 957.2389949989774, 958.1759686669459, 967.0661358062707, 987.9407235565889, 994.2046362909643, 8940.792992945999, 8947.239484643747, 9011.819763604823, 9082.40964337316, 9136.314776391797, 1007.6372505897871, 1014.6600888702368, 1026.3892983674702, 1030.3766221436074, 1045.926785125034, 4521.819127234874, 4573.199690054294, 4702.623790096784, 5105.642605017613, 5903.291605007426, 24428.145014924394, 24819.751802481744, 25314.0, 25548.23355299344, 25557.977680892556, 24910.0, 25216.873915630305, 25229.495410091695, 25422.110226141995, 25620.8718956404, 12508.562200323127, 12681.30252836103, 12750.234985900875, 12792.0, 12798.16811907223, 8833.381663283766, 8897.688580899638, 8945.821083578161, 8965.058668839678, 9031.729048128567, 20896.268630597857, 21274.0, 21413.036413361126, 21810.454738631663, 21825.56348872982, 21785.455363616038, 22357.77642223557, 22836.31491055271, 22898.313050608507, 22964.770352296262, 12327.815082773945, 12364.19632723906, 12373.072019598387, 12465.189762665397, 12526.0, 15598.9220053899, 15650.530484085495, 15675.92162039228, 15701.685966280838, 15725.21373931276, 12650.557230496888, 12771.425285862344, 12793.936030319788, 12796.808047879103, 12990.415431305424, 12244.0, 12523.185992910796, 12622.0, 12720.173188742701, 12794.104412691395, 10828.350298982086, 10872.67381978542, 10899.073578745896, 10928.672139835817, 10934.398608076313, 7872.094709108525, 7941.801454963441, 8087.433879628369, 8108.554029528196, 8146.592670366576, 7703.576303303372, 7806.219378062376, 7815.179406162271, 7921.366290696846, 7921.564313962787], "value": 7314.9640092745285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.7971570803097, 534.9197620356947, 556.8357334586296, 563.4027930393783, 573.9512141467975, 6174.228221472316, 6201.348858369874, 6224.28420731616, 6274.717637706302, 6274.968625156874, 6197.163382943301, 6238.251409830816, 6260.280067792205, 6283.528735344845, 6290.087937249107, 4864.246041863516, 5002.324686167357, 5194.272801807731, 5195.116830138866, 5203.739813009353, 4984.825531106412, 5048.091343558158, 5048.899022019576, 5066.84799456015, 5078.542931136197, 4914.410270767513, 4979.0, 5004.099262132815, 5005.54950054495, 5016.974915125437, 4939.431965323998, 4940.950590494085, 4961.776720047606, 4978.128827455199, 5006.674566153189, 4484.654603618934, 4529.343245229456, 4564.5435456454425, 4577.130345234395, 4597.7241365518175, 6080.14877917092, 6114.571979961404, 6125.754969801203, 6137.41694539018, 6165.445109940127, 5824.650520968756, 5837.416258374171, 5901.3803550627, 5910.822675319747, 5912.526997840162, 6586.341365863424, 6590.0, 6615.569987950816, 6638.236602790693, 6642.601443913332, 5026.497350264981, 5065.265536497224, 5080.13637681595, 5097.7960881564695, 5128.538431541142, 6938.791836244921, 6998.335158159966, 7024.859502809966, 7027.8594428111155, 7075.610841403773, 5225.686458812484, 5250.028744682246, 5250.947490525123, 5253.6603166193145, 5267.420583735786, 5285.312909321764, 5292.708901010481, 5309.761060752276, 5327.520523152857, 5369.7583608737705, 5793.797217097382, 5804.564657650693, 5833.533317334603, 5836.431969933215, 5858.297004359504, 6366.904496432558, 6497.15536980199, 6631.204255489372, 6635.270120286765, 6766.28953959837, 1791.2834866053684, 1795.3895675470403, 1815.2013114229696, 1823.972640410395, 1824.4344253281524, 1118.798616249083, 1264.6395777203452, 1272.1603741530546, 1284.6659868434274, 1291.8966482681362, 6151.231096112986, 6161.25824008321, 6255.218097737783, 6339.175907132136, 6354.332795056453, 6878.65606719662, 6904.620245886525, 6908.309169083152, 6943.472436064058, 6956.0, 6291.716872740738, 6297.622142671363, 6314.494840412756, 6353.142325786052, 6383.265924418658, 3641.9817900910325, 3647.252313275772, 3659.8902032939054, 3666.944995825065, 3671.9449208261362, 7030.894536581955, 7140.428765698835, 7144.0, 7157.4274058075225, 7183.317584829433, 6891.862162756817, 6951.08054617062, 6971.233164351917, 6995.860082798417, 7024.71696698575, 6838.316168383122, 6919.965400172967, 6995.8600827983155, 7002.159740831133, 7101.254368291255, 6753.2909044549615, 6770.796876093528, 6771.255161932282, 6808.38724514796, 6817.727290908507, 6711.530192886451, 6712.630805305755, 6733.831654208488, 6778.3221677831825, 6886.586804791728, 6829.556078854858, 6836.453083753388, 6892.070220338313, 6915.170179578483, 7100.573965561876, 5582.0, 5596.356419011703, 5600.915986260128, 5621.831345059655, 5646.9152962704775, 6759.425448836904, 6760.0, 6818.249992500921, 6820.35206655367, 6822.761203357859, 6599.340065993554, 6601.768938087144, 6647.700853461509, 6652.800415987528, 6653.434458071119, 6535.673216339259, 6568.507361947777, 6568.6058836469965, 6654.600723956578, 6657.367550082734, 6387.425131738166, 6410.519211059096, 6419.871602568016, 6437.935620643921, 6521.804345869631, 6251.249850018027, 6555.836104097436, 6584.176977877765, 6641.435477984232, 6644.302348253364, 6413.551051426355, 6418.133551970424, 6478.805635830932, 6508.023796430384, 6570.211574611078], "value": 5209.719027344825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.4309414351386, 975.1711045611229, 984.9753756156096, 985.1133979418527, 1023.0715102032668, 18622.348217812378, 19210.615787684237, 19226.903865480686, 19251.0, 19278.228870845185, 18116.36592719255, 18521.629567408643, 18624.81375186248, 18640.813591864076, 18763.718544221814, 1065.2649671726504, 1071.9464026798628, 1072.0673014477416, 1072.394097335007, 1073.1522097542932, 1047.2669131607868, 1074.4520294649706, 1078.946052697362, 1102.9779404411906, 1103.189155970361, 1162.4013632979022, 1162.4710756605723, 1162.581470670558, 1163.2090178678495, 1164.0222213340792, 1100.6918062942389, 1151.395517353392, 1157.9478923448464, 1158.7856246594365, 1158.9188756787028, 812.5937031484258, 817.9468334558235, 819.1317203764029, 819.7171975668444, 821.0311832038193, 20784.688229676565, 20812.47968800792, 20900.0, 20959.790402095936, 20971.161153553992, 23388.53222935549, 23889.641655375184, 23925.282241532783, 23982.0, 24014.519709605884, 17971.550711232194, 18502.53743656406, 18603.81396186034, 18621.813781862278, 18669.0, 3982.362821948503, 3989.142334398089, 3989.4215338776007, 3993.480847489837, 4014.5383280922483, 159826.4017359823, 164604.0, 164876.0, 168956.0, 169528.0, 17868.28526858937, 18210.36263730763, 18514.537136571424, 18572.0, 18630.347937822382, 34420.13949651279, 35491.4676279856, 35512.822435887654, 35532.28935421277, 35669.46495802565, 9470.431774093577, 9491.525423728786, 9529.571169297398, 9566.378185417925, 9573.138417542455, 4603.861884143481, 4615.769211539409, 4671.556202160789, 4686.133065382915, 4729.55069268419, 6015.789447369321, 6109.7861574844665, 6118.60229085108, 6144.324124346318, 6166.414190651881, 1068.3750006246278, 1101.9283746556448, 1109.2235435195396, 1112.777444511101, 1120.137494129532, 705.842418433769, 707.4552594502204, 707.6214225389392, 708.8121647763347, 717.2504732554493, 12080.0, 12358.62924112278, 12602.243865368107, 13151.736965260641, 13385.799213011813, 732.1726449112468, 736.8342123022385, 743.1119811824817, 744.6314074533141, 758.3061498728712, 6295.748170073146, 6307.684615769193, 6317.084022816666, 6346.2067241594805, 6372.84067898297, 154105.22947385415, 154415.0, 155825.0, 157772.0, 159077.0, 134877.0, 135797.3210133943, 137569.0, 138036.30981845027, 142744.0, 115604.0, 116984.41507792406, 117242.41378793222, 117592.41203793927, 118826.40586797183, 11333.206675532963, 11416.543338266376, 11618.94190529042, 11627.0, 11635.127365447455, 56053.719731401085, 56436.435635643116, 56761.0, 57984.4201557979, 58731.412685872594, 71154.0, 73009.0, 74304.25695742974, 75194.62402687952, 75693.6215318942, 16184.67630647404, 16708.916455417646, 16745.0, 16787.412440564523, 16904.0, 19135.8086419134, 19192.13635386383, 19397.127129278935, 19418.61162776765, 19427.028648567233, 18365.3572124975, 18622.906885465487, 18658.90670546693, 18761.249550018394, 18831.811681883006, 16921.492355229362, 16947.0, 17069.91465042667, 17157.399491017753, 17202.0, 17761.289548418434, 17797.911010444866, 17826.732599011284, 17881.0, 18025.369112081014, 11509.136814739095, 11782.823257651313, 11897.167198296036, 11913.166078374777, 12310.81533777012, 12200.267983920992, 12379.257244565355, 12444.813327800272, 12572.434240459019, 12618.810717839424], "value": 9915.6957826148, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 105.0, 105.0, 106.0, 105.0, 107.0, 105.0, 104.0, 106.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 120.0, 112.0, 111.0, 112.0, 123.0, 112.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 162.0, 161.0, 159.0, 161.0, 165.0, 166.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 75.0, 73.0, 75.0, 73.0, 73.0, 75.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 77.0, 77.0, 79.0, 78.0, 77.0, 86.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 114.0, 113.0, 113.0, 115.0, 115.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 149.0, 149.0, 152.0, 152.0, 152.0, 151.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 93.0, 95.0, 95.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 42.0, 49.0, 43.0, 46.0, 44.0, 43.0, 46.0, 43.0, 46.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 70.0, 72.0, 74.0, 71.0, 72.0, 71.0, 82.0, 70.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 105.0, 111.0, 108.0, 108.0, 112.0, 102.0, 105.0, 107.0], "value": 107.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 155.0, 157.0, 156.0, 160.0, 160.0, 157.0, 155.0, 157.0, 160.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 60.0, 60.0, 61.0, 66.0, 62.0, 58.0, 61.0, 60.0], "value": 61.2, "unit": "score"}]}]} 04:07:05 INFO - Return code: 0 04:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:07:05 INFO - # TBPL SUCCESS # 04:07:05 INFO - Running post-action listener: _package_coverage_data 04:07:05 INFO - Running post-action listener: _resource_record_post_action 04:07:05 INFO - [mozharness: 2017-09-16 11:07:05.158996Z] Finished run-tests step (success) 04:07:05 INFO - Running post-run listener: _resource_record_post_run 04:07:05 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 434176; Write bytes: 315342848; Read time: 344; Write time: 186708 04:07:05 INFO - TinderboxPrint: CPU usage
13.1% 04:07:05 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 344 04:07:05 INFO - TinderboxPrint: I/O write bytes / time
315,342,848 / 186,708 04:07:05 INFO - TinderboxPrint: CPU idle
8,205.5 (86.9%) 04:07:05 INFO - TinderboxPrint: CPU user
1,186.7 (12.6%) 04:07:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:07:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 450560; Read time: 0; Write time: 40 04:07:05 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:05 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 434176; Write bytes: 314892288; Read time: 344; Write time: 186668 04:07:05 INFO - Running post-run listener: _upload_blobber_files 04:07:05 INFO - Blob upload gear active. 04:07:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:07:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:07 INFO - (blobuploader) - INFO - Done attempting. 04:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:08 INFO - (blobuploader) - INFO - Done attempting. 04:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:09 INFO - (blobuploader) - INFO - Done attempting. 04:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:16 INFO - (blobuploader) - INFO - Done attempting. 04:07:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:16 INFO - Return code: 0 04:07:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50092149201b506b00c50f98ab6c9a263d9b9d5e17d26366231949a381db3e28df863ed5deffcb24a5b39d7f2093f4c90afe782fc2e2a37e2a2a07a5bbb0683d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb72b02066f0be7ebb66316c091ef869c865b240e33369e6492c92356dc8449bf734f2321cc2b2a0d934e70a25e9c54bdc6f362b335fca1e89fe7ad9d3be1ca4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77fa9de89fbef1e3a36a7838b0daf997a16e87eb6347ea57808ff6e484970ecfbf29e84297827b9b6718829636c814eef2583a420b4c26812eda504613959782", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b0f4d62b680350595c5a1dbc089477adc0ed6f5f01103f454a5c385143938c31ca31a71bd72acfca975552ecea16e987e50567d0c56d966103165a7adec611e"} 04:07:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:16 INFO - Contents: 04:07:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50092149201b506b00c50f98ab6c9a263d9b9d5e17d26366231949a381db3e28df863ed5deffcb24a5b39d7f2093f4c90afe782fc2e2a37e2a2a07a5bbb0683d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb72b02066f0be7ebb66316c091ef869c865b240e33369e6492c92356dc8449bf734f2321cc2b2a0d934e70a25e9c54bdc6f362b335fca1e89fe7ad9d3be1ca4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77fa9de89fbef1e3a36a7838b0daf997a16e87eb6347ea57808ff6e484970ecfbf29e84297827b9b6718829636c814eef2583a420b4c26812eda504613959782", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b0f4d62b680350595c5a1dbc089477adc0ed6f5f01103f454a5c385143938c31ca31a71bd72acfca975552ecea16e987e50567d0c56d966103165a7adec611e"} 04:07:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:16 INFO - Copying logs to upload dir... 04:07:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.445885 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-16 04:07:16.068974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:16.072056) ========= 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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 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/50092149201b506b00c50f98ab6c9a263d9b9d5e17d26366231949a381db3e28df863ed5deffcb24a5b39d7f2093f4c90afe782fc2e2a37e2a2a07a5bbb0683d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb72b02066f0be7ebb66316c091ef869c865b240e33369e6492c92356dc8449bf734f2321cc2b2a0d934e70a25e9c54bdc6f362b335fca1e89fe7ad9d3be1ca4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77fa9de89fbef1e3a36a7838b0daf997a16e87eb6347ea57808ff6e484970ecfbf29e84297827b9b6718829636c814eef2583a420b4c26812eda504613959782", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b0f4d62b680350595c5a1dbc089477adc0ed6f5f01103f454a5c385143938c31ca31a71bd72acfca975552ecea16e987e50567d0c56d966103165a7adec611e"} build_url:https://queue.taskcluster.net/v1/task/HjeSV61eTn20kZ6cmIUULA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 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/50092149201b506b00c50f98ab6c9a263d9b9d5e17d26366231949a381db3e28df863ed5deffcb24a5b39d7f2093f4c90afe782fc2e2a37e2a2a07a5bbb0683d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb72b02066f0be7ebb66316c091ef869c865b240e33369e6492c92356dc8449bf734f2321cc2b2a0d934e70a25e9c54bdc6f362b335fca1e89fe7ad9d3be1ca4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77fa9de89fbef1e3a36a7838b0daf997a16e87eb6347ea57808ff6e484970ecfbf29e84297827b9b6718829636c814eef2583a420b4c26812eda504613959782", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b0f4d62b680350595c5a1dbc089477adc0ed6f5f01103f454a5c385143938c31ca31a71bd72acfca975552ecea16e987e50567d0c56d966103165a7adec611e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:16.100511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:16.100866) ========= 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=00204705a9daa57ed339a427000001b9-1505558508.629424-385956466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 04:07:16.184783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 04:07:16.185137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 04:07:16.185530) ========= ========= Total master_lag: 0.22 =========