builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1506763046.55 results: success (0) revision: 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.550972) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.551425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.551714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.576439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.576727) ========= 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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 02:17:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-09-30 02:17:26 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134394 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.744280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.744650) ========= 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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:26.794876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-30 02:17:26.795211) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 --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 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 --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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 02:17:26,772 truncating revision to first 12 chars 2017-09-30 02:17:26,772 Setting DEBUG logging. 2017-09-30 02:17:26,772 attempt 1/10 2017-09-30 02:17:26,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59e5ec5729db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 02:17:27,396 attempt 1/10 2017-09-30 02:17:27,973 current task status: no status available at this point. state: STARTED 2017-09-30 02:17:27,973 sleeping for 11.00s (attempt 1/10) 2017-09-30 02:17:38,984 attempt 2/10 2017-09-30 02:17:39,526 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-30 02:17:39,714 unpacking tar archive at: mozilla-central-59e5ec5729db/testing/mozharness/ program finished with exit code 0 elapsedTime=13.208487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-30 02:17:40.022338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:40.022616) ========= script_repo_revision: 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:40.026026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:40.026295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 02:17:40.044017) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-30 02:17:40.044325) ========= /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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:40 INFO - MultiFileLogger online at 20170930 02:17:40 in /builds/slave/test 02:17:40 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 02:17:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:40 INFO - {'append_to_log': False, 02:17:40 INFO - 'base_work_dir': '/builds/slave/test', 02:17:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:17:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:40 INFO - 'branch': 'Firefox-Non-PGO', 02:17:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:40 INFO - 'code_coverage': False, 02:17:40 INFO - 'config_files': ('talos/linux_config.py',), 02:17:40 INFO - 'default_actions': ('clobber', 02:17:40 INFO - 'read-buildbot-config', 02:17:40 INFO - 'download-and-extract', 02:17:40 INFO - 'populate-webroot', 02:17:40 INFO - 'create-virtualenv', 02:17:40 INFO - 'install', 02:17:40 INFO - 'setup-mitmproxy', 02:17:40 INFO - 'run-tests'), 02:17:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:40 INFO - 'disable_ccov_upload': False, 02:17:40 INFO - 'disable_stylo': False, 02:17:40 INFO - 'download_minidump_stackwalk': True, 02:17:40 INFO - 'download_symbols': 'ondemand', 02:17:40 INFO - 'enable_stylo': False, 02:17:40 INFO - 'enable_webrender': False, 02:17:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:17:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:40 INFO - 'gecko_profile': False, 02:17:40 INFO - 'gecko_profile_interval': 0, 02:17:40 INFO - 'installer_path': 'installer.exe', 02:17:40 INFO - 'log_level': 'info', 02:17:40 INFO - 'log_name': 'talos', 02:17:40 INFO - 'log_to_console': True, 02:17:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:40 INFO - 'opt_config_files': (), 02:17:40 INFO - 'pip_index': False, 02:17:40 INFO - 'suite': 'dromaeojs-e10s', 02:17:40 INFO - 'system_bits': '32', 02:17:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:40 INFO - 'title': 'talos-linux64-ix-070', 02:17:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:40 INFO - 'use_talos_json': True, 02:17:40 INFO - 'verify': 'False', 02:17:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:40 INFO - 'work_dir': 'build'} 02:17:40 INFO - [mozharness: 2017-09-30 09:17:40.166628Z] Running clobber step. 02:17:40 INFO - Running pre-action listener: _resource_record_pre_action 02:17:40 INFO - Running main action method: clobber 02:17:40 INFO - rmtree: /builds/slave/test/build 02:17:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:41 INFO - Running post-action listener: _resource_record_post_action 02:17:41 INFO - [mozharness: 2017-09-30 09:17:41.666724Z] Finished clobber step (success) 02:17:41 INFO - [mozharness: 2017-09-30 09:17:41.666821Z] Running read-buildbot-config step. 02:17:41 INFO - Running pre-action listener: _resource_record_pre_action 02:17:41 INFO - Running main action method: read_buildbot_config 02:17:41 INFO - Using buildbot properties: 02:17:41 INFO - { 02:17:41 INFO - "project": "", 02:17:41 INFO - "product": "firefox", 02:17:41 INFO - "who": "archaeopteryx@coole-files.de", 02:17:41 INFO - "installer_path": "public/build/target.tar.bz2", 02:17:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:17:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:17:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:17:41 INFO - "stage_platform": "linux64", 02:17:41 INFO - "basedir": "/builds/slave/test", 02:17:41 INFO - "buildnumber": 884, 02:17:41 INFO - "platform": "ubuntu64_hw", 02:17:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:17:41 INFO - "slavebuilddir": "test", 02:17:41 INFO - "taskId": "dZZPeNpLRU2G04u5OMDnPQ", 02:17:41 INFO - "branch": "mozilla-central", 02:17:41 INFO - "script_repo_revision": "production", 02:17:41 INFO - "revision": "59e5ec5729db9ee88c1b469f3ae0092fcedc8c44", 02:17:41 INFO - "slavename": "talos-linux64-ix-070", 02:17:41 INFO - "repo_path": "mozilla-central" 02:17:41 INFO - } 02:17:41 INFO - Finding installer, test and symbols from parent task. 02:17:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZZPeNpLRU2G04u5OMDnPQ'}, attempt #1 02:17:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZZPeNpLRU2G04u5OMDnPQ'}, attempt #1 02:17:42 INFO - Task dependencies: An79CafaRoS1gX-FTBpPPA 02:17:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA'}, attempt #1 02:17:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 02:17:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.test_packages.json 02:17:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.crashreporter-symbols.zip 02:17:43 INFO - Running post-action listener: _resource_record_post_action 02:17:43 INFO - [mozharness: 2017-09-30 09:17:43.052209Z] Finished read-buildbot-config step (success) 02:17:43 INFO - [mozharness: 2017-09-30 09:17:43.052430Z] Running download-and-extract step. 02:17:43 INFO - Running pre-action listener: _resource_record_pre_action 02:17:43 INFO - Running main action method: download_and_extract 02:17:43 INFO - mkdir: /builds/slave/test/build/tests 02:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:43 INFO - trying https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.test_packages.json 02:17:43 INFO - Downloading https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:17:43 INFO - Downloaded 989 bytes. 02:17:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:17:43 INFO - Using the following test package requirements: 02:17:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:17:43 INFO - u'common': [u'target.common.tests.zip'], 02:17:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:17:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:17:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:17:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:17:43 INFO - u'mozbase': [u'target.common.tests.zip'], 02:17:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:17:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:17:43 INFO - u'web-platform': [u'target.common.tests.zip', 02:17:43 INFO - u'target.web-platform.tests.tar.gz'], 02:17:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:17:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:17:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.common.tests.zip 02:17:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:17:43 INFO - Fetch https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.common.tests.zip into memory 02:17:44 INFO - Content-Length response header: 55366769 02:17:44 INFO - Bytes received: 55366769 02:17:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.talos.tests.zip 02:17:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:17:55 INFO - Fetch https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.talos.tests.zip into memory 02:17:56 INFO - Content-Length response header: 14522385 02:17:56 INFO - Bytes received: 14522385 02:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:56 INFO - trying https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 02:17:56 INFO - Downloading https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:17:57 INFO - Downloaded 61605588 bytes. 02:17:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 02:17:57 INFO - mkdir: /builds/slave/test/properties 02:17:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:57 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:57 INFO - Contents: 02:17:57 INFO - build_url:https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 02:17:57 INFO - Running post-action listener: _resource_record_post_action 02:17:57 INFO - Running post-action listener: find_tests_for_verification 02:17:57 INFO - Running post-action listener: set_extra_try_arguments 02:17:57 INFO - [mozharness: 2017-09-30 09:17:57.989842Z] Finished download-and-extract step (success) 02:17:57 INFO - [mozharness: 2017-09-30 09:17:57.989941Z] Running populate-webroot step. 02:17:57 INFO - Running pre-action listener: _resource_record_pre_action 02:17:57 INFO - Running main action method: populate_webroot 02:17:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:17:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['tresize', 02:17:58 INFO - 'tcanvasmark']}, 02:17:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:17:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['dromaeo_css', 02:17:58 INFO - 'kraken']}, 02:17:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'tests': ['damp', 'tps']}, 02:17:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['damp', 'tps']}, 02:17:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['dromaeo_dom']}, 02:17:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:17:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['basic_compositor_video', 02:17:58 INFO - 'glvideo']}, 02:17:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:17:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['ts_paint_webext', 02:17:58 INFO - 'tp5o_webext']}, 02:17:58 INFO - 'other-e10s': {'tests': ['a11yr', 02:17:58 INFO - 'ts_paint', 02:17:58 INFO - 'tpaint', 02:17:58 INFO - 'sessionrestore', 02:17:58 INFO - 'sessionrestore_many_windows', 02:17:58 INFO - 'sessionrestore_no_auto_restore', 02:17:58 INFO - 'tabpaint', 02:17:58 INFO - 'cpstartup']}, 02:17:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['a11yr', 02:17:58 INFO - 'ts_paint', 02:17:58 INFO - 'tpaint', 02:17:58 INFO - 'sessionrestore', 02:17:58 INFO - 'sessionrestore_many_windows', 02:17:58 INFO - 'sessionrestore_no_auto_restore', 02:17:58 INFO - 'tabpaint', 02:17:58 INFO - 'cpstartup']}, 02:17:58 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 02:17:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:17:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['perf_reftest_singletons']}, 02:17:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['perf_reftest']}, 02:17:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:17:58 INFO - 'tsvgr_opacity', 02:17:58 INFO - 'tart', 02:17:58 INFO - 'tscrollx', 02:17:58 INFO - 'tsvg_static']}, 02:17:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['tsvgx', 02:17:58 INFO - 'tsvgr_opacity', 02:17:58 INFO - 'tart', 02:17:58 INFO - 'tscrollx', 02:17:58 INFO - 'tsvg_static']}, 02:17:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:17:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--disable-stylo'], 02:17:58 INFO - 'tests': ['tp5o']}, 02:17:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:17:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:17:58 INFO - 'talos_options': ['--mitmproxy', 02:17:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:17:58 INFO - '--firstNonBlankPaint'], 02:17:58 INFO - 'tests': ['tp6_google', 02:17:58 INFO - 'tp6_youtube', 02:17:58 INFO - 'tp6_amazon', 02:17:58 INFO - 'tp6_facebook']}, 02:17:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:17:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:17:58 INFO - 'talos_options': ['--disable-stylo', 02:17:58 INFO - '--mitmproxy', 02:17:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:17:58 INFO - '--firstNonBlankPaint'], 02:17:58 INFO - 'tests': ['tp6_google', 02:17:58 INFO - 'tp6_youtube', 02:17:58 INFO - 'tp6_amazon', 02:17:58 INFO - 'tp6_facebook']}, 02:17:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:17:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:17:58 INFO - 'talos_options': ['--stylo-threads=1', 02:17:58 INFO - '--mitmproxy', 02:17:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:17:58 INFO - '--firstNonBlankPaint'], 02:17:58 INFO - 'tests': ['tp6_google', 02:17:58 INFO - 'tp6_youtube', 02:17:58 INFO - 'tp6_amazon', 02:17:58 INFO - 'tp6_facebook']}, 02:17:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--xperf_path', 02:17:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:58 INFO - 'tests': ['tp5n']}, 02:17:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:17:58 INFO - 'talos_options': ['--disable-stylo', 02:17:58 INFO - '--xperf_path', 02:17:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:58 INFO - 'tests': ['tp5n']}}} 02:17:58 INFO - Running post-action listener: _resource_record_post_action 02:17:58 INFO - [mozharness: 2017-09-30 09:17:58.012974Z] Finished populate-webroot step (success) 02:17:58 INFO - [mozharness: 2017-09-30 09:17:58.013064Z] Running create-virtualenv step. 02:17:58 INFO - Running pre-action listener: _resource_record_pre_action 02:17:58 INFO - Running main action method: create_virtualenv 02:17:58 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:17:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:17:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:17:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:58 INFO - Installing pip...............done. 02:17:58 INFO - Return code: 0 02:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:17:58 INFO - Reading from file tmpfile_stdout 02:17:58 INFO - Output received: 02:17:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:17:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17: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')]} 02:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17: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')]} 02:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:17: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', 'pip>=1.5'] in /builds/slave/test/build 02:17: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 pip>=1.5 02:17:58 INFO - Using env: {'DISPLAY': ':0', 02:17:59 INFO - 'HOME': '/home/cltbld', 02:17:59 INFO - 'LANG': 'en_US.UTF-8', 02:17:59 INFO - 'LANGUAGE': 'en_US:en', 02:17:59 INFO - 'LOGNAME': 'cltbld', 02:17:59 INFO - 'MAIL': '/var/mail/cltbld', 02:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:59 INFO - 'MOZ_NO_REMOTE': '1', 02:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:59 INFO - 'NO_EM_RESTART': '1', 02:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:59 INFO - 'PWD': '/builds/slave/test', 02:17:59 INFO - 'SHELL': '/bin/bash', 02:17:59 INFO - 'SHLVL': '1', 02:17:59 INFO - 'TERM': 'linux', 02:17:59 INFO - 'TMOUT': '86400', 02:17:59 INFO - 'USER': 'cltbld', 02:17:59 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:59 INFO - '_': '/tools/buildbot/bin/python'} 02:18:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:18:00 INFO - Downloading/unpacking pip>=1.5 02:18:00 INFO - Running setup.py egg_info for package pip 02:18:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:18:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:18:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:18:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:18:00 INFO - Installing collected packages: pip 02:18:00 INFO - Found existing installation: pip 1.1 02:18:00 INFO - Uninstalling pip: 02:18:00 INFO - Successfully uninstalled pip 02:18:00 INFO - Running setup.py install for pip 02:18:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:18:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:18:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:18:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:18:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:18:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:18:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:18:00 INFO - Successfully installed pip 02:18:00 INFO - Cleaning up... 02:18:00 INFO - Return code: 0 02:18:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18: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')]} 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18: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', '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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:18: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 psutil>=3.1.1 02:18:00 INFO - Using env: {'DISPLAY': ':0', 02:18:00 INFO - 'HOME': '/home/cltbld', 02:18:00 INFO - 'LANG': 'en_US.UTF-8', 02:18:00 INFO - 'LANGUAGE': 'en_US:en', 02:18:00 INFO - 'LOGNAME': 'cltbld', 02:18:00 INFO - 'MAIL': '/var/mail/cltbld', 02:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:00 INFO - 'MOZ_NO_REMOTE': '1', 02:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:00 INFO - 'NO_EM_RESTART': '1', 02:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:00 INFO - 'PWD': '/builds/slave/test', 02:18:00 INFO - 'SHELL': '/bin/bash', 02:18:00 INFO - 'SHLVL': '1', 02:18:00 INFO - 'TERM': 'linux', 02:18:00 INFO - 'TMOUT': '86400', 02:18:00 INFO - 'USER': 'cltbld', 02:18:00 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:00 INFO - '_': '/tools/buildbot/bin/python'} 02:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:00 INFO - Downloading/unpacking psutil>=3.1.1 02:18: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 02:18: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 02:18: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 02:18: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 02:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:18:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:01 INFO - Installing collected packages: psutil 02:18:01 INFO - Running setup.py install for psutil 02:18:01 INFO - building 'psutil._psutil_linux' extension 02:18:01 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 02:18:01 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 02:18:01 INFO - building 'psutil._psutil_posix' extension 02:18:01 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 02:18:02 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 02:18:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:02 INFO - Successfully installed psutil 02:18:02 INFO - Cleaning up... 02:18:02 INFO - Return code: 0 02:18:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18: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')]} 02:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:18: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 mozsystemmonitor==0.3 02:18:02 INFO - Using env: {'DISPLAY': ':0', 02:18:02 INFO - 'HOME': '/home/cltbld', 02:18:02 INFO - 'LANG': 'en_US.UTF-8', 02:18:02 INFO - 'LANGUAGE': 'en_US:en', 02:18:02 INFO - 'LOGNAME': 'cltbld', 02:18:02 INFO - 'MAIL': '/var/mail/cltbld', 02:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:02 INFO - 'MOZ_NO_REMOTE': '1', 02:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:02 INFO - 'NO_EM_RESTART': '1', 02:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:02 INFO - 'PWD': '/builds/slave/test', 02:18:02 INFO - 'SHELL': '/bin/bash', 02:18:02 INFO - 'SHLVL': '1', 02:18:02 INFO - 'TERM': 'linux', 02:18:02 INFO - 'TMOUT': '86400', 02:18:02 INFO - 'USER': 'cltbld', 02:18:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:02 INFO - '_': '/tools/buildbot/bin/python'} 02:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:18: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 02:18: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 02:18: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 02:18: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 02:18:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:18:03 INFO - Installing collected packages: mozsystemmonitor 02:18:03 INFO - Running setup.py install for mozsystemmonitor 02:18:03 INFO - Successfully installed mozsystemmonitor 02:18:03 INFO - Cleaning up... 02:18:04 INFO - Return code: 0 02:18:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:18:04 INFO - Using env: {'DISPLAY': ':0', 02:18:04 INFO - 'HOME': '/home/cltbld', 02:18:04 INFO - 'LANG': 'en_US.UTF-8', 02:18:04 INFO - 'LANGUAGE': 'en_US:en', 02:18:04 INFO - 'LOGNAME': 'cltbld', 02:18:04 INFO - 'MAIL': '/var/mail/cltbld', 02:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:04 INFO - 'MOZ_NO_REMOTE': '1', 02:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:04 INFO - 'NO_EM_RESTART': '1', 02:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:04 INFO - 'PWD': '/builds/slave/test', 02:18:04 INFO - 'SHELL': '/bin/bash', 02:18:04 INFO - 'SHLVL': '1', 02:18:04 INFO - 'TERM': 'linux', 02:18:04 INFO - 'TMOUT': '86400', 02:18:04 INFO - 'USER': 'cltbld', 02:18:04 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:04 INFO - '_': '/tools/buildbot/bin/python'} 02:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:18: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 02:18: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 02:18: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 02:18: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 02:18:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:07 INFO - warning: no files found matching '*.txt' 02:18:07 INFO - no previously-included directories found matching 'build' 02:18:07 INFO - no previously-included directories found matching 'dist' 02:18:07 INFO - no previously-included directories found matching '.git*' 02:18:07 INFO - Installing collected packages: jsonschema, functools32 02:18:07 INFO - Running setup.py install for functools32 02:18:07 INFO - warning: no files found matching '*.txt' 02:18:07 INFO - no previously-included directories found matching 'build' 02:18:07 INFO - no previously-included directories found matching 'dist' 02:18:07 INFO - no previously-included directories found matching '.git*' 02:18:07 INFO - Successfully installed jsonschema functools32 02:18:07 INFO - Cleaning up... 02:18:07 INFO - Return code: 0 02:18:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:18:07 INFO - Using env: {'DISPLAY': ':0', 02:18:07 INFO - 'HOME': '/home/cltbld', 02:18:07 INFO - 'LANG': 'en_US.UTF-8', 02:18:07 INFO - 'LANGUAGE': 'en_US:en', 02:18:07 INFO - 'LOGNAME': 'cltbld', 02:18:07 INFO - 'MAIL': '/var/mail/cltbld', 02:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:07 INFO - 'MOZ_NO_REMOTE': '1', 02:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:07 INFO - 'NO_EM_RESTART': '1', 02:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:07 INFO - 'PWD': '/builds/slave/test', 02:18:07 INFO - 'SHELL': '/bin/bash', 02:18:07 INFO - 'SHLVL': '1', 02:18:07 INFO - 'TERM': 'linux', 02:18:07 INFO - 'TMOUT': '86400', 02:18:07 INFO - 'USER': 'cltbld', 02:18:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:07 INFO - '_': '/tools/buildbot/bin/python'} 02:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:18:07 INFO - Cleaning up... 02:18:07 INFO - Return code: 0 02:18:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:18:07 INFO - Using env: {'DISPLAY': ':0', 02:18:07 INFO - 'HOME': '/home/cltbld', 02:18:07 INFO - 'LANG': 'en_US.UTF-8', 02:18:07 INFO - 'LANGUAGE': 'en_US:en', 02:18:07 INFO - 'LOGNAME': 'cltbld', 02:18:07 INFO - 'MAIL': '/var/mail/cltbld', 02:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:07 INFO - 'MOZ_NO_REMOTE': '1', 02:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:07 INFO - 'NO_EM_RESTART': '1', 02:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:07 INFO - 'PWD': '/builds/slave/test', 02:18:07 INFO - 'SHELL': '/bin/bash', 02:18:07 INFO - 'SHLVL': '1', 02:18:07 INFO - 'TERM': 'linux', 02:18:07 INFO - 'TMOUT': '86400', 02:18:07 INFO - 'USER': 'cltbld', 02:18:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:07 INFO - '_': '/tools/buildbot/bin/python'} 02:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:07 INFO - Downloading/unpacking blobuploader==1.2.4 02:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18: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 02:18: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 02:18: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 02:18: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 02:18:09 INFO - Downloading docopt-0.6.1.tar.gz 02:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:09 INFO - Running setup.py install for blobuploader 02:18:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:09 INFO - Running setup.py install for requests 02:18:09 INFO - Running setup.py install for docopt 02:18:10 INFO - Successfully installed blobuploader requests docopt 02:18:10 INFO - Cleaning up... 02:18:10 INFO - Return code: 0 02:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:10 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')]} 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:10 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')]} 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:10 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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:10 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 02:18:10 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 02:18:10 INFO - Using env: {'DISPLAY': ':0', 02:18:10 INFO - 'HOME': '/home/cltbld', 02:18:10 INFO - 'LANG': 'en_US.UTF-8', 02:18:10 INFO - 'LANGUAGE': 'en_US:en', 02:18:10 INFO - 'LOGNAME': 'cltbld', 02:18:10 INFO - 'MAIL': '/var/mail/cltbld', 02:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:10 INFO - 'MOZ_NO_REMOTE': '1', 02:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:10 INFO - 'NO_EM_RESTART': '1', 02:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:10 INFO - 'PWD': '/builds/slave/test', 02:18:10 INFO - 'SHELL': '/bin/bash', 02:18:10 INFO - 'SHLVL': '1', 02:18:10 INFO - 'TERM': 'linux', 02:18:10 INFO - 'TMOUT': '86400', 02:18:10 INFO - 'USER': 'cltbld', 02:18:10 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:10 INFO - '_': '/tools/buildbot/bin/python'} 02:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:10 INFO - Running setup.py (path:/tmp/pip-HG_f4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:10 INFO - Running setup.py (path:/tmp/pip-8fQSkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:10 INFO - Running setup.py (path:/tmp/pip-LdnJoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:10 INFO - Running setup.py (path:/tmp/pip-RJ8j7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:10 INFO - Running setup.py (path:/tmp/pip-GEvwSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:10 INFO - Running setup.py (path:/tmp/pip-BTMohQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:10 INFO - Running setup.py (path:/tmp/pip-S8Qosn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:10 INFO - Running setup.py (path:/tmp/pip-0acPVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:10 INFO - Running setup.py (path:/tmp/pip-XhR8k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:10 INFO - Running setup.py (path:/tmp/pip-WgVaq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:10 INFO - Running setup.py (path:/tmp/pip-TuSdz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:11 INFO - Running setup.py (path:/tmp/pip-Mr8Cdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:11 INFO - Running setup.py (path:/tmp/pip-Ydvuqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:11 INFO - Running setup.py (path:/tmp/pip-HssyVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:11 INFO - Running setup.py (path:/tmp/pip-c6wFt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:11 INFO - Running setup.py (path:/tmp/pip-SXAJMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:11 INFO - Running setup.py (path:/tmp/pip-7T1BLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:11 INFO - Running setup.py install for manifestparser 02:18:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:11 INFO - Running setup.py install for mozcrash 02:18:11 INFO - Running setup.py install for mozdebug 02:18:11 INFO - Running setup.py install for mozdevice 02:18:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:11 INFO - Running setup.py install for mozfile 02:18:11 INFO - Running setup.py install for mozhttpd 02:18:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozinfo 02:18:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozInstall 02:18:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozleak 02:18:12 INFO - Running setup.py install for mozlog 02:18:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for moznetwork 02:18:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozprocess 02:18:12 INFO - Running setup.py install for mozprofile 02:18:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozrunner 02:18:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:12 INFO - Running setup.py install for mozscreenshot 02:18:13 INFO - Running setup.py install for moztest 02:18:13 INFO - Running setup.py install for mozversion 02:18:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:13 INFO - Cleaning up... 02:18:13 INFO - Return code: 0 02:18:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18: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')]} 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:13 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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:13 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 02:18:13 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 02:18:13 INFO - Using env: {'DISPLAY': ':0', 02:18:13 INFO - 'HOME': '/home/cltbld', 02:18:13 INFO - 'LANG': 'en_US.UTF-8', 02:18:13 INFO - 'LANGUAGE': 'en_US:en', 02:18:13 INFO - 'LOGNAME': 'cltbld', 02:18:13 INFO - 'MAIL': '/var/mail/cltbld', 02:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:13 INFO - 'MOZ_NO_REMOTE': '1', 02:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:13 INFO - 'NO_EM_RESTART': '1', 02:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:13 INFO - 'PWD': '/builds/slave/test', 02:18:13 INFO - 'SHELL': '/bin/bash', 02:18:13 INFO - 'SHLVL': '1', 02:18:13 INFO - 'TERM': 'linux', 02:18:13 INFO - 'TMOUT': '86400', 02:18:13 INFO - 'USER': 'cltbld', 02:18:13 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:13 INFO - '_': '/tools/buildbot/bin/python'} 02:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:13 INFO - Running setup.py (path:/tmp/pip-CXp8j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:13 INFO - Running setup.py (path:/tmp/pip-2IsQW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:13 INFO - Running setup.py (path:/tmp/pip-9dp7xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:13 INFO - Running setup.py (path:/tmp/pip-GpKIJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:13 INFO - Running setup.py (path:/tmp/pip-PmxriE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:13 INFO - Running setup.py (path:/tmp/pip-J3X_Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:13 INFO - Running setup.py (path:/tmp/pip-aCqUvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:13 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)) 02:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:13 INFO - Running setup.py (path:/tmp/pip-ccKo5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:14 INFO - Running setup.py (path:/tmp/pip-_FBcfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:14 INFO - Running setup.py (path:/tmp/pip-yTc6Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:14 INFO - Running setup.py (path:/tmp/pip-097qK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:14 INFO - Running setup.py (path:/tmp/pip-hLlyRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:14 INFO - Running setup.py (path:/tmp/pip-UYc5I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:14 INFO - Running setup.py (path:/tmp/pip-P3sjld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:14 INFO - Running setup.py (path:/tmp/pip-GMd_MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:14 INFO - Running setup.py (path:/tmp/pip-dFxwg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:14 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)) 02:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:14 INFO - Running setup.py (path:/tmp/pip-WbHqCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:14 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)) 02:18:14 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)) 02:18:14 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)) 02:18:14 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)) 02:18:14 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)) 02:18:14 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)) 02:18:14 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)) 02:18:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:14 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 02:18:14 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 02:18:14 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 02:18:14 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 02:18:15 INFO - Downloading blessings-1.6.tar.gz 02:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:15 INFO - Installing collected packages: blessings 02:18:15 INFO - Running setup.py install for blessings 02:18:15 INFO - Successfully installed blessings 02:18:15 INFO - Cleaning up... 02:18:15 INFO - Return code: 0 02:18:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:16 INFO - Reading from file tmpfile_stdout 02:18:16 INFO - Current package versions: 02:18:16 INFO - argparse == 1.2.1 02:18:16 INFO - blessings == 1.6 02:18:16 INFO - blobuploader == 1.2.4 02:18:16 INFO - docopt == 0.6.1 02:18:16 INFO - functools32 == 3.2.3-2 02:18:16 INFO - jsonschema == 2.5.1 02:18:16 INFO - manifestparser == 1.1 02:18:16 INFO - mozInstall == 1.13 02:18:16 INFO - mozcrash == 1.0 02:18:16 INFO - mozdebug == 0.1 02:18:16 INFO - mozdevice == 0.51 02:18:16 INFO - mozfile == 1.2 02:18:16 INFO - mozhttpd == 0.7 02:18:16 INFO - mozinfo == 0.10 02:18:16 INFO - mozleak == 0.1 02:18:16 INFO - mozlog == 3.5 02:18:16 INFO - moznetwork == 0.27 02:18:16 INFO - mozprocess == 0.25 02:18:16 INFO - mozprofile == 0.28 02:18:16 INFO - mozrunner == 6.13 02:18:16 INFO - mozscreenshot == 0.1 02:18:16 INFO - mozsystemmonitor == 0.3 02:18:16 INFO - moztest == 0.8 02:18:16 INFO - mozversion == 1.4 02:18:16 INFO - psutil == 3.1.1 02:18:16 INFO - requests == 1.2.3 02:18:16 INFO - wsgiref == 0.1.2 02:18:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:16 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')]} 02:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:16 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')]} 02:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:16 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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:16 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 02:18:16 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 02:18:16 INFO - Using env: {'DISPLAY': ':0', 02:18:16 INFO - 'HOME': '/home/cltbld', 02:18:16 INFO - 'LANG': 'en_US.UTF-8', 02:18:16 INFO - 'LANGUAGE': 'en_US:en', 02:18:16 INFO - 'LOGNAME': 'cltbld', 02:18:16 INFO - 'MAIL': '/var/mail/cltbld', 02:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:16 INFO - 'MOZ_NO_REMOTE': '1', 02:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:16 INFO - 'NO_EM_RESTART': '1', 02:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:16 INFO - 'PWD': '/builds/slave/test', 02:18:16 INFO - 'SHELL': '/bin/bash', 02:18:16 INFO - 'SHLVL': '1', 02:18:16 INFO - 'TERM': 'linux', 02:18:16 INFO - 'TMOUT': '86400', 02:18:16 INFO - 'USER': 'cltbld', 02:18:16 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:16 INFO - '_': '/tools/buildbot/bin/python'} 02:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 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)) 02:18:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:18:17 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)) 02:18:17 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)) 02:18:17 INFO - Installing collected packages: simplejson 02:18:17 INFO - Running setup.py install for simplejson 02:18:17 INFO - building 'simplejson._speedups' extension 02:18:17 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 02:18:18 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 02:18:18 INFO - Successfully installed simplejson 02:18:18 INFO - Cleaning up... 02:18:18 INFO - Return code: 0 02:18:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:18 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 0x15e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17acb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', '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 02:18:18 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 02:18:18 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 02:18:18 INFO - Using env: {'DISPLAY': ':0', 02:18:18 INFO - 'HOME': '/home/cltbld', 02:18:18 INFO - 'LANG': 'en_US.UTF-8', 02:18:18 INFO - 'LANGUAGE': 'en_US:en', 02:18:18 INFO - 'LOGNAME': 'cltbld', 02:18:18 INFO - 'MAIL': '/var/mail/cltbld', 02:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:18 INFO - 'MOZ_NO_REMOTE': '1', 02:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:18 INFO - 'NO_EM_RESTART': '1', 02:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:18 INFO - 'PWD': '/builds/slave/test', 02:18:18 INFO - 'SHELL': '/bin/bash', 02:18:18 INFO - 'SHLVL': '1', 02:18:18 INFO - 'TERM': 'linux', 02:18:18 INFO - 'TMOUT': '86400', 02:18:18 INFO - 'USER': 'cltbld', 02:18:18 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:18 INFO - '_': '/tools/buildbot/bin/python'} 02:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:18:18 INFO - Cleaning up... 02:18:18 INFO - Return code: 0 02:18:18 INFO - Running post-action listener: _resource_record_post_action 02:18:18 INFO - Running post-action listener: _start_resource_monitoring 02:18:18 INFO - Starting resource monitoring. 02:18:18 INFO - [mozharness: 2017-09-30 09:18:18.915447Z] Finished create-virtualenv step (success) 02:18:18 INFO - [mozharness: 2017-09-30 09:18:18.915972Z] Running install step. 02:18:18 INFO - Running pre-action listener: _resource_record_pre_action 02:18:18 INFO - Running main action method: install 02:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:19 INFO - Reading from file tmpfile_stdout 02:18:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:19 INFO - Reading from file tmpfile_stdout 02:18:19 INFO - Output received: 02:18:19 INFO - Usage: mozinstall [options] installer 02:18:19 INFO - Options: 02:18:19 INFO - -h, --help show this help message and exit 02:18:19 INFO - -d DEST, --destination=DEST 02:18:19 INFO - Directory to install application into. [default: 02:18:19 INFO - "/builds/slave/test"] 02:18:19 INFO - --app=APP Application being installed. [default: firefox] 02:18:19 INFO - mkdir: /builds/slave/test/build/application 02:18:19 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'] 02:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:18:37 INFO - Reading from file tmpfile_stdout 02:18:37 INFO - Output received: 02:18:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:18:37 INFO - Running post-action listener: _resource_record_post_action 02:18:37 INFO - [mozharness: 2017-09-30 09:18:37.048233Z] Finished install step (success) 02:18:37 INFO - [mozharness: 2017-09-30 09:18:37.048489Z] Running setup-mitmproxy step. 02:18:37 INFO - Running pre-action listener: _resource_record_pre_action 02:18:37 INFO - Running main action method: setup_mitmproxy 02:18:37 INFO - Skipping: mitmproxy is not required 02:18:37 INFO - Running post-action listener: _resource_record_post_action 02:18:37 INFO - [mozharness: 2017-09-30 09:18:37.049616Z] Finished setup-mitmproxy step (success) 02:18:37 INFO - [mozharness: 2017-09-30 09:18:37.049850Z] Running run-tests step. 02:18:37 INFO - Running pre-action listener: _resource_record_pre_action 02:18:37 INFO - Running pre-action listener: _set_gcov_prefix 02:18:37 INFO - Running main action method: run_tests 02:18:37 WARNING - Try message not found. 02:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:37 INFO - Python 2.7.3 02:18:37 INFO - Return code: 0 02:18:37 INFO - grabbing minidump binary from tooltool 02:18:37 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')]} 02:18:37 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 0x194ed60>, '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 0x194fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:37 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 02:18:37 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 02:18:37 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 02:18:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:37 INFO - Return code: 0 02:18:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:18:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:37 INFO - ENV: RUST_BACKTRACE is now full 02:18:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:18:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:37 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/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 02:18:37 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/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --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 02:18:37 INFO - Using env: {'DISPLAY': ':0', 02:18:37 INFO - 'HOME': '/home/cltbld', 02:18:37 INFO - 'LANG': 'en_US.UTF-8', 02:18:37 INFO - 'LANGUAGE': 'en_US:en', 02:18:37 INFO - 'LOGNAME': 'cltbld', 02:18:37 INFO - 'MAIL': '/var/mail/cltbld', 02:18:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:37 INFO - 'MOZ_NO_REMOTE': '1', 02:18:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:37 INFO - 'NO_EM_RESTART': '1', 02:18:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:37 INFO - 'PWD': '/builds/slave/test', 02:18:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:37 INFO - 'RUST_BACKTRACE': 'full', 02:18:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:18:37 INFO - 'SHELL': '/bin/bash', 02:18:37 INFO - 'SHLVL': '1', 02:18:37 INFO - 'TERM': 'linux', 02:18:37 INFO - 'TMOUT': '86400', 02:18:37 INFO - 'USER': 'cltbld', 02:18:37 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:37 INFO - '_': '/tools/buildbot/bin/python'} 02:18:37 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/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 02:18:37 INFO - mozversion application_buildid: 20170930082026 02:18:37 INFO - mozversion application_changeset: 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 02:18:37 INFO - mozversion application_display_name: Nightly 02:18:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:37 INFO - mozversion application_name: Firefox 02:18:37 INFO - mozversion application_remotingname: firefox 02:18:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:18:37 INFO - mozversion application_vendor: Mozilla 02:18:37 INFO - mozversion application_version: 58.0a1 02:18:37 INFO - mozversion platform_buildid: 20170930082026 02:18:37 INFO - mozversion platform_changeset: 59e5ec5729db9ee88c1b469f3ae0092fcedc8c44 02:18:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:18:37 INFO - mozversion platform_version: 58.0a1 02:18:37 INFO - using testdate: 1506763117 02:18:37 INFO - actual date: 1506763117 02:18:37 INFO - starting webserver on 'localhost:59865' 02:18:37 INFO - SUITE-START | Running 2 tests 02:18:37 INFO - TEST-START | dromaeo_css 02:18:37 INFO - Initialising browser for dromaeo_css test... 02:18:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59865/getInfo.html -profile /tmp/tmpq3gjGK/profile 02:18:37 INFO - TEST-INFO | started process 22989 (/builds/slave/test/build/application/firefox/firefox http://localhost:59865/getInfo.html) 02:18:43 INFO - TEST-INFO | 22989: exit 0 02:18:43 INFO - Browser initialized. 02:18:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:43 INFO - Using env: {'DISPLAY': ':0', 02:18:43 INFO - 'HOME': '/home/cltbld', 02:18:43 INFO - 'JSGC_DISABLE_POISONING': '1', 02:18:43 INFO - 'LANG': 'en_US.UTF-8', 02:18:43 INFO - 'LANGUAGE': 'en_US:en', 02:18:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:18:43 INFO - 'LOGNAME': 'cltbld', 02:18:43 INFO - 'MAIL': '/var/mail/cltbld', 02:18:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:43 INFO - 'MOZ_CRASHREPORTER': '1', 02:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:18:43 INFO - 'MOZ_NO_REMOTE': '1', 02:18:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:43 INFO - 'NO_EM_RESTART': '1', 02:18:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:43 INFO - 'PWD': '/builds/slave/test', 02:18:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:43 INFO - 'RUST_BACKTRACE': 'full', 02:18:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:18:43 INFO - 'SHELL': '/bin/bash', 02:18:43 INFO - 'SHLVL': '1', 02:18:43 INFO - 'TERM': 'linux', 02:18:43 INFO - 'TMOUT': '86400', 02:18:43 INFO - 'USER': 'cltbld', 02:18:43 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:43 INFO - '_': '/tools/buildbot/bin/python'} 02:18:43 INFO - TEST-INFO | started process 23228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq3gjGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:44 INFO - PID 23228 | 02:18:44 INFO - PID 23228 | (/builds/slave/test/build/application/firefox/firefox:23276): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:18:44 INFO - PID 23228 | 02:18:54 INFO - PID 23228 | RSS: Main: 151674880 02:18:54 INFO - PID 23228 | 02:21:51 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59865/tests/dromaeo/cssquery-ext.html) 02:21:53 INFO - PID 23228 | RSS: Main: 149966848 02:21:53 INFO - PID 23228 | 02:24:54 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-ext.html (next: http://localhost:59865/tests/dromaeo/cssquery-jquery.html) 02:24:55 INFO - PID 23228 | RSS: Main: 150790144 02:24:55 INFO - PID 23228 | 02:27:57 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59865/tests/dromaeo/cssquery-mootools.html) 02:27:57 INFO - PID 23228 | RSS: Main: 151515136 02:27:57 INFO - PID 23228 | 02:30:59 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59865/tests/dromaeo/cssquery-prototype.html) 02:31:00 INFO - PID 23228 | RSS: Main: 150384640 02:31:00 INFO - PID 23228 | 02:34:03 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59865/tests/dromaeo/cssquery-yui.html) 02:34:03 INFO - PID 23228 | RSS: Main: 154083328 02:34:03 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | Cycle 1(1): loaded http://localhost:59865/tests/dromaeo/cssquery-yui.html (next: http://localhost:59865/tests/dromaeo/cssquery-dojo.html) 02:37:05 INFO - PID 23228 | RSS: Main: 153890816 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | __start_tp_report 02:37:05 INFO - PID 23228 | _x_x_mozilla_page_load 02:37:05 INFO - PID 23228 | _x_x_mozilla_page_load_details 02:37:05 INFO - PID 23228 | |i|pagename|runs| 02:37:05 INFO - PID 23228 | |0;dojo.html;3145.5753473281106;3176.857041433136;3185.4584720597495;3191.2979144588185;3204.583404157459;6203.658798766066;6257.061440783879;6258.593191442553;6271.560990730651;6295.779647712331;6103.908441373372;6213.658248796314;6252.624842509453;6253.906191407133;6254.343293954137;5749.540036797057;5802.071668533035;5837.766489340422;5847.912281315784;5861.912071318934;5763.596548241604;5792.044312688401;5832.825015249549;5841.182234487175;5854.941450585504;5535.280413546254;5641.8589535261535;5672.376038635747;5750;5797.652140871519;5728.054870946289;5743.052396354597;5816.680082595455;5816.941830581683;5836.241288632493;5631;5703.572232082611;5704.458076482728;5781.4507621775865;5785;6198.752049917998;6203.565750397474;6205.317415084337;6240.937590624127;6299.8740025199695;6728.495362847806;6730.596164230162;6735;6756.628385438799;6767.35710107539;6772.288909664513;6773.3903948644365;6850.760223392207;6855.691493882788;6882.5870447772795;6235.469985051276;6263.029230469285;6282.371762823681;6323.936760632427;6366.522510811707;6922.307769223037;6967.616781077089;6976.407005404496;7018.824529386806;7030.261822508563;6583.07836902834;6596.208454985336;6682.63245521501;6684.699188536528;6686.398224159849;6718.966405168041;6750.628715420601;6798.796036118924;6831.521793474509;6859.657017149123;6532.248791388956;6598.802035938929;6607.306232845578;6674.599524028574;6694.464442844658;6713.4964877634375;6722.327767223336;6760.966195168992;6772.255051944282;6772.288909664513;5095.515925987025;5238.97380513095;5246.63273570854;5321.122014867581;5356.3572371315695;4627.282771170474;4658.277966915133;4664.976675116671;4666.043461090469;4671;5771.249737534094;5782.595218334676;5845.298564172326;5850.1224816277045;5855.209546711225;6573.704183311763;6642.269350371455;6706.295838936939;6744.12326397575;6790.42281406086;5849;5852.970735146297;5858.414158584193;5858.912116318259;5879.676617785977;5767.394423585463;5803.158542011384;5832.533397328203;5838;5839.182514447981;6412.9679351602945;6413.551051426449;6429.099926010363;6494.577852439576;6518.674066296666;6572.769953051811;6651.068850360856;6664.566803157779;6665.833354166185;6804.727810887608;6290.591111577733;6331.778387756406;6355.809325720235;6472.190976127984;6481.384268494486;6651.268360480247;6694.966525167343;6696.59820410777;6702.664866756545;6708.932910670831;6746.224184218878;6750.35871592198;6761.087253220752;6849.349311815369;6854.725810967506;6480.546361754632;6494.155759751202;6512;6568.507361947777;6583.144191255106;6551.80344589663;6569.310222426577;6584.703688333941;6595.637239951849;6605.570637908713;6423.807285781247;6445.742170313322;6452.54832161763;6541.051547525487;6548.770793022221;6426.100345951477;6524.641144737085;6563.278039415756;6636.435902948304;6645.269020407848;6283.8114856554375;6320.905186422116;6399.456046236122;6411.455026322815;6421.197350331208 02:37:05 INFO - PID 23228 | |1;ext.html;873.4890089297761;887.653815012145;894.9105089491052;895.5835536475538;897.54225345074;40549.59450405495;41393.17213655725;44307.556924430784;44434.777826110905;44471.555284447146;39846;39975.60024399755;40007.19985600294;40036.79981600088;40038.79980600093;7211.81970450739;7349.963250183741;8024.077231118437;8257.710980115697;8258.545779982129;8057.597120143999;8102.068262149869;8140.1452847451055;8142.267195952363;8172.141925097868;8054.073781515142;8084.15116412777;8090.514569125871;8097.311728503084;8124.6750129994725;7998.960005199966;8110.837783244361;8120.472169308976;8130.837383252302;8135.34917206628;8007.67969281228;8024.197580241929;8056.194380561956;8059.113497515269;8109.107998120202;39288.60711392878;39541.406878896836;39545.20909581821;39605;39659;3517.9296414071573;3564.269324788412;3564.590072141711;3581.3732596795458;3589.246258285763;32226.35547289041;32349.51475727866;32390.83804580962;32450.35099298001;32539.51190732141;4973.5523802857915;5134.666246693953;5179.300794392747;5188.118019936582;5195.1687729963405;198390;198575;199013;199524;199987.99999999854;43054.354184687254;43921.78039109784;50171;50206.49793502091;50406.243906341435;53838.73080634572;54157.45842541603;54484.72757636187;54626.453735462135;54645;15654;15727.370905163894;15785.68428631421;15803;15819.683606328039;12861;12886.742265154644;12887.420066097047;12958.352082395842;12986.220826750425;14334.49829255992;14468.638284042983;14469.855301447062;14607.707845843024;14617.707645847024;5695.316562012585;5756.884862302731;5764.74058667361;5770.19217309577;5828.388019258002;956.8803899512561;983.7491439682835;1006.9980369532216;1020.505055048301;1023.0741179232806;23411.648825267635;23525;23540.41148971255;23748.64377034346;24032.87983560071;1055.4669891704793;1097.2538673701958;1102.9227954043301;1124.8875112488686;1124.8987591116675;12367.814482782765;12411.689707757378;12477.438515266835;12636.305003224727;12784.360781960864;216030;216303;217092;217313;217966;54857.177142342895;54866.725666371414;54935.72532137314;55222.44777552173;55230.44769552333;1388.1532265318149;1432.1192466632945;1432.2122832442114;1436.8347640021323;1441.891858110646;22835.429114272276;23087.53824923526;23102.537949241258;23423.41441463977;23618.645720313867;38324.80837595794;38436.80781596074;38442.42336364901;38474;38524.80737596294;192618;193646;194934;195194;195412;34663.653363466045;34688;35371.64628353684;35375.64624353724;35389;42773.572264278206;43983.340249895635;43996.56003439925;44415;44488.33267500925;31531.84234078815;31735.365292693554;31925.36149277048;32372;32609.510857337635;31747.841260794474;31841.681583183872;31961.840190799827;32227.838860805547;32903.34193316168;36796.26407471782;36926.81536592407;37083.25833483369;37118.62881371152;37281.81359093187;31358;31444.68555314509;31455.899043533365;31568;31700.36599268048;22654.886725566266;23564.444488855912;23581;23656.526869462858;23780.048798047883 02:37:05 INFO - PID 23228 | |2;jquery.html;586.5073338395747;588.6644612570834;598.350789393508;606.8634557224625;612.378435887574;22464.88767556162;23191.884040579793;23235.76764232357;23240.76759232407;23361.415964600892;23635.40911477214;24642.876785616092;24719.382015449577;24855.50288994219;24859.254222373358;6437.35626437356;6646.6676666166495;6652.368025037614;6655.101561289212;6655.434288085518;6343.777967771129;6511.023346498016;6605.768798092067;6609.074729537869;6627.60234385936;6596.208454985408;6604.636744979024;6605.867882642344;6607.141071660677;6607.372299631527;6578.60528368297;6587.374199451045;6589.341065893396;6597.9340206598035;6741.359570840762;6900.482463815234;6921.653917304115;6957.304269573053;6960.582365058112;6961.860762784716;29255.41489170226;29879.551806722917;29903;29906;29933.25166870824;2110.5251318453224;2120.3003009007143;2126.5109024924354;2135.8398120140896;2146.9785302146934;20103.899480502503;20341;21068.683969740465;21333.573328533497;21342;2588.314096764359;2606.5829467285143;2673.518766622007;2676.6520352354264;2681.1554360376417;129293.35353323267;135553;146951;154134.22932885264;154168;20138.69791953122;20430.489237769176;20536.897315513626;21610.675839862415;22127.557448850934;39730.80134599309;39918.800405998365;39949.20101597952;39957.40063899044;40106;11029.558817647205;11056.889431105747;11192.642207337929;11275.774484510264;11371.943140284411;9235.861462078074;9313.48775817323;9352.625894964262;9442.197413219816;9450.96804187103;11117.499712512956;11227.71930701739;11250.831237531444;11414;11421.657350279505;4126.855560055384;4127.525334586501;4201.390798334285;4288.978555107205;4465.799039043251;934.1592566689898;945.6028468043438;945.952702364879;950.3917492804611;955.8040601676639;18844.15201315944;19030.714539281922;19079.52301192481;19380.709289360388;19416.805831941783;985.4727720669407;1007.5717819926502;1013.3767732844248;1018.3279035836313;1020.0972139656458;10335.069843714102;10352.378857268588;10371.740706482398;10550.208734344955;10608.840867386996;470572;486181;495689;496085;498482;109310.45344773385;112056.4397178009;113475.43262283636;113531;113862;1144.0390072339276;1148.3397046698183;1180.055955235808;1189.4825750798257;1191.1721353659298;17177;17331.740023899398;17720.822791772433;17797.11014449298;17966.5508362292;56053.719731401085;56103.43896560982;56127.87744245174;56902.14646780219;57938.71030644988;68561;68564.6571767138;69658;69671.30328696647;69696.65151674209;19935.900320498306;20301.390958271277;20385.286514971904;20412;20473.181072757518;22837.429064272863;22884.542309154058;22884.656730148727;23112;23116.537669246183;18174.636507270046;18328.816711833246;18539.629207416045;18629.72055419197;18678.34625788091;16318.102504362374;16379.262933167798;16811.32754689799;16838.410655626994;16967.830321696623;18356.26574937041;18773.436796896116;18785;18932.242710291433;18942.242310307985;19516.414507564798;19650.803491964896;19793.50516237048;19854.702179467607;19974.60050799005;18019.81980180234;18077.819221807615;18084.18621162077;18293.26826926908;18386.08069596488 02:37:05 INFO - PID 23228 | |3;mootools.html;1324.4635922451407;1371.7530844448002;1377.1736957825312;1382.6197795606206;1395.8185435893326;13933.303334833268;14465.92767036166;14474.782878256834;14517.49188778393;14546.345414456347;14369.640758981031;14419;14473.5657930262;14481.855181448182;14513.709725805478;2704.432069265452;2853.9286517837118;2854.24362543926;2854.885804567815;2856.742893139617;2675.812693111483;2711.701712811589;2789.316617428733;2792.0507027610606;2792.3298408382047;2777.125205560252;2835.7447829695325;2838.148555433372;2841.1334542964387;2844.7581955533806;2726.073135134054;2745.766609838166;2751.2159034675024;2759.9448011039767;2812.3812761192503;2587.6894772627215;2631.2369412870244;2668.7197844226466;2685.2749757565543;2687.9731202687917;14240.430382784676;14307.141571505743;14321.35553900077;14341.641458963504;14345.78481322781;7755.961220193919;8005.879911801328;8055.395845311625;8063.556504392256;8073.838523229561;5047.798088076473;5097.6941383517105;5171.120909445403;5242.79028838846;5254.343207099113;1948.4154753574012;1952.5704345044066;1969.1827891425041;1972.339266345776;1996.3511858645998;24921.252362429157;25528.744712552823;25554.74445255561;25594.616080758802;25597;6937.202221744564;7102.325279098477;7182.928170718226;7251.274872512707;7270.127584689871;18231.544211394557;18297.81702182961;18362.63274734498;18405.63188736218;18499.630007399777;7884.329831964347;7979.68081276754;8245.381596380295;8253.876191857127;8257.256846883689;7291.817704557322;7340.9632951835965;7351.632418379059;7352.926470735331;7405.481616286916;5067.695938243717;5128.8461346159675;5161.612879034087;5218.582513398919;5242.318498595235;1488.6501672107047;1493.4324956516455;1499.640086379283;1509.0492989416816;1512.7579587266205;867.4535042922918;873.7116751471999;893.1425831201989;897.2149369301861;900.3292547052357;7190.496665233383;7196.10048743907;7297.233790452032;7357.2642735726;7367.263273672697;714.1608609883366;726.3535453446436;743.9702411903463;748.7117459778025;751.6692655231681;4857.6842505237755;5084.237364395371;5197.766100525486;5268.92096618551;5404.216388623628;19481.902590486956;19956.10197541114;20255.18979240814;20262.392128236177;20285.79714202839;18685.252589896252;20046;20066.698999515018;20076.799232007786;20087.899560502105;10295.227857910537;10373.377597344184;10394.272400932014;10420.426876521713;10469.68590942273;7832.689356639691;7982.281594656509;8019.558924259221;8124.959375203322;8201.589920503831;16796.916015419843;17134.571635709206;17272.91363543174;17331.826681733524;17388.565285867953;17092.914535427244;17440.912795435943;17475.650486990442;17489.212985415434;17630.206640700944;10416.687499375032;10601.787964240826;10604.204684648528;10613.628523001658;10613.787724245318;12960.481580736665;12981.156224845732;13053.477860885458;13146.474141034252;13215.074944753775;10363.170946324426;10512.369257844553;10594.894051059391;10685.358878467317;10948.56205751761;9731.805363892825;9766.658166964122;9815.509224538888;9876.20990320787;10026.69919902404;9386.812263754824;9456.385334953206;9485.146336829719;9537.761555961157;9538.427694338361;6968.163820341591;7048.471364647569;7049.118860142482;7060.470464715064;7085.114360704912;7145.535540189871;7179.425645948207;7190.532615379983;7237.674304656409;7338.449616278907 02:37:05 INFO - PID 23228 | |4;prototype.html;517.6247220764945;524.7166530073762;539.7759929629203;550.6448340820174;551.0879494436708;6118.174046503721;6275.807596556662;6300.30696623371;6345.60396712723;6369.490440764739;6106.633601983884;6156.3535828737895;6159.661218632973;6187;6313.053042043695;4948.703077815325;4997.55071029401;5004.874878128039;5024.698518088908;5075.822346217883;5073.898522029557;5088.26220198071;5124.538791508763;5135.2040433732645;5144.742762861842;5012.749362531858;5048.1670524363435;5061.240813877929;5089.389273287211;5093.236014597822;5023.497650234984;5054.620903432257;5065.544101030907;5067.619928505377;5091.872703182413;4539.977300113512;4540.909181816378;4579.496255411902;4587.724736515786;4592.494825569184;6146.569740118193;6168.537359698041;6237.34507876671;6256.812295631138;6286.779962701284;5693.316801983747;5734.4265573442735;5737.9713101434645;5807.2160258365;5827.562932780016;6615.239247486505;6635.203775546917;6663.966680166568;6703.262641109474;6711.4295284900845;4997.325361076245;5007.37407824022;5016.097102521545;5025.974870125626;5038.571721403685;6882.724691012403;6956.791141359456;6978.965105174441;6990.440764738809;7054.541454805472;5117.565006974374;5117.897642047213;5120.385553733576;5123.180291153398;5125.1287281162295;5198.870028249324;5209.270702101709;5218.582513398919;5228.353068783321;5238;5735.684537350486;5755;5777.162311464898;5778.3643799182055;5780.53755699543;6347.619142851444;6506.869862602722;6532.41208291256;6536.182977127859;6654.866902662016;1686.4603326935262;1750.2823842224627;1769.186174359809;1785.4018903667156;1793.560577658482;1196.904247660185;1220.1702842067302;1238.1147479552164;1263.065331654569;1267.689416093063;5669.858253543694;5684.488396044293;5696.202531645573;5785.71071446426;5811.3316968548315;6707.899381509281;6789.287124851919;6950.548214366151;6953.965230173817;6965.930340696629;5589.385167631557;5748.482636562646;5756.366799652035;5779.2775903012125;5784.219130417424;3602.5316708827686;3610.097475631092;3610.458431235283;3639.454081887738;3661.5240018797385;6535;6557.278699343068;6567.179102612174;6571.21145462538;6604.636744979072;6895.689693963784;6913.412359949461;6952.409045231111;6973.476989225828;7025.508214425044;6423.164988551458;6442.420182183532;6479.514036447285;6507.186601674791;6521.739130434729;6821.727130914708;6851.9657401712675;6853.971904214209;6876.140482439695;6879.862402752017;6664.933350666432;6729.360710732472;6735.797926062226;6737.124173857564;6774.780539502937;6348.396902294275;6352.570671598854;6364.236291645032;6498.642574658439;6500.3174666659315;5489.862753431196;5521.309836270466;5537.916931246115;5626.606137570331;5637.49262566371;6539.6403197824575;6796.966015169893;6831.4876384272375;6876.656167191521;6921.134858142732;6209.627422354673;6544.3782840630065;6560.179977502812;6599.769008084694;6600.669966501751;6556.409923106943;6589.604623722592;6605.405513503808;6621.70876679043;6638.5684930479365;6486.610803351814;6513.934860651333;6514.54398192122;6518.272657745606;6522.184726909137;6330.715117819801;6547;6614.272430032596;6619.437347825488;6656.5340426169705;6325.620462772248;6397.360263973565;6416.647084410402;6427.453666438218;6434.388733070351 02:37:05 INFO - PID 23228 | |5;yui.html;905.461250555919;912.0332447605539;919.4483310013992;927.8051609162076;937.8968313485516;19085.61828763424;20180.59638807223;20206.6968995465;20212.292569760062;20219.292324768638;16984.235709393077;17574.209160587772;17623.823761762378;17714.379996700118;17876.106194690245;948.1419315519448;965.3098034905041;968.4721826604517;968.970930872075;969.2343048991323;954.3748844506824;977.5112443778111;990.9801803963917;991.33085167512;1001.0890090018084;1035.8912314207014;1060.6022741471947;1062.1821197677784;1064.4624464645344;1065.1319174872453;995.8705368302146;1026.343140390151;1030.2015937648307;1032.158790585674;1065.6003998500562;750.2497502497503;753.2730914667372;753.5591678867869;754.091319959453;755.7694903054567;20591;20833.270835520834;20869.895650521652;20891.895540522353;20936.790632093638;19426.70859937102;20714.275000374913;20727.27454539084;20818.16727330905;20818.895905520527;16277.348906043744;16418.097004664738;16592.502224933272;16774.245158967875;16785.07682077485;3662.5604927408617;3673.1735359544155;3679.0618392310057;3684.299983003221;3698.7595806272507;142586;143033;143418;143817.2809135958;146172;16850.578735531464;16979.575510612332;17052.14739263032;17206.053667048433;17215.56961075958;30787.69212307893;31743;31904.68095319017;31925.20186995344;32084;7503.962480187564;7638.197989211164;7816.8827467588035;7828.765137045898;7837.294643482114;3669.3945498992903;3861;3862.942055869164;3863.4784304118584;3865.342891708416;5574.470425309589;5674.120511320752;5675.744591493392;5678.744456499468;5681.17622944679;944.1927152284835;967.7241986034087;981.6269817469316;982.6364245229311;987.1905037869022;657.6152950523997;665.8568407792347;673.7675501951819;677.3869647968596;684.096991970594;11542.307461552165;11675.35785531804;12043.337616431005;12086.153969222245;12254.142210045211;655.2693746472744;665.0556210181554;666.9499787515956;671.771597656799;682.0723815610766;5165.690058596496;5209.348831396075;5211.339331183155;5242.030224408497;5284.550813180923;125184;125584;128988;129312;130868;90198;94975.050249498;109497;110153;117467;93447.99999999865;94141;94621;96799.51600242095;98073.50963245139;12021.218620789621;12325.137240393087;12326.630201093982;12342.75314493723;12733.970081817444;42632.147357053305;43454.47909323159;43830.561694382646;45172.54827451815;45358.546414535434;57345.71327143338;57953.710231448575;59103.113453297374;59180;59444.405555943886;18332.90833545877;18676.31913127825;18772.812271877105;18886.244550217838;19246.133923973175;19579.314723984593;19681.507962301057;19789.82311945656;19829.702554461983;20058.197672092952;17110.657786843945;17199.828001719823;17210.225539850486;17234.82765172332;17322.740158897373;19061.23755049838;19407.126679299185;19416.708749369052;19421.51446213856;19815.009249537754;14787.704245915236;14844.40622375093;14941.477048303257;15042.548723537873;15053.849461505244;11939.283642981101;12057.57798477049;12115;12182.512699491921;12278.324692142018;13767.242801646005;13811.79282310746;13840.792388114387;13847.169169849842;13875.583732488041 02:37:05 INFO - PID 23228 | __end_tp_report 02:37:05 INFO - PID 23228 | __start_cc_report 02:37:05 INFO - PID 23228 | _x_x_mozilla_cycle_collect,274 02:37:05 INFO - PID 23228 | __end_cc_report 02:37:05 INFO - PID 23228 | __startTimestamp1506764225767__endTimestamp 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | ------- Summary: start ------- 02:37:05 INFO - PID 23228 | Number of tests: 6 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#0] dojo.html Cycles:165 Average:6181.08 Median:6412.97 stddev:737.13 (11.5%) stddev-sans-first:699.87 02:37:05 INFO - PID 23228 | Values: 3145.6 3176.9 3185.5 3191.3 3204.6 6203.7 6257.1 6258.6 6271.6 6295.8 6103.9 6213.7 6252.6 6253.9 6254.3 5749.5 5802.1 5837.8 5847.9 5861.9 5763.6 5792.0 5832.8 5841.2 5854.9 5535.3 5641.9 5672.4 5750.0 5797.7 5728.1 5743.1 5816.7 5816.9 5836.2 5631.0 5703.6 5704.5 5781.5 5785.0 6198.8 6203.6 6205.3 6240.9 6299.9 6728.5 6730.6 6735.0 6756.6 6767.4 6772.3 6773.4 6850.8 6855.7 6882.6 6235.5 6263.0 6282.4 6323.9 6366.5 6922.3 6967.6 6976.4 7018.8 7030.3 6583.1 6596.2 6682.6 6684.7 6686.4 6719.0 6750.6 6798.8 6831.5 6859.7 6532.2 6598.8 6607.3 6674.6 6694.5 6713.5 6722.3 6761.0 6772.3 6772.3 5095.5 5239.0 5246.6 5321.1 5356.4 4627.3 4658.3 4665.0 4666.0 4671.0 5771.2 5782.6 5845.3 5850.1 5855.2 6573.7 6642.3 6706.3 6744.1 6790.4 5849.0 5853.0 5858.4 5858.9 5879.7 5767.4 5803.2 5832.5 5838.0 5839.2 6413.0 6413.6 6429.1 6494.6 6518.7 6572.8 6651.1 6664.6 6665.8 6804.7 6290.6 6331.8 6355.8 6472.2 6481.4 6651.3 6695.0 6696.6 6702.7 6708.9 6746.2 6750.4 6761.1 6849.3 6854.7 6480.5 6494.2 6512.0 6568.5 6583.1 6551.8 6569.3 6584.7 6595.6 6605.6 6423.8 6445.7 6452.5 6541.1 6548.8 6426.1 6524.6 6563.3 6636.4 6645.3 6283.8 6320.9 6399.5 6411.5 6421.2 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#1] ext.html Cycles:180 Average:37709.04 Median:3572.98 stddev:52720.53 (1475.5%) stddev-sans-first:52795.87 02:37:05 INFO - PID 23228 | Values: 873.5 887.7 894.9 895.6 897.5 40549.6 41393.2 44307.6 44434.8 44471.6 39846.0 39975.6 40007.2 40036.8 40038.8 7211.8 7350.0 8024.1 8257.7 8258.5 8057.6 8102.1 8140.1 8142.3 8172.1 8054.1 8084.2 8090.5 8097.3 8124.7 7999.0 8110.8 8120.5 8130.8 8135.3 8007.7 8024.2 8056.2 8059.1 8109.1 39288.6 39541.4 39545.2 39605.0 39659.0 3517.9 3564.3 3564.6 3581.4 3589.2 32226.4 32349.5 32390.8 32450.4 32539.5 4973.6 5134.7 5179.3 5188.1 5195.2 198390.0 198575.0 199013.0 199524.0 199988.0 43054.4 43921.8 50171.0 50206.5 50406.2 53838.7 54157.5 54484.7 54626.5 54645.0 15654.0 15727.4 15785.7 15803.0 15819.7 12861.0 12886.7 12887.4 12958.4 12986.2 14334.5 14468.6 14469.9 14607.7 14617.7 5695.3 5756.9 5764.7 5770.2 5828.4 956.9 983.7 1007.0 1020.5 1023.1 23411.6 23525.0 23540.4 23748.6 24032.9 1055.5 1097.3 1102.9 1124.9 1124.9 12367.8 12411.7 12477.4 12636.3 12784.4 216030.0 216303.0 217092.0 217313.0 217966.0 54857.2 54866.7 54935.7 55222.4 55230.4 1388.2 1432.1 1432.2 1436.8 1441.9 22835.4 23087.5 23102.5 23423.4 23618.6 38324.8 38436.8 38442.4 38474.0 38524.8 192618.0 193646.0 194934.0 195194.0 195412.0 34663.7 34688.0 35371.6 35375.6 35389.0 42773.6 43983.3 43996.6 44415.0 44488.3 31531.8 31735.4 31925.4 32372.0 32609.5 31747.8 31841.7 31961.8 32227.8 32903.3 36796.3 36926.8 37083.3 37118.6 37281.8 31358.0 31444.7 31455.9 31568.0 31700.4 22654.9 23564.4 23581.0 23656.5 23780.0 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#2] jquery.html Cycles:180 Average:35862.39 Median:22860.99 stddev:82440.83 (360.6%) stddev-sans-first:82629.55 02:37:05 INFO - PID 23228 | Values: 586.5 588.7 598.4 606.9 612.4 22464.9 23191.9 23235.8 23240.8 23361.4 23635.4 24642.9 24719.4 24855.5 24859.3 6437.4 6646.7 6652.4 6655.1 6655.4 6343.8 6511.0 6605.8 6609.1 6627.6 6596.2 6604.6 6605.9 6607.1 6607.4 6578.6 6587.4 6589.3 6597.9 6741.4 6900.5 6921.7 6957.3 6960.6 6961.9 29255.4 29879.6 29903.0 29906.0 29933.3 2110.5 2120.3 2126.5 2135.8 2147.0 20103.9 20341.0 21068.7 21333.6 21342.0 2588.3 2606.6 2673.5 2676.7 2681.2 129293.4 135553.0 146951.0 154134.2 154168.0 20138.7 20430.5 20536.9 21610.7 22127.6 39730.8 39918.8 39949.2 39957.4 40106.0 11029.6 11056.9 11192.6 11275.8 11371.9 9235.9 9313.5 9352.6 9442.2 9451.0 11117.5 11227.7 11250.8 11414.0 11421.7 4126.9 4127.5 4201.4 4289.0 4465.8 934.2 945.6 946.0 950.4 955.8 18844.2 19030.7 19079.5 19380.7 19416.8 985.5 1007.6 1013.4 1018.3 1020.1 10335.1 10352.4 10371.7 10550.2 10608.8 470572.0 486181.0 495689.0 496085.0 498482.0 109310.5 112056.4 113475.4 113531.0 113862.0 1144.0 1148.3 1180.1 1189.5 1191.2 17177.0 17331.7 17720.8 17797.1 17966.6 56053.7 56103.4 56127.9 56902.1 57938.7 68561.0 68564.7 69658.0 69671.3 69696.7 19935.9 20301.4 20385.3 20412.0 20473.2 22837.4 22884.5 22884.7 23112.0 23116.5 18174.6 18328.8 18539.6 18629.7 18678.3 16318.1 16379.3 16811.3 16838.4 16967.8 18356.3 18773.4 18785.0 18932.2 18942.2 19516.4 19650.8 19793.5 19854.7 19974.6 18019.8 18077.8 18084.2 18293.3 18386.1 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#3] mootools.html Cycles:180 Average:8925.88 Median:2748.49 stddev:6258.02 (227.7%) stddev-sans-first:6249.51 02:37:05 INFO - PID 23228 | Values: 1324.5 1371.8 1377.2 1382.6 1395.8 13933.3 14465.9 14474.8 14517.5 14546.3 14369.6 14419.0 14473.6 14481.9 14513.7 2704.4 2853.9 2854.2 2854.9 2856.7 2675.8 2711.7 2789.3 2792.1 2792.3 2777.1 2835.7 2838.1 2841.1 2844.8 2726.1 2745.8 2751.2 2759.9 2812.4 2587.7 2631.2 2668.7 2685.3 2688.0 14240.4 14307.1 14321.4 14341.6 14345.8 7756.0 8005.9 8055.4 8063.6 8073.8 5047.8 5097.7 5171.1 5242.8 5254.3 1948.4 1952.6 1969.2 1972.3 1996.4 24921.3 25528.7 25554.7 25594.6 25597.0 6937.2 7102.3 7182.9 7251.3 7270.1 18231.5 18297.8 18362.6 18405.6 18499.6 7884.3 7979.7 8245.4 8253.9 8257.3 7291.8 7341.0 7351.6 7352.9 7405.5 5067.7 5128.8 5161.6 5218.6 5242.3 1488.7 1493.4 1499.6 1509.0 1512.8 867.5 873.7 893.1 897.2 900.3 7190.5 7196.1 7297.2 7357.3 7367.3 714.2 726.4 744.0 748.7 751.7 4857.7 5084.2 5197.8 5268.9 5404.2 19481.9 19956.1 20255.2 20262.4 20285.8 18685.3 20046.0 20066.7 20076.8 20087.9 10295.2 10373.4 10394.3 10420.4 10469.7 7832.7 7982.3 8019.6 8125.0 8201.6 16796.9 17134.6 17272.9 17331.8 17388.6 17092.9 17440.9 17475.7 17489.2 17630.2 10416.7 10601.8 10604.2 10613.6 10613.8 12960.5 12981.2 13053.5 13146.5 13215.1 10363.2 10512.4 10594.9 10685.4 10948.6 9731.8 9766.7 9815.5 9876.2 10026.7 9386.8 9456.4 9485.1 9537.8 9538.4 6968.2 7048.5 7049.1 7060.5 7085.1 7145.5 7179.4 7190.5 7237.7 7338.4 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#4] prototype.html Cycles:180 Average:5581.76 Median:6177.77 stddev:1548.37 (25.1%) stddev-sans-first:1505.34 02:37:05 INFO - PID 23228 | Values: 517.6 524.7 539.8 550.6 551.1 6118.2 6275.8 6300.3 6345.6 6369.5 6106.6 6156.4 6159.7 6187.0 6313.1 4948.7 4997.6 5004.9 5024.7 5075.8 5073.9 5088.3 5124.5 5135.2 5144.7 5012.7 5048.2 5061.2 5089.4 5093.2 5023.5 5054.6 5065.5 5067.6 5091.9 4540.0 4540.9 4579.5 4587.7 4592.5 6146.6 6168.5 6237.3 6256.8 6286.8 5693.3 5734.4 5738.0 5807.2 5827.6 6615.2 6635.2 6664.0 6703.3 6711.4 4997.3 5007.4 5016.1 5026.0 5038.6 6882.7 6956.8 6979.0 6990.4 7054.5 5117.6 5117.9 5120.4 5123.2 5125.1 5198.9 5209.3 5218.6 5228.4 5238.0 5735.7 5755.0 5777.2 5778.4 5780.5 6347.6 6506.9 6532.4 6536.2 6654.9 1686.5 1750.3 1769.2 1785.4 1793.6 1196.9 1220.2 1238.1 1263.1 1267.7 5669.9 5684.5 5696.2 5785.7 5811.3 6707.9 6789.3 6950.5 6954.0 6965.9 5589.4 5748.5 5756.4 5779.3 5784.2 3602.5 3610.1 3610.5 3639.5 3661.5 6535.0 6557.3 6567.2 6571.2 6604.6 6895.7 6913.4 6952.4 6973.5 7025.5 6423.2 6442.4 6479.5 6507.2 6521.7 6821.7 6852.0 6854.0 6876.1 6879.9 6664.9 6729.4 6735.8 6737.1 6774.8 6348.4 6352.6 6364.2 6498.6 6500.3 5489.9 5521.3 5537.9 5626.6 5637.5 6539.6 6797.0 6831.5 6876.7 6921.1 6209.6 6544.4 6560.2 6599.8 6600.7 6556.4 6589.6 6605.4 6621.7 6638.6 6486.6 6513.9 6514.5 6518.3 6522.2 6330.7 6547.0 6614.3 6619.4 6656.5 6325.6 6397.4 6416.6 6427.5 6434.4 02:37:05 INFO - PID 23228 | 02:37:05 INFO - PID 23228 | [#5] yui.html Cycles:180 Average:24806.39 Median:20720.77 stddev:35837.13 (173.0%) stddev-sans-first:35892.73 02:37:05 INFO - PID 23228 | Values: 905.5 912.0 919.4 927.8 937.9 19085.6 20180.6 20206.7 20212.3 20219.3 16984.2 17574.2 17623.8 17714.4 17876.1 948.1 965.3 968.5 969.0 969.2 954.4 977.5 991.0 991.3 1001.1 1035.9 1060.6 1062.2 1064.5 1065.1 995.9 1026.3 1030.2 1032.2 1065.6 750.2 753.3 753.6 754.1 755.8 20591.0 20833.3 20869.9 20891.9 20936.8 19426.7 20714.3 20727.3 20818.2 20818.9 16277.3 16418.1 16592.5 16774.2 16785.1 3662.6 3673.2 3679.1 3684.3 3698.8 142586.0 143033.0 143418.0 143817.3 146172.0 16850.6 16979.6 17052.1 17206.1 17215.6 30787.7 31743.0 31904.7 31925.2 32084.0 7504.0 7638.2 7816.9 7828.8 7837.3 3669.4 3861.0 3862.9 3863.5 3865.3 5574.5 5674.1 5675.7 5678.7 5681.2 944.2 967.7 981.6 982.6 987.2 657.6 665.9 673.8 677.4 684.1 11542.3 11675.4 12043.3 12086.2 12254.1 655.3 665.1 666.9 671.8 682.1 5165.7 5209.3 5211.3 5242.0 5284.6 125184.0 125584.0 128988.0 129312.0 130868.0 90198.0 94975.1 109497.0 110153.0 117467.0 93448.0 94141.0 94621.0 96799.5 98073.5 12021.2 12325.1 12326.6 12342.8 12734.0 42632.1 43454.5 43830.6 45172.5 45358.5 57345.7 57953.7 59103.1 59180.0 59444.4 18332.9 18676.3 18772.8 18886.2 19246.1 19579.3 19681.5 19789.8 19829.7 20058.2 17110.7 17199.8 17210.2 17234.8 17322.7 19061.2 19407.1 19416.7 19421.5 19815.0 14787.7 14844.4 14941.5 15042.5 15053.8 11939.3 12057.6 12115.0 12182.5 12278.3 13767.2 13811.8 13840.8 13847.2 13875.6 02:37:05 INFO - PID 23228 | -------- Summary: end -------- 02:37:05 INFO - PID 23228 | 02:37:06 INFO - TEST-INFO | 23228: exit 0 02:37:06 INFO - TEST-OK | dromaeo_css | took 1108886ms 02:37:06 INFO - TEST-START | kraken 02:37:06 INFO - Initialising browser for kraken test... 02:37:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59865/getInfo.html -profile /tmp/tmppNTsRe/profile 02:37:06 INFO - TEST-INFO | started process 23596 (/builds/slave/test/build/application/firefox/firefox http://localhost:59865/getInfo.html) 02:37:11 INFO - TEST-INFO | 23596: exit 0 02:37:11 INFO - Browser initialized. 02:37:11 INFO - Running cycle 1/1 for kraken test... 02:37:11 INFO - Using env: {'DISPLAY': ':0', 02:37:11 INFO - 'HOME': '/home/cltbld', 02:37:11 INFO - 'JSGC_DISABLE_POISONING': '1', 02:37:11 INFO - 'LANG': 'en_US.UTF-8', 02:37:11 INFO - 'LANGUAGE': 'en_US:en', 02:37:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:37:11 INFO - 'LOGNAME': 'cltbld', 02:37:11 INFO - 'MAIL': '/var/mail/cltbld', 02:37:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:37:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:37:11 INFO - 'MOZ_CRASHREPORTER': '1', 02:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:37:11 INFO - 'MOZ_NO_REMOTE': '1', 02:37:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:11 INFO - 'NO_EM_RESTART': '1', 02:37:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:11 INFO - 'PWD': '/builds/slave/test', 02:37:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:37:11 INFO - 'RUST_BACKTRACE': 'full', 02:37:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:37:11 INFO - 'SHELL': '/bin/bash', 02:37:11 INFO - 'SHLVL': '1', 02:37:11 INFO - 'TERM': 'linux', 02:37:11 INFO - 'TMOUT': '86400', 02:37:11 INFO - 'USER': 'cltbld', 02:37:11 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093', 02:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:11 INFO - '_': '/tools/buildbot/bin/python'} 02:37:11 INFO - TEST-INFO | started process 23832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppNTsRe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:12 INFO - PID 23832 | 02:37:12 INFO - PID 23832 | (/builds/slave/test/build/application/firefox/firefox:23881): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:37:12 INFO - PID 23832 | 02:37:23 INFO - PID 23832 | RSS: Main: 151691264 02:37:23 INFO - PID 23832 | 02:37:25 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59865/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:26 INFO - PID 23832 | RSS: Main: 158056448 02:37:26 INFO - PID 23832 | 02:37:29 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59865/tests/kraken/driver.html?testName=audio-dft) 02:37:29 INFO - PID 23832 | RSS: Main: 158236672 02:37:29 INFO - PID 23832 | 02:37:32 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59865/tests/kraken/driver.html?testName=audio-fft) 02:37:33 INFO - PID 23832 | RSS: Main: 153505792 02:37:33 INFO - PID 23832 | 02:37:35 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59865/tests/kraken/driver.html?testName=audio-oscillator) 02:37:36 INFO - PID 23832 | RSS: Main: 154107904 02:37:36 INFO - PID 23832 | 02:37:38 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:38 INFO - PID 23832 | RSS: Main: 154574848 02:37:38 INFO - PID 23832 | 02:37:42 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59865/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:42 INFO - PID 23832 | RSS: Main: 157052928 02:37:42 INFO - PID 23832 | 02:37:46 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59865/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:47 INFO - PID 23832 | RSS: Main: 158265344 02:37:47 INFO - PID 23832 | 02:37:50 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59865/tests/kraken/driver.html?testName=json-parse-financial) 02:37:50 INFO - PID 23832 | RSS: Main: 158396416 02:37:50 INFO - PID 23832 | 02:37:52 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:52 INFO - PID 23832 | RSS: Main: 158072832 02:37:52 INFO - PID 23832 | 02:37:54 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:37:55 INFO - PID 23832 | RSS: Main: 155410432 02:37:55 INFO - PID 23832 | 02:37:57 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:37:57 INFO - PID 23832 | RSS: Main: 155140096 02:37:57 INFO - PID 23832 | 02:38:00 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:01 INFO - PID 23832 | RSS: Main: 154705920 02:38:01 INFO - PID 23832 | 02:38:03 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:04 INFO - PID 23832 | RSS: Main: 155045888 02:38:04 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | Cycle 1(1): loaded http://localhost:59865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59865/tests/kraken/driver.html?testName=ai-astar) 02:38:06 INFO - PID 23832 | RSS: Main: 156041216 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | __start_tp_report 02:38:06 INFO - PID 23832 | _x_x_mozilla_page_load 02:38:06 INFO - PID 23832 | _x_x_mozilla_page_load_details 02:38:06 INFO - PID 23832 | |i|pagename|runs| 02:38:06 INFO - PID 23832 | |0;ai-astar;107;107;107;106;110;107;107;108;108;106 02:38:06 INFO - PID 23832 | |1;audio-beat-detection;119;122;115;122;120;123;116;117;116;144 02:38:06 INFO - PID 23832 | |2;audio-dft;164;163;162;161;162;162;161;175;167;163 02:38:06 INFO - PID 23832 | |3;audio-fft;75;74;76;72;73;73;74;73;98;75 02:38:06 INFO - PID 23832 | |4;audio-oscillator;79;79;80;79;79;79;79;78;80;79 02:38:06 INFO - PID 23832 | |5;imaging-gaussian-blur;111;112;113;111;111;112;112;112;112;111 02:38:06 INFO - PID 23832 | |6;imaging-darkroom;148;148;148;148;149;147;147;150;148;149 02:38:06 INFO - PID 23832 | |7;imaging-desaturate;101;93;94;93;93;95;94;94;94;95 02:38:06 INFO - PID 23832 | |8;json-parse-financial;51;51;51;50;50;50;51;50;51;50 02:38:06 INFO - PID 23832 | |9;json-stringify-tinderbox;37;36;37;43;37;39;37;37;38;37 02:38:06 INFO - PID 23832 | |10;stanford-crypto-aes;76;78;73;82;74;75;76;74;79;76 02:38:06 INFO - PID 23832 | |11;stanford-crypto-ccm;113;117;116;123;110;109;111;117;108;112 02:38:06 INFO - PID 23832 | |12;stanford-crypto-pbkdf2;173;161;168;161;172;163;163;166;163;157 02:38:06 INFO - PID 23832 | |13;stanford-crypto-sha256-iterative;63;65;66;67;64;64;64;63;69;64 02:38:06 INFO - PID 23832 | __end_tp_report 02:38:06 INFO - PID 23832 | __start_cc_report 02:38:06 INFO - PID 23832 | _x_x_mozilla_cycle_collect,759 02:38:06 INFO - PID 23832 | __end_cc_report 02:38:06 INFO - PID 23832 | __startTimestamp1506764286585__endTimestamp 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | ------- Summary: start ------- 02:38:06 INFO - PID 23832 | Number of tests: 14 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.00 stddev:1.16 (1.1%) stddev-sans-first:1.22 02:38:06 INFO - PID 23832 | Values: 107.0 107.0 107.0 106.0 110.0 107.0 107.0 108.0 108.0 106.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:121.00 stddev:8.44 (7.0%) stddev-sans-first:8.90 02:38:06 INFO - PID 23832 | Values: 119.0 122.0 115.0 122.0 120.0 123.0 116.0 117.0 116.0 144.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.24 (2.6%) stddev-sans-first:4.50 02:38:06 INFO - PID 23832 | Values: 164.0 163.0 162.0 161.0 162.0 162.0 161.0 175.0 167.0 163.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#3] audio-fft Cycles:10 Average:76.30 Median:74.50 stddev:7.72 (10.4%) stddev-sans-first:8.17 02:38:06 INFO - PID 23832 | Values: 75.0 74.0 76.0 72.0 73.0 73.0 74.0 73.0 98.0 75.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 02:38:06 INFO - PID 23832 | Values: 79.0 79.0 80.0 79.0 79.0 79.0 79.0 78.0 80.0 79.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#5] imaging-gaussian-blur Cycles:10 Average:111.70 Median:112.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 02:38:06 INFO - PID 23832 | Values: 111.0 112.0 113.0 111.0 111.0 112.0 112.0 112.0 112.0 111.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 02:38:06 INFO - PID 23832 | Values: 148.0 148.0 148.0 148.0 149.0 147.0 147.0 150.0 148.0 149.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:2.37 (2.5%) stddev-sans-first:0.78 02:38:06 INFO - PID 23832 | Values: 101.0 93.0 94.0 93.0 93.0 95.0 94.0 94.0 94.0 95.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 02:38:06 INFO - PID 23832 | Values: 51.0 51.0 51.0 50.0 50.0 50.0 51.0 50.0 51.0 50.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:37.00 stddev:1.99 (5.4%) stddev-sans-first:2.09 02:38:06 INFO - PID 23832 | Values: 37.0 36.0 37.0 43.0 37.0 39.0 37.0 37.0 38.0 37.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.71 (3.6%) stddev-sans-first:2.87 02:38:06 INFO - PID 23832 | Values: 76.0 78.0 73.0 82.0 74.0 75.0 76.0 74.0 79.0 76.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:114.50 stddev:4.62 (4.0%) stddev-sans-first:4.90 02:38:06 INFO - PID 23832 | Values: 113.0 117.0 116.0 123.0 110.0 109.0 111.0 117.0 108.0 112.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:164.50 stddev:5.06 (3.1%) stddev-sans-first:4.38 02:38:06 INFO - PID 23832 | Values: 173.0 161.0 168.0 161.0 172.0 163.0 163.0 166.0 163.0 157.0 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.91 (3.0%) stddev-sans-first:1.90 02:38:06 INFO - PID 23832 | Values: 63.0 65.0 66.0 67.0 64.0 64.0 64.0 63.0 69.0 64.0 02:38:06 INFO - PID 23832 | -------- Summary: end -------- 02:38:06 INFO - PID 23832 | 02:38:06 INFO - PID 23832 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:38:07 INFO - TEST-INFO | 23832: exit 0 02:38:07 INFO - TEST-OK | kraken | took 60923ms 02:38:07 INFO - SUITE-END | took 1169s 02:38:07 INFO - Completed test suite (00:19:29) 02:38:07 INFO - javascript benchmark 02:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8617.775849649293, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.5753473281106, 3176.857041433136, 3185.4584720597495, 3191.2979144588185, 3204.583404157459, 6203.658798766066, 6257.061440783879, 6258.593191442553, 6271.560990730651, 6295.779647712331, 6103.908441373372, 6213.658248796314, 6252.624842509453, 6253.906191407133, 6254.343293954137, 5749.540036797057, 5802.071668533035, 5837.766489340422, 5847.912281315784, 5861.912071318934, 5763.596548241604, 5792.044312688401, 5832.825015249549, 5841.182234487175, 5854.941450585504, 5535.280413546254, 5641.8589535261535, 5672.376038635747, 5750.0, 5797.652140871519, 5728.054870946289, 5743.052396354597, 5816.680082595455, 5816.941830581683, 5836.241288632493, 5631.0, 5703.572232082611, 5704.458076482728, 5781.4507621775865, 5785.0, 6198.752049917998, 6203.565750397474, 6205.317415084337, 6240.937590624127, 6299.8740025199695, 6728.495362847806, 6730.596164230162, 6735.0, 6756.628385438799, 6767.35710107539, 6772.288909664513, 6773.3903948644365, 6850.760223392207, 6855.691493882788, 6882.5870447772795, 6235.469985051276, 6263.029230469285, 6282.371762823681, 6323.936760632427, 6366.522510811707, 6922.307769223037, 6967.616781077089, 6976.407005404496, 7018.824529386806, 7030.261822508563, 6583.07836902834, 6596.208454985336, 6682.63245521501, 6684.699188536528, 6686.398224159849, 6718.966405168041, 6750.628715420601, 6798.796036118924, 6831.521793474509, 6859.657017149123, 6532.248791388956, 6598.802035938929, 6607.306232845578, 6674.599524028574, 6694.464442844658, 6713.4964877634375, 6722.327767223336, 6760.966195168992, 6772.255051944282, 6772.288909664513, 5095.515925987025, 5238.97380513095, 5246.63273570854, 5321.122014867581, 5356.3572371315695, 4627.282771170474, 4658.277966915133, 4664.976675116671, 4666.043461090469, 4671.0, 5771.249737534094, 5782.595218334676, 5845.298564172326, 5850.1224816277045, 5855.209546711225, 6573.704183311763, 6642.269350371455, 6706.295838936939, 6744.12326397575, 6790.42281406086, 5849.0, 5852.970735146297, 5858.414158584193, 5858.912116318259, 5879.676617785977, 5767.394423585463, 5803.158542011384, 5832.533397328203, 5838.0, 5839.182514447981, 6412.9679351602945, 6413.551051426449, 6429.099926010363, 6494.577852439576, 6518.674066296666, 6572.769953051811, 6651.068850360856, 6664.566803157779, 6665.833354166185, 6804.727810887608, 6290.591111577733, 6331.778387756406, 6355.809325720235, 6472.190976127984, 6481.384268494486, 6651.268360480247, 6694.966525167343, 6696.59820410777, 6702.664866756545, 6708.932910670831, 6746.224184218878, 6750.35871592198, 6761.087253220752, 6849.349311815369, 6854.725810967506, 6480.546361754632, 6494.155759751202, 6512.0, 6568.507361947777, 6583.144191255106, 6551.80344589663, 6569.310222426577, 6584.703688333941, 6595.637239951849, 6605.570637908713, 6423.807285781247, 6445.742170313322, 6452.54832161763, 6541.051547525487, 6548.770793022221, 6426.100345951477, 6524.641144737085, 6563.278039415756, 6636.435902948304, 6645.269020407848, 6283.8114856554375, 6320.905186422116, 6399.456046236122, 6411.455026322815, 6421.197350331208], "value": 6125.464580200155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.4890089297761, 887.653815012145, 894.9105089491052, 895.5835536475538, 897.54225345074, 40549.59450405495, 41393.17213655725, 44307.556924430784, 44434.777826110905, 44471.555284447146, 39846.0, 39975.60024399755, 40007.19985600294, 40036.79981600088, 40038.79980600093, 7211.81970450739, 7349.963250183741, 8024.077231118437, 8257.710980115697, 8258.545779982129, 8057.597120143999, 8102.068262149869, 8140.1452847451055, 8142.267195952363, 8172.141925097868, 8054.073781515142, 8084.15116412777, 8090.514569125871, 8097.311728503084, 8124.6750129994725, 7998.960005199966, 8110.837783244361, 8120.472169308976, 8130.837383252302, 8135.34917206628, 8007.67969281228, 8024.197580241929, 8056.194380561956, 8059.113497515269, 8109.107998120202, 39288.60711392878, 39541.406878896836, 39545.20909581821, 39605.0, 39659.0, 3517.9296414071573, 3564.269324788412, 3564.590072141711, 3581.3732596795458, 3589.246258285763, 32226.35547289041, 32349.51475727866, 32390.83804580962, 32450.35099298001, 32539.51190732141, 4973.5523802857915, 5134.666246693953, 5179.300794392747, 5188.118019936582, 5195.1687729963405, 198390.0, 198575.0, 199013.0, 199524.0, 199987.99999999854, 43054.354184687254, 43921.78039109784, 50171.0, 50206.49793502091, 50406.243906341435, 53838.73080634572, 54157.45842541603, 54484.72757636187, 54626.453735462135, 54645.0, 15654.0, 15727.370905163894, 15785.68428631421, 15803.0, 15819.683606328039, 12861.0, 12886.742265154644, 12887.420066097047, 12958.352082395842, 12986.220826750425, 14334.49829255992, 14468.638284042983, 14469.855301447062, 14607.707845843024, 14617.707645847024, 5695.316562012585, 5756.884862302731, 5764.74058667361, 5770.19217309577, 5828.388019258002, 956.8803899512561, 983.7491439682835, 1006.9980369532216, 1020.505055048301, 1023.0741179232806, 23411.648825267635, 23525.0, 23540.41148971255, 23748.64377034346, 24032.87983560071, 1055.4669891704793, 1097.2538673701958, 1102.9227954043301, 1124.8875112488686, 1124.8987591116675, 12367.814482782765, 12411.689707757378, 12477.438515266835, 12636.305003224727, 12784.360781960864, 216030.0, 216303.0, 217092.0, 217313.0, 217966.0, 54857.177142342895, 54866.725666371414, 54935.72532137314, 55222.44777552173, 55230.44769552333, 1388.1532265318149, 1432.1192466632945, 1432.2122832442114, 1436.8347640021323, 1441.891858110646, 22835.429114272276, 23087.53824923526, 23102.537949241258, 23423.41441463977, 23618.645720313867, 38324.80837595794, 38436.80781596074, 38442.42336364901, 38474.0, 38524.80737596294, 192618.0, 193646.0, 194934.0, 195194.0, 195412.0, 34663.653363466045, 34688.0, 35371.64628353684, 35375.64624353724, 35389.0, 42773.572264278206, 43983.340249895635, 43996.56003439925, 44415.0, 44488.33267500925, 31531.84234078815, 31735.365292693554, 31925.36149277048, 32372.0, 32609.510857337635, 31747.841260794474, 31841.681583183872, 31961.840190799827, 32227.838860805547, 32903.34193316168, 36796.26407471782, 36926.81536592407, 37083.25833483369, 37118.62881371152, 37281.81359093187, 31358.0, 31444.68555314509, 31455.899043533365, 31568.0, 31700.36599268048, 22654.886725566266, 23564.444488855912, 23581.0, 23656.526869462858, 23780.048798047883], "value": 17383.16778491182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5073338395747, 588.6644612570834, 598.350789393508, 606.8634557224625, 612.378435887574, 22464.88767556162, 23191.884040579793, 23235.76764232357, 23240.76759232407, 23361.415964600892, 23635.40911477214, 24642.876785616092, 24719.382015449577, 24855.50288994219, 24859.254222373358, 6437.35626437356, 6646.6676666166495, 6652.368025037614, 6655.101561289212, 6655.434288085518, 6343.777967771129, 6511.023346498016, 6605.768798092067, 6609.074729537869, 6627.60234385936, 6596.208454985408, 6604.636744979024, 6605.867882642344, 6607.141071660677, 6607.372299631527, 6578.60528368297, 6587.374199451045, 6589.341065893396, 6597.9340206598035, 6741.359570840762, 6900.482463815234, 6921.653917304115, 6957.304269573053, 6960.582365058112, 6961.860762784716, 29255.41489170226, 29879.551806722917, 29903.0, 29906.0, 29933.25166870824, 2110.5251318453224, 2120.3003009007143, 2126.5109024924354, 2135.8398120140896, 2146.9785302146934, 20103.899480502503, 20341.0, 21068.683969740465, 21333.573328533497, 21342.0, 2588.314096764359, 2606.5829467285143, 2673.518766622007, 2676.6520352354264, 2681.1554360376417, 129293.35353323267, 135553.0, 146951.0, 154134.22932885264, 154168.0, 20138.69791953122, 20430.489237769176, 20536.897315513626, 21610.675839862415, 22127.557448850934, 39730.80134599309, 39918.800405998365, 39949.20101597952, 39957.40063899044, 40106.0, 11029.558817647205, 11056.889431105747, 11192.642207337929, 11275.774484510264, 11371.943140284411, 9235.861462078074, 9313.48775817323, 9352.625894964262, 9442.197413219816, 9450.96804187103, 11117.499712512956, 11227.71930701739, 11250.831237531444, 11414.0, 11421.657350279505, 4126.855560055384, 4127.525334586501, 4201.390798334285, 4288.978555107205, 4465.799039043251, 934.1592566689898, 945.6028468043438, 945.952702364879, 950.3917492804611, 955.8040601676639, 18844.15201315944, 19030.714539281922, 19079.52301192481, 19380.709289360388, 19416.805831941783, 985.4727720669407, 1007.5717819926502, 1013.3767732844248, 1018.3279035836313, 1020.0972139656458, 10335.069843714102, 10352.378857268588, 10371.740706482398, 10550.208734344955, 10608.840867386996, 470572.0, 486181.0, 495689.0, 496085.0, 498482.0, 109310.45344773385, 112056.4397178009, 113475.43262283636, 113531.0, 113862.0, 1144.0390072339276, 1148.3397046698183, 1180.055955235808, 1189.4825750798257, 1191.1721353659298, 17177.0, 17331.740023899398, 17720.822791772433, 17797.11014449298, 17966.5508362292, 56053.719731401085, 56103.43896560982, 56127.87744245174, 56902.14646780219, 57938.71030644988, 68561.0, 68564.6571767138, 69658.0, 69671.30328696647, 69696.65151674209, 19935.900320498306, 20301.390958271277, 20385.286514971904, 20412.0, 20473.181072757518, 22837.429064272863, 22884.542309154058, 22884.656730148727, 23112.0, 23116.537669246183, 18174.636507270046, 18328.816711833246, 18539.629207416045, 18629.72055419197, 18678.34625788091, 16318.102504362374, 16379.262933167798, 16811.32754689799, 16838.410655626994, 16967.830321696623, 18356.26574937041, 18773.436796896116, 18785.0, 18932.242710291433, 18942.242310307985, 19516.414507564798, 19650.803491964896, 19793.50516237048, 19854.702179467607, 19974.60050799005, 18019.81980180234, 18077.819221807615, 18084.18621162077, 18293.26826926908, 18386.08069596488], "value": 12823.997500401798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.4635922451407, 1371.7530844448002, 1377.1736957825312, 1382.6197795606206, 1395.8185435893326, 13933.303334833268, 14465.92767036166, 14474.782878256834, 14517.49188778393, 14546.345414456347, 14369.640758981031, 14419.0, 14473.5657930262, 14481.855181448182, 14513.709725805478, 2704.432069265452, 2853.9286517837118, 2854.24362543926, 2854.885804567815, 2856.742893139617, 2675.812693111483, 2711.701712811589, 2789.316617428733, 2792.0507027610606, 2792.3298408382047, 2777.125205560252, 2835.7447829695325, 2838.148555433372, 2841.1334542964387, 2844.7581955533806, 2726.073135134054, 2745.766609838166, 2751.2159034675024, 2759.9448011039767, 2812.3812761192503, 2587.6894772627215, 2631.2369412870244, 2668.7197844226466, 2685.2749757565543, 2687.9731202687917, 14240.430382784676, 14307.141571505743, 14321.35553900077, 14341.641458963504, 14345.78481322781, 7755.961220193919, 8005.879911801328, 8055.395845311625, 8063.556504392256, 8073.838523229561, 5047.798088076473, 5097.6941383517105, 5171.120909445403, 5242.79028838846, 5254.343207099113, 1948.4154753574012, 1952.5704345044066, 1969.1827891425041, 1972.339266345776, 1996.3511858645998, 24921.252362429157, 25528.744712552823, 25554.74445255561, 25594.616080758802, 25597.0, 6937.202221744564, 7102.325279098477, 7182.928170718226, 7251.274872512707, 7270.127584689871, 18231.544211394557, 18297.81702182961, 18362.63274734498, 18405.63188736218, 18499.630007399777, 7884.329831964347, 7979.68081276754, 8245.381596380295, 8253.876191857127, 8257.256846883689, 7291.817704557322, 7340.9632951835965, 7351.632418379059, 7352.926470735331, 7405.481616286916, 5067.695938243717, 5128.8461346159675, 5161.612879034087, 5218.582513398919, 5242.318498595235, 1488.6501672107047, 1493.4324956516455, 1499.640086379283, 1509.0492989416816, 1512.7579587266205, 867.4535042922918, 873.7116751471999, 893.1425831201989, 897.2149369301861, 900.3292547052357, 7190.496665233383, 7196.10048743907, 7297.233790452032, 7357.2642735726, 7367.263273672697, 714.1608609883366, 726.3535453446436, 743.9702411903463, 748.7117459778025, 751.6692655231681, 4857.6842505237755, 5084.237364395371, 5197.766100525486, 5268.92096618551, 5404.216388623628, 19481.902590486956, 19956.10197541114, 20255.18979240814, 20262.392128236177, 20285.79714202839, 18685.252589896252, 20046.0, 20066.698999515018, 20076.799232007786, 20087.899560502105, 10295.227857910537, 10373.377597344184, 10394.272400932014, 10420.426876521713, 10469.68590942273, 7832.689356639691, 7982.281594656509, 8019.558924259221, 8124.959375203322, 8201.589920503831, 16796.916015419843, 17134.571635709206, 17272.91363543174, 17331.826681733524, 17388.565285867953, 17092.914535427244, 17440.912795435943, 17475.650486990442, 17489.212985415434, 17630.206640700944, 10416.687499375032, 10601.787964240826, 10604.204684648528, 10613.628523001658, 10613.787724245318, 12960.481580736665, 12981.156224845732, 13053.477860885458, 13146.474141034252, 13215.074944753775, 10363.170946324426, 10512.369257844553, 10594.894051059391, 10685.358878467317, 10948.56205751761, 9731.805363892825, 9766.658166964122, 9815.509224538888, 9876.20990320787, 10026.69919902404, 9386.812263754824, 9456.385334953206, 9485.146336829719, 9537.761555961157, 9538.427694338361, 6968.163820341591, 7048.471364647569, 7049.118860142482, 7060.470464715064, 7085.114360704912, 7145.535540189871, 7179.425645948207, 7190.532615379983, 7237.674304656409, 7338.449616278907], "value": 6450.70337518981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.6247220764945, 524.7166530073762, 539.7759929629203, 550.6448340820174, 551.0879494436708, 6118.174046503721, 6275.807596556662, 6300.30696623371, 6345.60396712723, 6369.490440764739, 6106.633601983884, 6156.3535828737895, 6159.661218632973, 6187.0, 6313.053042043695, 4948.703077815325, 4997.55071029401, 5004.874878128039, 5024.698518088908, 5075.822346217883, 5073.898522029557, 5088.26220198071, 5124.538791508763, 5135.2040433732645, 5144.742762861842, 5012.749362531858, 5048.1670524363435, 5061.240813877929, 5089.389273287211, 5093.236014597822, 5023.497650234984, 5054.620903432257, 5065.544101030907, 5067.619928505377, 5091.872703182413, 4539.977300113512, 4540.909181816378, 4579.496255411902, 4587.724736515786, 4592.494825569184, 6146.569740118193, 6168.537359698041, 6237.34507876671, 6256.812295631138, 6286.779962701284, 5693.316801983747, 5734.4265573442735, 5737.9713101434645, 5807.2160258365, 5827.562932780016, 6615.239247486505, 6635.203775546917, 6663.966680166568, 6703.262641109474, 6711.4295284900845, 4997.325361076245, 5007.37407824022, 5016.097102521545, 5025.974870125626, 5038.571721403685, 6882.724691012403, 6956.791141359456, 6978.965105174441, 6990.440764738809, 7054.541454805472, 5117.565006974374, 5117.897642047213, 5120.385553733576, 5123.180291153398, 5125.1287281162295, 5198.870028249324, 5209.270702101709, 5218.582513398919, 5228.353068783321, 5238.0, 5735.684537350486, 5755.0, 5777.162311464898, 5778.3643799182055, 5780.53755699543, 6347.619142851444, 6506.869862602722, 6532.41208291256, 6536.182977127859, 6654.866902662016, 1686.4603326935262, 1750.2823842224627, 1769.186174359809, 1785.4018903667156, 1793.560577658482, 1196.904247660185, 1220.1702842067302, 1238.1147479552164, 1263.065331654569, 1267.689416093063, 5669.858253543694, 5684.488396044293, 5696.202531645573, 5785.71071446426, 5811.3316968548315, 6707.899381509281, 6789.287124851919, 6950.548214366151, 6953.965230173817, 6965.930340696629, 5589.385167631557, 5748.482636562646, 5756.366799652035, 5779.2775903012125, 5784.219130417424, 3602.5316708827686, 3610.097475631092, 3610.458431235283, 3639.454081887738, 3661.5240018797385, 6535.0, 6557.278699343068, 6567.179102612174, 6571.21145462538, 6604.636744979072, 6895.689693963784, 6913.412359949461, 6952.409045231111, 6973.476989225828, 7025.508214425044, 6423.164988551458, 6442.420182183532, 6479.514036447285, 6507.186601674791, 6521.739130434729, 6821.727130914708, 6851.9657401712675, 6853.971904214209, 6876.140482439695, 6879.862402752017, 6664.933350666432, 6729.360710732472, 6735.797926062226, 6737.124173857564, 6774.780539502937, 6348.396902294275, 6352.570671598854, 6364.236291645032, 6498.642574658439, 6500.3174666659315, 5489.862753431196, 5521.309836270466, 5537.916931246115, 5626.606137570331, 5637.49262566371, 6539.6403197824575, 6796.966015169893, 6831.4876384272375, 6876.656167191521, 6921.134858142732, 6209.627422354673, 6544.3782840630065, 6560.179977502812, 6599.769008084694, 6600.669966501751, 6556.409923106943, 6589.604623722592, 6605.405513503808, 6621.70876679043, 6638.5684930479365, 6486.610803351814, 6513.934860651333, 6514.54398192122, 6518.272657745606, 6522.184726909137, 6330.715117819801, 6547.0, 6614.272430032596, 6619.437347825488, 6656.5340426169705, 6325.620462772248, 6397.360263973565, 6416.647084410402, 6427.453666438218, 6434.388733070351], "value": 5128.162813403811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.461250555919, 912.0332447605539, 919.4483310013992, 927.8051609162076, 937.8968313485516, 19085.61828763424, 20180.59638807223, 20206.6968995465, 20212.292569760062, 20219.292324768638, 16984.235709393077, 17574.209160587772, 17623.823761762378, 17714.379996700118, 17876.106194690245, 948.1419315519448, 965.3098034905041, 968.4721826604517, 968.970930872075, 969.2343048991323, 954.3748844506824, 977.5112443778111, 990.9801803963917, 991.33085167512, 1001.0890090018084, 1035.8912314207014, 1060.6022741471947, 1062.1821197677784, 1064.4624464645344, 1065.1319174872453, 995.8705368302146, 1026.343140390151, 1030.2015937648307, 1032.158790585674, 1065.6003998500562, 750.2497502497503, 753.2730914667372, 753.5591678867869, 754.091319959453, 755.7694903054567, 20591.0, 20833.270835520834, 20869.895650521652, 20891.895540522353, 20936.790632093638, 19426.70859937102, 20714.275000374913, 20727.27454539084, 20818.16727330905, 20818.895905520527, 16277.348906043744, 16418.097004664738, 16592.502224933272, 16774.245158967875, 16785.07682077485, 3662.5604927408617, 3673.1735359544155, 3679.0618392310057, 3684.299983003221, 3698.7595806272507, 142586.0, 143033.0, 143418.0, 143817.2809135958, 146172.0, 16850.578735531464, 16979.575510612332, 17052.14739263032, 17206.053667048433, 17215.56961075958, 30787.69212307893, 31743.0, 31904.68095319017, 31925.20186995344, 32084.0, 7503.962480187564, 7638.197989211164, 7816.8827467588035, 7828.765137045898, 7837.294643482114, 3669.3945498992903, 3861.0, 3862.942055869164, 3863.4784304118584, 3865.342891708416, 5574.470425309589, 5674.120511320752, 5675.744591493392, 5678.744456499468, 5681.17622944679, 944.1927152284835, 967.7241986034087, 981.6269817469316, 982.6364245229311, 987.1905037869022, 657.6152950523997, 665.8568407792347, 673.7675501951819, 677.3869647968596, 684.096991970594, 11542.307461552165, 11675.35785531804, 12043.337616431005, 12086.153969222245, 12254.142210045211, 655.2693746472744, 665.0556210181554, 666.9499787515956, 671.771597656799, 682.0723815610766, 5165.690058596496, 5209.348831396075, 5211.339331183155, 5242.030224408497, 5284.550813180923, 125184.0, 125584.0, 128988.0, 129312.0, 130868.0, 90198.0, 94975.050249498, 109497.0, 110153.0, 117467.0, 93447.99999999865, 94141.0, 94621.0, 96799.51600242095, 98073.50963245139, 12021.218620789621, 12325.137240393087, 12326.630201093982, 12342.75314493723, 12733.970081817444, 42632.147357053305, 43454.47909323159, 43830.561694382646, 45172.54827451815, 45358.546414535434, 57345.71327143338, 57953.710231448575, 59103.113453297374, 59180.0, 59444.405555943886, 18332.90833545877, 18676.31913127825, 18772.812271877105, 18886.244550217838, 19246.133923973175, 19579.314723984593, 19681.507962301057, 19789.82311945656, 19829.702554461983, 20058.197672092952, 17110.657786843945, 17199.828001719823, 17210.225539850486, 17234.82765172332, 17322.740158897373, 19061.23755049838, 19407.126679299185, 19416.708749369052, 19421.51446213856, 19815.009249537754, 14787.704245915236, 14844.40622375093, 14941.477048303257, 15042.548723537873, 15053.849461505244, 11939.283642981101, 12057.57798477049, 12115.0, 12182.512699491921, 12278.324692142018, 13767.242801646005, 13811.79282310746, 13840.792388114387, 13847.169169849842, 13875.583732488041], "value": 9067.417750996246, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1410.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 106.0, 110.0, 107.0, 107.0, 108.0, 108.0, 106.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 115.0, 122.0, 120.0, 123.0, 116.0, 117.0, 116.0, 144.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 161.0, 162.0, 162.0, 161.0, 175.0, 167.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 72.0, 73.0, 73.0, 74.0, 73.0, 98.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0, 80.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 147.0, 150.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 94.0, 93.0, 93.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 50.0, 50.0, 50.0, 51.0, 50.0, 51.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 37.0, 43.0, 37.0, 39.0, 37.0, 37.0, 38.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 73.0, 82.0, 74.0, 75.0, 76.0, 74.0, 79.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 123.0, 110.0, 109.0, 111.0, 117.0, 108.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 161.0, 168.0, 161.0, 172.0, 163.0, 163.0, 166.0, 163.0, 157.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 67.0, 64.0, 64.0, 64.0, 63.0, 69.0, 64.0], "value": 64.9, "unit": "score"}]}]} 02:38:07 INFO - Return code: 0 02:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:38:07 INFO - # TBPL SUCCESS # 02:38:07 INFO - Running post-action listener: _package_coverage_data 02:38:07 INFO - Running post-action listener: _resource_record_post_action 02:38:07 INFO - [mozharness: 2017-09-30 09:38:07.396766Z] Finished run-tests step (success) 02:38:07 INFO - Running post-run listener: _resource_record_post_run 02:38:07 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 347201536; Read time: 16; Write time: 189656 02:38:07 INFO - TinderboxPrint: CPU usage
13.1% 02:38:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:38:07 INFO - TinderboxPrint: I/O write bytes / time
347,201,536 / 189,656 02:38:07 INFO - TinderboxPrint: CPU idle
8,229.9 (86.9%) 02:38:07 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 02:38:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:38:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13328384; Read time: 0; Write time: 2684 02:38:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:38:07 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 333402112; Read time: 0; Write time: 186972 02:38:08 INFO - Running post-run listener: _upload_blobber_files 02:38:08 INFO - Blob upload gear active. 02:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38: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 02:38: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'] 02:38: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 02:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:09 INFO - (blobuploader) - INFO - Done attempting. 02:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:10 INFO - (blobuploader) - INFO - Done attempting. 02:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:11 INFO - (blobuploader) - INFO - Done attempting. 02:38:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:38:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:15 INFO - (blobuploader) - INFO - Done attempting. 02:38:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:15 INFO - Return code: 0 02:38:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d65159f588868c15c72514e9bb2adad6723366e6abf8dadc7c63964b1ac34cb2f4a78605040df6b18f22bee3430b1634b74943f2db4ac6b2c482ed886a167b8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2d397227ddf4a9cd6a51718225f5a3a20b312ad1adc904fdea3c685f55fefed7b28056ac173d14fed7e6395e1b23af31f893156db6d53119b92290ef9dd6c22", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/071462c8b4d74777722a5dbb33f445411ba10d73ced4d16a1ac1265ae274820c653bf98100de8238c6fec939e2c823cdfd77ba6ac58ad2e30316348c5ea4e67c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82734c2e1735b7932ba5814c8180cc8b737d454b7946435bbff289165fefcc8079200ccfa8f2c24e433f262c8ee5b31eb71787c0493ea0b59d8eba4eebaac0b"} 02:38:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:15 INFO - Contents: 02:38:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d65159f588868c15c72514e9bb2adad6723366e6abf8dadc7c63964b1ac34cb2f4a78605040df6b18f22bee3430b1634b74943f2db4ac6b2c482ed886a167b8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2d397227ddf4a9cd6a51718225f5a3a20b312ad1adc904fdea3c685f55fefed7b28056ac173d14fed7e6395e1b23af31f893156db6d53119b92290ef9dd6c22", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/071462c8b4d74777722a5dbb33f445411ba10d73ced4d16a1ac1265ae274820c653bf98100de8238c6fec939e2c823cdfd77ba6ac58ad2e30316348c5ea4e67c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82734c2e1735b7932ba5814c8180cc8b737d454b7946435bbff289165fefcc8079200ccfa8f2c24e433f262c8ee5b31eb71787c0493ea0b59d8eba4eebaac0b"} 02:38:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:15 INFO - Copying logs to upload dir... 02:38:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.074772 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-30 02:38:15.173031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 02:38:15.176222) ========= 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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d65159f588868c15c72514e9bb2adad6723366e6abf8dadc7c63964b1ac34cb2f4a78605040df6b18f22bee3430b1634b74943f2db4ac6b2c482ed886a167b8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2d397227ddf4a9cd6a51718225f5a3a20b312ad1adc904fdea3c685f55fefed7b28056ac173d14fed7e6395e1b23af31f893156db6d53119b92290ef9dd6c22", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/071462c8b4d74777722a5dbb33f445411ba10d73ced4d16a1ac1265ae274820c653bf98100de8238c6fec939e2c823cdfd77ba6ac58ad2e30316348c5ea4e67c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82734c2e1735b7932ba5814c8180cc8b737d454b7946435bbff289165fefcc8079200ccfa8f2c24e433f262c8ee5b31eb71787c0493ea0b59d8eba4eebaac0b"} build_url:https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/An79CafaRoS1gX-FTBpPPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d65159f588868c15c72514e9bb2adad6723366e6abf8dadc7c63964b1ac34cb2f4a78605040df6b18f22bee3430b1634b74943f2db4ac6b2c482ed886a167b8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2d397227ddf4a9cd6a51718225f5a3a20b312ad1adc904fdea3c685f55fefed7b28056ac173d14fed7e6395e1b23af31f893156db6d53119b92290ef9dd6c22", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/071462c8b4d74777722a5dbb33f445411ba10d73ced4d16a1ac1265ae274820c653bf98100de8238c6fec939e2c823cdfd77ba6ac58ad2e30316348c5ea4e67c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82734c2e1735b7932ba5814c8180cc8b737d454b7946435bbff289165fefcc8079200ccfa8f2c24e433f262c8ee5b31eb71787c0493ea0b59d8eba4eebaac0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 02:38:15.207971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:38:15.208345) ========= 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=2432103b8b3de4003b23cad4000001c2-1506762533.800064-1686759093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:38:15.290796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 02:38:15.291101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 02:38:15.291403) ========= ========= Total master_lag: 0.24 =========