builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1505557350.67 results: success (0) revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:30.672087) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:30.672454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:30.672735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:30.803285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:30.803544) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:22:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.8M=0s 2017-09-16 03:22:31 (29.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.210329 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.061509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.061822) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020952 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.112298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.112590) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:22:31,172 truncating revision to first 12 chars 2017-09-16 03:22:31,172 Setting DEBUG logging. 2017-09-16 03:22:31,172 attempt 1/10 2017-09-16 03:22:31,172 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:22:31,530 unpacking tar archive at: mozilla-central-6c1b45e7e94d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.837668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.837954) ========= script_repo_revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.838309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.838574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:31.857196) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-16 03:22:31.857518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:32 INFO - MultiFileLogger online at 20170916 03:22:32 in /builds/slave/test 03:22:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:22:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:32 INFO - {'append_to_log': False, 03:22:32 INFO - 'base_work_dir': '/builds/slave/test', 03:22:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:22:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:32 INFO - 'branch': 'Firefox-Non-PGO', 03:22:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:32 INFO - 'code_coverage': False, 03:22:32 INFO - 'config_files': ('talos/linux_config.py',), 03:22:32 INFO - 'default_actions': ('clobber', 03:22:32 INFO - 'read-buildbot-config', 03:22:32 INFO - 'download-and-extract', 03:22:32 INFO - 'populate-webroot', 03:22:32 INFO - 'create-virtualenv', 03:22:32 INFO - 'install', 03:22:32 INFO - 'setup-mitmproxy', 03:22:32 INFO - 'run-tests'), 03:22:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:32 INFO - 'disable_ccov_upload': False, 03:22:32 INFO - 'disable_stylo': False, 03:22:32 INFO - 'download_minidump_stackwalk': True, 03:22:32 INFO - 'download_symbols': 'ondemand', 03:22:32 INFO - 'enable_stylo': False, 03:22:32 INFO - 'enable_webrender': False, 03:22:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:22:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:32 INFO - 'gecko_profile': False, 03:22:32 INFO - 'gecko_profile_interval': 0, 03:22:32 INFO - 'installer_path': 'installer.exe', 03:22:32 INFO - 'log_level': 'info', 03:22:32 INFO - 'log_name': 'talos', 03:22:32 INFO - 'log_to_console': True, 03:22:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:32 INFO - 'opt_config_files': (), 03:22:32 INFO - 'pip_index': False, 03:22:32 INFO - 'suite': 'dromaeojs-e10s', 03:22:32 INFO - 'system_bits': '32', 03:22:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:32 INFO - 'title': 'talos-linux64-ix-009', 03:22:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:32 INFO - 'use_talos_json': True, 03:22:32 INFO - 'verify': 'False', 03:22:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:32 INFO - 'work_dir': 'build'} 03:22:32 INFO - [mozharness: 2017-09-16 10:22:32.131127Z] Running clobber step. 03:22:32 INFO - Running pre-action listener: _resource_record_pre_action 03:22:32 INFO - Running main action method: clobber 03:22:32 INFO - rmtree: /builds/slave/test/build 03:22:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:33 INFO - Running post-action listener: _resource_record_post_action 03:22:33 INFO - [mozharness: 2017-09-16 10:22:33.076286Z] Finished clobber step (success) 03:22:33 INFO - [mozharness: 2017-09-16 10:22:33.076384Z] Running read-buildbot-config step. 03:22:33 INFO - Running pre-action listener: _resource_record_pre_action 03:22:33 INFO - Running main action method: read_buildbot_config 03:22:33 INFO - Using buildbot properties: 03:22:33 INFO - { 03:22:33 INFO - "project": "", 03:22:33 INFO - "product": "firefox", 03:22:33 INFO - "who": "archaeopteryx@coole-files.de", 03:22:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:22:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:22:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:22:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:22:33 INFO - "stage_platform": "linux64", 03:22:33 INFO - "basedir": "/builds/slave/test", 03:22:33 INFO - "buildnumber": 1153, 03:22:33 INFO - "platform": "ubuntu64_hw", 03:22:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:22:33 INFO - "slavebuilddir": "test", 03:22:33 INFO - "taskId": "ehLO_FApQfGZRB1im_OuXg", 03:22:33 INFO - "branch": "mozilla-central", 03:22:33 INFO - "script_repo_revision": "production", 03:22:33 INFO - "revision": "6c1b45e7e94dbf343813eda03f1fd0b3259b59b1", 03:22:33 INFO - "slavename": "talos-linux64-ix-009", 03:22:33 INFO - "repo_path": "mozilla-central" 03:22:33 INFO - } 03:22:33 INFO - Finding installer, test and symbols from parent task. 03:22:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehLO_FApQfGZRB1im_OuXg'}, attempt #1 03:22:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehLO_FApQfGZRB1im_OuXg'}, attempt #1 03:22:33 INFO - Task dependencies: HjCsUs2wRpaX7mNuomNYtQ 03:22:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ'}, attempt #1 03:22:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip 03:22:34 INFO - Running post-action listener: _resource_record_post_action 03:22:34 INFO - [mozharness: 2017-09-16 10:22:34.443772Z] Finished read-buildbot-config step (success) 03:22:34 INFO - [mozharness: 2017-09-16 10:22:34.443990Z] Running download-and-extract step. 03:22:34 INFO - Running pre-action listener: _resource_record_pre_action 03:22:34 INFO - Running main action method: download_and_extract 03:22:34 INFO - mkdir: /builds/slave/test/build/tests 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:34 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:22:34 INFO - Downloaded 989 bytes. 03:22:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:22:34 INFO - Using the following test package requirements: 03:22:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:22:35 INFO - u'common': [u'target.common.tests.zip'], 03:22:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:22:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:22:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:22:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:22:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:22:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:22:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:22:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:22:35 INFO - u'target.web-platform.tests.tar.gz'], 03:22:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:22:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:22:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip 03:22:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip into memory 03:22:36 INFO - Content-Length response header: 54731145 03:22:36 INFO - Bytes received: 54731145 03:22:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip 03:22:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:22:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip into memory 03:22:49 INFO - Content-Length response header: 14508749 03:22:49 INFO - Bytes received: 14508749 03:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:49 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:22:51 INFO - Downloaded 61438347 bytes. 03:22:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:51 INFO - mkdir: /builds/slave/test/properties 03:22:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:51 INFO - Contents: 03:22:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:51 INFO - Running post-action listener: _resource_record_post_action 03:22:51 INFO - Running post-action listener: find_tests_for_verification 03:22:51 INFO - Running post-action listener: set_extra_try_arguments 03:22:51 INFO - [mozharness: 2017-09-16 10:22:51.592650Z] Finished download-and-extract step (success) 03:22:51 INFO - [mozharness: 2017-09-16 10:22:51.592748Z] Running populate-webroot step. 03:22:51 INFO - Running pre-action listener: _resource_record_pre_action 03:22:51 INFO - Running main action method: populate_webroot 03:22:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['tresize', 03:22:51 INFO - 'tcanvasmark']}, 03:22:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['dromaeo_css', 03:22:51 INFO - 'kraken']}, 03:22:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'tests': ['damp', 'tps']}, 03:22:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['damp', 'tps']}, 03:22:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['dromaeo_dom']}, 03:22:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:22:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['basic_compositor_video', 03:22:51 INFO - 'glvideo']}, 03:22:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:22:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['ts_paint_webext', 03:22:51 INFO - 'tp5o_webext']}, 03:22:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:51 INFO - 'ts_paint', 03:22:51 INFO - 'tpaint', 03:22:51 INFO - 'sessionrestore', 03:22:51 INFO - 'sessionrestore_many_windows', 03:22:51 INFO - 'sessionrestore_no_auto_restore', 03:22:51 INFO - 'tabpaint']}, 03:22:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['a11yr', 03:22:51 INFO - 'ts_paint', 03:22:51 INFO - 'tpaint', 03:22:51 INFO - 'sessionrestore', 03:22:51 INFO - 'sessionrestore_many_windows', 03:22:51 INFO - 'sessionrestore_no_auto_restore', 03:22:51 INFO - 'tabpaint']}, 03:22:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:22:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:22:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['perf_reftest_singletons']}, 03:22:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['bloom_basic']}, 03:22:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:51 INFO - 'tsvgr_opacity', 03:22:51 INFO - 'tart', 03:22:51 INFO - 'tscrollx', 03:22:51 INFO - 'tsvg_static']}, 03:22:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['tsvgx', 03:22:51 INFO - 'tsvgr_opacity', 03:22:51 INFO - 'tart', 03:22:51 INFO - 'tscrollx', 03:22:51 INFO - 'tsvg_static']}, 03:22:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:22:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo'], 03:22:51 INFO - 'tests': ['tp5o']}, 03:22:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:51 INFO - 'talos_options': ['--mitmproxy', 03:22:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:51 INFO - '--firstNonBlankPaint'], 03:22:51 INFO - 'tests': ['tp6_google', 03:22:51 INFO - 'tp6_youtube', 03:22:51 INFO - 'tp6_amazon', 03:22:51 INFO - 'tp6_facebook']}, 03:22:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo', 03:22:51 INFO - '--mitmproxy', 03:22:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:51 INFO - '--firstNonBlankPaint'], 03:22:51 INFO - 'tests': ['tp6_google', 03:22:51 INFO - 'tp6_youtube', 03:22:51 INFO - 'tp6_amazon', 03:22:51 INFO - 'tp6_facebook']}, 03:22:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:51 INFO - 'talos_options': ['--stylo-threads=1', 03:22:51 INFO - '--mitmproxy', 03:22:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:51 INFO - '--firstNonBlankPaint'], 03:22:51 INFO - 'tests': ['tp6_google', 03:22:51 INFO - 'tp6_youtube', 03:22:51 INFO - 'tp6_amazon', 03:22:51 INFO - 'tp6_facebook']}, 03:22:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--xperf_path', 03:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:51 INFO - 'tests': ['tp5n']}, 03:22:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:51 INFO - 'talos_options': ['--disable-stylo', 03:22:51 INFO - '--xperf_path', 03:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:51 INFO - 'tests': ['tp5n']}}} 03:22:51 INFO - Running post-action listener: _resource_record_post_action 03:22:51 INFO - [mozharness: 2017-09-16 10:22:51.607873Z] Finished populate-webroot step (success) 03:22:51 INFO - [mozharness: 2017-09-16 10:22:51.607963Z] Running create-virtualenv step. 03:22:51 INFO - Running pre-action listener: _resource_record_pre_action 03:22:51 INFO - Running main action method: create_virtualenv 03:22:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:22:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:22:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:22:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:54 INFO - Installing pip...............done. 03:22:54 INFO - Return code: 0 03:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:22:54 INFO - Reading from file tmpfile_stdout 03:22:54 INFO - Output received: 03:22:54 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:22:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', '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:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:22:54 INFO - Using env: {'DISPLAY': ':0', 03:22:54 INFO - 'HOME': '/home/cltbld', 03:22:54 INFO - 'LANG': 'en_US.UTF-8', 03:22:54 INFO - 'LANGUAGE': 'en_US:en', 03:22:54 INFO - 'LOGNAME': 'cltbld', 03:22:54 INFO - 'MAIL': '/var/mail/cltbld', 03:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:54 INFO - 'MOZ_NO_REMOTE': '1', 03:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:54 INFO - 'NO_EM_RESTART': '1', 03:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:54 INFO - 'PWD': '/builds/slave/test', 03:22:54 INFO - 'SHELL': '/bin/bash', 03:22:54 INFO - 'SHLVL': '1', 03:22:54 INFO - 'TERM': 'linux', 03:22:54 INFO - 'TMOUT': '86400', 03:22:54 INFO - 'USER': 'cltbld', 03:22:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:54 INFO - '_': '/tools/buildbot/bin/python'} 03:22:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:22:55 INFO - Downloading/unpacking pip>=1.5 03:22:55 INFO - Running setup.py egg_info for package pip 03:22:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:55 INFO - Installing collected packages: pip 03:22:55 INFO - Found existing installation: pip 1.1 03:22:55 INFO - Uninstalling pip: 03:22:55 INFO - Successfully uninstalled pip 03:22:55 INFO - Running setup.py install for pip 03:22:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:22:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:22:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:22:55 INFO - Successfully installed pip 03:22:55 INFO - Cleaning up... 03:22:55 INFO - Return code: 0 03:22:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', '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:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:22:55 INFO - Using env: {'DISPLAY': ':0', 03:22:55 INFO - 'HOME': '/home/cltbld', 03:22:55 INFO - 'LANG': 'en_US.UTF-8', 03:22:55 INFO - 'LANGUAGE': 'en_US:en', 03:22:55 INFO - 'LOGNAME': 'cltbld', 03:22:55 INFO - 'MAIL': '/var/mail/cltbld', 03:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:55 INFO - 'MOZ_NO_REMOTE': '1', 03:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:55 INFO - 'NO_EM_RESTART': '1', 03:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:55 INFO - 'PWD': '/builds/slave/test', 03:22:55 INFO - 'SHELL': '/bin/bash', 03:22:55 INFO - 'SHLVL': '1', 03:22:55 INFO - 'TERM': 'linux', 03:22:55 INFO - 'TMOUT': '86400', 03:22:55 INFO - 'USER': 'cltbld', 03:22:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:55 INFO - '_': '/tools/buildbot/bin/python'} 03:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:55 INFO - Downloading/unpacking psutil>=3.1.1 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:57 INFO - Installing collected packages: psutil 03:22:57 INFO - Running setup.py install for psutil 03:22:57 INFO - building 'psutil._psutil_linux' extension 03:22:57 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:22:58 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:22:58 INFO - building 'psutil._psutil_posix' extension 03:22:58 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:22:58 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:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:58 INFO - Successfully installed psutil 03:22:58 INFO - Cleaning up... 03:22:58 INFO - Return code: 0 03:22:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22: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:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22: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:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:58 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', '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:22:58 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:22:58 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:22:58 INFO - Using env: {'DISPLAY': ':0', 03:22:58 INFO - 'HOME': '/home/cltbld', 03:22:58 INFO - 'LANG': 'en_US.UTF-8', 03:22:58 INFO - 'LANGUAGE': 'en_US:en', 03:22:58 INFO - 'LOGNAME': 'cltbld', 03:22:58 INFO - 'MAIL': '/var/mail/cltbld', 03:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:58 INFO - 'MOZ_NO_REMOTE': '1', 03:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:58 INFO - 'NO_EM_RESTART': '1', 03:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:58 INFO - 'PWD': '/builds/slave/test', 03:22:58 INFO - 'SHELL': '/bin/bash', 03:22:58 INFO - 'SHLVL': '1', 03:22:58 INFO - 'TERM': 'linux', 03:22:58 INFO - 'TMOUT': '86400', 03:22:58 INFO - 'USER': 'cltbld', 03:22:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:58 INFO - '_': '/tools/buildbot/bin/python'} 03:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:59 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:22:59 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:22:59 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:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:00 INFO - Installing collected packages: mozsystemmonitor 03:23:00 INFO - Running setup.py install for mozsystemmonitor 03:23:00 INFO - Successfully installed mozsystemmonitor 03:23:00 INFO - Cleaning up... 03:23:00 INFO - Return code: 0 03:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:00 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:23:00 INFO - Using env: {'DISPLAY': ':0', 03:23:00 INFO - 'HOME': '/home/cltbld', 03:23:00 INFO - 'LANG': 'en_US.UTF-8', 03:23:00 INFO - 'LANGUAGE': 'en_US:en', 03:23:00 INFO - 'LOGNAME': 'cltbld', 03:23:00 INFO - 'MAIL': '/var/mail/cltbld', 03:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:00 INFO - 'MOZ_NO_REMOTE': '1', 03:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:00 INFO - 'NO_EM_RESTART': '1', 03:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:00 INFO - 'PWD': '/builds/slave/test', 03:23:00 INFO - 'SHELL': '/bin/bash', 03:23:00 INFO - 'SHLVL': '1', 03:23:00 INFO - 'TERM': 'linux', 03:23:00 INFO - 'TMOUT': '86400', 03:23:00 INFO - 'USER': 'cltbld', 03:23:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:00 INFO - '_': '/tools/buildbot/bin/python'} 03:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:02 INFO - warning: no files found matching '*.txt' 03:23:02 INFO - no previously-included directories found matching 'build' 03:23:02 INFO - no previously-included directories found matching 'dist' 03:23:02 INFO - no previously-included directories found matching '.git*' 03:23:02 INFO - Installing collected packages: jsonschema, functools32 03:23:02 INFO - Running setup.py install for functools32 03:23:02 INFO - warning: no files found matching '*.txt' 03:23:02 INFO - no previously-included directories found matching 'build' 03:23:02 INFO - no previously-included directories found matching 'dist' 03:23:02 INFO - no previously-included directories found matching '.git*' 03:23:02 INFO - Successfully installed jsonschema functools32 03:23:02 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23: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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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', '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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:23: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 functools32==3.2.3-2 03:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:02 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23: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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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', '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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23: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 blobuploader==1.2.4 03:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:04 INFO - Downloading docopt-0.6.1.tar.gz 03:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:04 INFO - Running setup.py install for blobuploader 03:23:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:04 INFO - Running setup.py install for requests 03:23:05 INFO - Running setup.py install for docopt 03:23:05 INFO - Successfully installed blobuploader requests docopt 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:05 INFO - Running setup.py (path:/tmp/pip-6Qz0i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:05 INFO - Running setup.py (path:/tmp/pip-RqAXSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:05 INFO - Running setup.py (path:/tmp/pip-XAtsXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:05 INFO - Running setup.py (path:/tmp/pip-ei8k4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:05 INFO - Running setup.py (path:/tmp/pip-5X1lrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:05 INFO - Running setup.py (path:/tmp/pip-SiImsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:05 INFO - Running setup.py (path:/tmp/pip-1HjR1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:05 INFO - Running setup.py (path:/tmp/pip-4G2qs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:05 INFO - Running setup.py (path:/tmp/pip-w56zQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:06 INFO - Running setup.py (path:/tmp/pip-5gc_ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:06 INFO - Running setup.py (path:/tmp/pip-rzgqtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:06 INFO - Running setup.py (path:/tmp/pip-sJriPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:06 INFO - Running setup.py (path:/tmp/pip-eACp18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:06 INFO - Running setup.py (path:/tmp/pip-UHu5fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:06 INFO - Running setup.py (path:/tmp/pip-S8Zxfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:06 INFO - Running setup.py (path:/tmp/pip-mtmHvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:06 INFO - Running setup.py (path:/tmp/pip-n6chIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:06 INFO - Running setup.py install for manifestparser 03:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Running setup.py install for mozcrash 03:23:06 INFO - Running setup.py install for mozdebug 03:23:06 INFO - Running setup.py install for mozdevice 03:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:06 INFO - Running setup.py install for mozfile 03:23:07 INFO - Running setup.py install for mozhttpd 03:23:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for mozinfo 03:23:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for mozInstall 03:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for mozleak 03:23:07 INFO - Running setup.py install for mozlog 03:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for moznetwork 03:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for mozprocess 03:23:07 INFO - Running setup.py install for mozprofile 03:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:07 INFO - Running setup.py install for mozrunner 03:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:08 INFO - Running setup.py install for mozscreenshot 03:23:08 INFO - Running setup.py install for moztest 03:23:08 INFO - Running setup.py install for mozversion 03:23:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:08 INFO - Cleaning up... 03:23:08 INFO - Return code: 0 03:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:08 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:08 INFO - Using env: {'DISPLAY': ':0', 03:23:08 INFO - 'HOME': '/home/cltbld', 03:23:08 INFO - 'LANG': 'en_US.UTF-8', 03:23:08 INFO - 'LANGUAGE': 'en_US:en', 03:23:08 INFO - 'LOGNAME': 'cltbld', 03:23:08 INFO - 'MAIL': '/var/mail/cltbld', 03:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:08 INFO - 'MOZ_NO_REMOTE': '1', 03:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:08 INFO - 'NO_EM_RESTART': '1', 03:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:08 INFO - 'PWD': '/builds/slave/test', 03:23:08 INFO - 'SHELL': '/bin/bash', 03:23:08 INFO - 'SHLVL': '1', 03:23:08 INFO - 'TERM': 'linux', 03:23:08 INFO - 'TMOUT': '86400', 03:23:08 INFO - 'USER': 'cltbld', 03:23:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:08 INFO - '_': '/tools/buildbot/bin/python'} 03:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:08 INFO - Running setup.py (path:/tmp/pip-EP7NSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Running setup.py (path:/tmp/pip-CEbgy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Running setup.py (path:/tmp/pip-8fpevt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Running setup.py (path:/tmp/pip-Ba_6lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Running setup.py (path:/tmp/pip-KjUY2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Running setup.py (path:/tmp/pip-d0P19R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:08 INFO - Running setup.py (path:/tmp/pip-zqxqpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:09 INFO - Running setup.py (path:/tmp/pip-ab0TOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:09 INFO - Running setup.py (path:/tmp/pip-qnV6Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:09 INFO - Running setup.py (path:/tmp/pip-FaK4aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:09 INFO - Running setup.py (path:/tmp/pip-zZgLbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:09 INFO - Running setup.py (path:/tmp/pip-Bx6P54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:09 INFO - Running setup.py (path:/tmp/pip-M1xToA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:09 INFO - Running setup.py (path:/tmp/pip-yQRtxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:09 INFO - Running setup.py (path:/tmp/pip-BjhPLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Running setup.py (path:/tmp/pip-yPf7Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Running setup.py (path:/tmp/pip-BcMkod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23: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:23: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:23: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:23: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:23:10 INFO - Downloading blessings-1.6.tar.gz 03:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:11 INFO - Installing collected packages: blessings 03:23:11 INFO - Running setup.py install for blessings 03:23:11 INFO - Successfully installed blessings 03:23:11 INFO - Cleaning up... 03:23:11 INFO - Return code: 0 03:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:11 INFO - Reading from file tmpfile_stdout 03:23:11 INFO - Current package versions: 03:23:11 INFO - argparse == 1.2.1 03:23:11 INFO - blessings == 1.6 03:23:11 INFO - blobuploader == 1.2.4 03:23:11 INFO - docopt == 0.6.1 03:23:11 INFO - functools32 == 3.2.3-2 03:23:11 INFO - jsonschema == 2.5.1 03:23:11 INFO - manifestparser == 1.1 03:23:11 INFO - mozInstall == 1.13 03:23:11 INFO - mozcrash == 1.0 03:23:11 INFO - mozdebug == 0.1 03:23:11 INFO - mozdevice == 0.51 03:23:11 INFO - mozfile == 1.2 03:23:11 INFO - mozhttpd == 0.7 03:23:11 INFO - mozinfo == 0.10 03:23:11 INFO - mozleak == 0.1 03:23:11 INFO - mozlog == 3.5 03:23:11 INFO - moznetwork == 0.27 03:23:11 INFO - mozprocess == 0.25 03:23:11 INFO - mozprofile == 0.28 03:23:11 INFO - mozrunner == 6.13 03:23:11 INFO - mozscreenshot == 0.1 03:23:11 INFO - mozsystemmonitor == 0.3 03:23:11 INFO - moztest == 0.8 03:23:11 INFO - mozversion == 1.4 03:23:11 INFO - psutil == 3.1.1 03:23:11 INFO - requests == 1.2.3 03:23:11 INFO - wsgiref == 0.1.2 03:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:11 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:11 INFO - Using env: {'DISPLAY': ':0', 03:23:11 INFO - 'HOME': '/home/cltbld', 03:23:11 INFO - 'LANG': 'en_US.UTF-8', 03:23:11 INFO - 'LANGUAGE': 'en_US:en', 03:23:11 INFO - 'LOGNAME': 'cltbld', 03:23:11 INFO - 'MAIL': '/var/mail/cltbld', 03:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:11 INFO - 'MOZ_NO_REMOTE': '1', 03:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:11 INFO - 'NO_EM_RESTART': '1', 03:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:11 INFO - 'PWD': '/builds/slave/test', 03:23:11 INFO - 'SHELL': '/bin/bash', 03:23:11 INFO - 'SHLVL': '1', 03:23:11 INFO - 'TERM': 'linux', 03:23:11 INFO - 'TMOUT': '86400', 03:23:11 INFO - 'USER': 'cltbld', 03:23:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:11 INFO - '_': '/tools/buildbot/bin/python'} 03:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:23:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:12 INFO - Installing collected packages: simplejson 03:23:12 INFO - Running setup.py install for simplejson 03:23:12 INFO - building 'simplejson._speedups' extension 03:23:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:23:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:23:13 INFO - Successfully installed simplejson 03:23:13 INFO - Cleaning up... 03:23:13 INFO - Return code: 0 03:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:13 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 0xdaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:13 INFO - Using env: {'DISPLAY': ':0', 03:23:13 INFO - 'HOME': '/home/cltbld', 03:23:13 INFO - 'LANG': 'en_US.UTF-8', 03:23:13 INFO - 'LANGUAGE': 'en_US:en', 03:23:13 INFO - 'LOGNAME': 'cltbld', 03:23:13 INFO - 'MAIL': '/var/mail/cltbld', 03:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:13 INFO - 'MOZ_NO_REMOTE': '1', 03:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:13 INFO - 'NO_EM_RESTART': '1', 03:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:13 INFO - 'PWD': '/builds/slave/test', 03:23:13 INFO - 'SHELL': '/bin/bash', 03:23:13 INFO - 'SHLVL': '1', 03:23:13 INFO - 'TERM': 'linux', 03:23:13 INFO - 'TMOUT': '86400', 03:23:13 INFO - 'USER': 'cltbld', 03:23:13 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:13 INFO - '_': '/tools/buildbot/bin/python'} 03:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:14 INFO - Cleaning up... 03:23:14 INFO - Return code: 0 03:23:14 INFO - Running post-action listener: _resource_record_post_action 03:23:14 INFO - Running post-action listener: _start_resource_monitoring 03:23:14 INFO - Starting resource monitoring. 03:23:14 INFO - [mozharness: 2017-09-16 10:23:14.141904Z] Finished create-virtualenv step (success) 03:23:14 INFO - [mozharness: 2017-09-16 10:23:14.142895Z] Running install step. 03:23:14 INFO - Running pre-action listener: _resource_record_pre_action 03:23:14 INFO - Running main action method: install 03:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:14 INFO - Reading from file tmpfile_stdout 03:23:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:14 INFO - Reading from file tmpfile_stdout 03:23:14 INFO - Output received: 03:23:14 INFO - Usage: mozinstall [options] installer 03:23:14 INFO - Options: 03:23:14 INFO - -h, --help show this help message and exit 03:23:14 INFO - -d DEST, --destination=DEST 03:23:14 INFO - Directory to install application into. [default: 03:23:14 INFO - "/builds/slave/test"] 03:23:14 INFO - --app=APP Application being installed. [default: firefox] 03:23:14 INFO - mkdir: /builds/slave/test/build/application 03:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:23:32 INFO - Reading from file tmpfile_stdout 03:23:32 INFO - Output received: 03:23:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:32 INFO - Running post-action listener: _resource_record_post_action 03:23:32 INFO - [mozharness: 2017-09-16 10:23:32.226192Z] Finished install step (success) 03:23:32 INFO - [mozharness: 2017-09-16 10:23:32.226443Z] Running setup-mitmproxy step. 03:23:32 INFO - Running pre-action listener: _resource_record_pre_action 03:23:32 INFO - Running main action method: setup_mitmproxy 03:23:32 INFO - Skipping: mitmproxy is not required 03:23:32 INFO - Running post-action listener: _resource_record_post_action 03:23:32 INFO - [mozharness: 2017-09-16 10:23:32.227573Z] Finished setup-mitmproxy step (success) 03:23:32 INFO - [mozharness: 2017-09-16 10:23:32.227794Z] Running run-tests step. 03:23:32 INFO - Running pre-action listener: _resource_record_pre_action 03:23:32 INFO - Running pre-action listener: _set_gcov_prefix 03:23:32 INFO - Running main action method: run_tests 03:23:32 WARNING - Try message not found. 03:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:32 INFO - Python 2.7.3 03:23:32 INFO - Return code: 0 03:23:32 INFO - grabbing minidump binary from tooltool 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:32 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 0x111f090>, '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 0x111fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:32 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:23:32 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:23:32 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:23:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:32 INFO - Return code: 0 03:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:32 INFO - ENV: RUST_BACKTRACE is now full 03:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:23:32 INFO - Using env: {'DISPLAY': ':0', 03:23:32 INFO - 'HOME': '/home/cltbld', 03:23:32 INFO - 'LANG': 'en_US.UTF-8', 03:23:32 INFO - 'LANGUAGE': 'en_US:en', 03:23:32 INFO - 'LOGNAME': 'cltbld', 03:23:32 INFO - 'MAIL': '/var/mail/cltbld', 03:23:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:32 INFO - 'MOZ_NO_REMOTE': '1', 03:23:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:32 INFO - 'NO_EM_RESTART': '1', 03:23:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:32 INFO - 'PWD': '/builds/slave/test', 03:23:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:32 INFO - 'RUST_BACKTRACE': 'full', 03:23:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:32 INFO - 'SHELL': '/bin/bash', 03:23:32 INFO - 'SHLVL': '1', 03:23:32 INFO - 'TERM': 'linux', 03:23:32 INFO - 'TMOUT': '86400', 03:23:32 INFO - 'USER': 'cltbld', 03:23:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:32 INFO - '_': '/tools/buildbot/bin/python'} 03:23:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:23:32 INFO - mozversion application_buildid: 20170916093032 03:23:32 INFO - mozversion application_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:32 INFO - mozversion application_display_name: Nightly 03:23:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:32 INFO - mozversion application_name: Firefox 03:23:32 INFO - mozversion application_remotingname: firefox 03:23:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:23:32 INFO - mozversion application_vendor: Mozilla 03:23:32 INFO - mozversion application_version: 57.0a1 03:23:32 INFO - mozversion platform_buildid: 20170916093032 03:23:32 INFO - mozversion platform_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:23:32 INFO - mozversion platform_version: 57.0a1 03:23:32 INFO - using testdate: 1505557412 03:23:32 INFO - actual date: 1505557412 03:23:32 INFO - starting webserver on 'localhost:59794' 03:23:32 INFO - SUITE-START | Running 2 tests 03:23:32 INFO - TEST-START | dromaeo_css 03:23:32 INFO - Initialising browser for dromaeo_css test... 03:23:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59794/getInfo.html -profile /tmp/tmpcRDwxU/profile 03:23:32 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/firefox/firefox http://localhost:59794/getInfo.html) 03:23:41 INFO - TEST-INFO | 3551: exit 0 03:23:41 INFO - Browser initialized. 03:23:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:41 INFO - Using env: {'DISPLAY': ':0', 03:23:41 INFO - 'HOME': '/home/cltbld', 03:23:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:23:41 INFO - 'LANG': 'en_US.UTF-8', 03:23:41 INFO - 'LANGUAGE': 'en_US:en', 03:23:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:23:41 INFO - 'LOGNAME': 'cltbld', 03:23:41 INFO - 'MAIL': '/var/mail/cltbld', 03:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:23:41 INFO - 'MOZ_NO_REMOTE': '1', 03:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:41 INFO - 'NO_EM_RESTART': '1', 03:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:41 INFO - 'PWD': '/builds/slave/test', 03:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:41 INFO - 'RUST_BACKTRACE': 'full', 03:23:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:41 INFO - 'SHELL': '/bin/bash', 03:23:41 INFO - 'SHLVL': '1', 03:23:41 INFO - 'TERM': 'linux', 03:23:41 INFO - 'TMOUT': '86400', 03:23:41 INFO - 'USER': 'cltbld', 03:23:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:41 INFO - '_': '/tools/buildbot/bin/python'} 03:23:41 INFO - TEST-INFO | started process 3789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRDwxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:42 INFO - PID 3789 | 03:23:42 INFO - PID 3789 | (/builds/slave/test/build/application/firefox/firefox:3838): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:23:42 INFO - PID 3789 | 03:23:52 INFO - PID 3789 | RSS: Main: 154959872 03:23:52 INFO - PID 3789 | 03:26:50 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59794/tests/dromaeo/cssquery-ext.html) 03:26:51 INFO - PID 3789 | RSS: Main: 157675520 03:26:51 INFO - PID 3789 | 03:29:53 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-ext.html (next: http://localhost:59794/tests/dromaeo/cssquery-jquery.html) 03:29:53 INFO - PID 3789 | RSS: Main: 153067520 03:29:53 INFO - PID 3789 | 03:32:55 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59794/tests/dromaeo/cssquery-mootools.html) 03:32:56 INFO - PID 3789 | RSS: Main: 156868608 03:32:56 INFO - PID 3789 | 03:35:57 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59794/tests/dromaeo/cssquery-prototype.html) 03:35:58 INFO - PID 3789 | RSS: Main: 155430912 03:35:58 INFO - PID 3789 | 03:39:01 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59794/tests/dromaeo/cssquery-yui.html) 03:39:02 INFO - PID 3789 | RSS: Main: 156917760 03:39:02 INFO - PID 3789 | 03:42:03 INFO - PID 3789 | Cycle 1(1): loaded http://localhost:59794/tests/dromaeo/cssquery-yui.html (next: http://localhost:59794/tests/dromaeo/cssquery-dojo.html) 03:42:04 INFO - PID 3789 | RSS: Main: 158945280 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | __start_tp_report 03:42:04 INFO - PID 3789 | _x_x_mozilla_page_load 03:42:04 INFO - PID 3789 | _x_x_mozilla_page_load_details 03:42:04 INFO - PID 3789 | |i|pagename|runs| 03:42:04 INFO - PID 3789 | |0;dojo.html;3098.411301852648;3114;3125.9843700781494;3128.280495486039;3145.9370812583747;6143.784967526138;6166.907496387557;6195.132681424599;6233;6331.52513561483;6203.379662033794;6280.1207830903595;6293.150424692665;6299;6332.620042797435;5527.447255274481;5620.100783874581;5797.1594118852845;5809.705166459246;5852.239208902836;5757.280339957505;5760.884782304352;5766.279215098113;5780.913286300709;5841.7955371562;5592.273004509429;5636.633618814784;5660.688662123602;5717.48542631161;5762.711864406763;5696.287964004499;5743.052396354597;5750.367459579485;5790;5832.970835145839;5655.4910058094965;5678.659280443187;5733.455321744427;5736.684482353469;5751.568632352591;6055.666938318391;6180.042093475518;6189.907151392733;6193.938060619381;6195.96902015487;6602.372774586406;6630.867382652368;6676.899846502306;6692.431143352821;6736;6729.091572637681;6817.863642727168;6823.55646882951;6824.624645644488;6828.146481689789;6117;6201.9689901550655;6242.219722534684;6247.344028876948;6303.621782693007;6721.025451309532;6870.27862074485;6942.687579058955;6943.201531823804;6950.131233595801;6531.8693626127215;6556.442702370352;6602.042703808017;6624.503162262849;6624.933750662528;6520.380563846427;6602.471802255808;6631.767888123893;6641.468682505388;6646.8005959821285;6535.248446428722;6548.0177973303435;6548.8035358939305;6556.18047744032;6562.278149403562;6629.966850165815;6731.49513786468;6740.056392105109;6825.590464572141;6842.828929276709;5198.4801519847715;5202.661826981234;5213.2701421800975;5251.684898906078;5251.684898906078;4584.541545845455;4631.282151266559;4637.234856248681;4652.278896771006;4656.208444564432;5611.80358687444;5678.801241956512;5689.943100569024;5704.172894930211;5711.514521265656;6507.349265073455;6655.168103987002;6676.499262555328;6699.933000669931;6814.318568143245;5761.164631128463;5815.534757219497;5818.709064546841;5835.153902684087;5849.912251316234;5738.053221218453;5746.540276777848;5815.244018277682;5817.185594016841;5824.708764561755;6264.906026409516;6453.580517266362;6478.611283323015;6521.934780652227;6590.835229119214;6630.9668451657435;6636.568623039487;6640.50196235294;6669.09967154428;6672.232693240146;6375.7449702013255;6429.678516074271;6448.419642232034;6457.483401327976;6466.676666166767;6554.082428459924;6582.572132811352;6645.468362530889;6645.9003114954285;6672.199336079701;6536.281009089092;6548;6578.210614726264;6640.302768209269;6724.327567243236;6358.936410635834;6439.839004024937;6445.387688169616;6526.347365263436;6531.3468653134305;6413.294537600954;6557.245916719447;6564.376384243489;6586.209654841449;6626.635535045426;6445.5165862561435;6450.322716114741;6520.119783829312;6536.346365363425;6544.181977252843;6514.54398192122;6533.901991470037;6580.276169621434;6608.074869518176;6675.833104172434;6242.188515493139;6323.905141422974;6342.524310676626;6397.936020639734;6430.839229019312 03:42:04 INFO - PID 3789 | |1;ext.html;821.3224090125644;875.7722992022075;886.9113088691136;890.3055616619035;899.0290486274824;39225;41528.792356038255;41686.37470437946;41707.791461042725;41926.79036604817;38129.61870381295;38144;38170.61829381705;38485.615143848554;38526.42210366847;7065.682044308006;7217.422606191519;7232.710691572331;7242.71029158833;7246.094238220223;7085.539439936413;7089.539179953286;7178.318059784312;7186.820329491752;7187.389071928892;7170.677319520634;7176.210616832144;7176.31824976629;7196.460265480084;7780.922190778105;7875.8031049223655;7937.603119844013;7943.841123177562;7943.96028019862;7954.443188976774;7722.845543089107;7748.147703752583;7816.452848300622;7824.491408058515;7834.608269586498;38845.80577097096;39119.8044009781;39191.60808391908;39272.21455570901;39280;3399.099238701746;3432.48512723091;3452.7583069185166;3453.1539772755837;3453.2748122894222;31525.52711709326;31553.21116972071;31589.684103159136;31619.051428457184;31687.52468712948;5206.401263854667;5209.505097015777;5216.478352164791;5242.475752424765;5256.185291279858;176991;177944;178902;179022;179287.10356448396;47575.5242447578;47602.047959040625;47603.8578263972;47740;47775;49465.25802112971;49663.50336496661;49694.75152624214;49709;49868.75065624721;16044.839551604568;16319.265633046542;16341.91829040871;16413.917930410273;16464.92977956429;13558.322083895766;13567.796483052762;13568.525101621395;13570.93214533921;13581.524646637321;14182.503612373725;14413.279336033156;14416.495422660157;14420.125383700262;14448.638784030272;5825.912611310834;5832.445917637818;5862.794802181903;5887.11693246008;5887.705614719247;1005.8390657494766;1011.2668315471371;1015.7003683913264;1015.918726501878;1018.1447584029303;21800.781992179876;21955.451113722283;22022.348323875773;22186.55626887453;22396.55206895853;1123.9157063220127;1126.5887950897863;1127.4813585750646;1127.881572434899;1128.198978725098;11897.479905602435;11919.821202681967;11985.700357491132;12028.458719357475;12068.141540054505;207297;207947;208411;208426;208738;51440.742796286526;53004.20493692598;56648;56731.71634141803;57162.99999999917;1413.5900588829124;1447.623617859343;1453.2225259486336;1466.3254902744643;1474.0050465935665;27036.59445108364;27337.589936150576;27927.581086283317;27933.16200513988;28067.859660701564;37109;37230;37335.6266437343;37367.43948840715;37371;193852;193978;193980;194891;195396;32311;32493.512597310586;32500.674993249766;32561.837190813894;33310.16724581905;41758.37362439505;41958.79020605;41983.370249446896;42145;42813;31173.753049877752;31302.843485782425;31452.685473144975;31528.054158375286;32065.358692825546;30694.23264418318;30953.380932381675;31530.36939261248;31747;32260.35479290448;35058.298834022666;35195.64804352026;35662.465063023556;36243.27513449769;36247.45628815517;31018.534721978736;31241.37517249597;31296.530552042193;31783.84108079445;32136.35727285488;22434.439139021655;22657.093716251824;22743.31770046901;22811.771882281628;22845.200417985292 03:42:04 INFO - PID 3789 | |2;jquery.html;528.3184691747646;559.2729451712773;576.9134629805528;583.8948989181947;587.6209844650201;15719.685606287867;16460.423885164022;21560;21717;21741.239056633;23138.88430557849;23385.181518646852;23472.17847375342;23503.76496235037;23509.5298094038;3853.5183102112237;6224.8755024899365;6371.681415929208;6383.265924418705;6403.8399040023905;3996.0409501719523;6560.606363618174;6564.179477565304;6571.047198156264;6631.502637302197;6594.505412094089;6608.372204640552;6608.603483790988;6611.636360000198;6615.636140012298;6553.737850485975;6554.442872355856;6584.93415065848;6595.604263744191;6597.769078082292;6083.96572582662;6101;6116.816495505142;6119.112728654365;6120.081987701836;26561.804718787702;27347.316317092034;27885.860570697016;28030.299242518897;28121.85939070312;2046.2224354745101;2076.3874656976227;2081.718967939339;2084.530980529384;2084.770675225724;18559;18781.81218187828;18902.149403276748;19022.61954760897;19173.137208825498;2410.240774156153;2415.903363865443;2474.616434452663;2542.872856357193;2544.9618255726177;111825;117397.41301293438;128191;134580;134934.999999999;14383.625307588036;14427.711445771025;14629.507935559723;14661.560153195207;14791.334389952477;19308.613827723366;19485.707714384294;19582.510437239183;19629.50926226827;19655.606887862163;9118.40730352525;9206.539673016456;9239.72280831576;9245.399049061789;9324.580393882292;8488.702895398632;8666.350023748244;8673.392862499564;8680.218780309677;8732.083131271253;8140.674373025131;8301.169883011771;8437.493750374997;8461.111583283666;8631.180037896389;2565.9230223093336;2571.344307201689;2611.34179795831;2643.82349854313;2665.680118385806;950.5484894674975;958.91849192818;962.4610218277647;982.2289502740315;986.5067466266867;17871.73192402115;18227.17977691007;18320.083995800156;18349;18528.722069168973;1023.6775415744016;1024.390487659856;1038.8285932821152;1040.105509262034;1040.7398150462384;10252.692419227435;10312.43281619503;10386.740331491623;10451.320664156805;10509.369437833755;448985;450230;454298;456368;460101;105592.47203763932;106027.46986265173;107266;107464;108121.45939270411;1032.3496197395743;1075.1398880895254;1125.4597793059377;1164.6331405607207;1182.988170118305;19811.702824457934;19897.403077907686;20149.19403223913;20190.798092018893;20513.692294615295;54635.726821365635;56006.719966399905;56500.71749641225;57557.71221143867;57663.13505297508;66132.66933665301;66195.66902165458;66368.33631663621;66624.6668766653;66850;13666.93166534161;13694.767470927663;13821.723565528835;13825.548317426525;13840.930795346361;21291.574168516232;21511.46221344479;21680.56638867182;21957.67063494081;21977.23079692203;17140.914295428443;17858.91070544639;17928.19323130436;17995.19021644003;18041.909790450965;15532.844671553139;15994.360225590846;16182.271797768894;16498.17509124563;16522.50432487027;17709.20308586091;17884.10579470995;18116.72824907654;18156.27374904989;18159.36442224516;13487.190768553919;13656.385462654005;13689.110207836458;13793.448262069405;13910;17417.47747567575;17522.211500482255;17584.94490330584;17611.207495662984;17614.383496577557 03:42:04 INFO - PID 3789 | |3;mootools.html;1347.1176379471447;1408.8098106755585;1417.99291003545;1421.289355322339;1425.1947649577987;14846.480373186942;15297.158656273901;15491.92254038731;15547.844521554782;15559.92220038901;15120;15302.770458443132;15328;15329.463468778595;15344.769828452581;2738.657667791521;2836.1916853696703;2843.331817023008;2843.7440630343267;2847.4305138972186;2654.721254268303;2802;2816.8028587850185;2829.066408085337;2830.249983754307;2690.4888071266496;2796.9440611187765;2802.2574017885277;2805.6072149899032;2807.171884294138;2808.283887608657;2810.058630358832;2838.985805070982;2842.204182828811;2843.431313737261;2697.2852194168563;2793.6368272124696;2801.5657573076;2812.2828678686806;2823.39297051135;14745.336459859333;14899.255037248202;14906.478273260384;14911.403543858232;14965.326560304813;7995.600219988977;8247.793805154859;8248.670053197864;8259.256666899948;8268.462549934235;5466.371367292772;5730.025895597759;5793.420657934173;5862.97068514659;5871.765129394862;1903.8476921846357;1909.3221906223368;1910.245453046053;1928.431112821721;1955.7653081630153;26198;26364.86817565919;26516.071937482095;26555;26605.467890642274;6558.081868538313;6721.865562688817;6785.355391237825;6826.624535650587;6832.111825462658;17087.829121708874;17115.486535403958;17154.142292885306;17221.655566888592;17302.480925572254;7448.255174482617;7763.72826951054;7937.8412431752195;8010;8012.3590112790835;7279.2720727927845;7403.777886663301;7426.814329641694;7427;7486.401087912954;5092.949070509321;5185.637005409585;5238.349919775259;5273.578113750891;5288.735563221823;1542.9228538573252;1543.7221300166077;1544.4054039194991;1545.1072436265708;1558.0807323679085;859.0636206534907;860.3289434241302;865.6667183134539;875.159846547309;891.5141248019845;7256.201817800038;8096.595170241464;8251.587420628945;8347.248747612744;8380.916190838136;695.5861262548775;696.1715558485387;712.1667648850857;713.6610110197614;717.2827172827173;4340.82636694535;4371.169477799272;5417.566594672417;5613.775448982076;5760.0783874579865;21104.472388190417;21726;21949.890250548964;22031.889840550695;22304.665430018562;21270.89364553198;21444;21486.24798132058;21528;21612;10935.234533582732;11049.226554141133;11337;11585.015273701661;11665;8142.51144931306;8266.586670666322;8299.29455996247;8680;8989;18462.907685461487;18543.258269669062;18829.117088291063;18938.52653683669;18961.43115706531;19054.523636909187;19159.8084019158;19253.518662033563;19282.32511862078;19376.321828735927;12091.939540302243;12491;12502.374881256083;12504.749525047422;12510.061745368952;13791.172529648253;13794.793078104038;13812;13984.790228146383;14011.859881401055;11343.432828358384;11349.319040857576;11386.601468948547;11614.709632258922;11635.709107272385;10932.234743568191;11026.944865275622;11129.054030407506;11197.384143872165;11486.19596628228;9352.766180845261;9462.053794620759;9478.95260523693;9585.281103917374;9590.280728945496;6591.505637077143;6645.867082658417;6664.933350666625;6681.832954176184;6771;6881.10545629065;6899.896501552581;6964.547304425196;6966.79099627012;6978.267281935527 03:42:04 INFO - PID 3789 | |4;prototype.html;503.38838311451605;513.6507175120919;526.344700847445;529.2405398253505;530.9017831701135;6086.543509236808;6152.477039451646;6249.375062493748;6249.375062493748;6250.374962503742;6056.606320589159;6065.332813390534;6101.1153382759585;6119.66341851198;6142.928535732134;4894.730789806559;4968.850934471971;4975.6765810222405;4978.825741099062;4981.950180498185;5003.47463516331;5022.874428139289;5034.903534326381;5047.722375269359;5048.1418158913075;4969.130402179622;4976.4774698656665;4979.825706100287;4994.950050499485;5029.974850125763;4931.556159945604;4940.135476291634;4968.975155124202;4980.651354405193;4985.302057711923;4488.8877778055485;4491.191585514606;4496.7077139985795;4517.2998185281;4536.387587675687;6095.238095238095;6179.783707570258;6223.502119830403;6236.43872051513;6248.187735594389;5554.722413844798;5597.832065038015;5631.971840140773;5682;5708.857278568027;6504.154459920227;6551.475881929434;6557.770478033293;6565.770198043093;6578.967105164444;4867;4896.290037944514;4899.2896030075435;4902.705837649717;4907.656464047518;6803.693833777492;6837.829054273633;6844.589324640538;6870.31296870309;6883.58886428281;4908.705477671351;4955.182394904872;4959.132151873408;4987.351644286219;4991.850244492598;4978.352814134212;5035.77339019745;5036.992601479718;5046.596272298208;5047.2429135629945;5598.412166722517;5622.32532096151;5647.350554686182;5662.773489060474;5677.687727175045;6196.8760624787255;6364.872702545923;6449.451796597248;6524.902126468011;6565.474762019027;1654.4292219184363;1728.1272957156555;1735.470681442147;1739.6346767178782;1743.3375317379569;1193.8806119388166;1200.8198770184542;1211.7515909238762;1217.719924417389;1228.177121328712;5487.368952570506;5573.832785016456;5598.412166722435;5635.802746903839;5684.261046063985;6411.6153030818305;6466.935330646727;6548.70530826114;6557.540972132;6597.373249541286;5667.773289068391;5679.460451257124;5708;5726.856828579235;5742.339630942495;3456.1532424556144;3509.3156834417046;3521.8063006534885;3535.1338921964284;3578.409562422223;6432.35676432353;6441.581297215666;6468.288488266287;6473.06140609609;6479.50971276609;6744.133743159137;6752.932470675329;6759.222689390783;6763.966180169166;6811.352921472452;6466.189466949168;6469.902951455826;6503.642299673564;6504.414602685781;6516.250631177475;6639.037339585637;6658.966705166443;6669.132273122604;6702.83242918931;6708.295628959084;6444.162258906312;6501.869962600627;6550.279469258282;6582.913819219775;6606.405423511907;6314.715837787218;6341.0805433212845;6369.267534233622;6388.55280130405;6388.936110638834;4886.560209581155;4929.630277729257;4946.134426475281;4951.158303088411;4962.727050012284;6492.415682588589;6616.106825578678;6707.66461676924;6710.261871194067;6711.563748356341;6012.5791194617705;6351.428371446592;6393.8721225576155;6415.679216039086;6462.127612772216;6448.967755161194;6464.903026454513;6466.159399278064;6483.286838447862;6485.086899364793;6301.4328710416285;6320.6839658016;6375.171227740364;6383.265924418752;6404.103425520524;6429.967850160906;6445.227562420372;6502.382273683992;6537.803865884031;6571.638559879252;6178.66017369049;6180.938190618216;6195.380461953769;6196.1635179250225;6272 03:42:04 INFO - PID 3789 | |5;yui.html;919.3886065766266;921.4931787516865;952.0859974424552;953.8330792111383;962.2542529539608;17850.375236866712;18722.43832685018;18774.34289799859;18777.15502802374;18790.53023674409;15835;15910.045397276142;15918.840811591881;15966.84033159668;16772.58068548287;982.2583949118424;988.9307748457611;990.4404011733384;992.7964767222702;992.9553170107326;817.239966830847;818.8403261364036;819.3895547816855;820.6266148902235;968.2012339819642;1043.572135424476;1061.8938106189396;1063.1494804156644;1063.2450959818539;1063.611781699678;1040.2614143957799;1044.7544826965695;1048.8846226915034;1053.0364716284591;1053.3206082077056;720.9963950180268;739.7669734033763;743.5129989856598;745.4893398022318;764.7361660227212;18843;19156.521086972796;19159.616807663908;19246.61506769871;19514.219431222733;20080.59838803216;20147;20611;20618.896905515525;20722.378328650164;16789.6642067158;16806.915965420096;16858.662826743395;16912;16939.49181524556;3837.597052309495;3851.326017946876;3872.0900588361715;3872.4191371294532;3873.0511024799102;127890;129708;130780.34609826985;134190;135578.3221083898;14749.041312314665;14782.778258326134;15361.001534900195;15894.60263493422;16457.91771041161;27056.86471567669;27435.45129097407;27859;27940.58089128665;27951.161465156078;8032.39757018226;8108.472949258279;8112.18878112184;8155.755327340189;8163.061247956561;4108.301588729923;4193.622573968297;4199.0552125771455;4200.390943313264;4204.978975105105;4790.712557246577;4830.3237546743485;4863.294822250754;4887.9246565755475;4911.87720306988;996.0537489385113;997.3716558568055;1015.5836107196162;1015.6242190389603;1017.6031347774374;666.8966310221826;680.3263970632202;684.7055766020659;692.7159864455549;697.7209116353499;11001.339919604688;11061.557537698402;11167.553297868157;11663;11896.464659090188;665.3944910131756;684.6131935456451;686.0772261308532;692.6190595172635;695.8956156576554;4942.20924652054;5000.949990500121;5035.194368900959;5061.721605311744;5125.179971204664;123284;125860.37069814593;126178;127788;131726.34136829255;85804;86388;96860;110704;114902;87819;90071.09561185699;91012.54493727488;91593.5420322894;92591;11914;12042.698932526757;12117.575884843987;12347.69130771702;12378.504859805507;41037.38443923403;41985.58014419817;43012.78493607512;43303.350449743906;44650.330245047;54132.72933635306;54709.72645136908;55709.442905570424;55989.72005139948;56792.432075680365;16789.580260493585;16927.576810579834;16957.915210423867;16987.40544080951;17088.829111708725;20481;20628.587428251052;20750.688739668614;21015.054322555217;21085.367438976857;17215.139243038047;17251.654966900842;17276.827231727522;17355.913220434322;17591.208395621972;17954.19206135753;17958.19188136511;18246.17892194881;18255.90872045631;18322.725159122358;18083.728744068587;18110.456686299432;18156;18210.72683909716;18289.908550457163;11951.641450756491;11986.340751258764;12016.699582510508;12049.698757531132;12357.93821030889;11963.401829908296;12006.159568830448;12061;12123.090768192596;12286.569970051363 03:42:04 INFO - PID 3789 | __end_tp_report 03:42:04 INFO - PID 3789 | __start_cc_report 03:42:04 INFO - PID 3789 | _x_x_mozilla_cycle_collect,282 03:42:04 INFO - PID 3789 | __end_cc_report 03:42:04 INFO - PID 3789 | __startTimestamp1505558524162__endTimestamp 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | ------- Summary: start ------- 03:42:04 INFO - PID 3789 | Number of tests: 6 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#0] dojo.html Cycles:165 Average:6137.43 Median:6413.29 stddev:734.79 (11.5%) stddev-sans-first:697.30 03:42:04 INFO - PID 3789 | Values: 3098.4 3114.0 3126.0 3128.3 3145.9 6143.8 6166.9 6195.1 6233.0 6331.5 6203.4 6280.1 6293.2 6299.0 6332.6 5527.4 5620.1 5797.2 5809.7 5852.2 5757.3 5760.9 5766.3 5780.9 5841.8 5592.3 5636.6 5660.7 5717.5 5762.7 5696.3 5743.1 5750.4 5790.0 5833.0 5655.5 5678.7 5733.5 5736.7 5751.6 6055.7 6180.0 6189.9 6193.9 6196.0 6602.4 6630.9 6676.9 6692.4 6736.0 6729.1 6817.9 6823.6 6824.6 6828.1 6117.0 6202.0 6242.2 6247.3 6303.6 6721.0 6870.3 6942.7 6943.2 6950.1 6531.9 6556.4 6602.0 6624.5 6624.9 6520.4 6602.5 6631.8 6641.5 6646.8 6535.2 6548.0 6548.8 6556.2 6562.3 6630.0 6731.5 6740.1 6825.6 6842.8 5198.5 5202.7 5213.3 5251.7 5251.7 4584.5 4631.3 4637.2 4652.3 4656.2 5611.8 5678.8 5689.9 5704.2 5711.5 6507.3 6655.2 6676.5 6699.9 6814.3 5761.2 5815.5 5818.7 5835.2 5849.9 5738.1 5746.5 5815.2 5817.2 5824.7 6264.9 6453.6 6478.6 6521.9 6590.8 6631.0 6636.6 6640.5 6669.1 6672.2 6375.7 6429.7 6448.4 6457.5 6466.7 6554.1 6582.6 6645.5 6645.9 6672.2 6536.3 6548.0 6578.2 6640.3 6724.3 6358.9 6439.8 6445.4 6526.3 6531.3 6413.3 6557.2 6564.4 6586.2 6626.6 6445.5 6450.3 6520.1 6536.3 6544.2 6514.5 6533.9 6580.3 6608.1 6675.8 6242.2 6323.9 6342.5 6397.9 6430.8 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#1] ext.html Cycles:180 Average:36410.86 Median:3415.79 stddev:50170.76 (1468.8%) stddev-sans-first:50240.33 03:42:04 INFO - PID 3789 | Values: 821.3 875.8 886.9 890.3 899.0 39225.0 41528.8 41686.4 41707.8 41926.8 38129.6 38144.0 38170.6 38485.6 38526.4 7065.7 7217.4 7232.7 7242.7 7246.1 7085.5 7089.5 7178.3 7186.8 7187.4 7170.7 7176.2 7176.3 7196.5 7780.9 7875.8 7937.6 7943.8 7944.0 7954.4 7722.8 7748.1 7816.5 7824.5 7834.6 38845.8 39119.8 39191.6 39272.2 39280.0 3399.1 3432.5 3452.8 3453.2 3453.3 31525.5 31553.2 31589.7 31619.1 31687.5 5206.4 5209.5 5216.5 5242.5 5256.2 176991.0 177944.0 178902.0 179022.0 179287.1 47575.5 47602.0 47603.9 47740.0 47775.0 49465.3 49663.5 49694.8 49709.0 49868.8 16044.8 16319.3 16341.9 16413.9 16464.9 13558.3 13567.8 13568.5 13570.9 13581.5 14182.5 14413.3 14416.5 14420.1 14448.6 5825.9 5832.4 5862.8 5887.1 5887.7 1005.8 1011.3 1015.7 1015.9 1018.1 21800.8 21955.5 22022.3 22186.6 22396.6 1123.9 1126.6 1127.5 1127.9 1128.2 11897.5 11919.8 11985.7 12028.5 12068.1 207297.0 207947.0 208411.0 208426.0 208738.0 51440.7 53004.2 56648.0 56731.7 57163.0 1413.6 1447.6 1453.2 1466.3 1474.0 27036.6 27337.6 27927.6 27933.2 28067.9 37109.0 37230.0 37335.6 37367.4 37371.0 193852.0 193978.0 193980.0 194891.0 195396.0 32311.0 32493.5 32500.7 32561.8 33310.2 41758.4 41958.8 41983.4 42145.0 42813.0 31173.8 31302.8 31452.7 31528.1 32065.4 30694.2 30953.4 31530.4 31747.0 32260.4 35058.3 35195.6 35662.5 36243.3 36247.5 31018.5 31241.4 31296.5 31783.8 32136.4 22434.4 22657.1 22743.3 22811.8 22845.2 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#2] jquery.html Cycles:180 Average:32454.08 Median:21698.78 stddev:76415.52 (352.2%) stddev-sans-first:76592.29 03:42:04 INFO - PID 3789 | Values: 528.3 559.3 576.9 583.9 587.6 15719.7 16460.4 21560.0 21717.0 21741.2 23138.9 23385.2 23472.2 23503.8 23509.5 3853.5 6224.9 6371.7 6383.3 6403.8 3996.0 6560.6 6564.2 6571.0 6631.5 6594.5 6608.4 6608.6 6611.6 6615.6 6553.7 6554.4 6584.9 6595.6 6597.8 6084.0 6101.0 6116.8 6119.1 6120.1 26561.8 27347.3 27885.9 28030.3 28121.9 2046.2 2076.4 2081.7 2084.5 2084.8 18559.0 18781.8 18902.1 19022.6 19173.1 2410.2 2415.9 2474.6 2542.9 2545.0 111825.0 117397.4 128191.0 134580.0 134935.0 14383.6 14427.7 14629.5 14661.6 14791.3 19308.6 19485.7 19582.5 19629.5 19655.6 9118.4 9206.5 9239.7 9245.4 9324.6 8488.7 8666.4 8673.4 8680.2 8732.1 8140.7 8301.2 8437.5 8461.1 8631.2 2565.9 2571.3 2611.3 2643.8 2665.7 950.5 958.9 962.5 982.2 986.5 17871.7 18227.2 18320.1 18349.0 18528.7 1023.7 1024.4 1038.8 1040.1 1040.7 10252.7 10312.4 10386.7 10451.3 10509.4 448985.0 450230.0 454298.0 456368.0 460101.0 105592.5 106027.5 107266.0 107464.0 108121.5 1032.3 1075.1 1125.5 1164.6 1183.0 19811.7 19897.4 20149.2 20190.8 20513.7 54635.7 56006.7 56500.7 57557.7 57663.1 66132.7 66195.7 66368.3 66624.7 66850.0 13666.9 13694.8 13821.7 13825.5 13840.9 21291.6 21511.5 21680.6 21957.7 21977.2 17140.9 17858.9 17928.2 17995.2 18041.9 15532.8 15994.4 16182.3 16498.2 16522.5 17709.2 17884.1 18116.7 18156.3 18159.4 13487.2 13656.4 13689.1 13793.4 13910.0 17417.5 17522.2 17584.9 17611.2 17614.4 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#3] mootools.html Cycles:180 Average:9360.78 Median:2799.25 stddev:6694.78 (239.2%) stddev-sans-first:6686.49 03:42:04 INFO - PID 3789 | Values: 1347.1 1408.8 1418.0 1421.3 1425.2 14846.5 15297.2 15491.9 15547.8 15559.9 15120.0 15302.8 15328.0 15329.5 15344.8 2738.7 2836.2 2843.3 2843.7 2847.4 2654.7 2802.0 2816.8 2829.1 2830.2 2690.5 2796.9 2802.3 2805.6 2807.2 2808.3 2810.1 2839.0 2842.2 2843.4 2697.3 2793.6 2801.6 2812.3 2823.4 14745.3 14899.3 14906.5 14911.4 14965.3 7995.6 8247.8 8248.7 8259.3 8268.5 5466.4 5730.0 5793.4 5863.0 5871.8 1903.8 1909.3 1910.2 1928.4 1955.8 26198.0 26364.9 26516.1 26555.0 26605.5 6558.1 6721.9 6785.4 6826.6 6832.1 17087.8 17115.5 17154.1 17221.7 17302.5 7448.3 7763.7 7937.8 8010.0 8012.4 7279.3 7403.8 7426.8 7427.0 7486.4 5092.9 5185.6 5238.3 5273.6 5288.7 1542.9 1543.7 1544.4 1545.1 1558.1 859.1 860.3 865.7 875.2 891.5 7256.2 8096.6 8251.6 8347.2 8380.9 695.6 696.2 712.2 713.7 717.3 4340.8 4371.2 5417.6 5613.8 5760.1 21104.5 21726.0 21949.9 22031.9 22304.7 21270.9 21444.0 21486.2 21528.0 21612.0 10935.2 11049.2 11337.0 11585.0 11665.0 8142.5 8266.6 8299.3 8680.0 8989.0 18462.9 18543.3 18829.1 18938.5 18961.4 19054.5 19159.8 19253.5 19282.3 19376.3 12091.9 12491.0 12502.4 12504.7 12510.1 13791.2 13794.8 13812.0 13984.8 14011.9 11343.4 11349.3 11386.6 11614.7 11635.7 10932.2 11026.9 11129.1 11197.4 11486.2 9352.8 9462.1 9479.0 9585.3 9590.3 6591.5 6645.9 6664.9 6681.8 6771.0 6881.1 6899.9 6964.5 6966.8 6978.3 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#4] prototype.html Cycles:180 Average:5456.64 Median:6110.39 stddev:1520.51 (24.9%) stddev-sans-first:1478.63 03:42:04 INFO - PID 3789 | Values: 503.4 513.7 526.3 529.2 530.9 6086.5 6152.5 6249.4 6249.4 6250.4 6056.6 6065.3 6101.1 6119.7 6142.9 4894.7 4968.9 4975.7 4978.8 4982.0 5003.5 5022.9 5034.9 5047.7 5048.1 4969.1 4976.5 4979.8 4995.0 5030.0 4931.6 4940.1 4969.0 4980.7 4985.3 4488.9 4491.2 4496.7 4517.3 4536.4 6095.2 6179.8 6223.5 6236.4 6248.2 5554.7 5597.8 5632.0 5682.0 5708.9 6504.2 6551.5 6557.8 6565.8 6579.0 4867.0 4896.3 4899.3 4902.7 4907.7 6803.7 6837.8 6844.6 6870.3 6883.6 4908.7 4955.2 4959.1 4987.4 4991.9 4978.4 5035.8 5037.0 5046.6 5047.2 5598.4 5622.3 5647.4 5662.8 5677.7 6196.9 6364.9 6449.5 6524.9 6565.5 1654.4 1728.1 1735.5 1739.6 1743.3 1193.9 1200.8 1211.8 1217.7 1228.2 5487.4 5573.8 5598.4 5635.8 5684.3 6411.6 6466.9 6548.7 6557.5 6597.4 5667.8 5679.5 5708.0 5726.9 5742.3 3456.2 3509.3 3521.8 3535.1 3578.4 6432.4 6441.6 6468.3 6473.1 6479.5 6744.1 6752.9 6759.2 6764.0 6811.4 6466.2 6469.9 6503.6 6504.4 6516.3 6639.0 6659.0 6669.1 6702.8 6708.3 6444.2 6501.9 6550.3 6582.9 6606.4 6314.7 6341.1 6369.3 6388.6 6388.9 4886.6 4929.6 4946.1 4951.2 4962.7 6492.4 6616.1 6707.7 6710.3 6711.6 6012.6 6351.4 6393.9 6415.7 6462.1 6449.0 6464.9 6466.2 6483.3 6485.1 6301.4 6320.7 6375.2 6383.3 6404.1 6430.0 6445.2 6502.4 6537.8 6571.6 6178.7 6180.9 6195.4 6196.2 6272.0 03:42:04 INFO - PID 3789 | 03:42:04 INFO - PID 3789 | [#5] yui.html Cycles:180 Average:23716.24 Median:20113.80 stddev:33987.01 (169.0%) stddev-sans-first:34039.25 03:42:04 INFO - PID 3789 | Values: 919.4 921.5 952.1 953.8 962.3 17850.4 18722.4 18774.3 18777.2 18790.5 15835.0 15910.0 15918.8 15966.8 16772.6 982.3 988.9 990.4 992.8 993.0 817.2 818.8 819.4 820.6 968.2 1043.6 1061.9 1063.1 1063.2 1063.6 1040.3 1044.8 1048.9 1053.0 1053.3 721.0 739.8 743.5 745.5 764.7 18843.0 19156.5 19159.6 19246.6 19514.2 20080.6 20147.0 20611.0 20618.9 20722.4 16789.7 16806.9 16858.7 16912.0 16939.5 3837.6 3851.3 3872.1 3872.4 3873.1 127890.0 129708.0 130780.3 134190.0 135578.3 14749.0 14782.8 15361.0 15894.6 16457.9 27056.9 27435.5 27859.0 27940.6 27951.2 8032.4 8108.5 8112.2 8155.8 8163.1 4108.3 4193.6 4199.1 4200.4 4205.0 4790.7 4830.3 4863.3 4887.9 4911.9 996.1 997.4 1015.6 1015.6 1017.6 666.9 680.3 684.7 692.7 697.7 11001.3 11061.6 11167.6 11663.0 11896.5 665.4 684.6 686.1 692.6 695.9 4942.2 5000.9 5035.2 5061.7 5125.2 123284.0 125860.4 126178.0 127788.0 131726.3 85804.0 86388.0 96860.0 110704.0 114902.0 87819.0 90071.1 91012.5 91593.5 92591.0 11914.0 12042.7 12117.6 12347.7 12378.5 41037.4 41985.6 43012.8 43303.4 44650.3 54132.7 54709.7 55709.4 55989.7 56792.4 16789.6 16927.6 16957.9 16987.4 17088.8 20481.0 20628.6 20750.7 21015.1 21085.4 17215.1 17251.7 17276.8 17355.9 17591.2 17954.2 17958.2 18246.2 18255.9 18322.7 18083.7 18110.5 18156.0 18210.7 18289.9 11951.6 11986.3 12016.7 12049.7 12357.9 11963.4 12006.2 12061.0 12123.1 12286.6 03:42:04 INFO - PID 3789 | -------- Summary: end -------- 03:42:04 INFO - PID 3789 | 03:42:04 INFO - TEST-INFO | 3789: exit 0 03:42:04 INFO - TEST-OK | dromaeo_css | took 1112226ms 03:42:04 INFO - TEST-START | kraken 03:42:04 INFO - Initialising browser for kraken test... 03:42:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59794/getInfo.html -profile /tmp/tmplwTuFR/profile 03:42:04 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox http://localhost:59794/getInfo.html) 03:42:10 INFO - TEST-INFO | 4159: exit 0 03:42:10 INFO - Browser initialized. 03:42:10 INFO - Running cycle 1/1 for kraken test... 03:42:10 INFO - Using env: {'DISPLAY': ':0', 03:42:10 INFO - 'HOME': '/home/cltbld', 03:42:10 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:10 INFO - 'LANG': 'en_US.UTF-8', 03:42:10 INFO - 'LANGUAGE': 'en_US:en', 03:42:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:10 INFO - 'LOGNAME': 'cltbld', 03:42:10 INFO - 'MAIL': '/var/mail/cltbld', 03:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:10 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:10 INFO - 'MOZ_NO_REMOTE': '1', 03:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:10 INFO - 'NO_EM_RESTART': '1', 03:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:10 INFO - 'PWD': '/builds/slave/test', 03:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:10 INFO - 'RUST_BACKTRACE': 'full', 03:42:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:10 INFO - 'SHELL': '/bin/bash', 03:42:10 INFO - 'SHLVL': '1', 03:42:10 INFO - 'TERM': 'linux', 03:42:10 INFO - 'TMOUT': '86400', 03:42:10 INFO - 'USER': 'cltbld', 03:42:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413', 03:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:10 INFO - '_': '/tools/buildbot/bin/python'} 03:42:10 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwTuFR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:11 INFO - PID 4394 | 03:42:11 INFO - PID 4394 | (/builds/slave/test/build/application/firefox/firefox:4443): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:11 INFO - PID 4394 | 03:42:22 INFO - PID 4394 | RSS: Main: 154537984 03:42:22 INFO - PID 4394 | 03:42:24 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59794/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:25 INFO - PID 4394 | RSS: Main: 159768576 03:42:25 INFO - PID 4394 | 03:42:28 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59794/tests/kraken/driver.html?testName=audio-dft) 03:42:28 INFO - PID 4394 | RSS: Main: 159907840 03:42:28 INFO - PID 4394 | 03:42:31 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59794/tests/kraken/driver.html?testName=audio-fft) 03:42:32 INFO - PID 4394 | RSS: Main: 156884992 03:42:32 INFO - PID 4394 | 03:42:34 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59794/tests/kraken/driver.html?testName=audio-oscillator) 03:42:35 INFO - PID 4394 | RSS: Main: 157278208 03:42:35 INFO - PID 4394 | 03:42:37 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:37 INFO - PID 4394 | RSS: Main: 157396992 03:42:37 INFO - PID 4394 | 03:42:41 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59794/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:41 INFO - PID 4394 | RSS: Main: 159694848 03:42:41 INFO - PID 4394 | 03:42:45 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59794/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:46 INFO - PID 4394 | RSS: Main: 160600064 03:42:46 INFO - PID 4394 | 03:42:49 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59794/tests/kraken/driver.html?testName=json-parse-financial) 03:42:49 INFO - PID 4394 | RSS: Main: 160505856 03:42:49 INFO - PID 4394 | 03:42:51 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:51 INFO - PID 4394 | RSS: Main: 160403456 03:42:51 INFO - PID 4394 | 03:42:53 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:54 INFO - PID 4394 | RSS: Main: 157597696 03:42:54 INFO - PID 4394 | 03:42:57 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:57 INFO - PID 4394 | RSS: Main: 157523968 03:42:57 INFO - PID 4394 | 03:43:00 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:00 INFO - PID 4394 | RSS: Main: 157675520 03:43:00 INFO - PID 4394 | 03:43:03 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:04 INFO - PID 4394 | RSS: Main: 157507584 03:43:04 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:59794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59794/tests/kraken/driver.html?testName=ai-astar) 03:43:06 INFO - PID 4394 | RSS: Main: 159145984 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | __start_tp_report 03:43:06 INFO - PID 4394 | _x_x_mozilla_page_load 03:43:06 INFO - PID 4394 | _x_x_mozilla_page_load_details 03:43:06 INFO - PID 4394 | |i|pagename|runs| 03:43:06 INFO - PID 4394 | |0;ai-astar;106;108;107;108;108;107;107;108;108;109 03:43:06 INFO - PID 4394 | |1;audio-beat-detection;115;117;115;116;115;120;117;123;117;117 03:43:06 INFO - PID 4394 | |2;audio-dft;164;164;163;163;162;163;163;164;168;167 03:43:06 INFO - PID 4394 | |3;audio-fft;74;73;76;73;75;74;73;72;75;75 03:43:06 INFO - PID 4394 | |4;audio-oscillator;79;80;79;80;79;79;78;79;79;81 03:43:06 INFO - PID 4394 | |5;imaging-gaussian-blur;114;114;113;117;113;113;115;115;115;117 03:43:06 INFO - PID 4394 | |6;imaging-darkroom;148;148;147;149;147;148;146;147;150;148 03:43:06 INFO - PID 4394 | |7;imaging-desaturate;98;94;94;95;94;94;94;94;94;94 03:43:06 INFO - PID 4394 | |8;json-parse-financial;53;53;53;55;54;54;52;53;54;52 03:43:06 INFO - PID 4394 | |9;json-stringify-tinderbox;39;38;38;38;39;38;39;38;39;39 03:43:06 INFO - PID 4394 | |10;stanford-crypto-aes;74;73;73;73;73;75;77;77;73;74 03:43:06 INFO - PID 4394 | |11;stanford-crypto-ccm;117;110;122;113;122;110;117;114;124;109 03:43:06 INFO - PID 4394 | |12;stanford-crypto-pbkdf2;174;173;165;173;166;170;168;175;164;165 03:43:06 INFO - PID 4394 | |13;stanford-crypto-sha256-iterative;64;63;64;70;67;65;65;63;64;64 03:43:06 INFO - PID 4394 | __end_tp_report 03:43:06 INFO - PID 4394 | __start_cc_report 03:43:06 INFO - PID 4394 | _x_x_mozilla_cycle_collect,726 03:43:06 INFO - PID 4394 | __end_cc_report 03:43:06 INFO - PID 4394 | __startTimestamp1505558586540__endTimestamp 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | ------- Summary: start ------- 03:43:06 INFO - PID 4394 | Number of tests: 14 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.00 stddev:0.84 (0.8%) stddev-sans-first:0.67 03:43:06 INFO - PID 4394 | Values: 106.0 108.0 107.0 108.0 108.0 107.0 107.0 108.0 108.0 109.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:117.00 stddev:2.53 (2.2%) stddev-sans-first:2.55 03:43:06 INFO - PID 4394 | Values: 115.0 117.0 115.0 116.0 115.0 120.0 117.0 123.0 117.0 117.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 03:43:06 INFO - PID 4394 | Values: 164.0 164.0 163.0 163.0 162.0 163.0 163.0 164.0 168.0 167.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.50 stddev:1.25 (1.7%) stddev-sans-first:1.32 03:43:06 INFO - PID 4394 | Values: 74.0 73.0 76.0 73.0 75.0 74.0 73.0 72.0 75.0 75.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 03:43:06 INFO - PID 4394 | Values: 79.0 80.0 79.0 80.0 79.0 79.0 78.0 79.0 79.0 81.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.51 (1.3%) stddev-sans-first:1.58 03:43:06 INFO - PID 4394 | Values: 114.0 114.0 113.0 117.0 113.0 113.0 115.0 115.0 115.0 117.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 03:43:06 INFO - PID 4394 | Values: 148.0 148.0 147.0 149.0 147.0 148.0 146.0 147.0 150.0 148.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.27 (1.4%) stddev-sans-first:0.33 03:43:06 INFO - PID 4394 | Values: 98.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 03:43:06 INFO - PID 4394 | Values: 53.0 53.0 53.0 55.0 54.0 54.0 52.0 53.0 54.0 52.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 03:43:06 INFO - PID 4394 | Values: 39.0 38.0 38.0 38.0 39.0 38.0 39.0 38.0 39.0 39.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:1.62 (2.2%) stddev-sans-first:1.72 03:43:06 INFO - PID 4394 | Values: 74.0 73.0 73.0 73.0 73.0 75.0 77.0 77.0 73.0 74.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:5.49 (4.7%) stddev-sans-first:5.81 03:43:06 INFO - PID 4394 | Values: 117.0 110.0 122.0 113.0 122.0 110.0 117.0 114.0 124.0 109.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:171.50 stddev:4.22 (2.5%) stddev-sans-first:4.12 03:43:06 INFO - PID 4394 | Values: 174.0 173.0 165.0 173.0 166.0 170.0 168.0 175.0 164.0 165.0 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:2.13 (3.3%) stddev-sans-first:2.24 03:43:06 INFO - PID 4394 | Values: 64.0 63.0 64.0 70.0 67.0 65.0 65.0 63.0 64.0 64.0 03:43:06 INFO - PID 4394 | -------- Summary: end -------- 03:43:06 INFO - PID 4394 | 03:43:06 INFO - PID 4394 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:07 INFO - TEST-INFO | 4394: exit 0 03:43:07 INFO - TEST-OK | kraken | took 62414ms 03:43:07 INFO - SUITE-END | took 1174s 03:43:07 INFO - Completed test suite (00:19:35) 03:43:07 INFO - javascript benchmark 03:43:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8388.030983604725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.411301852648, 3114.0, 3125.9843700781494, 3128.280495486039, 3145.9370812583747, 6143.784967526138, 6166.907496387557, 6195.132681424599, 6233.0, 6331.52513561483, 6203.379662033794, 6280.1207830903595, 6293.150424692665, 6299.0, 6332.620042797435, 5527.447255274481, 5620.100783874581, 5797.1594118852845, 5809.705166459246, 5852.239208902836, 5757.280339957505, 5760.884782304352, 5766.279215098113, 5780.913286300709, 5841.7955371562, 5592.273004509429, 5636.633618814784, 5660.688662123602, 5717.48542631161, 5762.711864406763, 5696.287964004499, 5743.052396354597, 5750.367459579485, 5790.0, 5832.970835145839, 5655.4910058094965, 5678.659280443187, 5733.455321744427, 5736.684482353469, 5751.568632352591, 6055.666938318391, 6180.042093475518, 6189.907151392733, 6193.938060619381, 6195.96902015487, 6602.372774586406, 6630.867382652368, 6676.899846502306, 6692.431143352821, 6736.0, 6729.091572637681, 6817.863642727168, 6823.55646882951, 6824.624645644488, 6828.146481689789, 6117.0, 6201.9689901550655, 6242.219722534684, 6247.344028876948, 6303.621782693007, 6721.025451309532, 6870.27862074485, 6942.687579058955, 6943.201531823804, 6950.131233595801, 6531.8693626127215, 6556.442702370352, 6602.042703808017, 6624.503162262849, 6624.933750662528, 6520.380563846427, 6602.471802255808, 6631.767888123893, 6641.468682505388, 6646.8005959821285, 6535.248446428722, 6548.0177973303435, 6548.8035358939305, 6556.18047744032, 6562.278149403562, 6629.966850165815, 6731.49513786468, 6740.056392105109, 6825.590464572141, 6842.828929276709, 5198.4801519847715, 5202.661826981234, 5213.2701421800975, 5251.684898906078, 5251.684898906078, 4584.541545845455, 4631.282151266559, 4637.234856248681, 4652.278896771006, 4656.208444564432, 5611.80358687444, 5678.801241956512, 5689.943100569024, 5704.172894930211, 5711.514521265656, 6507.349265073455, 6655.168103987002, 6676.499262555328, 6699.933000669931, 6814.318568143245, 5761.164631128463, 5815.534757219497, 5818.709064546841, 5835.153902684087, 5849.912251316234, 5738.053221218453, 5746.540276777848, 5815.244018277682, 5817.185594016841, 5824.708764561755, 6264.906026409516, 6453.580517266362, 6478.611283323015, 6521.934780652227, 6590.835229119214, 6630.9668451657435, 6636.568623039487, 6640.50196235294, 6669.09967154428, 6672.232693240146, 6375.7449702013255, 6429.678516074271, 6448.419642232034, 6457.483401327976, 6466.676666166767, 6554.082428459924, 6582.572132811352, 6645.468362530889, 6645.9003114954285, 6672.199336079701, 6536.281009089092, 6548.0, 6578.210614726264, 6640.302768209269, 6724.327567243236, 6358.936410635834, 6439.839004024937, 6445.387688169616, 6526.347365263436, 6531.3468653134305, 6413.294537600954, 6557.245916719447, 6564.376384243489, 6586.209654841449, 6626.635535045426, 6445.5165862561435, 6450.322716114741, 6520.119783829312, 6536.346365363425, 6544.181977252843, 6514.54398192122, 6533.901991470037, 6580.276169621434, 6608.074869518176, 6675.833104172434, 6242.188515493139, 6323.905141422974, 6342.524310676626, 6397.936020639734, 6430.839229019312], "value": 6081.415154508328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.3224090125644, 875.7722992022075, 886.9113088691136, 890.3055616619035, 899.0290486274824, 39225.0, 41528.792356038255, 41686.37470437946, 41707.791461042725, 41926.79036604817, 38129.61870381295, 38144.0, 38170.61829381705, 38485.615143848554, 38526.42210366847, 7065.682044308006, 7217.422606191519, 7232.710691572331, 7242.71029158833, 7246.094238220223, 7085.539439936413, 7089.539179953286, 7178.318059784312, 7186.820329491752, 7187.389071928892, 7170.677319520634, 7176.210616832144, 7176.31824976629, 7196.460265480084, 7780.922190778105, 7875.8031049223655, 7937.603119844013, 7943.841123177562, 7943.96028019862, 7954.443188976774, 7722.845543089107, 7748.147703752583, 7816.452848300622, 7824.491408058515, 7834.608269586498, 38845.80577097096, 39119.8044009781, 39191.60808391908, 39272.21455570901, 39280.0, 3399.099238701746, 3432.48512723091, 3452.7583069185166, 3453.1539772755837, 3453.2748122894222, 31525.52711709326, 31553.21116972071, 31589.684103159136, 31619.051428457184, 31687.52468712948, 5206.401263854667, 5209.505097015777, 5216.478352164791, 5242.475752424765, 5256.185291279858, 176991.0, 177944.0, 178902.0, 179022.0, 179287.10356448396, 47575.5242447578, 47602.047959040625, 47603.8578263972, 47740.0, 47775.0, 49465.25802112971, 49663.50336496661, 49694.75152624214, 49709.0, 49868.75065624721, 16044.839551604568, 16319.265633046542, 16341.91829040871, 16413.917930410273, 16464.92977956429, 13558.322083895766, 13567.796483052762, 13568.525101621395, 13570.93214533921, 13581.524646637321, 14182.503612373725, 14413.279336033156, 14416.495422660157, 14420.125383700262, 14448.638784030272, 5825.912611310834, 5832.445917637818, 5862.794802181903, 5887.11693246008, 5887.705614719247, 1005.8390657494766, 1011.2668315471371, 1015.7003683913264, 1015.918726501878, 1018.1447584029303, 21800.781992179876, 21955.451113722283, 22022.348323875773, 22186.55626887453, 22396.55206895853, 1123.9157063220127, 1126.5887950897863, 1127.4813585750646, 1127.881572434899, 1128.198978725098, 11897.479905602435, 11919.821202681967, 11985.700357491132, 12028.458719357475, 12068.141540054505, 207297.0, 207947.0, 208411.0, 208426.0, 208738.0, 51440.742796286526, 53004.20493692598, 56648.0, 56731.71634141803, 57162.99999999917, 1413.5900588829124, 1447.623617859343, 1453.2225259486336, 1466.3254902744643, 1474.0050465935665, 27036.59445108364, 27337.589936150576, 27927.581086283317, 27933.16200513988, 28067.859660701564, 37109.0, 37230.0, 37335.6266437343, 37367.43948840715, 37371.0, 193852.0, 193978.0, 193980.0, 194891.0, 195396.0, 32311.0, 32493.512597310586, 32500.674993249766, 32561.837190813894, 33310.16724581905, 41758.37362439505, 41958.79020605, 41983.370249446896, 42145.0, 42813.0, 31173.753049877752, 31302.843485782425, 31452.685473144975, 31528.054158375286, 32065.358692825546, 30694.23264418318, 30953.380932381675, 31530.36939261248, 31747.0, 32260.35479290448, 35058.298834022666, 35195.64804352026, 35662.465063023556, 36243.27513449769, 36247.45628815517, 31018.534721978736, 31241.37517249597, 31296.530552042193, 31783.84108079445, 32136.35727285488, 22434.439139021655, 22657.093716251824, 22743.31770046901, 22811.771882281628, 22845.200417985292], "value": 16997.299384386995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.3184691747646, 559.2729451712773, 576.9134629805528, 583.8948989181947, 587.6209844650201, 15719.685606287867, 16460.423885164022, 21560.0, 21717.0, 21741.239056633, 23138.88430557849, 23385.181518646852, 23472.17847375342, 23503.76496235037, 23509.5298094038, 3853.5183102112237, 6224.8755024899365, 6371.681415929208, 6383.265924418705, 6403.8399040023905, 3996.0409501719523, 6560.606363618174, 6564.179477565304, 6571.047198156264, 6631.502637302197, 6594.505412094089, 6608.372204640552, 6608.603483790988, 6611.636360000198, 6615.636140012298, 6553.737850485975, 6554.442872355856, 6584.93415065848, 6595.604263744191, 6597.769078082292, 6083.96572582662, 6101.0, 6116.816495505142, 6119.112728654365, 6120.081987701836, 26561.804718787702, 27347.316317092034, 27885.860570697016, 28030.299242518897, 28121.85939070312, 2046.2224354745101, 2076.3874656976227, 2081.718967939339, 2084.530980529384, 2084.770675225724, 18559.0, 18781.81218187828, 18902.149403276748, 19022.61954760897, 19173.137208825498, 2410.240774156153, 2415.903363865443, 2474.616434452663, 2542.872856357193, 2544.9618255726177, 111825.0, 117397.41301293438, 128191.0, 134580.0, 134934.999999999, 14383.625307588036, 14427.711445771025, 14629.507935559723, 14661.560153195207, 14791.334389952477, 19308.613827723366, 19485.707714384294, 19582.510437239183, 19629.50926226827, 19655.606887862163, 9118.40730352525, 9206.539673016456, 9239.72280831576, 9245.399049061789, 9324.580393882292, 8488.702895398632, 8666.350023748244, 8673.392862499564, 8680.218780309677, 8732.083131271253, 8140.674373025131, 8301.169883011771, 8437.493750374997, 8461.111583283666, 8631.180037896389, 2565.9230223093336, 2571.344307201689, 2611.34179795831, 2643.82349854313, 2665.680118385806, 950.5484894674975, 958.91849192818, 962.4610218277647, 982.2289502740315, 986.5067466266867, 17871.73192402115, 18227.17977691007, 18320.083995800156, 18349.0, 18528.722069168973, 1023.6775415744016, 1024.390487659856, 1038.8285932821152, 1040.105509262034, 1040.7398150462384, 10252.692419227435, 10312.43281619503, 10386.740331491623, 10451.320664156805, 10509.369437833755, 448985.0, 450230.0, 454298.0, 456368.0, 460101.0, 105592.47203763932, 106027.46986265173, 107266.0, 107464.0, 108121.45939270411, 1032.3496197395743, 1075.1398880895254, 1125.4597793059377, 1164.6331405607207, 1182.988170118305, 19811.702824457934, 19897.403077907686, 20149.19403223913, 20190.798092018893, 20513.692294615295, 54635.726821365635, 56006.719966399905, 56500.71749641225, 57557.71221143867, 57663.13505297508, 66132.66933665301, 66195.66902165458, 66368.33631663621, 66624.6668766653, 66850.0, 13666.93166534161, 13694.767470927663, 13821.723565528835, 13825.548317426525, 13840.930795346361, 21291.574168516232, 21511.46221344479, 21680.56638867182, 21957.67063494081, 21977.23079692203, 17140.914295428443, 17858.91070544639, 17928.19323130436, 17995.19021644003, 18041.909790450965, 15532.844671553139, 15994.360225590846, 16182.271797768894, 16498.17509124563, 16522.50432487027, 17709.20308586091, 17884.10579470995, 18116.72824907654, 18156.27374904989, 18159.36442224516, 13487.190768553919, 13656.385462654005, 13689.110207836458, 13793.448262069405, 13910.0, 17417.47747567575, 17522.211500482255, 17584.94490330584, 17611.207495662984, 17614.383496577557], "value": 11416.073229086365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.1176379471447, 1408.8098106755585, 1417.99291003545, 1421.289355322339, 1425.1947649577987, 14846.480373186942, 15297.158656273901, 15491.92254038731, 15547.844521554782, 15559.92220038901, 15120.0, 15302.770458443132, 15328.0, 15329.463468778595, 15344.769828452581, 2738.657667791521, 2836.1916853696703, 2843.331817023008, 2843.7440630343267, 2847.4305138972186, 2654.721254268303, 2802.0, 2816.8028587850185, 2829.066408085337, 2830.249983754307, 2690.4888071266496, 2796.9440611187765, 2802.2574017885277, 2805.6072149899032, 2807.171884294138, 2808.283887608657, 2810.058630358832, 2838.985805070982, 2842.204182828811, 2843.431313737261, 2697.2852194168563, 2793.6368272124696, 2801.5657573076, 2812.2828678686806, 2823.39297051135, 14745.336459859333, 14899.255037248202, 14906.478273260384, 14911.403543858232, 14965.326560304813, 7995.600219988977, 8247.793805154859, 8248.670053197864, 8259.256666899948, 8268.462549934235, 5466.371367292772, 5730.025895597759, 5793.420657934173, 5862.97068514659, 5871.765129394862, 1903.8476921846357, 1909.3221906223368, 1910.245453046053, 1928.431112821721, 1955.7653081630153, 26198.0, 26364.86817565919, 26516.071937482095, 26555.0, 26605.467890642274, 6558.081868538313, 6721.865562688817, 6785.355391237825, 6826.624535650587, 6832.111825462658, 17087.829121708874, 17115.486535403958, 17154.142292885306, 17221.655566888592, 17302.480925572254, 7448.255174482617, 7763.72826951054, 7937.8412431752195, 8010.0, 8012.3590112790835, 7279.2720727927845, 7403.777886663301, 7426.814329641694, 7427.0, 7486.401087912954, 5092.949070509321, 5185.637005409585, 5238.349919775259, 5273.578113750891, 5288.735563221823, 1542.9228538573252, 1543.7221300166077, 1544.4054039194991, 1545.1072436265708, 1558.0807323679085, 859.0636206534907, 860.3289434241302, 865.6667183134539, 875.159846547309, 891.5141248019845, 7256.201817800038, 8096.595170241464, 8251.587420628945, 8347.248747612744, 8380.916190838136, 695.5861262548775, 696.1715558485387, 712.1667648850857, 713.6610110197614, 717.2827172827173, 4340.82636694535, 4371.169477799272, 5417.566594672417, 5613.775448982076, 5760.0783874579865, 21104.472388190417, 21726.0, 21949.890250548964, 22031.889840550695, 22304.665430018562, 21270.89364553198, 21444.0, 21486.24798132058, 21528.0, 21612.0, 10935.234533582732, 11049.226554141133, 11337.0, 11585.015273701661, 11665.0, 8142.51144931306, 8266.586670666322, 8299.29455996247, 8680.0, 8989.0, 18462.907685461487, 18543.258269669062, 18829.117088291063, 18938.52653683669, 18961.43115706531, 19054.523636909187, 19159.8084019158, 19253.518662033563, 19282.32511862078, 19376.321828735927, 12091.939540302243, 12491.0, 12502.374881256083, 12504.749525047422, 12510.061745368952, 13791.172529648253, 13794.793078104038, 13812.0, 13984.790228146383, 14011.859881401055, 11343.432828358384, 11349.319040857576, 11386.601468948547, 11614.709632258922, 11635.709107272385, 10932.234743568191, 11026.944865275622, 11129.054030407506, 11197.384143872165, 11486.19596628228, 9352.766180845261, 9462.053794620759, 9478.95260523693, 9585.281103917374, 9590.280728945496, 6591.505637077143, 6645.867082658417, 6664.933350666625, 6681.832954176184, 6771.0, 6881.10545629065, 6899.896501552581, 6964.547304425196, 6966.79099627012, 6978.267281935527], "value": 6658.1314859879785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.38838311451605, 513.6507175120919, 526.344700847445, 529.2405398253505, 530.9017831701135, 6086.543509236808, 6152.477039451646, 6249.375062493748, 6249.375062493748, 6250.374962503742, 6056.606320589159, 6065.332813390534, 6101.1153382759585, 6119.66341851198, 6142.928535732134, 4894.730789806559, 4968.850934471971, 4975.6765810222405, 4978.825741099062, 4981.950180498185, 5003.47463516331, 5022.874428139289, 5034.903534326381, 5047.722375269359, 5048.1418158913075, 4969.130402179622, 4976.4774698656665, 4979.825706100287, 4994.950050499485, 5029.974850125763, 4931.556159945604, 4940.135476291634, 4968.975155124202, 4980.651354405193, 4985.302057711923, 4488.8877778055485, 4491.191585514606, 4496.7077139985795, 4517.2998185281, 4536.387587675687, 6095.238095238095, 6179.783707570258, 6223.502119830403, 6236.43872051513, 6248.187735594389, 5554.722413844798, 5597.832065038015, 5631.971840140773, 5682.0, 5708.857278568027, 6504.154459920227, 6551.475881929434, 6557.770478033293, 6565.770198043093, 6578.967105164444, 4867.0, 4896.290037944514, 4899.2896030075435, 4902.705837649717, 4907.656464047518, 6803.693833777492, 6837.829054273633, 6844.589324640538, 6870.31296870309, 6883.58886428281, 4908.705477671351, 4955.182394904872, 4959.132151873408, 4987.351644286219, 4991.850244492598, 4978.352814134212, 5035.77339019745, 5036.992601479718, 5046.596272298208, 5047.2429135629945, 5598.412166722517, 5622.32532096151, 5647.350554686182, 5662.773489060474, 5677.687727175045, 6196.8760624787255, 6364.872702545923, 6449.451796597248, 6524.902126468011, 6565.474762019027, 1654.4292219184363, 1728.1272957156555, 1735.470681442147, 1739.6346767178782, 1743.3375317379569, 1193.8806119388166, 1200.8198770184542, 1211.7515909238762, 1217.719924417389, 1228.177121328712, 5487.368952570506, 5573.832785016456, 5598.412166722435, 5635.802746903839, 5684.261046063985, 6411.6153030818305, 6466.935330646727, 6548.70530826114, 6557.540972132, 6597.373249541286, 5667.773289068391, 5679.460451257124, 5708.0, 5726.856828579235, 5742.339630942495, 3456.1532424556144, 3509.3156834417046, 3521.8063006534885, 3535.1338921964284, 3578.409562422223, 6432.35676432353, 6441.581297215666, 6468.288488266287, 6473.06140609609, 6479.50971276609, 6744.133743159137, 6752.932470675329, 6759.222689390783, 6763.966180169166, 6811.352921472452, 6466.189466949168, 6469.902951455826, 6503.642299673564, 6504.414602685781, 6516.250631177475, 6639.037339585637, 6658.966705166443, 6669.132273122604, 6702.83242918931, 6708.295628959084, 6444.162258906312, 6501.869962600627, 6550.279469258282, 6582.913819219775, 6606.405423511907, 6314.715837787218, 6341.0805433212845, 6369.267534233622, 6388.55280130405, 6388.936110638834, 4886.560209581155, 4929.630277729257, 4946.134426475281, 4951.158303088411, 4962.727050012284, 6492.415682588589, 6616.106825578678, 6707.66461676924, 6710.261871194067, 6711.563748356341, 6012.5791194617705, 6351.428371446592, 6393.8721225576155, 6415.679216039086, 6462.127612772216, 6448.967755161194, 6464.903026454513, 6466.159399278064, 6483.286838447862, 6485.086899364793, 6301.4328710416285, 6320.6839658016, 6375.171227740364, 6383.265924418752, 6404.103425520524, 6429.967850160906, 6445.227562420372, 6502.382273683992, 6537.803865884031, 6571.638559879252, 6178.66017369049, 6180.938190618216, 6195.380461953769, 6196.1635179250225, 6272.0], "value": 5010.708332830371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [919.3886065766266, 921.4931787516865, 952.0859974424552, 953.8330792111383, 962.2542529539608, 17850.375236866712, 18722.43832685018, 18774.34289799859, 18777.15502802374, 18790.53023674409, 15835.0, 15910.045397276142, 15918.840811591881, 15966.84033159668, 16772.58068548287, 982.2583949118424, 988.9307748457611, 990.4404011733384, 992.7964767222702, 992.9553170107326, 817.239966830847, 818.8403261364036, 819.3895547816855, 820.6266148902235, 968.2012339819642, 1043.572135424476, 1061.8938106189396, 1063.1494804156644, 1063.2450959818539, 1063.611781699678, 1040.2614143957799, 1044.7544826965695, 1048.8846226915034, 1053.0364716284591, 1053.3206082077056, 720.9963950180268, 739.7669734033763, 743.5129989856598, 745.4893398022318, 764.7361660227212, 18843.0, 19156.521086972796, 19159.616807663908, 19246.61506769871, 19514.219431222733, 20080.59838803216, 20147.0, 20611.0, 20618.896905515525, 20722.378328650164, 16789.6642067158, 16806.915965420096, 16858.662826743395, 16912.0, 16939.49181524556, 3837.597052309495, 3851.326017946876, 3872.0900588361715, 3872.4191371294532, 3873.0511024799102, 127890.0, 129708.0, 130780.34609826985, 134190.0, 135578.3221083898, 14749.041312314665, 14782.778258326134, 15361.001534900195, 15894.60263493422, 16457.91771041161, 27056.86471567669, 27435.45129097407, 27859.0, 27940.58089128665, 27951.161465156078, 8032.39757018226, 8108.472949258279, 8112.18878112184, 8155.755327340189, 8163.061247956561, 4108.301588729923, 4193.622573968297, 4199.0552125771455, 4200.390943313264, 4204.978975105105, 4790.712557246577, 4830.3237546743485, 4863.294822250754, 4887.9246565755475, 4911.87720306988, 996.0537489385113, 997.3716558568055, 1015.5836107196162, 1015.6242190389603, 1017.6031347774374, 666.8966310221826, 680.3263970632202, 684.7055766020659, 692.7159864455549, 697.7209116353499, 11001.339919604688, 11061.557537698402, 11167.553297868157, 11663.0, 11896.464659090188, 665.3944910131756, 684.6131935456451, 686.0772261308532, 692.6190595172635, 695.8956156576554, 4942.20924652054, 5000.949990500121, 5035.194368900959, 5061.721605311744, 5125.179971204664, 123284.0, 125860.37069814593, 126178.0, 127788.0, 131726.34136829255, 85804.0, 86388.0, 96860.0, 110704.0, 114902.0, 87819.0, 90071.09561185699, 91012.54493727488, 91593.5420322894, 92591.0, 11914.0, 12042.698932526757, 12117.575884843987, 12347.69130771702, 12378.504859805507, 41037.38443923403, 41985.58014419817, 43012.78493607512, 43303.350449743906, 44650.330245047, 54132.72933635306, 54709.72645136908, 55709.442905570424, 55989.72005139948, 56792.432075680365, 16789.580260493585, 16927.576810579834, 16957.915210423867, 16987.40544080951, 17088.829111708725, 20481.0, 20628.587428251052, 20750.688739668614, 21015.054322555217, 21085.367438976857, 17215.139243038047, 17251.654966900842, 17276.827231727522, 17355.913220434322, 17591.208395621972, 17954.19206135753, 17958.19188136511, 18246.17892194881, 18255.90872045631, 18322.725159122358, 18083.728744068587, 18110.456686299432, 18156.0, 18210.72683909716, 18289.908550457163, 11951.641450756491, 11986.340751258764, 12016.699582510508, 12049.698757531132, 12357.93821030889, 11963.401829908296, 12006.159568830448, 12061.0, 12123.090768192596, 12286.569970051363], "value": 8846.714323952, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 107.0, 108.0, 108.0, 107.0, 107.0, 108.0, 108.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 115.0, 116.0, 115.0, 120.0, 117.0, 123.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 162.0, 163.0, 163.0, 164.0, 168.0, 167.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 73.0, 75.0, 74.0, 73.0, 72.0, 75.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 79.0, 79.0, 78.0, 79.0, 79.0, 81.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 117.0, 113.0, 113.0, 115.0, 115.0, 115.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 146.0, 147.0, 150.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 52.0, 53.0, 54.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 39.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 75.0, 77.0, 77.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 122.0, 113.0, 122.0, 110.0, 117.0, 114.0, 124.0, 109.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 165.0, 173.0, 166.0, 170.0, 168.0, 175.0, 164.0, 165.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 70.0, 67.0, 65.0, 65.0, 63.0, 64.0, 64.0], "value": 64.9, "unit": "score"}]}]} 03:43:07 INFO - Return code: 0 03:43:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:07 INFO - # TBPL SUCCESS # 03:43:07 INFO - Running post-action listener: _package_coverage_data 03:43:07 INFO - Running post-action listener: _resource_record_post_action 03:43:07 INFO - [mozharness: 2017-09-16 10:43:07.820560Z] Finished run-tests step (success) 03:43:07 INFO - Running post-run listener: _resource_record_post_run 03:43:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 9613312; Write bytes: 468279296; Read time: 3852; Write time: 527956 03:43:07 INFO - TinderboxPrint: CPU usage
13.1% 03:43:07 INFO - TinderboxPrint: I/O read bytes / time
9,613,312 / 3,852 03:43:07 INFO - TinderboxPrint: I/O write bytes / time
468,279,296 / 527,956 03:43:07 INFO - TinderboxPrint: CPU idle
8,261.7 (86.9%) 03:43:07 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 03:43:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 94863360; Read time: 64; Write time: 74068 03:43:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:07 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 7237632; Write bytes: 373415936; Read time: 3240; Write time: 453888 03:43:08 INFO - Running post-run listener: _upload_blobber_files 03:43:08 INFO - Blob upload gear active. 03:43:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:09 INFO - (blobuploader) - INFO - Done attempting. 03:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:17 INFO - (blobuploader) - INFO - Done attempting. 03:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:18 INFO - (blobuploader) - INFO - Done attempting. 03:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:19 INFO - (blobuploader) - INFO - Done attempting. 03:43:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:19 INFO - Return code: 0 03:43:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26bc1750ec4a4ca6cc027fbbeaefb23f0924e13a98cc1285349836e9b7bd864bef6516b8275629602de296289c1d3728a9230df29e3c7f5e3b45c14b2ee57b3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dc8335468663b805e28b689d7e44425a76c782a0f839eea8413d3502ced558e9f556460969d37acb5e2218bd6680f5165bd66f6730c003dcce14e9f70c4a5b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5000101515d2916dba268f185695d12a7508d18c9a7dd7d29799e61c1cb5dd1222fadff7deb3c7001f29c6838ee0775aa716f666b34185c66454ba2f48db88a3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e90bb32abf8d80a0b38c3c7e19aadc1c48983ab18c813f589d450260d6d53863cc1102b45361f21b5733f7e86b18b9849d9e4a1c349e9dedd52cdd0b1f1a142c"} 03:43:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:19 INFO - Contents: 03:43:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26bc1750ec4a4ca6cc027fbbeaefb23f0924e13a98cc1285349836e9b7bd864bef6516b8275629602de296289c1d3728a9230df29e3c7f5e3b45c14b2ee57b3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dc8335468663b805e28b689d7e44425a76c782a0f839eea8413d3502ced558e9f556460969d37acb5e2218bd6680f5165bd66f6730c003dcce14e9f70c4a5b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5000101515d2916dba268f185695d12a7508d18c9a7dd7d29799e61c1cb5dd1222fadff7deb3c7001f29c6838ee0775aa716f666b34185c66454ba2f48db88a3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e90bb32abf8d80a0b38c3c7e19aadc1c48983ab18c813f589d450260d6d53863cc1102b45361f21b5733f7e86b18b9849d9e4a1c349e9dedd52cdd0b1f1a142c"} 03:43:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:19 INFO - Copying logs to upload dir... 03:43:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.340019 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-16 03:43:19.232065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:19.236115) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 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-Non-PGO/sha512/26bc1750ec4a4ca6cc027fbbeaefb23f0924e13a98cc1285349836e9b7bd864bef6516b8275629602de296289c1d3728a9230df29e3c7f5e3b45c14b2ee57b3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dc8335468663b805e28b689d7e44425a76c782a0f839eea8413d3502ced558e9f556460969d37acb5e2218bd6680f5165bd66f6730c003dcce14e9f70c4a5b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5000101515d2916dba268f185695d12a7508d18c9a7dd7d29799e61c1cb5dd1222fadff7deb3c7001f29c6838ee0775aa716f666b34185c66454ba2f48db88a3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e90bb32abf8d80a0b38c3c7e19aadc1c48983ab18c813f589d450260d6d53863cc1102b45361f21b5733f7e86b18b9849d9e4a1c349e9dedd52cdd0b1f1a142c"} build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26bc1750ec4a4ca6cc027fbbeaefb23f0924e13a98cc1285349836e9b7bd864bef6516b8275629602de296289c1d3728a9230df29e3c7f5e3b45c14b2ee57b3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dc8335468663b805e28b689d7e44425a76c782a0f839eea8413d3502ced558e9f556460969d37acb5e2218bd6680f5165bd66f6730c003dcce14e9f70c4a5b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5000101515d2916dba268f185695d12a7508d18c9a7dd7d29799e61c1cb5dd1222fadff7deb3c7001f29c6838ee0775aa716f666b34185c66454ba2f48db88a3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e90bb32abf8d80a0b38c3c7e19aadc1c48983ab18c813f589d450260d6d53863cc1102b45361f21b5733f7e86b18b9849d9e4a1c349e9dedd52cdd0b1f1a142c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:19.264345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:19.264687) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505544301.871206-1967399413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:19.350823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:19.351169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:19.351532) ========= ========= Total master_lag: 0.23 =========