builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1508369823.58 results: success (0) revision: adc0384c565aae18fd8b2a669363ac27bd3a6676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.581824) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.582349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.582632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.602128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.602519) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-18 16:37:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2017-10-18 16:37:03 (20.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.714922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.715240) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:03.764842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-18 16:37:03.765183) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev adc0384c565aae18fd8b2a669363ac27bd3a6676 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev adc0384c565aae18fd8b2a669363ac27bd3a6676 --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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-18 16:37:03,931 truncating revision to first 12 chars 2017-10-18 16:37:03,931 Setting DEBUG logging. 2017-10-18 16:37:03,931 attempt 1/10 2017-10-18 16:37:03,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/adc0384c565a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-18 16:37:05,151 unpacking tar archive at: mozilla-beta-adc0384c565a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-18 16:37:05.398747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:05.399075) ========= script_repo_revision: adc0384c565aae18fd8b2a669363ac27bd3a6676 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:05.399560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:05.399856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-18 16:37:05.414729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-18 16:37:05.415016) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:05 INFO - MultiFileLogger online at 20171018 16:37:05 in /builds/slave/test 16:37:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 16:37:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:05 INFO - {'append_to_log': False, 16:37:05 INFO - 'base_work_dir': '/builds/slave/test', 16:37:05 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 16:37:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:05 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 16:37:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:05 INFO - 'code_coverage': False, 16:37:05 INFO - 'config_files': ('talos/linux_config.py',), 16:37:05 INFO - 'default_actions': ('clobber', 16:37:05 INFO - 'read-buildbot-config', 16:37:05 INFO - 'download-and-extract', 16:37:05 INFO - 'populate-webroot', 16:37:05 INFO - 'create-virtualenv', 16:37:05 INFO - 'install', 16:37:05 INFO - 'setup-mitmproxy', 16:37:05 INFO - 'run-tests'), 16:37:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:05 INFO - 'disable_ccov_upload': False, 16:37:05 INFO - 'disable_stylo': False, 16:37:05 INFO - 'download_minidump_stackwalk': True, 16:37:05 INFO - 'download_symbols': 'ondemand', 16:37:05 INFO - 'enable_stylo': False, 16:37:05 INFO - 'enable_webrender': False, 16:37:05 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:37:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:05 INFO - 'gecko_profile': False, 16:37:05 INFO - 'gecko_profile_interval': 0, 16:37:05 INFO - 'installer_path': 'installer.exe', 16:37:05 INFO - 'log_level': 'info', 16:37:05 INFO - 'log_name': 'talos', 16:37:05 INFO - 'log_to_console': True, 16:37:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:05 INFO - 'opt_config_files': (), 16:37:05 INFO - 'pip_index': False, 16:37:05 INFO - 'suite': 'dromaeojs-e10s', 16:37:05 INFO - 'system_bits': '32', 16:37:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:05 INFO - 'title': 'talos-linux64-ix-006', 16:37:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:05 INFO - 'use_talos_json': True, 16:37:05 INFO - 'verify': 'False', 16:37:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:05 INFO - 'work_dir': 'build'} 16:37:05 INFO - [mozharness: 2017-10-18 23:37:05.746611Z] Running clobber step. 16:37:05 INFO - Running pre-action listener: _resource_record_pre_action 16:37:05 INFO - Running main action method: clobber 16:37:05 INFO - rmtree: /builds/slave/test/build 16:37:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:37:06 INFO - Running post-action listener: _resource_record_post_action 16:37:06 INFO - [mozharness: 2017-10-18 23:37:06.890049Z] Finished clobber step (success) 16:37:06 INFO - [mozharness: 2017-10-18 23:37:06.890148Z] Running read-buildbot-config step. 16:37:06 INFO - Running pre-action listener: _resource_record_pre_action 16:37:06 INFO - Running main action method: read_buildbot_config 16:37:06 INFO - Using buildbot properties: 16:37:06 INFO - { 16:37:06 INFO - "project": "", 16:37:06 INFO - "product": "firefox", 16:37:06 INFO - "who": "ryanvm@gmail.com", 16:37:06 INFO - "installer_path": "public/build/target.tar.bz2", 16:37:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:37:06 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 16:37:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 16:37:06 INFO - "stage_platform": "linux64", 16:37:06 INFO - "basedir": "/builds/slave/test", 16:37:06 INFO - "buildnumber": 143, 16:37:06 INFO - "platform": "ubuntu64_hw", 16:37:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:37:06 INFO - "slavebuilddir": "test", 16:37:06 INFO - "taskId": "E8-3bCUjT_u1fV79pPM93w", 16:37:06 INFO - "branch": "mozilla-beta", 16:37:06 INFO - "script_repo_revision": "production", 16:37:06 INFO - "revision": "adc0384c565aae18fd8b2a669363ac27bd3a6676", 16:37:06 INFO - "slavename": "talos-linux64-ix-006", 16:37:06 INFO - "repo_path": "releases/mozilla-beta" 16:37:06 INFO - } 16:37:06 INFO - Finding installer, test and symbols from parent task. 16:37:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E8-3bCUjT_u1fV79pPM93w'}, attempt #1 16:37:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E8-3bCUjT_u1fV79pPM93w'}, attempt #1 16:37:07 INFO - Task dependencies: TWJRsNEyQKyidsjJqZwYGw 16:37:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw'}, attempt #1 16:37:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 16:37:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.test_packages.json 16:37:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.crashreporter-symbols.zip 16:37:08 INFO - Running post-action listener: _resource_record_post_action 16:37:08 INFO - [mozharness: 2017-10-18 23:37:08.260271Z] Finished read-buildbot-config step (success) 16:37:08 INFO - [mozharness: 2017-10-18 23:37:08.260490Z] Running download-and-extract step. 16:37:08 INFO - Running pre-action listener: _resource_record_pre_action 16:37:08 INFO - Running main action method: download_and_extract 16:37:08 INFO - mkdir: /builds/slave/test/build/tests 16:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:08 INFO - trying https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.test_packages.json 16:37:08 INFO - Downloading https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:37:08 INFO - Downloaded 989 bytes. 16:37:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:37:08 INFO - Using the following test package requirements: 16:37:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:37:08 INFO - u'common': [u'target.common.tests.zip'], 16:37:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:37:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:37:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:37:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:37:08 INFO - u'mozbase': [u'target.common.tests.zip'], 16:37:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:37:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:37:08 INFO - u'web-platform': [u'target.common.tests.zip', 16:37:08 INFO - u'target.web-platform.tests.tar.gz'], 16:37:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:37:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.common.tests.zip 16:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.common.tests.zip into memory 16:37:12 INFO - Content-Length response header: 55172676 16:37:12 INFO - Bytes received: 55172676 16:37:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.talos.tests.zip 16:37:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:37:23 INFO - Fetch https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.talos.tests.zip into memory 16:37:24 INFO - Content-Length response header: 14509251 16:37:24 INFO - Bytes received: 14509251 16:37:25 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')]} 16:37:25 INFO - trying https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 16:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:37:28 INFO - Downloaded 53494050 bytes. 16:37:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 16:37:28 INFO - mkdir: /builds/slave/test/properties 16:37:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:28 INFO - Contents: 16:37:28 INFO - build_url:https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 16:37:28 INFO - Running post-action listener: _resource_record_post_action 16:37:28 INFO - Running post-action listener: find_tests_for_verification 16:37:28 INFO - Running post-action listener: set_extra_try_arguments 16:37:28 INFO - [mozharness: 2017-10-18 23:37:28.592082Z] Finished download-and-extract step (success) 16:37:28 INFO - [mozharness: 2017-10-18 23:37:28.592309Z] Running populate-webroot step. 16:37:28 INFO - Running pre-action listener: _resource_record_pre_action 16:37:28 INFO - Running main action method: populate_webroot 16:37:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:37:28 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['tresize', 16:37:28 INFO - 'tcanvasmark']}, 16:37:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:37:28 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['dromaeo_css', 16:37:28 INFO - 'kraken']}, 16:37:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:28 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'tests': ['damp', 'tps']}, 16:37:28 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['damp', 'tps']}, 16:37:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:28 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['dromaeo_dom']}, 16:37:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:37:28 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['basic_compositor_video', 16:37:28 INFO - 'glvideo']}, 16:37:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:37:28 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['ts_paint_webext', 16:37:28 INFO - 'tp5o_webext']}, 16:37:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:37:28 INFO - 'ts_paint', 16:37:28 INFO - 'tpaint', 16:37:28 INFO - 'sessionrestore', 16:37:28 INFO - 'sessionrestore_many_windows', 16:37:28 INFO - 'sessionrestore_no_auto_restore', 16:37:28 INFO - 'tabpaint']}, 16:37:28 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['a11yr', 16:37:28 INFO - 'ts_paint', 16:37:28 INFO - 'tpaint', 16:37:28 INFO - 'sessionrestore', 16:37:28 INFO - 'sessionrestore_many_windows', 16:37:28 INFO - 'sessionrestore_no_auto_restore', 16:37:28 INFO - 'tabpaint']}, 16:37:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:37:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:37:28 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['perf_reftest_singletons']}, 16:37:28 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['bloom_basic']}, 16:37:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:37:28 INFO - 'tsvgr_opacity', 16:37:28 INFO - 'tart', 16:37:28 INFO - 'tscrollx', 16:37:28 INFO - 'tsvg_static']}, 16:37:28 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['tsvgx', 16:37:28 INFO - 'tsvgr_opacity', 16:37:28 INFO - 'tart', 16:37:28 INFO - 'tscrollx', 16:37:28 INFO - 'tsvg_static']}, 16:37:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:37:28 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo'], 16:37:28 INFO - 'tests': ['tp5o']}, 16:37:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:37:28 INFO - 'talos_options': ['--mitmproxy', 16:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:37:28 INFO - '--firstNonBlankPaint'], 16:37:28 INFO - 'tests': ['tp6_google', 16:37:28 INFO - 'tp6_youtube', 16:37:28 INFO - 'tp6_amazon', 16:37:28 INFO - 'tp6_facebook']}, 16:37:28 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo', 16:37:28 INFO - '--mitmproxy', 16:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:37:28 INFO - '--firstNonBlankPaint'], 16:37:28 INFO - 'tests': ['tp6_google', 16:37:28 INFO - 'tp6_youtube', 16:37:28 INFO - 'tp6_amazon', 16:37:28 INFO - 'tp6_facebook']}, 16:37:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:37:28 INFO - 'talos_options': ['--stylo-threads=1', 16:37:28 INFO - '--mitmproxy', 16:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:37:28 INFO - '--firstNonBlankPaint'], 16:37:28 INFO - 'tests': ['tp6_google', 16:37:28 INFO - 'tp6_youtube', 16:37:28 INFO - 'tp6_amazon', 16:37:28 INFO - 'tp6_facebook']}, 16:37:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--xperf_path', 16:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:28 INFO - 'tests': ['tp5n']}, 16:37:28 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:37:28 INFO - 'talos_options': ['--disable-stylo', 16:37:28 INFO - '--xperf_path', 16:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:28 INFO - 'tests': ['tp5n']}}} 16:37:28 INFO - Running post-action listener: _resource_record_post_action 16:37:28 INFO - [mozharness: 2017-10-18 23:37:28.613578Z] Finished populate-webroot step (success) 16:37:28 INFO - [mozharness: 2017-10-18 23:37:28.613667Z] Running create-virtualenv step. 16:37:28 INFO - Running pre-action listener: _resource_record_pre_action 16:37:28 INFO - Running main action method: create_virtualenv 16:37:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:28 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:37:28 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:37:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:37:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:29 INFO - Installing pip...............done. 16:37:29 INFO - Return code: 0 16:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:37:29 INFO - Reading from file tmpfile_stdout 16:37:29 INFO - Output received: 16:37:29 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:37:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:29 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')]} 16:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:29 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')]} 16:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:29 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:29 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 16:37:29 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 16:37:29 INFO - Using env: {'DISPLAY': ':0', 16:37:29 INFO - 'HOME': '/home/cltbld', 16:37:29 INFO - 'LANG': 'en_US.UTF-8', 16:37:29 INFO - 'LANGUAGE': 'en_US:en', 16:37:29 INFO - 'LOGNAME': 'cltbld', 16:37:29 INFO - 'MAIL': '/var/mail/cltbld', 16:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:29 INFO - 'MOZ_NO_REMOTE': '1', 16:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:29 INFO - 'NO_EM_RESTART': '1', 16:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:29 INFO - 'PWD': '/builds/slave/test', 16:37:29 INFO - 'SHELL': '/bin/bash', 16:37:29 INFO - 'SHLVL': '1', 16:37:29 INFO - 'TERM': 'linux', 16:37:29 INFO - 'TMOUT': '86400', 16:37:29 INFO - 'USER': 'cltbld', 16:37:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:29 INFO - '_': '/tools/buildbot/bin/python'} 16:37:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:37:30 INFO - Downloading/unpacking pip>=1.5 16:37:30 INFO - Running setup.py egg_info for package pip 16:37:30 INFO - warning: no files found matching 'pip/cacert.pem' 16:37:30 INFO - warning: no files found matching '*.html' under directory 'docs' 16:37:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:37:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:37:30 INFO - Installing collected packages: pip 16:37:30 INFO - Found existing installation: pip 1.1 16:37:30 INFO - Uninstalling pip: 16:37:30 INFO - Successfully uninstalled pip 16:37:30 INFO - Running setup.py install for pip 16:37:30 INFO - warning: no files found matching 'pip/cacert.pem' 16:37:30 INFO - warning: no files found matching '*.html' under directory 'docs' 16:37:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:37:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:37:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Successfully installed pip 16:37:30 INFO - Cleaning up... 16:37:30 INFO - Return code: 0 16:37:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:37:30 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')]} 16:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:30 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')]} 16:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:30 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:30 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 16:37:30 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 16:37:30 INFO - Using env: {'DISPLAY': ':0', 16:37:30 INFO - 'HOME': '/home/cltbld', 16:37:30 INFO - 'LANG': 'en_US.UTF-8', 16:37:30 INFO - 'LANGUAGE': 'en_US:en', 16:37:30 INFO - 'LOGNAME': 'cltbld', 16:37:30 INFO - 'MAIL': '/var/mail/cltbld', 16:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:30 INFO - 'MOZ_NO_REMOTE': '1', 16:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:30 INFO - 'NO_EM_RESTART': '1', 16:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:30 INFO - 'PWD': '/builds/slave/test', 16:37:30 INFO - 'SHELL': '/bin/bash', 16:37:30 INFO - 'SHLVL': '1', 16:37:30 INFO - 'TERM': 'linux', 16:37:30 INFO - 'TMOUT': '86400', 16:37:30 INFO - 'USER': 'cltbld', 16:37:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:30 INFO - '_': '/tools/buildbot/bin/python'} 16:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:31 INFO - Downloading/unpacking psutil>=3.1.1 16:37:31 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 16:37:31 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 16:37:31 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 16:37:31 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 16:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:32 INFO - Installing collected packages: psutil 16:37:32 INFO - Running setup.py install for psutil 16:37:32 INFO - building 'psutil._psutil_linux' extension 16:37:32 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 16:37:32 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 16:37:32 INFO - building 'psutil._psutil_posix' extension 16:37:32 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 16:37:32 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 16:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:32 INFO - Successfully installed psutil 16:37:32 INFO - Cleaning up... 16:37:32 INFO - Return code: 0 16:37:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:32 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:32 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 16:37:32 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 16:37:32 INFO - Using env: {'DISPLAY': ':0', 16:37:32 INFO - 'HOME': '/home/cltbld', 16:37:32 INFO - 'LANG': 'en_US.UTF-8', 16:37:32 INFO - 'LANGUAGE': 'en_US:en', 16:37:32 INFO - 'LOGNAME': 'cltbld', 16:37:32 INFO - 'MAIL': '/var/mail/cltbld', 16:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:32 INFO - 'MOZ_NO_REMOTE': '1', 16:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:32 INFO - 'NO_EM_RESTART': '1', 16:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:32 INFO - 'PWD': '/builds/slave/test', 16:37:32 INFO - 'SHELL': '/bin/bash', 16:37:32 INFO - 'SHLVL': '1', 16:37:32 INFO - 'TERM': 'linux', 16:37:32 INFO - 'TMOUT': '86400', 16:37:32 INFO - 'USER': 'cltbld', 16:37:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:32 INFO - '_': '/tools/buildbot/bin/python'} 16:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:37:34 INFO - Installing collected packages: mozsystemmonitor 16:37:34 INFO - Running setup.py install for mozsystemmonitor 16:37:34 INFO - Successfully installed mozsystemmonitor 16:37:34 INFO - Cleaning up... 16:37:35 INFO - Return code: 0 16:37:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:37:35 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')]} 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:35 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')]} 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:35 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:35 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 16:37:35 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 16:37:35 INFO - Using env: {'DISPLAY': ':0', 16:37:35 INFO - 'HOME': '/home/cltbld', 16:37:35 INFO - 'LANG': 'en_US.UTF-8', 16:37:35 INFO - 'LANGUAGE': 'en_US:en', 16:37:35 INFO - 'LOGNAME': 'cltbld', 16:37:35 INFO - 'MAIL': '/var/mail/cltbld', 16:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:35 INFO - 'MOZ_NO_REMOTE': '1', 16:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:35 INFO - 'NO_EM_RESTART': '1', 16:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:35 INFO - 'PWD': '/builds/slave/test', 16:37:35 INFO - 'SHELL': '/bin/bash', 16:37:35 INFO - 'SHLVL': '1', 16:37:35 INFO - 'TERM': 'linux', 16:37:35 INFO - 'TMOUT': '86400', 16:37:35 INFO - 'USER': 'cltbld', 16:37:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:35 INFO - '_': '/tools/buildbot/bin/python'} 16:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:37:35 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 16:37:35 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 16:37:35 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 16:37:35 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 16:37:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:36 INFO - warning: no files found matching '*.txt' 16:37:36 INFO - no previously-included directories found matching 'build' 16:37:36 INFO - no previously-included directories found matching 'dist' 16:37:36 INFO - no previously-included directories found matching '.git*' 16:37:36 INFO - Installing collected packages: jsonschema, functools32 16:37:37 INFO - Running setup.py install for functools32 16:37:37 INFO - warning: no files found matching '*.txt' 16:37:37 INFO - no previously-included directories found matching 'build' 16:37:37 INFO - no previously-included directories found matching 'dist' 16:37:37 INFO - no previously-included directories found matching '.git*' 16:37:37 INFO - Successfully installed jsonschema functools32 16:37:37 INFO - Cleaning up... 16:37:37 INFO - Return code: 0 16:37:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37: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')]} 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:37 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:37 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 16:37:37 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 16:37:37 INFO - Using env: {'DISPLAY': ':0', 16:37:37 INFO - 'HOME': '/home/cltbld', 16:37:37 INFO - 'LANG': 'en_US.UTF-8', 16:37:37 INFO - 'LANGUAGE': 'en_US:en', 16:37:37 INFO - 'LOGNAME': 'cltbld', 16:37:37 INFO - 'MAIL': '/var/mail/cltbld', 16:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:37 INFO - 'MOZ_NO_REMOTE': '1', 16:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:37 INFO - 'NO_EM_RESTART': '1', 16:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:37 INFO - 'PWD': '/builds/slave/test', 16:37:37 INFO - 'SHELL': '/bin/bash', 16:37:37 INFO - 'SHLVL': '1', 16:37:37 INFO - 'TERM': 'linux', 16:37:37 INFO - 'TMOUT': '86400', 16:37:37 INFO - 'USER': 'cltbld', 16:37:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:37 INFO - '_': '/tools/buildbot/bin/python'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:37:38 INFO - Cleaning up... 16:37:38 INFO - Return code: 0 16:37:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:38 INFO - Using env: {'DISPLAY': ':0', 16:37:38 INFO - 'HOME': '/home/cltbld', 16:37:38 INFO - 'LANG': 'en_US.UTF-8', 16:37:38 INFO - 'LANGUAGE': 'en_US:en', 16:37:38 INFO - 'LOGNAME': 'cltbld', 16:37:38 INFO - 'MAIL': '/var/mail/cltbld', 16:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:38 INFO - 'MOZ_NO_REMOTE': '1', 16:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:38 INFO - 'NO_EM_RESTART': '1', 16:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:38 INFO - 'PWD': '/builds/slave/test', 16:37:38 INFO - 'SHELL': '/bin/bash', 16:37:38 INFO - 'SHLVL': '1', 16:37:38 INFO - 'TERM': 'linux', 16:37:38 INFO - 'TMOUT': '86400', 16:37:38 INFO - 'USER': 'cltbld', 16:37:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:38 INFO - '_': '/tools/buildbot/bin/python'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:40 INFO - Downloading docopt-0.6.1.tar.gz 16:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:40 INFO - Running setup.py install for blobuploader 16:37:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:40 INFO - Running setup.py install for requests 16:37:40 INFO - Running setup.py install for docopt 16:37:40 INFO - Successfully installed blobuploader requests docopt 16:37:40 INFO - Cleaning up... 16:37:40 INFO - Return code: 0 16:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:40 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:40 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 16:37:40 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 16:37:40 INFO - Using env: {'DISPLAY': ':0', 16:37:40 INFO - 'HOME': '/home/cltbld', 16:37:40 INFO - 'LANG': 'en_US.UTF-8', 16:37:40 INFO - 'LANGUAGE': 'en_US:en', 16:37:40 INFO - 'LOGNAME': 'cltbld', 16:37:40 INFO - 'MAIL': '/var/mail/cltbld', 16:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:40 INFO - 'MOZ_NO_REMOTE': '1', 16:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:40 INFO - 'NO_EM_RESTART': '1', 16:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:40 INFO - 'PWD': '/builds/slave/test', 16:37:40 INFO - 'SHELL': '/bin/bash', 16:37:40 INFO - 'SHLVL': '1', 16:37:40 INFO - 'TERM': 'linux', 16:37:40 INFO - 'TMOUT': '86400', 16:37:40 INFO - 'USER': 'cltbld', 16:37:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:40 INFO - '_': '/tools/buildbot/bin/python'} 16:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:40 INFO - Running setup.py (path:/tmp/pip-Rn06xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:40 INFO - Running setup.py (path:/tmp/pip-bkeVvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:41 INFO - Running setup.py (path:/tmp/pip-QvPY1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:41 INFO - Running setup.py (path:/tmp/pip-83yK2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:41 INFO - Running setup.py (path:/tmp/pip-c3txcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:41 INFO - Running setup.py (path:/tmp/pip-y0rgVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:41 INFO - Running setup.py (path:/tmp/pip-QWWtJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:41 INFO - Running setup.py (path:/tmp/pip-StGoza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:41 INFO - Running setup.py (path:/tmp/pip-hJP2d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:41 INFO - Running setup.py (path:/tmp/pip-lFBr4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:41 INFO - Running setup.py (path:/tmp/pip-zJfaPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:41 INFO - Running setup.py (path:/tmp/pip-ikAuhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:41 INFO - Running setup.py (path:/tmp/pip-vrAd8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:41 INFO - Running setup.py (path:/tmp/pip-cr1IkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:41 INFO - Running setup.py (path:/tmp/pip-qKzmcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:41 INFO - Running setup.py (path:/tmp/pip-3qEPMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:42 INFO - Running setup.py (path:/tmp/pip-muphoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:42 INFO - Running setup.py install for manifestparser 16:37:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Running setup.py install for mozcrash 16:37:42 INFO - Running setup.py install for mozdebug 16:37:42 INFO - Running setup.py install for mozdevice 16:37:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Running setup.py install for mozfile 16:37:42 INFO - Running setup.py install for mozhttpd 16:37:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Running setup.py install for mozinfo 16:37:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Running setup.py install for mozInstall 16:37:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:42 INFO - Running setup.py install for mozleak 16:37:42 INFO - Running setup.py install for mozlog 16:37:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Running setup.py install for moznetwork 16:37:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Running setup.py install for mozprocess 16:37:43 INFO - Running setup.py install for mozprofile 16:37:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Running setup.py install for mozrunner 16:37:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Running setup.py install for mozscreenshot 16:37:43 INFO - Running setup.py install for moztest 16:37:43 INFO - Running setup.py install for mozversion 16:37:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:43 INFO - Cleaning up... 16:37:43 INFO - Return code: 0 16:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37: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')]} 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:43 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:43 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 16:37:43 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 16:37:43 INFO - Using env: {'DISPLAY': ':0', 16:37:43 INFO - 'HOME': '/home/cltbld', 16:37:43 INFO - 'LANG': 'en_US.UTF-8', 16:37:43 INFO - 'LANGUAGE': 'en_US:en', 16:37:43 INFO - 'LOGNAME': 'cltbld', 16:37:43 INFO - 'MAIL': '/var/mail/cltbld', 16:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:43 INFO - 'MOZ_NO_REMOTE': '1', 16:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:43 INFO - 'NO_EM_RESTART': '1', 16:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:43 INFO - 'PWD': '/builds/slave/test', 16:37:43 INFO - 'SHELL': '/bin/bash', 16:37:43 INFO - 'SHLVL': '1', 16:37:43 INFO - 'TERM': 'linux', 16:37:43 INFO - 'TMOUT': '86400', 16:37:43 INFO - 'USER': 'cltbld', 16:37:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:43 INFO - '_': '/tools/buildbot/bin/python'} 16:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:44 INFO - Running setup.py (path:/tmp/pip-85SNqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:44 INFO - Running setup.py (path:/tmp/pip-2Rt9ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:44 INFO - Running setup.py (path:/tmp/pip-t7GQnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:44 INFO - Running setup.py (path:/tmp/pip-JX15BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:44 INFO - Running setup.py (path:/tmp/pip-ovyNHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:44 INFO - Running setup.py (path:/tmp/pip-dCEQgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:44 INFO - Running setup.py (path:/tmp/pip-gLNWeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:44 INFO - Running setup.py (path:/tmp/pip-ftVgFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:44 INFO - Running setup.py (path:/tmp/pip-zmmliP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:44 INFO - Running setup.py (path:/tmp/pip-a9o88Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:44 INFO - Running setup.py (path:/tmp/pip-nNsBAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:44 INFO - Running setup.py (path:/tmp/pip-DwAQ8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:44 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)) 16:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:44 INFO - Running setup.py (path:/tmp/pip-1R4iU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:45 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)) 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:45 INFO - Running setup.py (path:/tmp/pip-SV7zfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:45 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)) 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:45 INFO - Running setup.py (path:/tmp/pip-I6aRfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:45 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)) 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:45 INFO - Running setup.py (path:/tmp/pip-FbcBiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:45 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)) 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:45 INFO - Running setup.py (path:/tmp/pip-zGj3X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:45 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 16:37:45 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 16:37:45 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 16:37:45 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 16:37:46 INFO - Downloading blessings-1.6.tar.gz 16:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:46 INFO - Installing collected packages: blessings 16:37:46 INFO - Running setup.py install for blessings 16:37:46 INFO - Successfully installed blessings 16:37:46 INFO - Cleaning up... 16:37:46 INFO - Return code: 0 16:37:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:46 INFO - Reading from file tmpfile_stdout 16:37:46 INFO - Current package versions: 16:37:46 INFO - argparse == 1.2.1 16:37:46 INFO - blessings == 1.6 16:37:46 INFO - blobuploader == 1.2.4 16:37:46 INFO - docopt == 0.6.1 16:37:46 INFO - functools32 == 3.2.3-2 16:37:46 INFO - jsonschema == 2.5.1 16:37:46 INFO - manifestparser == 1.1 16:37:46 INFO - mozInstall == 1.13 16:37:46 INFO - mozcrash == 1.0 16:37:46 INFO - mozdebug == 0.1 16:37:46 INFO - mozdevice == 0.51 16:37:46 INFO - mozfile == 1.2 16:37:46 INFO - mozhttpd == 0.7 16:37:46 INFO - mozinfo == 0.10 16:37:46 INFO - mozleak == 0.1 16:37:46 INFO - mozlog == 3.5 16:37:46 INFO - moznetwork == 0.27 16:37:46 INFO - mozprocess == 0.25 16:37:46 INFO - mozprofile == 0.28 16:37:46 INFO - mozrunner == 6.13 16:37:46 INFO - mozscreenshot == 0.1 16:37:46 INFO - mozsystemmonitor == 0.3 16:37:46 INFO - moztest == 0.8 16:37:46 INFO - mozversion == 1.4 16:37:46 INFO - psutil == 3.1.1 16:37:46 INFO - requests == 1.2.3 16:37:46 INFO - wsgiref == 0.1.2 16:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:46 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:46 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 16:37:46 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 16:37:46 INFO - Using env: {'DISPLAY': ':0', 16:37:46 INFO - 'HOME': '/home/cltbld', 16:37:46 INFO - 'LANG': 'en_US.UTF-8', 16:37:46 INFO - 'LANGUAGE': 'en_US:en', 16:37:46 INFO - 'LOGNAME': 'cltbld', 16:37:46 INFO - 'MAIL': '/var/mail/cltbld', 16:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:46 INFO - 'MOZ_NO_REMOTE': '1', 16:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:46 INFO - 'NO_EM_RESTART': '1', 16:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:46 INFO - 'PWD': '/builds/slave/test', 16:37:46 INFO - 'SHELL': '/bin/bash', 16:37:46 INFO - 'SHLVL': '1', 16:37:46 INFO - 'TERM': 'linux', 16:37:46 INFO - 'TMOUT': '86400', 16:37:46 INFO - 'USER': 'cltbld', 16:37:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:46 INFO - '_': '/tools/buildbot/bin/python'} 16:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 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)) 16:37:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:37:48 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)) 16:37:48 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)) 16:37:48 INFO - Installing collected packages: simplejson 16:37:48 INFO - Running setup.py install for simplejson 16:37:48 INFO - building 'simplejson._speedups' extension 16:37:48 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 16:37:49 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 16:37:49 INFO - Successfully installed simplejson 16:37:49 INFO - Cleaning up... 16:37:49 INFO - Return code: 0 16:37:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:49 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 0x15ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1774a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1917a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', '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 16:37:49 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 16:37:49 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 16:37:49 INFO - Using env: {'DISPLAY': ':0', 16:37:49 INFO - 'HOME': '/home/cltbld', 16:37:49 INFO - 'LANG': 'en_US.UTF-8', 16:37:49 INFO - 'LANGUAGE': 'en_US:en', 16:37:49 INFO - 'LOGNAME': 'cltbld', 16:37:49 INFO - 'MAIL': '/var/mail/cltbld', 16:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:49 INFO - 'MOZ_NO_REMOTE': '1', 16:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:49 INFO - 'NO_EM_RESTART': '1', 16:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:49 INFO - 'PWD': '/builds/slave/test', 16:37:49 INFO - 'SHELL': '/bin/bash', 16:37:49 INFO - 'SHLVL': '1', 16:37:49 INFO - 'TERM': 'linux', 16:37:49 INFO - 'TMOUT': '86400', 16:37:49 INFO - 'USER': 'cltbld', 16:37:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:49 INFO - '_': '/tools/buildbot/bin/python'} 16:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:37:49 INFO - Cleaning up... 16:37:49 INFO - Return code: 0 16:37:49 INFO - Running post-action listener: _resource_record_post_action 16:37:49 INFO - Running post-action listener: _start_resource_monitoring 16:37:49 INFO - Starting resource monitoring. 16:37:49 INFO - [mozharness: 2017-10-18 23:37:49.593608Z] Finished create-virtualenv step (success) 16:37:49 INFO - [mozharness: 2017-10-18 23:37:49.594128Z] Running install step. 16:37:49 INFO - Running pre-action listener: _resource_record_pre_action 16:37:49 INFO - Running main action method: install 16:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:49 INFO - Reading from file tmpfile_stdout 16:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:49 INFO - Reading from file tmpfile_stdout 16:37:49 INFO - Output received: 16:37:49 INFO - Usage: mozinstall [options] installer 16:37:49 INFO - Options: 16:37:49 INFO - -h, --help show this help message and exit 16:37:49 INFO - -d DEST, --destination=DEST 16:37:49 INFO - Directory to install application into. [default: 16:37:49 INFO - "/builds/slave/test"] 16:37:49 INFO - --app=APP Application being installed. [default: firefox] 16:37:49 INFO - mkdir: /builds/slave/test/build/application 16:37:49 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'] 16:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:38:04 INFO - Reading from file tmpfile_stdout 16:38:04 INFO - Output received: 16:38:04 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:04 INFO - Running post-action listener: _resource_record_post_action 16:38:04 INFO - [mozharness: 2017-10-18 23:38:04.557656Z] Finished install step (success) 16:38:04 INFO - [mozharness: 2017-10-18 23:38:04.557803Z] Running setup-mitmproxy step. 16:38:04 INFO - Running pre-action listener: _resource_record_pre_action 16:38:04 INFO - Running main action method: setup_mitmproxy 16:38:04 INFO - Skipping: mitmproxy is not required 16:38:04 INFO - Running post-action listener: _resource_record_post_action 16:38:04 INFO - [mozharness: 2017-10-18 23:38:04.558442Z] Finished setup-mitmproxy step (success) 16:38:04 INFO - [mozharness: 2017-10-18 23:38:04.558630Z] Running run-tests step. 16:38:04 INFO - Running pre-action listener: _resource_record_pre_action 16:38:04 INFO - Running pre-action listener: _set_gcov_prefix 16:38:04 INFO - Running main action method: run_tests 16:38:04 WARNING - Try message not found. 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:04 INFO - Python 2.7.3 16:38:04 INFO - Return code: 0 16:38:04 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38:04 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 0x191b090>, '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 0x191bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1915f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:04 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 16:38:04 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 16:38:04 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 16:38:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:04 INFO - Return code: 0 16:38:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: RUST_BACKTRACE is now full 16:38:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 16:38:04 INFO - Using env: {'DISPLAY': ':0', 16:38:04 INFO - 'HOME': '/home/cltbld', 16:38:04 INFO - 'LANG': 'en_US.UTF-8', 16:38:04 INFO - 'LANGUAGE': 'en_US:en', 16:38:04 INFO - 'LOGNAME': 'cltbld', 16:38:04 INFO - 'MAIL': '/var/mail/cltbld', 16:38:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:04 INFO - 'MOZ_NO_REMOTE': '1', 16:38:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:04 INFO - 'NO_EM_RESTART': '1', 16:38:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:04 INFO - 'PWD': '/builds/slave/test', 16:38:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:04 INFO - 'RUST_BACKTRACE': 'full', 16:38:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:38:04 INFO - 'SHELL': '/bin/bash', 16:38:04 INFO - 'SHLVL': '1', 16:38:04 INFO - 'TERM': 'linux', 16:38:04 INFO - 'TMOUT': '86400', 16:38:04 INFO - 'USER': 'cltbld', 16:38:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:04 INFO - '_': '/tools/buildbot/bin/python'} 16:38:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 16:38:04 INFO - mozversion application_buildid: 20171018222315 16:38:04 INFO - mozversion application_changeset: adc0384c565aae18fd8b2a669363ac27bd3a6676 16:38:04 INFO - mozversion application_display_name: Firefox 16:38:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:04 INFO - mozversion application_name: Firefox 16:38:04 INFO - mozversion application_remotingname: firefox 16:38:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:04 INFO - mozversion application_vendor: Mozilla 16:38:04 INFO - mozversion application_version: 57.0 16:38:04 INFO - mozversion platform_buildid: 20171018222315 16:38:04 INFO - mozversion platform_changeset: adc0384c565aae18fd8b2a669363ac27bd3a6676 16:38:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:04 INFO - mozversion platform_version: 57.0 16:38:04 INFO - using testdate: 1508369884 16:38:04 INFO - actual date: 1508369884 16:38:04 INFO - starting webserver on 'localhost:48385' 16:38:04 INFO - SUITE-START | Running 2 tests 16:38:04 INFO - TEST-START | dromaeo_css 16:38:04 INFO - Initialising browser for dromaeo_css test... 16:38:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48385/getInfo.html -profile /tmp/tmpIpdEKC/profile 16:38:04 INFO - TEST-INFO | started process 2061 (/builds/slave/test/build/application/firefox/firefox http://localhost:48385/getInfo.html) 16:38:10 INFO - TEST-INFO | 2061: exit 0 16:38:10 INFO - Browser initialized. 16:38:10 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:10 INFO - Using env: {'DISPLAY': ':0', 16:38:10 INFO - 'HOME': '/home/cltbld', 16:38:10 INFO - 'JSGC_DISABLE_POISONING': '1', 16:38:10 INFO - 'LANG': 'en_US.UTF-8', 16:38:10 INFO - 'LANGUAGE': 'en_US:en', 16:38:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:38:10 INFO - 'LOGNAME': 'cltbld', 16:38:10 INFO - 'MAIL': '/var/mail/cltbld', 16:38:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:10 INFO - 'MOZ_CRASHREPORTER': '1', 16:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:38:10 INFO - 'MOZ_NO_REMOTE': '1', 16:38:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:10 INFO - 'NO_EM_RESTART': '1', 16:38:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:10 INFO - 'PWD': '/builds/slave/test', 16:38:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:10 INFO - 'RUST_BACKTRACE': 'full', 16:38:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:38:10 INFO - 'SHELL': '/bin/bash', 16:38:10 INFO - 'SHLVL': '1', 16:38:10 INFO - 'TERM': 'linux', 16:38:10 INFO - 'TMOUT': '86400', 16:38:10 INFO - 'USER': 'cltbld', 16:38:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:10 INFO - '_': '/tools/buildbot/bin/python'} 16:38:10 INFO - TEST-INFO | started process 2301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIpdEKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:11 INFO - PID 2301 | 16:38:11 INFO - PID 2301 | (/builds/slave/test/build/application/firefox/firefox:2351): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:38:11 INFO - PID 2301 | 16:38:21 INFO - PID 2301 | RSS: Main: 142176256 16:38:21 INFO - PID 2301 | 16:41:18 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48385/tests/dromaeo/cssquery-ext.html) 16:41:19 INFO - PID 2301 | RSS: Main: 145936384 16:41:19 INFO - PID 2301 | 16:44:21 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-ext.html (next: http://localhost:48385/tests/dromaeo/cssquery-jquery.html) 16:44:21 INFO - PID 2301 | RSS: Main: 144179200 16:44:21 INFO - PID 2301 | 16:47:23 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48385/tests/dromaeo/cssquery-mootools.html) 16:47:23 INFO - PID 2301 | RSS: Main: 145108992 16:47:23 INFO - PID 2301 | 16:50:25 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48385/tests/dromaeo/cssquery-prototype.html) 16:50:25 INFO - PID 2301 | RSS: Main: 144785408 16:50:25 INFO - PID 2301 | 16:53:28 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48385/tests/dromaeo/cssquery-yui.html) 16:53:29 INFO - PID 2301 | RSS: Main: 146354176 16:53:29 INFO - PID 2301 | 16:56:30 INFO - PID 2301 | Cycle 1(1): loaded http://localhost:48385/tests/dromaeo/cssquery-yui.html (next: http://localhost:48385/tests/dromaeo/cssquery-dojo.html) 16:56:30 INFO - PID 2301 | RSS: Main: 149422080 16:56:30 INFO - PID 2301 | 16:56:30 INFO - PID 2301 | __start_tp_report 16:56:30 INFO - PID 2301 | _x_x_mozilla_page_load 16:56:31 INFO - PID 2301 | _x_x_mozilla_page_load_details 16:56:31 INFO - PID 2301 | |i|pagename|runs| 16:56:31 INFO - PID 2301 | |0;dojo.html;3948.2300951314487;3967.6825853931687;3975.145343751093;3980.940285895711;3995.8401663933446;6275.058741188824;6311.842203944903;6318.399752023562;6419.261784894738;6428.32502587228;6283.748650053993;6319.083732858733;6327.841803954903;6409.967950160242;6413.551051426402;5671.829845104653;5684.4315568443235;5774.364819869811;5780.595358324908;5793.565482588801;5698.971505142468;5764.020116580192;5771.797987070453;5780.104083867007;5863.8534036649;5809.796657117002;5839.211706419622;5860.824175274749;5861.2087368205175;5892.263467066617;5770.451807078321;5771.307443106854;5806.158107074492;5836.620619659709;5853.209816674758;5660.575456840754;5678.971605141948;5714.942850571482;5732.914006289909;5734;6208.286047104551;6247.531435142382;6303.338149494329;6313.621182729005;6320.873582528324;6756.662166891636;6802.183737951477;6805.965970170167;6834.043233947252;6883.552569083044;6834.829129271759;6860.862782744317;6873.553219040747;6897.896531552031;6944.652767361612;6437.742490300382;6487.513436492282;6494.642794646245;6495.415412612888;6496;7038.6480675965995;7039.084918960502;7046.189688185822;7135.393491553173;7143.1428228612895;6681.899771503431;6804.897926531106;6828.487863410264;6901.275366086589;6903.482238832007;6867.3476019778045;6954.130733658293;6958.47811414146;6988.336108069725;6992.895106573405;6711.463082953352;6780.8304792379595;6862.210845752802;6882.346177113166;6894.310568943066;6702.530822842452;6762;6782.864342713118;6862.416694580917;6865.176178858569;4949.455559888409;5021.046001259822;5040.1179793535985;5042.873928151752;5046.747662616928;4635.072985402933;4665.066986602693;4739.644526660514;4749.952500474951;4754.310624959361;6514.609123452608;6517.706703198368;6598.208215014229;6600.339966003361;6612.206535215805;6742.898856517156;6864.725410983505;6894;6924.965375173092;6932.757353492603;6479.643619600873;6484;6486.708098135595;6494.0258961156205;6495.805125846232;5718.571107166979;5731.885362292731;5798.507126894261;5800.622959507618;5806.44838740319;7016.649167541603;7057.258987806309;7067.187273463514;7068.29317068289;7131.251218622074;6852.109225800614;6865.828354291183;6866;6867.07294515254;6886.48351373639;7022.297770222936;7044.788656340318;7175;7177.7487787927175;7188.17336006366;6849.452043836581;6864.347886950732;6924.792256232321;6927.965360173167;6943.6875340608785;6812.693428795816;6859.657017149023;6934.653267336714;6955.930440695731;7058.894116588152;6602.3397660233595;6661.233958094687;6670.299618540177;6682.766103186365;6709;6598.901016484852;6667.899981500184;6693.631850248283;6695.230048544479;6719.966400167968;6530.706118224596;6579.144711187515;6636.303188165173;6638.137042184679;6659.600423974577;6648.434883034803;6662.834004049369;6673.9332606673315;6727.663616819042;6778.186617605918;6500.382463665944;6506.772262970773;6528.445082168069;6530.608163510205;6535.967320163369 16:56:31 INFO - PID 2301 | |1;ext.html;962.6919385796548;985.5318723606288;1028.5011769291891;1029.212652320974;1030.8866024737279;45859;46645;46770.298445523345;46775.76612116943;46897.531024689786;43181.568184318145;45310;46106.538934610646;46111.538884611145;46130.538694613046;8706.259967902735;8839.77900552485;8851.159139881702;8873.73378798637;8877.33419993503;8691.608877600524;8800.471971681687;8811.251043661296;8827.602757875911;8838.602262898185;8800.735977920673;8804.295656347476;8813.647454101829;8821.25019373351;8826.49949508585;8767.649294028231;8780.824383512327;8798.604062817189;8807.691730789424;8840.8673869892;8467.280281176107;8486.32109431244;8487.83024339516;8507.574621268912;8519.744407667718;41279.79360103211;41437;41505.584944150476;41585.37621935673;41748;3822.503074600284;3853.2678791029616;3853.8651147209994;3878.1855810279876;3904.39481880309;34085.31829363399;34140.14649633754;34351.484727729105;34414.65585344139;34482.655173448446;5602.215689803431;5610.046292130348;5651.519620832234;5661.631993920423;5679.290088738908;249634;249792;251008;252073;277550;55562.72218638962;56239.71880140655;56282.71858640681;56310.43689563134;56460.58848528819;58079.70960145172;58097.4190258092;58238.708806455696;58292.417075829544;58382.708086460145;18103.547411314823;18375.264989400275;18380.17289221988;18426.170822313026;18643.90678046601;15290.923545382202;15291.847081529264;15427.922860385626;15433;15497.147656878755;14107.78838317426;14137.717245655029;14157.575272741627;14231.715365692628;14397;5641.8589535261945;5661.377248502661;5759.136129580596;5823.272090988627;5891.204687367236;1103.812351900179;1109.290054365207;1116.447358557503;1126.0541145437708;1130.2766229613055;26253.21240362792;26310.86844565765;26330.341741456235;26508.734912651013;26599.601005984925;1193.516625766566;1220.6887243752785;1236.1594116001206;1238.1147479552164;1240.206267988488;13787.379567919468;14048.38443578981;14110.153390796586;14240.928795355956;14315;313849;322617;336919;337690;337691;62973.37026629675;63017.36982630207;63319;63416.68291658512;63439.36560634427;1515.1893736850732;1523.4210999820218;1537.9692406152037;1539.1150088698819;1572.771948067524;30924.536131958488;31179.064628061195;31227.84386078055;31298;31392.372152556363;40822.1835563293;40886.79556602198;41028.589714102476;41120.38319425271;41138;256439;258453;259685;259860;260212;35677.82161089178;36588.085297867765;36668.26663466662;36787.264254714224;37039.629603703615;47134.528654713016;47344.76327618478;47656;47928;48014.759926200146;35124;35256;35368.64631353757;35624.64375356317;36165;35901.64098358983;35940.4608930861;36215.27569448649;36255;36420;41386.1722765537;41457.79271103625;41772.1645567093;41793.79103104465;41867.7906610465;33836.154096147795;34128.82935585405;34258.314833703684;34389;34544;25856.482870342865;26059.478810424065;26198.34504137412;26247;26651.298785538318 16:56:31 INFO - PID 2301 | |2;jquery.html;639.9968780640094;648.7072683804502;650.9300770316795;651.9369860299216;656.8913786744549;23535.29394118177;24418.633720494185;24552.75447245527;24757.75242247577;24898.87550562247;25494.745052549468;25750.227493175236;25902.870485647545;25964.870175649095;25988.610170847453;6621.470282377399;6856.382925536701;6898.0687607172895;6906.136732908387;6924;6835.931640683604;6900.689468973908;6901.689423975933;6909.723611055551;6916.65416729164;6623.834404139887;6828.078209441712;6878.3465570770695;6881.380675739182;6889.4832887533385;6823.112995310603;6853.383195512378;6872.759453419157;6876.553024053445;6879.828004299882;6361.2048493938255;6413.4227919487;6422.646754428504;6429.292777794439;6440.935590644081;29797.70202297971;30461.086167415015;30930.381392372252;31014.224644383845;31367.529487057483;2297.184499502686;2330.5571941331264;2331.720193576765;2333.3116730564525;2338.590746619335;20074.498137546532;20558.79441205584;20591.485212869648;20660.380188594216;20669.58660826775;2577.7164511903675;2609.5955126955164;2665.200439868051;2680.1021657744677;2684.315499547603;143541.56458435385;149206;166787;171874;171896;16427.83572164287;16799.6640067198;17022.40421585263;17131.74302385465;17148.39980600698;27331.86334068357;27351;27358.99051104377;27403;27427.451450970868;11005.61480348184;11343.319400835811;11418.486168122454;11494.080473562095;11572.305661660159;10543.525541350658;10557.155427565776;10558.366498009991;10623.20325975555;10725.356478611307;9779.559919803625;9793.51032448389;9971.202303815677;10125.139363154067;10145.442000689885;3071.4778487657154;3097.829619370911;3099.3491366813223;3115.517094850302;3206.11831746267;1059.433203236265;1059.9947000265104;1077.6120596585224;1091.1816137896578;1092.6448904106198;21255.574888502142;21376.465588360104;21613.56772864534;21617.351479455643;21697.34907952764;1149.706824759681;1152.3668417665594;1154.255505199142;1154.9480273387717;1162.2329262686756;11906.987906028085;11927;11977.341246231541;12043.578474753516;12081.818772718416;644714;649856;652140;659343;680303;131942;135555.32222339022;136063;137566;138191;1264.7913094339515;1276.9808452873215;1303.3808940753067;1305.1712162776705;1313.2317594207495;19174.904125479843;19351.612967740846;19391.51521211981;19544;19678.80321196827;61199.38800611937;61850;61993.070103947575;62000.68999654973;63415.365846340945;78557.21442785728;78920;79412.20587794048;79485.20514794778;80144;16165.191740412698;16191.514254572381;16252.837471625133;16320.265588048329;16348.754768678242;24164.275071747874;24626.014959401422;24833.62749558794;24907;24963;20106.59786804285;20242.291519796738;20422.183112675328;20434.182632694527;20526.076326565042;17711;18047.278108875496;18086;18224.72662910084;18485.260589576268;20405.69391459159;20485.487862802955;20603.793962060787;20771.584568308852;20800.583988319846;15985;15988.600284992968;16005.119718415599;16074.839251607802;16075.839241607435;19890.602187955872;19903.800961990193;20147;20193.697094543888;20237.49406264855 16:56:31 INFO - PID 2301 | |3;mootools.html;1446.9638259043522;1507.811523559555;1508.886833487488;1511.879049676026;1531.9387224511013;17043.914780426097;17813.842100263475;17891.910540447298;17908.55228619282;17912.19395127219;17145.828541714578;17422;17426.82573174268;17434.3026278949;17439.128043597833;2966.4067186562665;2989.8505074746286;3035.772317076217;3047.8780848766023;3063.1576316513024;2969.4951858184054;2999.2501874531367;3001.9849900750573;3003.714647108521;3020.6375234971833;2882.120953109301;2976.6874478179802;2977.270568710669;3005.5040918248574;3018.6377634683868;2992.132281638322;2994.056872085308;3011.804232724866;3013.5329024001317;3013.819170849756;2888.0902515707485;2899.4635992341273;2908.9272768180754;2930.2820808901743;2948.43979643867;17237.655246895116;17568.29726810926;17632.647347053116;17637.55906102345;17642;8873.423227490257;9106.453612783187;9192.816143677155;9194.448333100036;9198.402103863295;6099.57302988791;6107.7556897724035;6230.221222347207;6232.9376706232815;6276.403741644536;2178.596959562486;2209.657503087024;2212.203606701586;2251.808596269319;2259.2770313499686;31766.364672706415;31868.840655796805;31894.681053189404;31943.520847187312;31948;7119.430445564342;7456.40348772097;7506.949027136206;7538.396928245727;7679.347255483346;21087.68368474474;21109.788902110784;21115.683264750733;21128.894355528126;21142.78857211439;8116.75649730509;8262.215089566482;8315.916840831635;8330.375221858385;8334.916650833535;7530.774076777706;7623.809404764815;7706.922930770733;7723.459357844897;7723.497972631761;5883.0881213411985;5930.792422265286;5971.343152253248;6025.6685882276015;6297.118403423525;1706.48805358392;1716.3906813081176;1729.1959238953946;1737.3224442467447;1768.2308195934809;865.8874346334936;978.9167920726676;1009.6365308488938;1013.8884722680499;1025.1183981775666;9647.662331818494;9807.509624518745;9807.9019209807;9891.802163956825;10401.635942741968;1096.4956120184645;1100.9724756881142;1101.5758932810925;1101.6724846559875;1132.8583927009124;5970.731317090741;6099.2680878294;6161.106639537242;6178.320384757673;6317.810465686037;26312.34219144537;27111.86444067767;27135.864320678666;27316.863415682794;27361.179164625093;25403.110891118722;26713.19860404152;26991.325216869736;27013;27082.187534374;12562.623121306375;13219.603411897659;13330.26683532415;13422.395992180376;13454.93272533631;9936.602535898483;10081.848772268275;10084.495775211357;10099;10286.794264114826;21223.363299101053;22479;23091.422714431603;23591.64612530779;23609.763902360755;23057.769422305562;23291.76708232896;23545;23907.16324928689;24449.877750611133;12823.166494177849;12878.613641590768;13057.608271751862;13137.605871823478;13152.145110567782;16193.838061619233;16503.66992660164;16515.83484165191;16524;16545;12847;12950.546730864375;13096.934515327363;13103.934480327538;13108;12524.311162886128;12735.936320318338;12819.230846149261;12914.741705166032;12987.350632468528;10945;11176.497057632263;11229.49467273991;11247.325160490396;11248.662540123809;8787.692430764893;8794.340424468319;8839.292856571588;8914.55427228623;8915.910840891507;8803.163699448542;8977.596008179517;9032.412893161923;9059;9089.681861135094 16:56:31 INFO - PID 2301 | |4;prototype.html;564.2354609504124;574.198992405594;586.1442294250394;587.2219309415024;591.3879135095175;6273.278572964111;6274.623522588642;6290.276618188904;6426.967865160679;6450.129232553604;6282.42420607551;6348.619082855032;6362.14111095002;6363.809085727424;6375.6812159392075;5225.320708307924;5284.859631849088;5285.524302812746;5289.947100529003;5307.787688492455;4903.8528844134735;5207.3490813648295;5222.895542089156;5265.104932161523;5270.81552145675;5055.9241611375855;5075.314832497621;5078.898422031557;5090.261912022773;5137;5073.289739436482;5083.36457942759;5091.210862316347;5104.285400043997;5119.59043276537;4622.9075418491775;4634.513376095529;4652.209124448852;4689.859304220879;4697.342372067879;6239.625622462667;6254.906176407358;6262.749490020394;6274.623522588659;6287.811365658992;5963.373845746178;6025.9096113558335;6042.728077236535;6044.184035155242;6044.727987240584;6626.481936864009;6678.298778628223;6697.7655782047395;6736.05695202672;6802.897956530656;5174.275601415805;5197.8440646780655;5218.060749065166;5218.538809133449;5220.973895130538;6778.322167783232;6816.693248803816;6974.232834388214;7031.859362812766;7086.2205157432645;5162.819301324435;5302.655327403783;5310.575153987672;5339.893202135935;5380.78476860929;5398.217258497496;5413.621046526705;5437.537809286255;5440.211169380497;5474.507294343528;5990.430909063632;6023.578349515492;6027.397260274025;6044.73322504061;6057;6705.731770729214;6853.588784672936;6860.965695171592;6873.690683919235;6895.75864844738;1846.9722954155698;1848.1775609853755;1854.842338401224;1863.1615772902248;1872.410190789897;1276.44474653526;1328.7674656935192;1342.5368247954636;1358.2122369025942;1363.795430685405;6365.61806291624;6413.422791948747;6441.549091563639;6480.675966201671;6491.7078731457195;6714.462842972551;6768.492363072691;6791.252962174256;6803.931960680429;6941.895871561931;6396.712147953353;6485.6108633482145;6485.772997945143;6496;6548.541602087904;3498.772579782306;3518.82405879705;3574.9970025178973;3604.7656902301264;3642.581103173116;6908.1364829396325;7073.610951397723;7087.397571206505;7117.3594376505325;7136.500444968802;7038.260982596856;7110.369163409571;7185.3533182012825;7185.461090418135;7206.279372062857;6929.41100006495;7025.859482810315;7054.858902821915;7074.787756367317;7077.796774548442;6701.798946031627;6721.865562688817;6733.912487129006;6777.491688123312;6839.521233513607;6715.5299129060495;6727.798166055026;6804.387605115563;6863.794086177422;6878.415334696407;6943.9652801735665;6949.861002780017;7007.579545227302;7044.964775176091;7148.714051437884;5216;5253.973730131325;5262.447443018581;5275.630705850554;5280.6303558750515;6685.699143538455;6884.449244060564;6886.690098945459;6965.651717414008;6992.230854606091;6526.9020964686515;6657.933420665731;6692.665366731741;6732.293109223657;6773.764657663058;6637.867242655217;6676.532642714963;6687.1975362956755;6693.765718199839;6699.5310328276555;6457.222524823032;6661.700223489857;6662.167229096363;6693.966530167318;6701.899471508029;6595.868082638224;6630.83422914431;6740.292269311652;6753.729850805913;6755.459563234831;6519.5436319457185;6535.509836762357;6537.182852143482;6539.738410463528;6592.978088396306 16:56:31 INFO - PID 2301 | |5;yui.html;964.9083337082975;966.5940305071869;1010.1565193063791;1013.609760242307;1025.0774303127184;22025.559488810213;22373.888130559346;22586.096556137734;22607.886960565196;22614.208502702408;19903;20295.898520507377;20892.477688057807;21064.262750803726;21064.789352106513;1085.6688709943464;1098.593520397454;1099.0493223361775;1099.6096385783053;1099.8130317845985;1070.5664205996584;1088.4884104470887;1098.1544210957559;1101.3116801998751;1103.1450625765017;1169.9415029248503;1177.1171621284036;1181.4978634080524;1181.7754626620958;1182.0838849891318;1160.8200728886952;1174.8120300751839;1175.4651633506776;1175.7295821960954;1177.9057675385948;862.1723145780059;867.9262262707678;867.9783005424852;870.6386849457467;873.3973558244791;20489.2828750993;21563.353099407042;21983.34049978503;22193.44516387103;22322.330330090124;23384.76615233843;23424.765752342428;23718.28845134649;23772;24211.273661790176;19730.112144953513;19752.506187345287;19837.603247935105;19881.105350259273;19948.80051199484;4225;4245.8513952011535;4247.193033323659;4252.829886804524;4253.298205796071;166487;169442;170314.1484292583;171208;173360;17942.820571794375;18386.81613183878;18455.723164152547;18627.534311642048;18685.90657046706;34322.65677343245;34364.65635343664;35271;35350.46974295388;35630.46554301688;10240.078392944672;10344.32761870476;10406.375617462976;10434.37393756377;10461.84307235392;4866.391701037371;4929.186684197068;4939.086269040239;4946.406431228275;4952.702837829742;6343.175387199634;6355.428011478989;6369.331220221903;6438.581492202992;6442.452391546677;1147.5237776322733;1147.707334629664;1160.3618010094415;1160.8142697168412;1164.470166074434;719.5754504842168;722.8409749855024;728.1989811207735;738.2433006168612;752.2778132992279;13745;13837;14242.501512447221;14954.40182392692;15123.848761512465;737.6127533045087;738.4646131554688;740.4631642059463;746.813296675831;760.6767123972289;6318.6524741138755;6437.0988061671405;6477.5465717400275;6493.642849643315;6612.966935165389;156110;158212;158989;159270;161247;132294;133520.3323983374;133641;136307;136671;122792;123516.38241808733;124352;125093;125492;12219.51121955112;12224.938875305566;12257.693557660774;12316.768323167611;12327.013838893046;58797.70601147138;59140.40859591349;59542.40457595542;59670;60304.39695602988;75391.24608753843;75616;75980.24019759953;76278;77574;18001.2799488019;18825.623487530447;18911.338103166323;18980;19145.329913452963;19840;20017;20077.799222007594;20126.194952202335;20432.59134817325;17659.117044148;18043.097845107954;18289.99405032736;18552.628947420704;18586.814131858508;17775;18095.185716642518;18141;18197.909010454863;18337.174827132545;14688.853111468748;15068.171250581323;15082.773758393414;15108.697826043637;15199.240037998277;12756.107072505207;12872.420741066488;12914.67713307175;12927.482900683868;13067.215967042008;14104.36530356157;14144.646383840487;14208.573742787732;14288.928555357157;14335.56993290203 16:56:31 INFO - PID 2301 | __end_tp_report 16:56:31 INFO - PID 2301 | __start_cc_report 16:56:31 INFO - PID 2301 | _x_x_mozilla_cycle_collect,274 16:56:31 INFO - PID 2301 | __end_cc_report 16:56:31 INFO - PID 2301 | __startTimestamp1508370990997__endTimestamp 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | ------- Summary: start ------- 16:56:31 INFO - PID 2301 | Number of tests: 6 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#0] dojo.html Cycles:165 Average:6362.85 Median:6602.34 stddev:720.30 (10.9%) stddev-sans-first:697.16 16:56:31 INFO - PID 2301 | Values: 3948.2 3967.7 3975.1 3980.9 3995.8 6275.1 6311.8 6318.4 6419.3 6428.3 6283.7 6319.1 6327.8 6410.0 6413.6 5671.8 5684.4 5774.4 5780.6 5793.6 5699.0 5764.0 5771.8 5780.1 5863.9 5809.8 5839.2 5860.8 5861.2 5892.3 5770.5 5771.3 5806.2 5836.6 5853.2 5660.6 5679.0 5714.9 5732.9 5734.0 6208.3 6247.5 6303.3 6313.6 6320.9 6756.7 6802.2 6806.0 6834.0 6883.6 6834.8 6860.9 6873.6 6897.9 6944.7 6437.7 6487.5 6494.6 6495.4 6496.0 7038.6 7039.1 7046.2 7135.4 7143.1 6681.9 6804.9 6828.5 6901.3 6903.5 6867.3 6954.1 6958.5 6988.3 6992.9 6711.5 6780.8 6862.2 6882.3 6894.3 6702.5 6762.0 6782.9 6862.4 6865.2 4949.5 5021.0 5040.1 5042.9 5046.7 4635.1 4665.1 4739.6 4750.0 4754.3 6514.6 6517.7 6598.2 6600.3 6612.2 6742.9 6864.7 6894.0 6925.0 6932.8 6479.6 6484.0 6486.7 6494.0 6495.8 5718.6 5731.9 5798.5 5800.6 5806.4 7016.6 7057.3 7067.2 7068.3 7131.3 6852.1 6865.8 6866.0 6867.1 6886.5 7022.3 7044.8 7175.0 7177.7 7188.2 6849.5 6864.3 6924.8 6928.0 6943.7 6812.7 6859.7 6934.7 6955.9 7058.9 6602.3 6661.2 6670.3 6682.8 6709.0 6598.9 6667.9 6693.6 6695.2 6720.0 6530.7 6579.1 6636.3 6638.1 6659.6 6648.4 6662.8 6673.9 6727.7 6778.2 6500.4 6506.8 6528.4 6530.6 6536.0 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#1] ext.html Cycles:180 Average:46459.81 Median:36727.77 stddev:74004.67 (201.5%) stddev-sans-first:74133.42 16:56:31 INFO - PID 2301 | Values: 962.7 985.5 1028.5 1029.2 1030.9 45859.0 46645.0 46770.3 46775.8 46897.5 43181.6 45310.0 46106.5 46111.5 46130.5 8706.3 8839.8 8851.2 8873.7 8877.3 8691.6 8800.5 8811.3 8827.6 8838.6 8800.7 8804.3 8813.6 8821.3 8826.5 8767.6 8780.8 8798.6 8807.7 8840.9 8467.3 8486.3 8487.8 8507.6 8519.7 41279.8 41437.0 41505.6 41585.4 41748.0 3822.5 3853.3 3853.9 3878.2 3904.4 34085.3 34140.1 34351.5 34414.7 34482.7 5602.2 5610.0 5651.5 5661.6 5679.3 249634.0 249792.0 251008.0 252073.0 277550.0 55562.7 56239.7 56282.7 56310.4 56460.6 58079.7 58097.4 58238.7 58292.4 58382.7 18103.5 18375.3 18380.2 18426.2 18643.9 15290.9 15291.8 15427.9 15433.0 15497.1 14107.8 14137.7 14157.6 14231.7 14397.0 5641.9 5661.4 5759.1 5823.3 5891.2 1103.8 1109.3 1116.4 1126.1 1130.3 26253.2 26310.9 26330.3 26508.7 26599.6 1193.5 1220.7 1236.2 1238.1 1240.2 13787.4 14048.4 14110.2 14240.9 14315.0 313849.0 322617.0 336919.0 337690.0 337691.0 62973.4 63017.4 63319.0 63416.7 63439.4 1515.2 1523.4 1538.0 1539.1 1572.8 30924.5 31179.1 31227.8 31298.0 31392.4 40822.2 40886.8 41028.6 41120.4 41138.0 256439.0 258453.0 259685.0 259860.0 260212.0 35677.8 36588.1 36668.3 36787.3 37039.6 47134.5 47344.8 47656.0 47928.0 48014.8 35124.0 35256.0 35368.6 35624.6 36165.0 35901.6 35940.5 36215.3 36255.0 36420.0 41386.2 41457.8 41772.2 41793.8 41867.8 33836.2 34128.8 34258.3 34389.0 34544.0 25856.5 26059.5 26198.3 26247.0 26651.3 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#2] jquery.html Cycles:180 Average:41889.55 Median:21657.35 stddev:109786.33 (506.9%) stddev-sans-first:110050.62 16:56:31 INFO - PID 2301 | Values: 640.0 648.7 650.9 651.9 656.9 23535.3 24418.6 24552.8 24757.8 24898.9 25494.7 25750.2 25902.9 25964.9 25988.6 6621.5 6856.4 6898.1 6906.1 6924.0 6835.9 6900.7 6901.7 6909.7 6916.7 6623.8 6828.1 6878.3 6881.4 6889.5 6823.1 6853.4 6872.8 6876.6 6879.8 6361.2 6413.4 6422.6 6429.3 6440.9 29797.7 30461.1 30930.4 31014.2 31367.5 2297.2 2330.6 2331.7 2333.3 2338.6 20074.5 20558.8 20591.5 20660.4 20669.6 2577.7 2609.6 2665.2 2680.1 2684.3 143541.6 149206.0 166787.0 171874.0 171896.0 16427.8 16799.7 17022.4 17131.7 17148.4 27331.9 27351.0 27359.0 27403.0 27427.5 11005.6 11343.3 11418.5 11494.1 11572.3 10543.5 10557.2 10558.4 10623.2 10725.4 9779.6 9793.5 9971.2 10125.1 10145.4 3071.5 3097.8 3099.3 3115.5 3206.1 1059.4 1060.0 1077.6 1091.2 1092.6 21255.6 21376.5 21613.6 21617.4 21697.3 1149.7 1152.4 1154.3 1154.9 1162.2 11907.0 11927.0 11977.3 12043.6 12081.8 644714.0 649856.0 652140.0 659343.0 680303.0 131942.0 135555.3 136063.0 137566.0 138191.0 1264.8 1277.0 1303.4 1305.2 1313.2 19174.9 19351.6 19391.5 19544.0 19678.8 61199.4 61850.0 61993.1 62000.7 63415.4 78557.2 78920.0 79412.2 79485.2 80144.0 16165.2 16191.5 16252.8 16320.3 16348.8 24164.3 24626.0 24833.6 24907.0 24963.0 20106.6 20242.3 20422.2 20434.2 20526.1 17711.0 18047.3 18086.0 18224.7 18485.3 20405.7 20485.5 20603.8 20771.6 20800.6 15985.0 15988.6 16005.1 16074.8 16075.8 19890.6 19903.8 20147.0 20193.7 20237.5 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#3] mootools.html Cycles:180 Average:11016.36 Median:26852.26 stddev:8198.39 (30.5%) stddev-sans-first:8189.87 16:56:31 INFO - PID 2301 | Values: 1447.0 1507.8 1508.9 1511.9 1531.9 17043.9 17813.8 17891.9 17908.6 17912.2 17145.8 17422.0 17426.8 17434.3 17439.1 2966.4 2989.9 3035.8 3047.9 3063.2 2969.5 2999.3 3002.0 3003.7 3020.6 2882.1 2976.7 2977.3 3005.5 3018.6 2992.1 2994.1 3011.8 3013.5 3013.8 2888.1 2899.5 2908.9 2930.3 2948.4 17237.7 17568.3 17632.6 17637.6 17642.0 8873.4 9106.5 9192.8 9194.4 9198.4 6099.6 6107.8 6230.2 6232.9 6276.4 2178.6 2209.7 2212.2 2251.8 2259.3 31766.4 31868.8 31894.7 31943.5 31948.0 7119.4 7456.4 7506.9 7538.4 7679.3 21087.7 21109.8 21115.7 21128.9 21142.8 8116.8 8262.2 8315.9 8330.4 8334.9 7530.8 7623.8 7706.9 7723.5 7723.5 5883.1 5930.8 5971.3 6025.7 6297.1 1706.5 1716.4 1729.2 1737.3 1768.2 865.9 978.9 1009.6 1013.9 1025.1 9647.7 9807.5 9807.9 9891.8 10401.6 1096.5 1101.0 1101.6 1101.7 1132.9 5970.7 6099.3 6161.1 6178.3 6317.8 26312.3 27111.9 27135.9 27316.9 27361.2 25403.1 26713.2 26991.3 27013.0 27082.2 12562.6 13219.6 13330.3 13422.4 13454.9 9936.6 10081.8 10084.5 10099.0 10286.8 21223.4 22479.0 23091.4 23591.6 23609.8 23057.8 23291.8 23545.0 23907.2 24449.9 12823.2 12878.6 13057.6 13137.6 13152.1 16193.8 16503.7 16515.8 16524.0 16545.0 12847.0 12950.5 13096.9 13103.9 13108.0 12524.3 12735.9 12819.2 12914.7 12987.4 10945.0 11176.5 11229.5 11247.3 11248.7 8787.7 8794.3 8839.3 8914.6 8915.9 8803.2 8977.6 9032.4 9059.0 9089.7 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#4] prototype.html Cycles:180 Average:5749.25 Median:6420.20 stddev:1592.91 (24.8%) stddev-sans-first:1549.11 16:56:31 INFO - PID 2301 | Values: 564.2 574.2 586.1 587.2 591.4 6273.3 6274.6 6290.3 6427.0 6450.1 6282.4 6348.6 6362.1 6363.8 6375.7 5225.3 5284.9 5285.5 5289.9 5307.8 4903.9 5207.3 5222.9 5265.1 5270.8 5055.9 5075.3 5078.9 5090.3 5137.0 5073.3 5083.4 5091.2 5104.3 5119.6 4622.9 4634.5 4652.2 4689.9 4697.3 6239.6 6254.9 6262.7 6274.6 6287.8 5963.4 6025.9 6042.7 6044.2 6044.7 6626.5 6678.3 6697.8 6736.1 6802.9 5174.3 5197.8 5218.1 5218.5 5221.0 6778.3 6816.7 6974.2 7031.9 7086.2 5162.8 5302.7 5310.6 5339.9 5380.8 5398.2 5413.6 5437.5 5440.2 5474.5 5990.4 6023.6 6027.4 6044.7 6057.0 6705.7 6853.6 6861.0 6873.7 6895.8 1847.0 1848.2 1854.8 1863.2 1872.4 1276.4 1328.8 1342.5 1358.2 1363.8 6365.6 6413.4 6441.5 6480.7 6491.7 6714.5 6768.5 6791.3 6803.9 6941.9 6396.7 6485.6 6485.8 6496.0 6548.5 3498.8 3518.8 3575.0 3604.8 3642.6 6908.1 7073.6 7087.4 7117.4 7136.5 7038.3 7110.4 7185.4 7185.5 7206.3 6929.4 7025.9 7054.9 7074.8 7077.8 6701.8 6721.9 6733.9 6777.5 6839.5 6715.5 6727.8 6804.4 6863.8 6878.4 6944.0 6949.9 7007.6 7045.0 7148.7 5216.0 5254.0 5262.4 5275.6 5280.6 6685.7 6884.4 6886.7 6965.7 6992.2 6526.9 6657.9 6692.7 6732.3 6773.8 6637.9 6676.5 6687.2 6693.8 6699.5 6457.2 6661.7 6662.2 6694.0 6701.9 6595.9 6630.8 6740.3 6753.7 6755.5 6519.5 6535.5 6537.2 6539.7 6593.0 16:56:31 INFO - PID 2301 | 16:56:31 INFO - PID 2301 | [#5] yui.html Cycles:180 Average:29736.48 Median:18569.72 stddev:44764.48 (241.1%) stddev-sans-first:44837.93 16:56:31 INFO - PID 2301 | Values: 964.9 966.6 1010.2 1013.6 1025.1 22025.6 22373.9 22586.1 22607.9 22614.2 19903.0 20295.9 20892.5 21064.3 21064.8 1085.7 1098.6 1099.0 1099.6 1099.8 1070.6 1088.5 1098.2 1101.3 1103.1 1169.9 1177.1 1181.5 1181.8 1182.1 1160.8 1174.8 1175.5 1175.7 1177.9 862.2 867.9 868.0 870.6 873.4 20489.3 21563.4 21983.3 22193.4 22322.3 23384.8 23424.8 23718.3 23772.0 24211.3 19730.1 19752.5 19837.6 19881.1 19948.8 4225.0 4245.9 4247.2 4252.8 4253.3 166487.0 169442.0 170314.1 171208.0 173360.0 17942.8 18386.8 18455.7 18627.5 18685.9 34322.7 34364.7 35271.0 35350.5 35630.5 10240.1 10344.3 10406.4 10434.4 10461.8 4866.4 4929.2 4939.1 4946.4 4952.7 6343.2 6355.4 6369.3 6438.6 6442.5 1147.5 1147.7 1160.4 1160.8 1164.5 719.6 722.8 728.2 738.2 752.3 13745.0 13837.0 14242.5 14954.4 15123.8 737.6 738.5 740.5 746.8 760.7 6318.7 6437.1 6477.5 6493.6 6613.0 156110.0 158212.0 158989.0 159270.0 161247.0 132294.0 133520.3 133641.0 136307.0 136671.0 122792.0 123516.4 124352.0 125093.0 125492.0 12219.5 12224.9 12257.7 12316.8 12327.0 58797.7 59140.4 59542.4 59670.0 60304.4 75391.2 75616.0 75980.2 76278.0 77574.0 18001.3 18825.6 18911.3 18980.0 19145.3 19840.0 20017.0 20077.8 20126.2 20432.6 17659.1 18043.1 18290.0 18552.6 18586.8 17775.0 18095.2 18141.0 18197.9 18337.2 14688.9 15068.2 15082.8 15108.7 15199.2 12756.1 12872.4 12914.7 12927.5 13067.2 14104.4 14144.6 14208.6 14288.9 14335.6 16:56:31 INFO - PID 2301 | -------- Summary: end -------- 16:56:31 INFO - PID 2301 | 16:56:31 INFO - TEST-INFO | 2301: exit 0 16:56:31 INFO - TEST-OK | dromaeo_css | took 1106635ms 16:56:31 INFO - TEST-START | kraken 16:56:31 INFO - Initialising browser for kraken test... 16:56:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48385/getInfo.html -profile /tmp/tmpLo15q5/profile 16:56:31 INFO - TEST-INFO | started process 2734 (/builds/slave/test/build/application/firefox/firefox http://localhost:48385/getInfo.html) 16:56:36 INFO - TEST-INFO | 2734: exit 0 16:56:36 INFO - Browser initialized. 16:56:36 INFO - Running cycle 1/1 for kraken test... 16:56:36 INFO - Using env: {'DISPLAY': ':0', 16:56:36 INFO - 'HOME': '/home/cltbld', 16:56:36 INFO - 'JSGC_DISABLE_POISONING': '1', 16:56:36 INFO - 'LANG': 'en_US.UTF-8', 16:56:36 INFO - 'LANGUAGE': 'en_US:en', 16:56:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:56:36 INFO - 'LOGNAME': 'cltbld', 16:56:36 INFO - 'MAIL': '/var/mail/cltbld', 16:56:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:36 INFO - 'MOZ_CRASHREPORTER': '1', 16:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:56:36 INFO - 'MOZ_NO_REMOTE': '1', 16:56:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:36 INFO - 'NO_EM_RESTART': '1', 16:56:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:36 INFO - 'PWD': '/builds/slave/test', 16:56:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:36 INFO - 'RUST_BACKTRACE': 'full', 16:56:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:36 INFO - 'SHELL': '/bin/bash', 16:56:36 INFO - 'SHLVL': '1', 16:56:36 INFO - 'TERM': 'linux', 16:56:36 INFO - 'TMOUT': '86400', 16:56:36 INFO - 'USER': 'cltbld', 16:56:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379', 16:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:36 INFO - '_': '/tools/buildbot/bin/python'} 16:56:36 INFO - TEST-INFO | started process 2993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLo15q5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:37 INFO - PID 2993 | 16:56:37 INFO - PID 2993 | (/builds/slave/test/build/application/firefox/firefox:3102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:37 INFO - PID 2993 | 16:56:47 INFO - PID 2993 | RSS: Main: 143192064 16:56:47 INFO - PID 2993 | 16:56:50 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48385/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:50 INFO - PID 2993 | RSS: Main: 150159360 16:56:50 INFO - PID 2993 | 16:56:53 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48385/tests/kraken/driver.html?testName=audio-dft) 16:56:54 INFO - PID 2993 | RSS: Main: 150331392 16:56:54 INFO - PID 2993 | 16:56:56 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48385/tests/kraken/driver.html?testName=audio-fft) 16:56:57 INFO - PID 2993 | RSS: Main: 152403968 16:56:57 INFO - PID 2993 | 16:56:59 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48385/tests/kraken/driver.html?testName=audio-oscillator) 16:57:00 INFO - PID 2993 | RSS: Main: 152420352 16:57:00 INFO - PID 2993 | 16:57:02 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:02 INFO - PID 2993 | RSS: Main: 152203264 16:57:02 INFO - PID 2993 | 16:57:05 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48385/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:06 INFO - PID 2993 | RSS: Main: 152059904 16:57:06 INFO - PID 2993 | 16:57:09 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48385/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:10 INFO - PID 2993 | RSS: Main: 154394624 16:57:10 INFO - PID 2993 | 16:57:13 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48385/tests/kraken/driver.html?testName=json-parse-financial) 16:57:13 INFO - PID 2993 | RSS: Main: 154484736 16:57:13 INFO - PID 2993 | 16:57:15 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:16 INFO - PID 2993 | RSS: Main: 154791936 16:57:16 INFO - PID 2993 | 16:57:17 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:18 INFO - PID 2993 | RSS: Main: 154775552 16:57:18 INFO - PID 2993 | 16:57:20 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:20 INFO - PID 2993 | RSS: Main: 151572480 16:57:20 INFO - PID 2993 | 16:57:23 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:23 INFO - PID 2993 | RSS: Main: 151515136 16:57:23 INFO - PID 2993 | 16:57:26 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:27 INFO - PID 2993 | RSS: Main: 151973888 16:57:27 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | Cycle 1(1): loaded http://localhost:48385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48385/tests/kraken/driver.html?testName=ai-astar) 16:57:28 INFO - PID 2993 | RSS: Main: 153423872 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | __start_tp_report 16:57:28 INFO - PID 2993 | _x_x_mozilla_page_load 16:57:28 INFO - PID 2993 | _x_x_mozilla_page_load_details 16:57:28 INFO - PID 2993 | |i|pagename|runs| 16:57:28 INFO - PID 2993 | |0;ai-astar;104;104;106;108;103;106;105;106;104;104 16:57:28 INFO - PID 2993 | |1;audio-beat-detection;112;110;113;109;126;114;109;132;126;111 16:57:28 INFO - PID 2993 | |2;audio-dft;161;162;163;170;162;161;160;162;161;161 16:57:28 INFO - PID 2993 | |3;audio-fft;72;74;74;72;72;79;73;72;73;72 16:57:28 INFO - PID 2993 | |4;audio-oscillator;77;78;77;76;79;77;77;77;79;81 16:57:28 INFO - PID 2993 | |5;imaging-gaussian-blur;113;113;114;114;114;110;114;110;114;109 16:57:28 INFO - PID 2993 | |6;imaging-darkroom;148;148;148;149;149;148;150;148;148;148 16:57:28 INFO - PID 2993 | |7;imaging-desaturate;93;94;94;95;94;95;94;94;94;95 16:57:28 INFO - PID 2993 | |8;json-parse-financial;43;43;43;42;45;43;47;44;42;42 16:57:28 INFO - PID 2993 | |9;json-stringify-tinderbox;38;37;38;37;38;37;37;37;38;37 16:57:28 INFO - PID 2993 | |10;stanford-crypto-aes;69;69;72;69;68;69;69;71;68;72 16:57:28 INFO - PID 2993 | |11;stanford-crypto-ccm;101;101;101;100;102;102;101;99;110;107 16:57:28 INFO - PID 2993 | |12;stanford-crypto-pbkdf2;149;147;155;156;149;147;146;158;153;152 16:57:28 INFO - PID 2993 | |13;stanford-crypto-sha256-iterative;57;57;58;57;64;59;60;61;57;59 16:57:28 INFO - PID 2993 | __end_tp_report 16:57:28 INFO - PID 2993 | __start_cc_report 16:57:28 INFO - PID 2993 | _x_x_mozilla_cycle_collect,677 16:57:28 INFO - PID 2993 | __end_cc_report 16:57:28 INFO - PID 2993 | __startTimestamp1508371048941__endTimestamp 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | ------- Summary: start ------- 16:57:28 INFO - PID 2993 | Number of tests: 14 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#0] ai-astar Cycles:10 Average:105.00 Median:105.50 stddev:1.49 (1.4%) stddev-sans-first:1.54 16:57:28 INFO - PID 2993 | Values: 104.0 104.0 106.0 108.0 103.0 106.0 105.0 106.0 104.0 104.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#1] audio-beat-detection Cycles:10 Average:116.20 Median:113.50 stddev:8.46 (7.5%) stddev-sans-first:8.83 16:57:28 INFO - PID 2993 | Values: 112.0 110.0 113.0 109.0 126.0 114.0 109.0 132.0 126.0 111.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.83 (1.7%) stddev-sans-first:2.96 16:57:28 INFO - PID 2993 | Values: 161.0 162.0 163.0 170.0 162.0 161.0 160.0 162.0 161.0 161.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.00 stddev:2.16 (3.0%) stddev-sans-first:2.24 16:57:28 INFO - PID 2993 | Values: 72.0 74.0 74.0 72.0 72.0 79.0 73.0 72.0 73.0 72.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:77.50 stddev:1.48 (1.9%) stddev-sans-first:1.54 16:57:28 INFO - PID 2993 | Values: 77.0 78.0 77.0 76.0 79.0 77.0 77.0 77.0 79.0 81.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 16:57:28 INFO - PID 2993 | Values: 113.0 113.0 114.0 114.0 114.0 110.0 114.0 110.0 114.0 109.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:57:28 INFO - PID 2993 | Values: 148.0 148.0 148.0 149.0 149.0 148.0 150.0 148.0 148.0 148.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 16:57:28 INFO - PID 2993 | Values: 93.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#8] json-parse-financial Cycles:10 Average:43.40 Median:43.00 stddev:1.58 (3.7%) stddev-sans-first:1.67 16:57:28 INFO - PID 2993 | Values: 43.0 43.0 43.0 42.0 45.0 43.0 47.0 44.0 42.0 42.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.50 16:57:28 INFO - PID 2993 | Values: 38.0 37.0 38.0 37.0 38.0 37.0 37.0 37.0 38.0 37.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#10] stanford-crypto-aes Cycles:10 Average:69.60 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.58 16:57:28 INFO - PID 2993 | Values: 69.0 69.0 72.0 69.0 68.0 69.0 69.0 71.0 68.0 72.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#11] stanford-crypto-ccm Cycles:10 Average:102.40 Median:102.00 stddev:3.41 (3.3%) stddev-sans-first:3.57 16:57:28 INFO - PID 2993 | Values: 101.0 101.0 101.0 100.0 102.0 102.0 101.0 99.0 110.0 107.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:152.50 stddev:4.21 (2.8%) stddev-sans-first:4.39 16:57:28 INFO - PID 2993 | Values: 149.0 147.0 155.0 156.0 149.0 147.0 146.0 158.0 153.0 152.0 16:57:28 INFO - PID 2993 | 16:57:28 INFO - PID 2993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.90 Median:59.00 stddev:2.28 (3.9%) stddev-sans-first:2.32 16:57:28 INFO - PID 2993 | Values: 57.0 57.0 58.0 57.0 64.0 59.0 60.0 61.0 57.0 59.0 16:57:28 INFO - PID 2993 | -------- Summary: end -------- 16:57:28 INFO - PID 2993 | 16:57:29 INFO - PID 2993 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:57:29 INFO - TEST-INFO | 2993: exit 0 16:57:29 INFO - TEST-OK | kraken | took 58044ms 16:57:29 INFO - SUITE-END | took 1164s 16:57:29 INFO - Completed test suite (00:19:24) 16:57:29 INFO - javascript benchmark 16:57:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9391.03855746702, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3948.2300951314487, 3967.6825853931687, 3975.145343751093, 3980.940285895711, 3995.8401663933446, 6275.058741188824, 6311.842203944903, 6318.399752023562, 6419.261784894738, 6428.32502587228, 6283.748650053993, 6319.083732858733, 6327.841803954903, 6409.967950160242, 6413.551051426402, 5671.829845104653, 5684.4315568443235, 5774.364819869811, 5780.595358324908, 5793.565482588801, 5698.971505142468, 5764.020116580192, 5771.797987070453, 5780.104083867007, 5863.8534036649, 5809.796657117002, 5839.211706419622, 5860.824175274749, 5861.2087368205175, 5892.263467066617, 5770.451807078321, 5771.307443106854, 5806.158107074492, 5836.620619659709, 5853.209816674758, 5660.575456840754, 5678.971605141948, 5714.942850571482, 5732.914006289909, 5734.0, 6208.286047104551, 6247.531435142382, 6303.338149494329, 6313.621182729005, 6320.873582528324, 6756.662166891636, 6802.183737951477, 6805.965970170167, 6834.043233947252, 6883.552569083044, 6834.829129271759, 6860.862782744317, 6873.553219040747, 6897.896531552031, 6944.652767361612, 6437.742490300382, 6487.513436492282, 6494.642794646245, 6495.415412612888, 6496.0, 7038.6480675965995, 7039.084918960502, 7046.189688185822, 7135.393491553173, 7143.1428228612895, 6681.899771503431, 6804.897926531106, 6828.487863410264, 6901.275366086589, 6903.482238832007, 6867.3476019778045, 6954.130733658293, 6958.47811414146, 6988.336108069725, 6992.895106573405, 6711.463082953352, 6780.8304792379595, 6862.210845752802, 6882.346177113166, 6894.310568943066, 6702.530822842452, 6762.0, 6782.864342713118, 6862.416694580917, 6865.176178858569, 4949.455559888409, 5021.046001259822, 5040.1179793535985, 5042.873928151752, 5046.747662616928, 4635.072985402933, 4665.066986602693, 4739.644526660514, 4749.952500474951, 4754.310624959361, 6514.609123452608, 6517.706703198368, 6598.208215014229, 6600.339966003361, 6612.206535215805, 6742.898856517156, 6864.725410983505, 6894.0, 6924.965375173092, 6932.757353492603, 6479.643619600873, 6484.0, 6486.708098135595, 6494.0258961156205, 6495.805125846232, 5718.571107166979, 5731.885362292731, 5798.507126894261, 5800.622959507618, 5806.44838740319, 7016.649167541603, 7057.258987806309, 7067.187273463514, 7068.29317068289, 7131.251218622074, 6852.109225800614, 6865.828354291183, 6866.0, 6867.07294515254, 6886.48351373639, 7022.297770222936, 7044.788656340318, 7175.0, 7177.7487787927175, 7188.17336006366, 6849.452043836581, 6864.347886950732, 6924.792256232321, 6927.965360173167, 6943.6875340608785, 6812.693428795816, 6859.657017149023, 6934.653267336714, 6955.930440695731, 7058.894116588152, 6602.3397660233595, 6661.233958094687, 6670.299618540177, 6682.766103186365, 6709.0, 6598.901016484852, 6667.899981500184, 6693.631850248283, 6695.230048544479, 6719.966400167968, 6530.706118224596, 6579.144711187515, 6636.303188165173, 6638.137042184679, 6659.600423974577, 6648.434883034803, 6662.834004049369, 6673.9332606673315, 6727.663616819042, 6778.186617605918, 6500.382463665944, 6506.772262970773, 6528.445082168069, 6530.608163510205, 6535.967320163369], "value": 6316.043794132778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.6919385796548, 985.5318723606288, 1028.5011769291891, 1029.212652320974, 1030.8866024737279, 45859.0, 46645.0, 46770.298445523345, 46775.76612116943, 46897.531024689786, 43181.568184318145, 45310.0, 46106.538934610646, 46111.538884611145, 46130.538694613046, 8706.259967902735, 8839.77900552485, 8851.159139881702, 8873.73378798637, 8877.33419993503, 8691.608877600524, 8800.471971681687, 8811.251043661296, 8827.602757875911, 8838.602262898185, 8800.735977920673, 8804.295656347476, 8813.647454101829, 8821.25019373351, 8826.49949508585, 8767.649294028231, 8780.824383512327, 8798.604062817189, 8807.691730789424, 8840.8673869892, 8467.280281176107, 8486.32109431244, 8487.83024339516, 8507.574621268912, 8519.744407667718, 41279.79360103211, 41437.0, 41505.584944150476, 41585.37621935673, 41748.0, 3822.503074600284, 3853.2678791029616, 3853.8651147209994, 3878.1855810279876, 3904.39481880309, 34085.31829363399, 34140.14649633754, 34351.484727729105, 34414.65585344139, 34482.655173448446, 5602.215689803431, 5610.046292130348, 5651.519620832234, 5661.631993920423, 5679.290088738908, 249634.0, 249792.0, 251008.0, 252073.0, 277550.0, 55562.72218638962, 56239.71880140655, 56282.71858640681, 56310.43689563134, 56460.58848528819, 58079.70960145172, 58097.4190258092, 58238.708806455696, 58292.417075829544, 58382.708086460145, 18103.547411314823, 18375.264989400275, 18380.17289221988, 18426.170822313026, 18643.90678046601, 15290.923545382202, 15291.847081529264, 15427.922860385626, 15433.0, 15497.147656878755, 14107.78838317426, 14137.717245655029, 14157.575272741627, 14231.715365692628, 14397.0, 5641.8589535261945, 5661.377248502661, 5759.136129580596, 5823.272090988627, 5891.204687367236, 1103.812351900179, 1109.290054365207, 1116.447358557503, 1126.0541145437708, 1130.2766229613055, 26253.21240362792, 26310.86844565765, 26330.341741456235, 26508.734912651013, 26599.601005984925, 1193.516625766566, 1220.6887243752785, 1236.1594116001206, 1238.1147479552164, 1240.206267988488, 13787.379567919468, 14048.38443578981, 14110.153390796586, 14240.928795355956, 14315.0, 313849.0, 322617.0, 336919.0, 337690.0, 337691.0, 62973.37026629675, 63017.36982630207, 63319.0, 63416.68291658512, 63439.36560634427, 1515.1893736850732, 1523.4210999820218, 1537.9692406152037, 1539.1150088698819, 1572.771948067524, 30924.536131958488, 31179.064628061195, 31227.84386078055, 31298.0, 31392.372152556363, 40822.1835563293, 40886.79556602198, 41028.589714102476, 41120.38319425271, 41138.0, 256439.0, 258453.0, 259685.0, 259860.0, 260212.0, 35677.82161089178, 36588.085297867765, 36668.26663466662, 36787.264254714224, 37039.629603703615, 47134.528654713016, 47344.76327618478, 47656.0, 47928.0, 48014.759926200146, 35124.0, 35256.0, 35368.64631353757, 35624.64375356317, 36165.0, 35901.64098358983, 35940.4608930861, 36215.27569448649, 36255.0, 36420.0, 41386.1722765537, 41457.79271103625, 41772.1645567093, 41793.79103104465, 41867.7906610465, 33836.154096147795, 34128.82935585405, 34258.314833703684, 34389.0, 34544.0, 25856.482870342865, 26059.478810424065, 26198.34504137412, 26247.0, 26651.298785538318], "value": 19538.642630251135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.9968780640094, 648.7072683804502, 650.9300770316795, 651.9369860299216, 656.8913786744549, 23535.29394118177, 24418.633720494185, 24552.75447245527, 24757.75242247577, 24898.87550562247, 25494.745052549468, 25750.227493175236, 25902.870485647545, 25964.870175649095, 25988.610170847453, 6621.470282377399, 6856.382925536701, 6898.0687607172895, 6906.136732908387, 6924.0, 6835.931640683604, 6900.689468973908, 6901.689423975933, 6909.723611055551, 6916.65416729164, 6623.834404139887, 6828.078209441712, 6878.3465570770695, 6881.380675739182, 6889.4832887533385, 6823.112995310603, 6853.383195512378, 6872.759453419157, 6876.553024053445, 6879.828004299882, 6361.2048493938255, 6413.4227919487, 6422.646754428504, 6429.292777794439, 6440.935590644081, 29797.70202297971, 30461.086167415015, 30930.381392372252, 31014.224644383845, 31367.529487057483, 2297.184499502686, 2330.5571941331264, 2331.720193576765, 2333.3116730564525, 2338.590746619335, 20074.498137546532, 20558.79441205584, 20591.485212869648, 20660.380188594216, 20669.58660826775, 2577.7164511903675, 2609.5955126955164, 2665.200439868051, 2680.1021657744677, 2684.315499547603, 143541.56458435385, 149206.0, 166787.0, 171874.0, 171896.0, 16427.83572164287, 16799.6640067198, 17022.40421585263, 17131.74302385465, 17148.39980600698, 27331.86334068357, 27351.0, 27358.99051104377, 27403.0, 27427.451450970868, 11005.61480348184, 11343.319400835811, 11418.486168122454, 11494.080473562095, 11572.305661660159, 10543.525541350658, 10557.155427565776, 10558.366498009991, 10623.20325975555, 10725.356478611307, 9779.559919803625, 9793.51032448389, 9971.202303815677, 10125.139363154067, 10145.442000689885, 3071.4778487657154, 3097.829619370911, 3099.3491366813223, 3115.517094850302, 3206.11831746267, 1059.433203236265, 1059.9947000265104, 1077.6120596585224, 1091.1816137896578, 1092.6448904106198, 21255.574888502142, 21376.465588360104, 21613.56772864534, 21617.351479455643, 21697.34907952764, 1149.706824759681, 1152.3668417665594, 1154.255505199142, 1154.9480273387717, 1162.2329262686756, 11906.987906028085, 11927.0, 11977.341246231541, 12043.578474753516, 12081.818772718416, 644714.0, 649856.0, 652140.0, 659343.0, 680303.0, 131942.0, 135555.32222339022, 136063.0, 137566.0, 138191.0, 1264.7913094339515, 1276.9808452873215, 1303.3808940753067, 1305.1712162776705, 1313.2317594207495, 19174.904125479843, 19351.612967740846, 19391.51521211981, 19544.0, 19678.80321196827, 61199.38800611937, 61850.0, 61993.070103947575, 62000.68999654973, 63415.365846340945, 78557.21442785728, 78920.0, 79412.20587794048, 79485.20514794778, 80144.0, 16165.191740412698, 16191.514254572381, 16252.837471625133, 16320.265588048329, 16348.754768678242, 24164.275071747874, 24626.014959401422, 24833.62749558794, 24907.0, 24963.0, 20106.59786804285, 20242.291519796738, 20422.183112675328, 20434.182632694527, 20526.076326565042, 17711.0, 18047.278108875496, 18086.0, 18224.72662910084, 18485.260589576268, 20405.69391459159, 20485.487862802955, 20603.793962060787, 20771.584568308852, 20800.583988319846, 15985.0, 15988.600284992968, 16005.119718415599, 16074.839251607802, 16075.839241607435, 19890.602187955872, 19903.800961990193, 20147.0, 20193.697094543888, 20237.49406264855], "value": 13198.323533352235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.9638259043522, 1507.811523559555, 1508.886833487488, 1511.879049676026, 1531.9387224511013, 17043.914780426097, 17813.842100263475, 17891.910540447298, 17908.55228619282, 17912.19395127219, 17145.828541714578, 17422.0, 17426.82573174268, 17434.3026278949, 17439.128043597833, 2966.4067186562665, 2989.8505074746286, 3035.772317076217, 3047.8780848766023, 3063.1576316513024, 2969.4951858184054, 2999.2501874531367, 3001.9849900750573, 3003.714647108521, 3020.6375234971833, 2882.120953109301, 2976.6874478179802, 2977.270568710669, 3005.5040918248574, 3018.6377634683868, 2992.132281638322, 2994.056872085308, 3011.804232724866, 3013.5329024001317, 3013.819170849756, 2888.0902515707485, 2899.4635992341273, 2908.9272768180754, 2930.2820808901743, 2948.43979643867, 17237.655246895116, 17568.29726810926, 17632.647347053116, 17637.55906102345, 17642.0, 8873.423227490257, 9106.453612783187, 9192.816143677155, 9194.448333100036, 9198.402103863295, 6099.57302988791, 6107.7556897724035, 6230.221222347207, 6232.9376706232815, 6276.403741644536, 2178.596959562486, 2209.657503087024, 2212.203606701586, 2251.808596269319, 2259.2770313499686, 31766.364672706415, 31868.840655796805, 31894.681053189404, 31943.520847187312, 31948.0, 7119.430445564342, 7456.40348772097, 7506.949027136206, 7538.396928245727, 7679.347255483346, 21087.68368474474, 21109.788902110784, 21115.683264750733, 21128.894355528126, 21142.78857211439, 8116.75649730509, 8262.215089566482, 8315.916840831635, 8330.375221858385, 8334.916650833535, 7530.774076777706, 7623.809404764815, 7706.922930770733, 7723.459357844897, 7723.497972631761, 5883.0881213411985, 5930.792422265286, 5971.343152253248, 6025.6685882276015, 6297.118403423525, 1706.48805358392, 1716.3906813081176, 1729.1959238953946, 1737.3224442467447, 1768.2308195934809, 865.8874346334936, 978.9167920726676, 1009.6365308488938, 1013.8884722680499, 1025.1183981775666, 9647.662331818494, 9807.509624518745, 9807.9019209807, 9891.802163956825, 10401.635942741968, 1096.4956120184645, 1100.9724756881142, 1101.5758932810925, 1101.6724846559875, 1132.8583927009124, 5970.731317090741, 6099.2680878294, 6161.106639537242, 6178.320384757673, 6317.810465686037, 26312.34219144537, 27111.86444067767, 27135.864320678666, 27316.863415682794, 27361.179164625093, 25403.110891118722, 26713.19860404152, 26991.325216869736, 27013.0, 27082.187534374, 12562.623121306375, 13219.603411897659, 13330.26683532415, 13422.395992180376, 13454.93272533631, 9936.602535898483, 10081.848772268275, 10084.495775211357, 10099.0, 10286.794264114826, 21223.363299101053, 22479.0, 23091.422714431603, 23591.64612530779, 23609.763902360755, 23057.769422305562, 23291.76708232896, 23545.0, 23907.16324928689, 24449.877750611133, 12823.166494177849, 12878.613641590768, 13057.608271751862, 13137.605871823478, 13152.145110567782, 16193.838061619233, 16503.66992660164, 16515.83484165191, 16524.0, 16545.0, 12847.0, 12950.546730864375, 13096.934515327363, 13103.934480327538, 13108.0, 12524.311162886128, 12735.936320318338, 12819.230846149261, 12914.741705166032, 12987.350632468528, 10945.0, 11176.497057632263, 11229.49467273991, 11247.325160490396, 11248.662540123809, 8787.692430764893, 8794.340424468319, 8839.292856571588, 8914.55427228623, 8915.910840891507, 8803.163699448542, 8977.596008179517, 9032.412893161923, 9059.0, 9089.681861135094], "value": 7711.315600048838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2354609504124, 574.198992405594, 586.1442294250394, 587.2219309415024, 591.3879135095175, 6273.278572964111, 6274.623522588642, 6290.276618188904, 6426.967865160679, 6450.129232553604, 6282.42420607551, 6348.619082855032, 6362.14111095002, 6363.809085727424, 6375.6812159392075, 5225.320708307924, 5284.859631849088, 5285.524302812746, 5289.947100529003, 5307.787688492455, 4903.8528844134735, 5207.3490813648295, 5222.895542089156, 5265.104932161523, 5270.81552145675, 5055.9241611375855, 5075.314832497621, 5078.898422031557, 5090.261912022773, 5137.0, 5073.289739436482, 5083.36457942759, 5091.210862316347, 5104.285400043997, 5119.59043276537, 4622.9075418491775, 4634.513376095529, 4652.209124448852, 4689.859304220879, 4697.342372067879, 6239.625622462667, 6254.906176407358, 6262.749490020394, 6274.623522588659, 6287.811365658992, 5963.373845746178, 6025.9096113558335, 6042.728077236535, 6044.184035155242, 6044.727987240584, 6626.481936864009, 6678.298778628223, 6697.7655782047395, 6736.05695202672, 6802.897956530656, 5174.275601415805, 5197.8440646780655, 5218.060749065166, 5218.538809133449, 5220.973895130538, 6778.322167783232, 6816.693248803816, 6974.232834388214, 7031.859362812766, 7086.2205157432645, 5162.819301324435, 5302.655327403783, 5310.575153987672, 5339.893202135935, 5380.78476860929, 5398.217258497496, 5413.621046526705, 5437.537809286255, 5440.211169380497, 5474.507294343528, 5990.430909063632, 6023.578349515492, 6027.397260274025, 6044.73322504061, 6057.0, 6705.731770729214, 6853.588784672936, 6860.965695171592, 6873.690683919235, 6895.75864844738, 1846.9722954155698, 1848.1775609853755, 1854.842338401224, 1863.1615772902248, 1872.410190789897, 1276.44474653526, 1328.7674656935192, 1342.5368247954636, 1358.2122369025942, 1363.795430685405, 6365.61806291624, 6413.422791948747, 6441.549091563639, 6480.675966201671, 6491.7078731457195, 6714.462842972551, 6768.492363072691, 6791.252962174256, 6803.931960680429, 6941.895871561931, 6396.712147953353, 6485.6108633482145, 6485.772997945143, 6496.0, 6548.541602087904, 3498.772579782306, 3518.82405879705, 3574.9970025178973, 3604.7656902301264, 3642.581103173116, 6908.1364829396325, 7073.610951397723, 7087.397571206505, 7117.3594376505325, 7136.500444968802, 7038.260982596856, 7110.369163409571, 7185.3533182012825, 7185.461090418135, 7206.279372062857, 6929.41100006495, 7025.859482810315, 7054.858902821915, 7074.787756367317, 7077.796774548442, 6701.798946031627, 6721.865562688817, 6733.912487129006, 6777.491688123312, 6839.521233513607, 6715.5299129060495, 6727.798166055026, 6804.387605115563, 6863.794086177422, 6878.415334696407, 6943.9652801735665, 6949.861002780017, 7007.579545227302, 7044.964775176091, 7148.714051437884, 5216.0, 5253.973730131325, 5262.447443018581, 5275.630705850554, 5280.6303558750515, 6685.699143538455, 6884.449244060564, 6886.690098945459, 6965.651717414008, 6992.230854606091, 6526.9020964686515, 6657.933420665731, 6692.665366731741, 6732.293109223657, 6773.764657663058, 6637.867242655217, 6676.532642714963, 6687.1975362956755, 6693.765718199839, 6699.5310328276555, 6457.222524823032, 6661.700223489857, 6662.167229096363, 6693.966530167318, 6701.899471508029, 6595.868082638224, 6630.83422914431, 6740.292269311652, 6753.729850805913, 6755.459563234831, 6519.5436319457185, 6535.509836762357, 6537.182852143482, 6539.738410463528, 6592.978088396306], "value": 5292.832702384485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [964.9083337082975, 966.5940305071869, 1010.1565193063791, 1013.609760242307, 1025.0774303127184, 22025.559488810213, 22373.888130559346, 22586.096556137734, 22607.886960565196, 22614.208502702408, 19903.0, 20295.898520507377, 20892.477688057807, 21064.262750803726, 21064.789352106513, 1085.6688709943464, 1098.593520397454, 1099.0493223361775, 1099.6096385783053, 1099.8130317845985, 1070.5664205996584, 1088.4884104470887, 1098.1544210957559, 1101.3116801998751, 1103.1450625765017, 1169.9415029248503, 1177.1171621284036, 1181.4978634080524, 1181.7754626620958, 1182.0838849891318, 1160.8200728886952, 1174.8120300751839, 1175.4651633506776, 1175.7295821960954, 1177.9057675385948, 862.1723145780059, 867.9262262707678, 867.9783005424852, 870.6386849457467, 873.3973558244791, 20489.2828750993, 21563.353099407042, 21983.34049978503, 22193.44516387103, 22322.330330090124, 23384.76615233843, 23424.765752342428, 23718.28845134649, 23772.0, 24211.273661790176, 19730.112144953513, 19752.506187345287, 19837.603247935105, 19881.105350259273, 19948.80051199484, 4225.0, 4245.8513952011535, 4247.193033323659, 4252.829886804524, 4253.298205796071, 166487.0, 169442.0, 170314.1484292583, 171208.0, 173360.0, 17942.820571794375, 18386.81613183878, 18455.723164152547, 18627.534311642048, 18685.90657046706, 34322.65677343245, 34364.65635343664, 35271.0, 35350.46974295388, 35630.46554301688, 10240.078392944672, 10344.32761870476, 10406.375617462976, 10434.37393756377, 10461.84307235392, 4866.391701037371, 4929.186684197068, 4939.086269040239, 4946.406431228275, 4952.702837829742, 6343.175387199634, 6355.428011478989, 6369.331220221903, 6438.581492202992, 6442.452391546677, 1147.5237776322733, 1147.707334629664, 1160.3618010094415, 1160.8142697168412, 1164.470166074434, 719.5754504842168, 722.8409749855024, 728.1989811207735, 738.2433006168612, 752.2778132992279, 13745.0, 13837.0, 14242.501512447221, 14954.40182392692, 15123.848761512465, 737.6127533045087, 738.4646131554688, 740.4631642059463, 746.813296675831, 760.6767123972289, 6318.6524741138755, 6437.0988061671405, 6477.5465717400275, 6493.642849643315, 6612.966935165389, 156110.0, 158212.0, 158989.0, 159270.0, 161247.0, 132294.0, 133520.3323983374, 133641.0, 136307.0, 136671.0, 122792.0, 123516.38241808733, 124352.0, 125093.0, 125492.0, 12219.51121955112, 12224.938875305566, 12257.693557660774, 12316.768323167611, 12327.013838893046, 58797.70601147138, 59140.40859591349, 59542.40457595542, 59670.0, 60304.39695602988, 75391.24608753843, 75616.0, 75980.24019759953, 76278.0, 77574.0, 18001.2799488019, 18825.623487530447, 18911.338103166323, 18980.0, 19145.329913452963, 19840.0, 20017.0, 20077.799222007594, 20126.194952202335, 20432.59134817325, 17659.117044148, 18043.097845107954, 18289.99405032736, 18552.628947420704, 18586.814131858508, 17775.0, 18095.185716642518, 18141.0, 18197.909010454863, 18337.174827132545, 14688.853111468748, 15068.171250581323, 15082.773758393414, 15108.697826043637, 15199.240037998277, 12756.107072505207, 12872.420741066488, 12914.67713307175, 12927.482900683868, 13067.215967042008, 14104.36530356157, 14144.646383840487, 14208.573742787732, 14288.928555357157, 14335.56993290203], "value": 10317.629451737026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1352.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 106.0, 108.0, 103.0, 106.0, 105.0, 106.0, 104.0, 104.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 113.0, 109.0, 126.0, 114.0, 109.0, 132.0, 126.0, 111.0], "value": 116.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 170.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 72.0, 72.0, 79.0, 73.0, 72.0, 73.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 76.0, 79.0, 77.0, 77.0, 77.0, 79.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 110.0, 114.0, 110.0, 114.0, 109.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 43.0, 42.0, 45.0, 43.0, 47.0, 44.0, 42.0, 42.0], "value": 43.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 69.0, 68.0, 69.0, 69.0, 71.0, 68.0, 72.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 101.0, 100.0, 102.0, 102.0, 101.0, 99.0, 110.0, 107.0], "value": 102.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 155.0, 156.0, 149.0, 147.0, 146.0, 158.0, 153.0, 152.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 64.0, 59.0, 60.0, 61.0, 57.0, 59.0], "value": 58.9, "unit": "score"}]}]} 16:57:29 INFO - Return code: 0 16:57:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:57:29 INFO - # TBPL SUCCESS # 16:57:29 INFO - Running post-action listener: _package_coverage_data 16:57:29 INFO - Running post-action listener: _resource_record_post_action 16:57:29 INFO - [mozharness: 2017-10-18 23:57:29.747000Z] Finished run-tests step (success) 16:57:29 INFO - Running post-run listener: _resource_record_post_run 16:57:29 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291921920; Read time: 12; Write time: 205088 16:57:29 INFO - TinderboxPrint: CPU usage
13.0% 16:57:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:57:29 INFO - TinderboxPrint: I/O write bytes / time
291,921,920 / 205,088 16:57:29 INFO - TinderboxPrint: CPU idle
8,179.2 (86.9%) 16:57:29 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 16:57:29 INFO - TinderboxPrint: Swap in / out
0 / 0 16:57:29 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9252864; Read time: 0; Write time: 676 16:57:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:57:29 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282669056; Read time: 12; Write time: 204412 16:57:30 INFO - Running post-run listener: _upload_blobber_files 16:57:30 INFO - Blob upload gear active. 16:57:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:30 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 16:57:30 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:30 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:31 INFO - (blobuploader) - INFO - Done attempting. 16:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:38 INFO - (blobuploader) - INFO - Done attempting. 16:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:39 INFO - (blobuploader) - INFO - Done attempting. 16:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:40 INFO - (blobuploader) - INFO - Done attempting. 16:57:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:40 INFO - Return code: 0 16:57:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b3ab0c5ffcc03456050d059dfdba14112d7fb114c5a2fa7b87ba7a4485bde59f8dcc299c660da52fd228c9a30a029cae2c80c1f437ff09cebf740f5dabbffba9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/670928cc6e6a979fe7f8e4b3212060e66ce0781366bb2b4e1a50dcdc6f2c442bd5f0b30770d79d7503ff52935e9842ecd11cf4c8251c12b6d5de15ada7b724d5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e080facb21e46c7d6f420ddf046074daf3362b497d3600f155bca7b2bb4578e7feef7e09c9d61e82776bd2fbbaa4a5b7d8eb1c7d8a5e7648887554ba803692be", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39344742afeaa74db69c98982398c6e468675dfde1928806e882fcdfb1dd3bd2e09909db8f7fdadbe141a8044acb30daea110548602af1dd797a5ea2d94c3dcf"} 16:57:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:40 INFO - Contents: 16:57:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b3ab0c5ffcc03456050d059dfdba14112d7fb114c5a2fa7b87ba7a4485bde59f8dcc299c660da52fd228c9a30a029cae2c80c1f437ff09cebf740f5dabbffba9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/670928cc6e6a979fe7f8e4b3212060e66ce0781366bb2b4e1a50dcdc6f2c442bd5f0b30770d79d7503ff52935e9842ecd11cf4c8251c12b6d5de15ada7b724d5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e080facb21e46c7d6f420ddf046074daf3362b497d3600f155bca7b2bb4578e7feef7e09c9d61e82776bd2fbbaa4a5b7d8eb1c7d8a5e7648887554ba803692be", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39344742afeaa74db69c98982398c6e468675dfde1928806e882fcdfb1dd3bd2e09909db8f7fdadbe141a8044acb30daea110548602af1dd797a5ea2d94c3dcf"} 16:57:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:40 INFO - Copying logs to upload dir... 16:57:40 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.816840 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-18 16:57:40.260162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-18 16:57:40.264246) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b3ab0c5ffcc03456050d059dfdba14112d7fb114c5a2fa7b87ba7a4485bde59f8dcc299c660da52fd228c9a30a029cae2c80c1f437ff09cebf740f5dabbffba9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/670928cc6e6a979fe7f8e4b3212060e66ce0781366bb2b4e1a50dcdc6f2c442bd5f0b30770d79d7503ff52935e9842ecd11cf4c8251c12b6d5de15ada7b724d5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e080facb21e46c7d6f420ddf046074daf3362b497d3600f155bca7b2bb4578e7feef7e09c9d61e82776bd2fbbaa4a5b7d8eb1c7d8a5e7648887554ba803692be", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39344742afeaa74db69c98982398c6e468675dfde1928806e882fcdfb1dd3bd2e09909db8f7fdadbe141a8044acb30daea110548602af1dd797a5ea2d94c3dcf"} build_url:https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/TWJRsNEyQKyidsjJqZwYGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b3ab0c5ffcc03456050d059dfdba14112d7fb114c5a2fa7b87ba7a4485bde59f8dcc299c660da52fd228c9a30a029cae2c80c1f437ff09cebf740f5dabbffba9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/670928cc6e6a979fe7f8e4b3212060e66ce0781366bb2b4e1a50dcdc6f2c442bd5f0b30770d79d7503ff52935e9842ecd11cf4c8251c12b6d5de15ada7b724d5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e080facb21e46c7d6f420ddf046074daf3362b497d3600f155bca7b2bb4578e7feef7e09c9d61e82776bd2fbbaa4a5b7d8eb1c7d8a5e7648887554ba803692be", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/39344742afeaa74db69c98982398c6e468675dfde1928806e882fcdfb1dd3bd2e09909db8f7fdadbe141a8044acb30daea110548602af1dd797a5ea2d94c3dcf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-18 16:57:40.294956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:57:40.295374) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1508369817.247084-2023791379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-18 16:57:40.377946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-18 16:57:40.378328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-18 16:57:40.378676) ========= ========= Total master_lag: 0.19 =========