builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1503319539.79 results: success (0) revision: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.785503) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.786002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.786309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.802622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.802917) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 05:45:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-08-21 05:45:40 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.977118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:39.977466) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021246 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.027766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.028132) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 --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=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 05:45:40,147 truncating revision to first 12 chars 2017-08-21 05:45:40,147 Setting DEBUG logging. 2017-08-21 05:45:40,147 attempt 1/10 2017-08-21 05:45:40,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c7c96eebbcb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 05:45:40,436 unpacking tar archive at: mozilla-central-c7c96eebbcb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.659014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.659375) ========= script_repo_revision: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.659805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.660101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:45:40.672334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-21 05:45:40.672655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:40 INFO - MultiFileLogger online at 20170821 05:45:40 in /builds/slave/test 05:45:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:45:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:40 INFO - {'append_to_log': False, 05:45:40 INFO - 'base_work_dir': '/builds/slave/test', 05:45:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:45:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:40 INFO - 'branch': 'Firefox-Non-PGO', 05:45:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:40 INFO - 'code_coverage': False, 05:45:40 INFO - 'config_files': ('talos/linux_config.py',), 05:45:40 INFO - 'default_actions': ('clobber', 05:45:40 INFO - 'read-buildbot-config', 05:45:40 INFO - 'download-and-extract', 05:45:40 INFO - 'populate-webroot', 05:45:40 INFO - 'create-virtualenv', 05:45:40 INFO - 'install', 05:45:40 INFO - 'setup-mitmproxy', 05:45:40 INFO - 'run-tests'), 05:45:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:40 INFO - 'disable_ccov_upload': False, 05:45:40 INFO - 'download_minidump_stackwalk': True, 05:45:40 INFO - 'download_symbols': 'ondemand', 05:45:40 INFO - 'enable_stylo': False, 05:45:40 INFO - 'enable_webrender': False, 05:45:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:40 INFO - 'gecko_profile': False, 05:45:40 INFO - 'gecko_profile_interval': 0, 05:45:40 INFO - 'installer_path': 'installer.exe', 05:45:40 INFO - 'log_level': 'info', 05:45:40 INFO - 'log_name': 'talos', 05:45:40 INFO - 'log_to_console': True, 05:45:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:40 INFO - 'opt_config_files': (), 05:45:40 INFO - 'pip_index': False, 05:45:40 INFO - 'suite': 'dromaeojs-e10s', 05:45:40 INFO - 'system_bits': '32', 05:45:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:40 INFO - 'title': 'talos-linux64-ix-064', 05:45:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:40 INFO - 'use_talos_json': True, 05:45:40 INFO - 'verify': 'False', 05:45:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:40 INFO - 'work_dir': 'build'} 05:45:40 INFO - [mozharness: 2017-08-21 12:45:40.943271Z] Running clobber step. 05:45:40 INFO - Running pre-action listener: _resource_record_pre_action 05:45:40 INFO - Running main action method: clobber 05:45:40 INFO - rmtree: /builds/slave/test/build 05:45:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - [mozharness: 2017-08-21 12:45:42.485442Z] Finished clobber step (success) 05:45:42 INFO - [mozharness: 2017-08-21 12:45:42.485538Z] Running read-buildbot-config step. 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: read_buildbot_config 05:45:42 INFO - Using buildbot properties: 05:45:42 INFO - { 05:45:42 INFO - "project": "", 05:45:42 INFO - "product": "firefox", 05:45:42 INFO - "who": "archaeopteryx@coole-files.de", 05:45:42 INFO - "installer_path": "public/build/target.tar.bz2", 05:45:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:45:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:45:42 INFO - "stage_platform": "linux64", 05:45:42 INFO - "basedir": "/builds/slave/test", 05:45:42 INFO - "buildnumber": 1090, 05:45:42 INFO - "platform": "ubuntu64_hw", 05:45:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:42 INFO - "slavebuilddir": "test", 05:45:42 INFO - "taskId": "DjS9XUEtRQmiJljdzUMqqA", 05:45:42 INFO - "branch": "mozilla-central", 05:45:42 INFO - "script_repo_revision": "production", 05:45:42 INFO - "revision": "c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476", 05:45:42 INFO - "slavename": "talos-linux64-ix-064", 05:45:42 INFO - "repo_path": "mozilla-central" 05:45:42 INFO - } 05:45:42 INFO - Finding installer, test and symbols from parent task. 05:45:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DjS9XUEtRQmiJljdzUMqqA'}, attempt #1 05:45:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DjS9XUEtRQmiJljdzUMqqA'}, attempt #1 05:45:43 INFO - Task dependencies: G7SN3CghTUOgq49ARGJ-8A 05:45:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A'}, attempt #1 05:45:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 05:45:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.test_packages.json 05:45:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.crashreporter-symbols.zip 05:45:43 INFO - Running post-action listener: _resource_record_post_action 05:45:43 INFO - [mozharness: 2017-08-21 12:45:43.846356Z] Finished read-buildbot-config step (success) 05:45:43 INFO - [mozharness: 2017-08-21 12:45:43.846660Z] Running download-and-extract step. 05:45:43 INFO - Running pre-action listener: _resource_record_pre_action 05:45:43 INFO - Running main action method: download_and_extract 05:45:43 INFO - mkdir: /builds/slave/test/build/tests 05:45:44 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')]} 05:45:44 INFO - trying https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.test_packages.json 05:45:44 INFO - Downloading https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:45:44 INFO - Downloaded 989 bytes. 05:45:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:45:44 INFO - Using the following test package requirements: 05:45:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:45:44 INFO - u'common': [u'target.common.tests.zip'], 05:45:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:45:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:45:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:45:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:45:44 INFO - u'mozbase': [u'target.common.tests.zip'], 05:45:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:45:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:45:44 INFO - u'web-platform': [u'target.common.tests.zip', 05:45:44 INFO - u'target.web-platform.tests.tar.gz'], 05:45:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:45:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:45:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip 05:45:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:45:44 INFO - Fetch https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip into memory 05:45:45 INFO - Content-Length response header: 54005814 05:45:45 INFO - Bytes received: 54005814 05:45:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:45:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip 05:45:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:45:56 INFO - Fetch https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.common.tests.zip into memory 05:45:57 INFO - Content-Length response header: 54005814 05:45:57 INFO - Bytes received: 54005814 05:46:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.talos.tests.zip 05:46:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:46:09 INFO - Fetch https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.talos.tests.zip into memory 05:46:10 INFO - Content-Length response header: 14496256 05:46:10 INFO - Bytes received: 14496256 05:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:10 INFO - trying https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 05:46:10 INFO - Downloading https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:46:11 INFO - Downloaded 62090232 bytes. 05:46:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 05:46:11 INFO - mkdir: /builds/slave/test/properties 05:46:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:11 INFO - Contents: 05:46:11 INFO - build_url:https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 05:46:11 INFO - Running post-action listener: _resource_record_post_action 05:46:11 INFO - Running post-action listener: find_tests_for_verification 05:46:11 INFO - Running post-action listener: set_extra_try_arguments 05:46:11 INFO - [mozharness: 2017-08-21 12:46:11.595411Z] Finished download-and-extract step (success) 05:46:11 INFO - [mozharness: 2017-08-21 12:46:11.595506Z] Running populate-webroot step. 05:46:11 INFO - Running pre-action listener: _resource_record_pre_action 05:46:11 INFO - Running main action method: populate_webroot 05:46:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:11 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:11 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:11 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'tests': ['damp', 'tps']}, 05:46:11 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['damp', 'tps']}, 05:46:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:46:11 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:46:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:46:11 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:46:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:11 INFO - 'ts_paint', 05:46:11 INFO - 'tpaint', 05:46:11 INFO - 'sessionrestore', 05:46:11 INFO - 'sessionrestore_many_windows', 05:46:11 INFO - 'sessionrestore_no_auto_restore', 05:46:11 INFO - 'tabpaint']}, 05:46:11 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['a11yr', 05:46:11 INFO - 'ts_paint', 05:46:11 INFO - 'tpaint', 05:46:11 INFO - 'sessionrestore', 05:46:11 INFO - 'sessionrestore_many_windows', 05:46:11 INFO - 'sessionrestore_no_auto_restore', 05:46:11 INFO - 'tabpaint']}, 05:46:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:46:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:46:11 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['bloom_basic_singleton']}, 05:46:11 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['bloom_basic']}, 05:46:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:11 INFO - 'tsvgr_opacity', 05:46:11 INFO - 'tart', 05:46:11 INFO - 'tscrollx', 05:46:11 INFO - 'tsvg_static']}, 05:46:11 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['tsvgx', 05:46:11 INFO - 'tsvgr_opacity', 05:46:11 INFO - 'tart', 05:46:11 INFO - 'tscrollx', 05:46:11 INFO - 'tsvg_static']}, 05:46:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:11 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--stylo'], 05:46:11 INFO - 'tests': ['tp5o']}, 05:46:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:46:11 INFO - 'talos_options': ['--mitmproxy', 05:46:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:46:11 INFO - '--firstNonBlankPaint'], 05:46:11 INFO - 'tests': ['tp6_google', 05:46:11 INFO - 'tp6_youtube', 05:46:11 INFO - 'tp6_amazon', 05:46:11 INFO - 'tp6_facebook']}, 05:46:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:46:11 INFO - 'talos_options': ['--stylo', 05:46:11 INFO - '--mitmproxy', 05:46:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:46:11 INFO - '--firstNonBlankPaint'], 05:46:11 INFO - 'tests': ['tp6_google', 05:46:11 INFO - 'tp6_youtube', 05:46:11 INFO - 'tp6_amazon', 05:46:11 INFO - 'tp6_facebook']}, 05:46:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:46:11 INFO - 'talos_options': ['--stylo', 05:46:11 INFO - '--stylo-threads=1', 05:46:11 INFO - '--mitmproxy', 05:46:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:46:11 INFO - '--firstNonBlankPaint'], 05:46:11 INFO - 'tests': ['tp6_google', 05:46:11 INFO - 'tp6_youtube', 05:46:11 INFO - 'tp6_amazon', 05:46:11 INFO - 'tp6_facebook']}, 05:46:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--xperf_path', 05:46:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:11 INFO - 'tests': ['tp5n']}, 05:46:11 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:46:11 INFO - 'talos_options': ['--stylo', 05:46:11 INFO - '--xperf_path', 05:46:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:11 INFO - 'tests': ['tp5n']}}} 05:46:11 INFO - Running post-action listener: _resource_record_post_action 05:46:11 INFO - [mozharness: 2017-08-21 12:46:11.609576Z] Finished populate-webroot step (success) 05:46:11 INFO - [mozharness: 2017-08-21 12:46:11.609665Z] Running create-virtualenv step. 05:46:11 INFO - Running pre-action listener: _resource_record_pre_action 05:46:11 INFO - Running main action method: create_virtualenv 05:46:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:46:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:46:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:11 INFO - Using real prefix '/usr' 05:46:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:14 INFO - Installing pip.................done. 05:46:14 INFO - Return code: 0 05:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:14 INFO - Reading from file tmpfile_stdout 05:46:14 INFO - Output received: 05:46:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:46:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:14 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:14 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 05:46:14 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 05:46:14 INFO - Using env: {'DISPLAY': ':0', 05:46:14 INFO - 'HOME': '/home/cltbld', 05:46:14 INFO - 'LANG': 'en_US.UTF-8', 05:46:14 INFO - 'LANGUAGE': 'en_US:en', 05:46:14 INFO - 'LOGNAME': 'cltbld', 05:46:14 INFO - 'MAIL': '/var/mail/cltbld', 05:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:14 INFO - 'MOZ_NO_REMOTE': '1', 05:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:14 INFO - 'NO_EM_RESTART': '1', 05:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:14 INFO - 'PWD': '/builds/slave/test', 05:46:14 INFO - 'SHELL': '/bin/bash', 05:46:14 INFO - 'SHLVL': '1', 05:46:14 INFO - 'TERM': 'linux', 05:46:14 INFO - 'TMOUT': '86400', 05:46:14 INFO - 'USER': 'cltbld', 05:46:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:14 INFO - '_': '/tools/buildbot/bin/python'} 05:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:46:14 INFO - Cleaning up... 05:46:14 INFO - Return code: 0 05:46:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:14 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:14 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 05:46:14 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 05:46:14 INFO - Using env: {'DISPLAY': ':0', 05:46:14 INFO - 'HOME': '/home/cltbld', 05:46:14 INFO - 'LANG': 'en_US.UTF-8', 05:46:14 INFO - 'LANGUAGE': 'en_US:en', 05:46:14 INFO - 'LOGNAME': 'cltbld', 05:46:14 INFO - 'MAIL': '/var/mail/cltbld', 05:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:14 INFO - 'MOZ_NO_REMOTE': '1', 05:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:14 INFO - 'NO_EM_RESTART': '1', 05:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:14 INFO - 'PWD': '/builds/slave/test', 05:46:14 INFO - 'SHELL': '/bin/bash', 05:46:14 INFO - 'SHLVL': '1', 05:46:14 INFO - 'TERM': 'linux', 05:46:14 INFO - 'TMOUT': '86400', 05:46:14 INFO - 'USER': 'cltbld', 05:46:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:14 INFO - '_': '/tools/buildbot/bin/python'} 05:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:14 INFO - Downloading/unpacking psutil>=3.1.1 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:16 INFO - Installing collected packages: psutil 05:46:16 INFO - Running setup.py install for psutil 05:46:16 INFO - building 'psutil._psutil_linux' extension 05:46:16 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 05:46:16 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 05:46:16 INFO - building 'psutil._psutil_posix' extension 05:46:16 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 05:46:16 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 05:46:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:16 INFO - Successfully installed psutil 05:46:16 INFO - Cleaning up... 05:46:16 INFO - Return code: 0 05:46:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:16 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:16 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 05:46:16 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 05:46:16 INFO - Using env: {'DISPLAY': ':0', 05:46:16 INFO - 'HOME': '/home/cltbld', 05:46:16 INFO - 'LANG': 'en_US.UTF-8', 05:46:16 INFO - 'LANGUAGE': 'en_US:en', 05:46:16 INFO - 'LOGNAME': 'cltbld', 05:46:16 INFO - 'MAIL': '/var/mail/cltbld', 05:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:16 INFO - 'MOZ_NO_REMOTE': '1', 05:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:16 INFO - 'NO_EM_RESTART': '1', 05:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:16 INFO - 'PWD': '/builds/slave/test', 05:46:16 INFO - 'SHELL': '/bin/bash', 05:46:16 INFO - 'SHLVL': '1', 05:46:16 INFO - 'TERM': 'linux', 05:46:16 INFO - 'TMOUT': '86400', 05:46:16 INFO - 'USER': 'cltbld', 05:46:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:16 INFO - '_': '/tools/buildbot/bin/python'} 05:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:17 INFO - Installing collected packages: mozsystemmonitor 05:46:17 INFO - Running setup.py install for mozsystemmonitor 05:46:18 INFO - Successfully installed mozsystemmonitor 05:46:18 INFO - Cleaning up... 05:46:18 INFO - Return code: 0 05:46:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:46:18 INFO - Using env: {'DISPLAY': ':0', 05:46:18 INFO - 'HOME': '/home/cltbld', 05:46:18 INFO - 'LANG': 'en_US.UTF-8', 05:46:18 INFO - 'LANGUAGE': 'en_US:en', 05:46:18 INFO - 'LOGNAME': 'cltbld', 05:46:18 INFO - 'MAIL': '/var/mail/cltbld', 05:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:18 INFO - 'MOZ_NO_REMOTE': '1', 05:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:18 INFO - 'NO_EM_RESTART': '1', 05:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:18 INFO - 'PWD': '/builds/slave/test', 05:46:18 INFO - 'SHELL': '/bin/bash', 05:46:18 INFO - 'SHLVL': '1', 05:46:18 INFO - 'TERM': 'linux', 05:46:18 INFO - 'TMOUT': '86400', 05:46:18 INFO - 'USER': 'cltbld', 05:46:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:18 INFO - '_': '/tools/buildbot/bin/python'} 05:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:18 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 05:46:18 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 05:46:18 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 05:46:18 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 05:46:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:19 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 05:46:19 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 05:46:19 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 05:46:19 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 05:46:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:19 INFO - warning: no files found matching '*.txt' 05:46:19 INFO - no previously-included directories found matching 'build' 05:46:19 INFO - no previously-included directories found matching 'dist' 05:46:19 INFO - no previously-included directories found matching '.git*' 05:46:19 INFO - Installing collected packages: jsonschema, functools32 05:46:19 INFO - Running setup.py install for functools32 05:46:19 INFO - warning: no files found matching '*.txt' 05:46:19 INFO - no previously-included directories found matching 'build' 05:46:19 INFO - no previously-included directories found matching 'dist' 05:46:19 INFO - no previously-included directories found matching '.git*' 05:46:19 INFO - Successfully installed jsonschema functools32 05:46:19 INFO - Cleaning up... 05:46:19 INFO - Return code: 0 05:46:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46:19 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')]} 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:19 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')]} 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:19 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:19 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 05:46:19 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 05:46:19 INFO - Using env: {'DISPLAY': ':0', 05:46:19 INFO - 'HOME': '/home/cltbld', 05:46:19 INFO - 'LANG': 'en_US.UTF-8', 05:46:19 INFO - 'LANGUAGE': 'en_US:en', 05:46:19 INFO - 'LOGNAME': 'cltbld', 05:46:19 INFO - 'MAIL': '/var/mail/cltbld', 05:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:19 INFO - 'MOZ_NO_REMOTE': '1', 05:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:19 INFO - 'NO_EM_RESTART': '1', 05:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:19 INFO - 'PWD': '/builds/slave/test', 05:46:19 INFO - 'SHELL': '/bin/bash', 05:46:19 INFO - 'SHLVL': '1', 05:46:19 INFO - 'TERM': 'linux', 05:46:19 INFO - 'TMOUT': '86400', 05:46:19 INFO - 'USER': 'cltbld', 05:46:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:19 INFO - '_': '/tools/buildbot/bin/python'} 05:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:19 INFO - Cleaning up... 05:46:19 INFO - Return code: 0 05:46:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:19 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')]} 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:19 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')]} 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:19 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:19 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 05:46:19 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 05:46:19 INFO - Using env: {'DISPLAY': ':0', 05:46:19 INFO - 'HOME': '/home/cltbld', 05:46:19 INFO - 'LANG': 'en_US.UTF-8', 05:46:19 INFO - 'LANGUAGE': 'en_US:en', 05:46:19 INFO - 'LOGNAME': 'cltbld', 05:46:19 INFO - 'MAIL': '/var/mail/cltbld', 05:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:19 INFO - 'MOZ_NO_REMOTE': '1', 05:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:19 INFO - 'NO_EM_RESTART': '1', 05:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:19 INFO - 'PWD': '/builds/slave/test', 05:46:19 INFO - 'SHELL': '/bin/bash', 05:46:19 INFO - 'SHLVL': '1', 05:46:19 INFO - 'TERM': 'linux', 05:46:19 INFO - 'TMOUT': '86400', 05:46:19 INFO - 'USER': 'cltbld', 05:46:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:19 INFO - '_': '/tools/buildbot/bin/python'} 05:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:20 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 05:46:20 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 05:46:20 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 05:46:20 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 05:46:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:21 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 05:46:21 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 05:46:21 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 05:46:21 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 05:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:21 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 05:46:21 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 05:46:21 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 05:46:21 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 05:46:21 INFO - Downloading docopt-0.6.1.tar.gz 05:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:21 INFO - Running setup.py install for blobuploader 05:46:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:21 INFO - Running setup.py install for requests 05:46:22 INFO - Running setup.py install for docopt 05:46:22 INFO - Successfully installed blobuploader requests docopt 05:46:22 INFO - Cleaning up... 05:46:22 INFO - Return code: 0 05:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:22 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')]} 05:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:22 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')]} 05:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:22 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:22 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 05:46:22 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 05:46:22 INFO - Using env: {'DISPLAY': ':0', 05:46:22 INFO - 'HOME': '/home/cltbld', 05:46:22 INFO - 'LANG': 'en_US.UTF-8', 05:46:22 INFO - 'LANGUAGE': 'en_US:en', 05:46:22 INFO - 'LOGNAME': 'cltbld', 05:46:22 INFO - 'MAIL': '/var/mail/cltbld', 05:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:22 INFO - 'MOZ_NO_REMOTE': '1', 05:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:22 INFO - 'NO_EM_RESTART': '1', 05:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:22 INFO - 'PWD': '/builds/slave/test', 05:46:22 INFO - 'SHELL': '/bin/bash', 05:46:22 INFO - 'SHLVL': '1', 05:46:22 INFO - 'TERM': 'linux', 05:46:22 INFO - 'TMOUT': '86400', 05:46:22 INFO - 'USER': 'cltbld', 05:46:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:22 INFO - '_': '/tools/buildbot/bin/python'} 05:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:22 INFO - Running setup.py (path:/tmp/pip-fTM5lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:22 INFO - Running setup.py (path:/tmp/pip-YOPR49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:22 INFO - Running setup.py (path:/tmp/pip-yUClX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:22 INFO - Running setup.py (path:/tmp/pip-DKyudH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:23 INFO - Running setup.py (path:/tmp/pip-VtUBRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:23 INFO - Running setup.py (path:/tmp/pip-mLla_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:23 INFO - Running setup.py (path:/tmp/pip-ddKc1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:23 INFO - Running setup.py (path:/tmp/pip-Gvtq6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:23 INFO - Running setup.py (path:/tmp/pip-1ZrN9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:23 INFO - Running setup.py (path:/tmp/pip-mYi1do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:23 INFO - Running setup.py (path:/tmp/pip-7cN8CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:23 INFO - Running setup.py (path:/tmp/pip-WdzypQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:23 INFO - Running setup.py (path:/tmp/pip-4nul5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:23 INFO - Running setup.py (path:/tmp/pip-WfybCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:23 INFO - Running setup.py (path:/tmp/pip-fiM1E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:23 INFO - Running setup.py (path:/tmp/pip-LuKKYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:23 INFO - Running setup.py (path:/tmp/pip-1QU5WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:24 INFO - Running setup.py install for manifestparser 05:46:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozcrash 05:46:24 INFO - Running setup.py install for mozdebug 05:46:24 INFO - Running setup.py install for mozdevice 05:46:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozfile 05:46:24 INFO - Running setup.py install for mozhttpd 05:46:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozinfo 05:46:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozInstall 05:46:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozleak 05:46:24 INFO - Running setup.py install for mozlog 05:46:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for moznetwork 05:46:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozprocess 05:46:25 INFO - Running setup.py install for mozprofile 05:46:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozrunner 05:46:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozscreenshot 05:46:25 INFO - Running setup.py install for moztest 05:46:25 INFO - Running setup.py install for mozversion 05:46:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:25 INFO - Cleaning up... 05:46:25 INFO - Return code: 0 05:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46: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')]} 05:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:25 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:25 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 05:46:25 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 05:46:25 INFO - Using env: {'DISPLAY': ':0', 05:46:25 INFO - 'HOME': '/home/cltbld', 05:46:25 INFO - 'LANG': 'en_US.UTF-8', 05:46:25 INFO - 'LANGUAGE': 'en_US:en', 05:46:25 INFO - 'LOGNAME': 'cltbld', 05:46:25 INFO - 'MAIL': '/var/mail/cltbld', 05:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:25 INFO - 'MOZ_NO_REMOTE': '1', 05:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:25 INFO - 'NO_EM_RESTART': '1', 05:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:25 INFO - 'PWD': '/builds/slave/test', 05:46:25 INFO - 'SHELL': '/bin/bash', 05:46:25 INFO - 'SHLVL': '1', 05:46:25 INFO - 'TERM': 'linux', 05:46:25 INFO - 'TMOUT': '86400', 05:46:25 INFO - 'USER': 'cltbld', 05:46:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:25 INFO - '_': '/tools/buildbot/bin/python'} 05:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:26 INFO - Running setup.py (path:/tmp/pip-UMpjfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:26 INFO - Running setup.py (path:/tmp/pip-WXVdDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:26 INFO - Running setup.py (path:/tmp/pip-XbpWFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:26 INFO - Running setup.py (path:/tmp/pip-A1Logf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:26 INFO - Running setup.py (path:/tmp/pip-VBxumR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:26 INFO - Running setup.py (path:/tmp/pip-4_ExY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:26 INFO - Running setup.py (path:/tmp/pip-AHWgeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:26 INFO - Running setup.py (path:/tmp/pip-dir15r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:26 INFO - Running setup.py (path:/tmp/pip-P3Qghh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:26 INFO - Running setup.py (path:/tmp/pip-ardY1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:26 INFO - Running setup.py (path:/tmp/pip-32nX94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:26 INFO - Running setup.py (path:/tmp/pip-6LwEbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:26 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)) 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:26 INFO - Running setup.py (path:/tmp/pip-mAvQSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:27 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)) 05:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:27 INFO - Running setup.py (path:/tmp/pip-rAu5Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:27 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)) 05:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:27 INFO - Running setup.py (path:/tmp/pip-hvHUKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:27 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)) 05:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:27 INFO - Running setup.py (path:/tmp/pip-kPfwiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:27 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)) 05:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:27 INFO - Running setup.py (path:/tmp/pip-xMcSHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:27 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)) 05:46:27 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)) 05:46:27 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)) 05:46:27 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)) 05:46:27 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)) 05:46:27 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)) 05:46:27 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)) 05:46:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:28 INFO - Downloading blessings-1.6.tar.gz 05:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:28 INFO - Installing collected packages: blessings 05:46:28 INFO - Running setup.py install for blessings 05:46:28 INFO - Successfully installed blessings 05:46:28 INFO - Cleaning up... 05:46:28 INFO - Return code: 0 05:46:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:28 INFO - Reading from file tmpfile_stdout 05:46:28 INFO - Current package versions: 05:46:28 INFO - argparse == 1.2.1 05:46:28 INFO - blessings == 1.6 05:46:28 INFO - blobuploader == 1.2.4 05:46:28 INFO - docopt == 0.6.1 05:46:28 INFO - functools32 == 3.2.3-2 05:46:28 INFO - jsonschema == 2.5.1 05:46:28 INFO - manifestparser == 1.1 05:46:28 INFO - mozInstall == 1.13 05:46:28 INFO - mozcrash == 1.0 05:46:28 INFO - mozdebug == 0.1 05:46:28 INFO - mozdevice == 0.51 05:46:28 INFO - mozfile == 1.2 05:46:28 INFO - mozhttpd == 0.7 05:46:28 INFO - mozinfo == 0.10 05:46:28 INFO - mozleak == 0.1 05:46:28 INFO - mozlog == 3.5 05:46:28 INFO - moznetwork == 0.27 05:46:28 INFO - mozprocess == 0.25 05:46:28 INFO - mozprofile == 0.28 05:46:28 INFO - mozrunner == 6.13 05:46:28 INFO - mozscreenshot == 0.1 05:46:28 INFO - mozsystemmonitor == 0.3 05:46:28 INFO - moztest == 0.8 05:46:28 INFO - mozversion == 1.4 05:46:28 INFO - psutil == 3.1.1 05:46:28 INFO - requests == 1.2.3 05:46:28 INFO - wsgiref == 0.1.2 05:46:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:28 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')]} 05:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:28 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')]} 05:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:28 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:28 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 05:46:28 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 05:46:28 INFO - Using env: {'DISPLAY': ':0', 05:46:28 INFO - 'HOME': '/home/cltbld', 05:46:28 INFO - 'LANG': 'en_US.UTF-8', 05:46:28 INFO - 'LANGUAGE': 'en_US:en', 05:46:28 INFO - 'LOGNAME': 'cltbld', 05:46:28 INFO - 'MAIL': '/var/mail/cltbld', 05:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:28 INFO - 'MOZ_NO_REMOTE': '1', 05:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:28 INFO - 'NO_EM_RESTART': '1', 05:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:28 INFO - 'PWD': '/builds/slave/test', 05:46:28 INFO - 'SHELL': '/bin/bash', 05:46:28 INFO - 'SHLVL': '1', 05:46:28 INFO - 'TERM': 'linux', 05:46:28 INFO - 'TMOUT': '86400', 05:46:28 INFO - 'USER': 'cltbld', 05:46:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:28 INFO - '_': '/tools/buildbot/bin/python'} 05:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 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)) 05:46:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:46:30 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)) 05:46:30 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)) 05:46:30 INFO - Installing collected packages: simplejson 05:46:30 INFO - Running setup.py install for simplejson 05:46:30 INFO - building 'simplejson._speedups' extension 05:46:30 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 05:46:31 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 05:46:31 INFO - Successfully installed simplejson 05:46:31 INFO - Cleaning up... 05:46:31 INFO - Return code: 0 05:46:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:31 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')]} 05:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:31 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')]} 05:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:31 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 0x285b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', '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 05:46:31 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 05:46:31 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 05:46:31 INFO - Using env: {'DISPLAY': ':0', 05:46:31 INFO - 'HOME': '/home/cltbld', 05:46:31 INFO - 'LANG': 'en_US.UTF-8', 05:46:31 INFO - 'LANGUAGE': 'en_US:en', 05:46:31 INFO - 'LOGNAME': 'cltbld', 05:46:31 INFO - 'MAIL': '/var/mail/cltbld', 05:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:31 INFO - 'MOZ_NO_REMOTE': '1', 05:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:31 INFO - 'NO_EM_RESTART': '1', 05:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:31 INFO - 'PWD': '/builds/slave/test', 05:46:31 INFO - 'SHELL': '/bin/bash', 05:46:31 INFO - 'SHLVL': '1', 05:46:31 INFO - 'TERM': 'linux', 05:46:31 INFO - 'TMOUT': '86400', 05:46:31 INFO - 'USER': 'cltbld', 05:46:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:31 INFO - '_': '/tools/buildbot/bin/python'} 05:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:31 INFO - Cleaning up... 05:46:31 INFO - Return code: 0 05:46:31 INFO - Running post-action listener: _resource_record_post_action 05:46:31 INFO - Running post-action listener: _start_resource_monitoring 05:46:31 INFO - Starting resource monitoring. 05:46:31 INFO - [mozharness: 2017-08-21 12:46:31.656733Z] Finished create-virtualenv step (success) 05:46:31 INFO - [mozharness: 2017-08-21 12:46:31.657319Z] Running install step. 05:46:31 INFO - Running pre-action listener: _resource_record_pre_action 05:46:31 INFO - Running main action method: install 05:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:31 INFO - Reading from file tmpfile_stdout 05:46:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:32 INFO - Reading from file tmpfile_stdout 05:46:32 INFO - Output received: 05:46:32 INFO - Usage: mozinstall [options] installer 05:46:32 INFO - Options: 05:46:32 INFO - -h, --help show this help message and exit 05:46:32 INFO - -d DEST, --destination=DEST 05:46:32 INFO - Directory to install application into. [default: 05:46:32 INFO - "/builds/slave/test"] 05:46:32 INFO - --app=APP Application being installed. [default: firefox] 05:46:32 INFO - mkdir: /builds/slave/test/build/application 05:46:32 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'] 05:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:46:50 INFO - Reading from file tmpfile_stdout 05:46:50 INFO - Output received: 05:46:50 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:50 INFO - Running post-action listener: _resource_record_post_action 05:46:50 INFO - [mozharness: 2017-08-21 12:46:50.065251Z] Finished install step (success) 05:46:50 INFO - [mozharness: 2017-08-21 12:46:50.065531Z] Running setup-mitmproxy step. 05:46:50 INFO - Running pre-action listener: _resource_record_pre_action 05:46:50 INFO - Running main action method: setup_mitmproxy 05:46:50 INFO - Skipping: mitmproxy is not required 05:46:50 INFO - Running post-action listener: _resource_record_post_action 05:46:50 INFO - [mozharness: 2017-08-21 12:46:50.066661Z] Finished setup-mitmproxy step (success) 05:46:50 INFO - [mozharness: 2017-08-21 12:46:50.066878Z] Running run-tests step. 05:46:50 INFO - Running pre-action listener: _resource_record_pre_action 05:46:50 INFO - Running pre-action listener: _set_gcov_prefix 05:46:50 INFO - Running main action method: run_tests 05:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:50 INFO - Python 2.7.3 05:46:50 INFO - Return code: 0 05:46:50 INFO - grabbing minidump binary from tooltool 05:46:50 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')]} 05:46:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2bc7130>, '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 0x2bc8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc84c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:46:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:46:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:50 INFO - Return code: 0 05:46:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:50 INFO - ENV: RUST_BACKTRACE is now full 05:46:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 05:46:50 INFO - Using env: {'DISPLAY': ':0', 05:46:50 INFO - 'HOME': '/home/cltbld', 05:46:50 INFO - 'LANG': 'en_US.UTF-8', 05:46:50 INFO - 'LANGUAGE': 'en_US:en', 05:46:50 INFO - 'LOGNAME': 'cltbld', 05:46:50 INFO - 'MAIL': '/var/mail/cltbld', 05:46:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:50 INFO - 'MOZ_NO_REMOTE': '1', 05:46:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:50 INFO - 'NO_EM_RESTART': '1', 05:46:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:50 INFO - 'PWD': '/builds/slave/test', 05:46:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:50 INFO - 'RUST_BACKTRACE': 'full', 05:46:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:46:50 INFO - 'SHELL': '/bin/bash', 05:46:50 INFO - 'SHLVL': '1', 05:46:50 INFO - 'TERM': 'linux', 05:46:50 INFO - 'TMOUT': '86400', 05:46:50 INFO - 'USER': 'cltbld', 05:46:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323', 05:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:50 INFO - '_': '/tools/buildbot/bin/python'} 05:46:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:46:50 INFO - mozversion application_buildid: 20170821114200 05:46:50 INFO - mozversion application_changeset: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 05:46:50 INFO - mozversion application_display_name: Nightly 05:46:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:50 INFO - mozversion application_name: Firefox 05:46:50 INFO - mozversion application_remotingname: firefox 05:46:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:50 INFO - mozversion application_vendor: Mozilla 05:46:50 INFO - mozversion application_version: 57.0a1 05:46:50 INFO - mozversion platform_buildid: 20170821114200 05:46:50 INFO - mozversion platform_changeset: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 05:46:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:50 INFO - mozversion platform_version: 57.0a1 05:46:50 INFO - using testdate: 1503319610 05:46:50 INFO - actual date: 1503319610 05:46:50 INFO - starting webserver on 'localhost:58689' 05:46:50 INFO - SUITE-START | Running 2 tests 05:46:50 INFO - TEST-START | dromaeo_css 05:46:50 INFO - Initialising browser for dromaeo_css test... 05:46:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58689/getInfo.html -profile /tmp/tmpGUpLzF/profile 05:46:50 INFO - TEST-INFO | started process 12578 (/builds/slave/test/build/application/firefox/firefox http://localhost:58689/getInfo.html) 05:46:56 INFO - TEST-INFO | 12578: exit 0 05:46:57 INFO - Browser initialized. 05:46:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:57 INFO - TEST-INFO | started process 12753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGUpLzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:58 INFO - PID 12753 | 05:46:58 INFO - PID 12753 | (/builds/slave/test/build/application/firefox/firefox:12803): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:46:58 INFO - PID 12753 | 05:46:58 INFO - PID 12753 | 05:46:58 INFO - PID 12753 | (/builds/slave/test/build/application/firefox/firefox:12855): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:46:58 INFO - PID 12753 | 05:46:58 INFO - PID 12753 | __metrics Screen width/height:1600/1200 05:46:58 INFO - PID 12753 | colorDepth:24 05:46:58 INFO - PID 12753 | Browser inner width/height: 1024/768 05:46:58 INFO - PID 12753 | __metrics 05:47:08 INFO - PID 12753 | RSS: Main: 172097536 05:47:08 INFO - PID 12753 | 05:50:07 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58689/tests/dromaeo/cssquery-ext.html) 05:50:08 INFO - PID 12753 | RSS: Main: 175878144 05:50:08 INFO - PID 12753 | 05:53:09 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-ext.html (next: http://localhost:58689/tests/dromaeo/cssquery-jquery.html) 05:53:10 INFO - PID 12753 | RSS: Main: 172556288 05:53:10 INFO - PID 12753 | 05:56:12 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58689/tests/dromaeo/cssquery-mootools.html) 05:56:12 INFO - PID 12753 | RSS: Main: 175353856 05:56:12 INFO - PID 12753 | 05:59:14 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58689/tests/dromaeo/cssquery-prototype.html) 05:59:14 INFO - PID 12753 | RSS: Main: 173019136 05:59:14 INFO - PID 12753 | 06:02:18 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58689/tests/dromaeo/cssquery-yui.html) 06:02:19 INFO - PID 12753 | RSS: Main: 176467968 06:02:19 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | Cycle 1(1): loaded http://localhost:58689/tests/dromaeo/cssquery-yui.html (next: http://localhost:58689/tests/dromaeo/cssquery-dojo.html) 06:05:21 INFO - PID 12753 | RSS: Main: 176902144 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | __start_tp_report 06:05:21 INFO - PID 12753 | _x_x_mozilla_page_load 06:05:21 INFO - PID 12753 | _x_x_mozilla_page_load_details 06:05:21 INFO - PID 12753 | |i|pagename|runs| 06:05:21 INFO - PID 12753 | |0;dojo.html;3137.3882092991876;3172.7144556989865;3178.4596618574847;3196.792208506447;3216.5657636219116;6157.630542167473;6203.131561581376;6253.9687301563545;6276.937230627693;6313.589616674924;6155.907661385083;6216.502679785618;6219;6220.098085777571;6254.749810007605;5709.457601527848;5729.197912292282;5740.512056475204;5748.683822389767;5824.621399609012;5839.357670656224;5841.094630332305;5846.093855452412;5859.238299021143;5886.735096920649;5548.72256387179;5649.971750141223;5714.5142662873495;5826.417358264182;5831.067029275317;5695.373508914016;5701.401352857932;5745.6552606843725;5760.711964401763;5784.334801497797;5665.405132461115;5684.8294551163535;5720.856978575569;5746.310442746855;5766.163906233573;5989;6040.788572399945;6046.697665116771;6062.030075187993;6094.329623741385;6653.201615806134;6654.70053847578;6670.39966403026;6677.699503522354;6680.432163266129;6728.93271067288;6735.562188457735;6737.124173857367;6738.494612904003;6743.19081710193;6201.6899155042065;6206.875862482725;6224.62652240867;6282.2147231596055;6286.371362863677;6945.791626251221;7013.26360732126;7036.085308909809;7044.084269044992;7051.048108505389;6606.174228221473;6609.702563384659;6689.1972963244725;6706.027625994204;6718.697658605374;6549.214094308713;6568.244651865001;6601.53789234749;6664.900026499607;6726.058351830748;6596.241432235259;6606.042123892009;6611.702473388709;6611.966940165268;6618.834529136714;6582.670866456754;6642.202935647753;6648.8670226595195;6718.361755633207;6751.493637977172;5356.7857285708915;5396.676199427969;5397.622166448389;5417.756200970965;5419.403865574784;4601.976990115028;4604.654650901196;4685.4143232095985;4690.319903613957;4705.576498115118;5680.4319568042865;5778.508826749773;5797.304323481209;5847.649141051551;5850.2102216200265;6637.834054148589;6639.701213445406;6693.698783554752;6706.094677218611;6726.596404215763;5809.4771470567;5828.038373668297;5838.854028649318;5853.034249348895;5872.207252020922;5879.235699359056;5882.294124704978;5966.940330596725;5980.461758441674;5994.730237139339;6494.967525162344;6507.381798729113;6572.539922205496;6574.967125164344;6578.243501997236;6592.340765923369;6616.503762217757;6679.6994135265;6688.498362622726;6746.932530674827;6443.226812782496;6499.3175716549085;6506.41442270198;6524;6563.949768037091;6578;6651.7006734698025;6665.800025999228;6667.899981500378;6682.732690692318;6757.391834734897;6761.560498567577;6819.5908245505425;6822.727090916506;6826.965865170642;6375.203099612549;6441.67791610427;6476.4495017924;6499;6604.042413850061;6451.935480645134;6521.836954076186;6542.280349161493;6544.607323560602;6544.770933017321;6391.392817682313;6505.186851643544;6507.869842603216;6509.73961041572;6510.7721229756735;6489.221293444817;6529.053287273414;6606.933930660824;6636.867262654817;6637.867242655217;6183.227096612924;6231.937680623136;6316.368363163647;6387.297397286202;6417.422431981144 06:05:21 INFO - PID 12753 | |1;ext.html;776.3866545429112;800.46368932815;828.8922440082787;832.6378025558882;1196.3719047500056;31731.68268317319;32191.356172876527;42678.14643707128;43291.350629740504;43447;42959;43258.13483730331;43269.35095973563;43357.566424335746;43383.34924976128;7812.492188007761;7909.644066017028;8014.879776803353;8039.55782431966;8070.475419097769;7894.3289820365335;7999.560024198696;8000.919990800105;8003.1996800320085;8005.67977280911;8000.599970001505;8027.638756255982;8033.678652853879;8057.59712014397;8059.194080591952;7996.160403157672;8005.359571234288;8015.038195416529;8033.678652853879;8036.919630803675;7882.763517094496;7934.166912474165;7937.523748575104;7941.96029019857;7942.920570794276;38447;38597.42103868444;38600.42099368512;38636;38692.226155477016;3477.930441391158;3505.9474107888145;3513.2797776456023;3516.859325626972;3523.612402635708;31358.843205783825;31425.371492570248;31448.213794655087;31464.842675786702;31474.05577832669;5102.336696229503;5122.76947537358;5134.717590532519;5150.175971844525;5151.2530683050745;196896.03103969063;197524;198055;199053;199749;48971.02057958892;48990.51009489859;49004.75497622489;49075.26387104196;49133.50866491289;52606.47393526016;52619.473805261456;52627.210591841154;52628.15801446931;52671;14451.927740361441;16289.837101628833;16509.6698066038;16554.58613534671;16561.337546498005;12039.75920481603;13528.255945922872;13729.107608005448;13735.24456154901;13753.312334383241;14336.283185840666;14382.41793402725;14409.855901440851;14412;14528.927355363367;5891.703825158458;5944.078667806497;5969.134475501115;5970.373110823301;6028.788992385245;1005.3063386263601;1017.4099022567042;1019.3272440189439;1020.6070662794729;1027.3733022856052;22751.658725119138;22970.770292296864;23157.421064473187;23253.488523245935;23261.7673823263;1089.7765957978595;1110.1119104716195;1118.3792994887915;1121.3608243301403;1143.2568830260232;12226.633201003984;12244.877551224374;12286.955608773176;12423.44094515749;12600.621981340575;237625;239150;239958;241017;241108;54671.17993230105;54706;55017.1747423789;55066.449335506935;55124.72437637866;1448.2830998655522;1466.9339879705226;1472.2491529320123;1482.1699848085107;1501.2643804535699;23011.424714382276;23152.53694926126;23161.768382316634;23257;23260.767392326536;38240.61759382371;38243;38255.617443825206;38274;38488.61511384962;201635;202228;202309;202309;202567;33629.32741345208;35505.64494355127;35892.461613076346;36005;36067.63932360748;46557.53442465532;47352.28971565498;47386.289205661255;47406.762966186325;47533.28700069433;34569.65430345664;34598.30803383968;34698.826505867306;34748.131296716776;35562.28875422425;33841.83079084589;34585.135371615914;34651.13372165716;34667.826660866536;35110.473342899364;38202.617973819906;38238;38604.22791544097;38649;38792.224155517295;33440.66559334376;34259;34301.65698343085;34359.828200858836;34662.30675386528;24600.384990375383;24617.876910615334;24754.87622561948;25236.116735914155;25277.115300965113 06:05:21 INFO - PID 12753 | |2;jquery.html;562.1539582927693;577.6851615869354;581.255992329818;585.2976428286058;588.294047143428;22029.66955495669;22986.770132298672;23771.881140594316;23793.5241295174;23804.88097559512;25673.35816604586;26228.737712622868;26254.737452625468;26257.47485050298;26449.47101057978;6582.506312026605;6705.698243579026;6715.026321183425;6725.529212955071;6736.2590115087305;6612.107365505667;6643.036759669845;6783.525153239275;7032.50772445929;7097.112860892388;7105;7128.215896251409;7128.394086502628;7128.964355178243;7132.037174981363;7086.185088714812;7095.716171353166;7096.964515177391;7109.9644501777675;7114.110736157981;6927.896081558781;6928.307169283082;6929.514933954625;6941.548799328028;6953.026576279325;31331.37337253242;31562.684373156204;33012;33093;33108.503372449435;1911.6559019376507;1940.078462730206;1942.7085937109405;1946.883187008784;1950.414875537333;20344.898275508676;20866;20926.790732092635;20932.47668808292;20935.790642093536;2562.4234547226724;2578.8323758955607;2592.196419110082;2688.7042425333198;2700.729927007303;150122;154219.45780542164;154226;154310.22844885816;154414;20213.6967945478;22608.321750347517;22876.199333023596;23293.883530582578;23527.29418117459;46586.30120548195;46601.30098048532;46751.29873051907;46776.06447871092;46854;11988.820167697491;12013.519459221534;12218;12302.569410070604;12318.322492262832;8275.379346549033;10040.246981476419;10062.345947513388;10090.09189172978;10224.948875255575;10034.849477257847;11968.521259149711;12001.459934302977;12018.519259229533;12150.635480935585;4519.254323036728;4558.931616025762;4602.514642093299;4620.3762492063815;4625.283081122431;948.5352177433147;968.977728496443;983.1790454970037;988.4316518002033;992.6277645882794;19307.710384344246;19749;19845.900770496344;19974.30089946845;23971.28086157418;1010.1968934696934;1043.5147656339839;1050.6427814543092;1064.973375665599;1067.4449286371043;11077.058450031676;11114.777704445865;11149.331040137618;11188.440577971069;11342.943285283522;522538;525755;529152;541490;544475;120122;122790;124365.37817310856;124442;124691.25926222227;1217.7686239614445;1276.3363051213503;1278.7058976435471;1278.9936050319875;1285.1582213650074;21180.682289765973;21271.36185914425;21385.89307053455;21398;21573.568528629654;59340.70329648324;60814.695926520086;60833;60837.69581152066;62339.37660623336;75793.24206758082;75811;75855.62072189603;76175;76205.23794761981;12331.75336493283;12752.87247127554;14236.857631423552;14595.85404145945;14900.478483253035;23195.188168414024;23486.882565587064;23520.529589407775;23525;23532.647010294517;18465.723014155068;18539.609529285088;18635.72046419278;18869.056547172862;18967.146478408227;16380.918095409446;16576.917115414344;16647.167641618114;17082.316707331567;17152.48542543726;18531.536711582317;18933.90533047326;19023.33418330352;19214.135363908936;19215.807841921403;14468.131912085308;14613.85386146125;14614.85385146135;14625.561233163022;14628.707425851211;18069.367572134914;18073.548161296072;18406.907965460086;18455.261789528267;18464.630707386044 06:05:21 INFO - PID 12753 | |3;mootools.html;1333.6199183232782;1365.6858922447836;1404.5294826233212;1407.7606806842837;1414.7524183267926;14272;14887.553373398789;14911.627209319773;14913.850861491395;14927.552173434788;14847.55457336279;15163.090214587133;15166.848331516709;15171.848281517181;15172.620684482867;2703.297142742891;2732.3442373830235;2741.684706258776;2742.437800250954;2742.684591272009;2509.6737424134835;2617.450335429562;2664.134156399168;2664.5337066013467;2665.1604744505516;2606.986965065172;2651.827631203975;2652.9071482498116;2656.282803643015;2670.27902466334;2577.7164511903675;2579.8452092874395;2586.767190952823;2596;2598.2854714953446;2407.6388541718707;2419.685440892673;2427.672264244322;2429.5626787178303;2437.6343548467694;13678;14112.788308175386;14114.223717695522;14136.646583835383;14140.787888181685;7783.532988020737;8075.192480751936;8095.757127286132;8096.068952070528;8100.108988011314;5260.263563101169;5285.894282114336;5353.785848566053;5409.648372855751;5463.344398672145;1759.4897479730862;1784.2060283173994;1787.5888545634448;1817.0551313317133;1823.6899727046434;22300.330990070324;22440.32679019632;22457.550848983094;22504.21235256758;22622.321330360115;7100.431965442752;7143.857122857514;7321.084864391951;7394.149672787591;7405.333519983227;16429.424970125987;16445.506634800975;16489.752653710202;16500.33998640041;16512.917435412746;7669.424793140537;7908.485948413335;7919;7923.643436045391;7924.722634707758;5711.885762284731;6468.094466774655;6471.741130354733;7290.9635451822405;7300.12398512182;5145.45972672864;5308.654937429054;5334.306540149756;5370.650907690988;5443.237946687467;1530.5102367242375;1552.2859484636967;1565.5538171621033;1567.576754276339;1591.8089829220567;849.4733265375506;870.3428911172025;880.9163129502687;888.7289376740156;900.1268769293774;7283.745068922668;7305.525140865827;8134.3085837703275;8512.574371281411;8627.870581941275;930.851063829784;946.4983558713893;976.682578162086;977.1385510602314;1017.7811770469384;4881.243407271879;4962.801487940515;4976.154053810861;5100.362454693163;5155.74221288934;18520.536986575175;19324.1304141314;19442.027898605014;19508.21967121299;19618.60762784765;19583;19886;20333.288334908208;20347.389578312675;20347.491312717004;10963.355496675404;11028;11265.943670281596;11273.379964101889;11390.715232119097;7859.646315915912;7862.2923936845955;7930.920690793018;7965.442419030613;7992.960915081002;17254;17593.82406175922;17802.5549361267;17879.821201788334;17918.462446126636;18182.36361727333;18320.175592098654;18329.175187116878;18506.352277670754;18666.066696664842;10399.32404393712;10428.739281518023;10474.633387831389;10490.370577765358;10490.947545262225;13050.673733156747;13172.07795454309;13174.07781455289;13179.077464577771;13207.537736179187;11066.170037247077;11156.721081973015;11234.887651123385;11346.773064538827;11496.94251528737;10487.52806123711;10729.839052414063;11703.531858725555;11854.170208085696;11977.341246231541;9148.63405463774;9371;9371;9381.812363752822;9406.341556091282;7213.20654727969;7288.817779555554;7336.156342020736;7336.229695881855;7360.631968401452;7299.708011679686;7353.852922941618;7367.189609142883;7449.888251676338;7478.513896596922 06:05:21 INFO - PID 12753 | |4;prototype.html;491.51819719173506;512.0987062769526;528.4213785904439;531.0494215354515;537.4517991648519;6286.654234017127;6301.968490157548;6365.936340636592;6398.936010639893;6419.293877673452;6292.119103325526;6311.747530098802;6316.336784637616;6323.810285691437;6328.525360597962;5213.58291336694;5219.217117432387;5233.86915327118;5233.947660523384;5241.9213711794355;4879.902401951958;5003.974980125095;5188.16989281715;5227.79088836446;5233.188855727369;4966.9751651241695;4983.028309479653;4990.126727822635;4998.325226094467;5007.949920500803;4978.278149668296;4994.800207991676;5008.24876268559;5019.038767127376;5032.32063671407;4479.843205487825;4727.5272472752795;4843.29772183035;4857.3812509680165;4872.585830204437;6177.845553861144;6178.227721534809;6199.504039676815;6224.688765561749;6229.781957631461;6093.695315234265;6105.572609917308;6112.327643959161;6125.540584456139;6128.57100003;6740.7866584014855;6752.020956961213;6763.5941843489545;6782.5252232343755;6794.388505034522;5381.0852155133725;5391.757370918318;5397.379301380352;5405.5135037846385;5415.512603865632;6751.729930802762;6888.621125838077;6893.827654308632;6910.792676219721;7062.788116356517;5506.807261745819;5522.917156242579;5524.4199359067525;5555.916661250085;5575.553955683617;5619.353774316006;5649;5663;5668.829935101871;5695.45893140151;6072.817815465543;6081.118237855486;6084.939150608438;6093.603915745551;6097.725602347905;6755.2906944771075;6763.492738044666;6778.847595908609;6787.9272436537685;6788.796336109925;1969.6507892093962;1983.2959299448776;1997.4806550296737;1999.2802591067205;2004.9699254511195;1395;1453.2443129572564;1456.8470310617445;1460.7662773956115;1474.2555009720022;5816.941830581724;5843.217818565378;5853.443922827325;5865.3254875689845;5916.822495325147;6749.291324410964;6757.966210168917;6800.251972283045;6840.931590684129;6849.1780986281965;5729.140628905698;5802.506786923159;5834.299884013945;5843.123531470228;5871.442212989759;3553.502509648651;3607.134287770916;3656.2504686539196;3659.121810765397;3661.2494438640015;6553.4101930826455;6613.6362500062;6642.701078451481;6676.6327851967635;6737.258901520829;6909.30906909305;6998.860022799516;7028;7046.718131274692;7070.717171313193;6531.452733433965;6602.471802255712;6646.60120392778;6656.134702488645;6682.365175308338;6730.360615741497;6784;6784.5929244243525;6881.144325105225;6895.551934093696;6670.7665231716655;6681.632510211985;6742.6291553965;6811.795646130624;6829.419499342612;6543.312952139957;6581.387560047819;6607.438367738604;6632.336766323522;6660.333966603494;5487.835364939058;5505.366882808528;5524.8342549723575;5525.419830917695;5565.443455654402;6465;6528.183977002875;6572.09409271306;6782.253952065367;6814.488913331421;6473.320301368289;6491.870162596816;6524.902126468011;6524.934750652433;6568.930786802142;6437.742490300336;6469.5794773339585;6489.091527186103;6535.5425120241125;6596.340365963365;6447.967760161169;6473.643949582818;6476.417122459001;6503.6422996733745;6508.186476690414;6684.799456016132;6690.799276021728;6703.966480167763;6711.966440167768;6715.597064176165;6465.22417309907;6481.189851268591;6481.837954051187;6510.18622672166;6520.869582608227 06:05:21 INFO - PID 12753 | |5;yui.html;901.5492253873067;912.0696889173043;924.1682485762817;927.2211342472326;928.2295694573505;22228.555428891414;23935;23985.400364990885;24000.15999440018;24033.279001629937;21298.46753831155;21993.450163745914;22078.448038798997;22136.557268854613;22284.554308913812;1034.6327053895852;1052.41590917041;1060.1042119409087;1063.8989296016905;1064.9574017039308;976.677696360203;1062.8352605346145;1069.6897899609105;1071.1591400750413;1071.6892101290655;1118.1278602689915;1119.3731510354228;1120.1318977792234;1120.2942146447726;1120.4733775125678;1117.2961034548223;1119;1120.1318977792196;1120.6581992492286;1121.551379448219;821.2444551013082;821.5645707774889;823.3701218567801;823.4236034775681;823.7611092783086;19977;20066.29767958129;20292.391228263026;20443.5911281775;20591;20852.791472085235;21211.257605983872;21646.242381516728;21762.673559896615;21810.454738631663;16108.275127619168;16223.018004575702;16286;16439.09584972826;16691.83308166915;3611.9097022574647;3634.1459756957356;3635.7818530887967;3636.454531820248;3636.690881275095;124260.37869810684;125989.37005314915;126507;128187.7181228185;128435;16393.180340982904;16766.497005089866;17184.226709798088;17261.309547617955;17283.481495555152;25219.87390063038;29517.557236641038;29785.25536861596;30357;31927;8714.128587141235;8751.56242187888;8996.100389960951;9014.59434325457;9032;4171.958280417218;4300.118475712471;4308.655307575386;4310.89222769427;4332.826686932551;5191.6884986900905;5262.868428289246;5263.289455923478;5274.736263186825;5281.471852814765;1083.4907593431076;1111.4165063341811;1130.8699499557492;1131.9094472442184;1132.049078773834;683.1665368250726;689.9517033807685;696.6864910790064;708.5217478202193;710.2897102897103;11336.326982212537;11779.823302650468;11861.406929653484;12022.398880055962;12221.327826969602;680.4012469027224;684.1345697692423;685.372883811307;704.1620471638734;716.45907339958;5596.944030559643;5672.319321681424;5673.461021202979;5674.177244299553;5704.258446401941;105428.47285763675;112176.43911780552;116694.81616214103;120995.39502302432;123066.38466807609;97271.51364243275;99991;100082;100611.99999999853;105620.47189764002;86877.56561217153;86929.56535217284;87599.56200219085;89106.55446722725;90893.54553227192;11716;12395.72464817218;12407;12501.374931253218;12858.971282297207;38290;39751.60248397479;40256.59743402529;40761.38857917193;41043.179136417704;74973.625131874;75131;76068;76296;76721;19846.305379311656;20064.89967550153;20126.496837579176;20240.696389553876;20612.896935515226;20053.899730501253;20486.59026819485;20641;20644.17423303111;20934.47663808417;18126.54683632867;18251.54371140732;18316.81683183151;18449.53876153107;18507.16717747678;18052.819471805113;18649.067546622344;18829.529261768566;19135.23459061622;19648.115834787754;18945.90527047356;19116.71324930155;19508.804911950698;19534.804651953298;19822.108005140093;13503.932480337535;14314.785278220626;14453.277336132942;14512.274386280433;14599.270036497921;11753.47109380097;13167.47330106785;13638.795418068936;14053.297335132998;14826.40694372213 06:05:21 INFO - PID 12753 | __end_tp_report 06:05:21 INFO - PID 12753 | __start_cc_report 06:05:21 INFO - PID 12753 | _x_x_mozilla_cycle_collect,366 06:05:21 INFO - PID 12753 | __end_cc_report 06:05:21 INFO - PID 12753 | __startTimestamp1503320721448__endTimestamp 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | ------- Summary: start ------- 06:05:21 INFO - PID 12753 | Number of tests: 6 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#0] dojo.html Cycles:165 Average:6167.51 Median:6441.68 stddev:723.57 (11.2%) stddev-sans-first:685.63 06:05:21 INFO - PID 12753 | Values: 3137.4 3172.7 3178.5 3196.8 3216.6 6157.6 6203.1 6254.0 6276.9 6313.6 6155.9 6216.5 6219.0 6220.1 6254.7 5709.5 5729.2 5740.5 5748.7 5824.6 5839.4 5841.1 5846.1 5859.2 5886.7 5548.7 5650.0 5714.5 5826.4 5831.1 5695.4 5701.4 5745.7 5760.7 5784.3 5665.4 5684.8 5720.9 5746.3 5766.2 5989.0 6040.8 6046.7 6062.0 6094.3 6653.2 6654.7 6670.4 6677.7 6680.4 6728.9 6735.6 6737.1 6738.5 6743.2 6201.7 6206.9 6224.6 6282.2 6286.4 6945.8 7013.3 7036.1 7044.1 7051.0 6606.2 6609.7 6689.2 6706.0 6718.7 6549.2 6568.2 6601.5 6664.9 6726.1 6596.2 6606.0 6611.7 6612.0 6618.8 6582.7 6642.2 6648.9 6718.4 6751.5 5356.8 5396.7 5397.6 5417.8 5419.4 4602.0 4604.7 4685.4 4690.3 4705.6 5680.4 5778.5 5797.3 5847.6 5850.2 6637.8 6639.7 6693.7 6706.1 6726.6 5809.5 5828.0 5838.9 5853.0 5872.2 5879.2 5882.3 5966.9 5980.5 5994.7 6495.0 6507.4 6572.5 6575.0 6578.2 6592.3 6616.5 6679.7 6688.5 6746.9 6443.2 6499.3 6506.4 6524.0 6563.9 6578.0 6651.7 6665.8 6667.9 6682.7 6757.4 6761.6 6819.6 6822.7 6827.0 6375.2 6441.7 6476.4 6499.0 6604.0 6451.9 6521.8 6542.3 6544.6 6544.8 6391.4 6505.2 6507.9 6509.7 6510.8 6489.2 6529.1 6606.9 6636.9 6637.9 6183.2 6231.9 6316.4 6387.3 6417.4 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#1] ext.html Cycles:180 Average:38839.20 Median:3515.07 stddev:55518.72 (1579.4%) stddev-sans-first:55600.90 06:05:21 INFO - PID 12753 | Values: 776.4 800.5 828.9 832.6 1196.4 31731.7 32191.4 42678.1 43291.4 43447.0 42959.0 43258.1 43269.4 43357.6 43383.3 7812.5 7909.6 8014.9 8039.6 8070.5 7894.3 7999.6 8000.9 8003.2 8005.7 8000.6 8027.6 8033.7 8057.6 8059.2 7996.2 8005.4 8015.0 8033.7 8036.9 7882.8 7934.2 7937.5 7942.0 7942.9 38447.0 38597.4 38600.4 38636.0 38692.2 3477.9 3505.9 3513.3 3516.9 3523.6 31358.8 31425.4 31448.2 31464.8 31474.1 5102.3 5122.8 5134.7 5150.2 5151.3 196896.0 197524.0 198055.0 199053.0 199749.0 48971.0 48990.5 49004.8 49075.3 49133.5 52606.5 52619.5 52627.2 52628.2 52671.0 14451.9 16289.8 16509.7 16554.6 16561.3 12039.8 13528.3 13729.1 13735.2 13753.3 14336.3 14382.4 14409.9 14412.0 14528.9 5891.7 5944.1 5969.1 5970.4 6028.8 1005.3 1017.4 1019.3 1020.6 1027.4 22751.7 22970.8 23157.4 23253.5 23261.8 1089.8 1110.1 1118.4 1121.4 1143.3 12226.6 12244.9 12287.0 12423.4 12600.6 237625.0 239150.0 239958.0 241017.0 241108.0 54671.2 54706.0 55017.2 55066.4 55124.7 1448.3 1466.9 1472.2 1482.2 1501.3 23011.4 23152.5 23161.8 23257.0 23260.8 38240.6 38243.0 38255.6 38274.0 38488.6 201635.0 202228.0 202309.0 202309.0 202567.0 33629.3 35505.6 35892.5 36005.0 36067.6 46557.5 47352.3 47386.3 47406.8 47533.3 34569.7 34598.3 34698.8 34748.1 35562.3 33841.8 34585.1 34651.1 34667.8 35110.5 38202.6 38238.0 38604.2 38649.0 38792.2 33440.7 34259.0 34301.7 34359.8 34662.3 24600.4 24617.9 24754.9 25236.1 25277.1 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#2] jquery.html Cycles:180 Average:38250.41 Median:22742.26 stddev:89805.14 (394.9%) stddev-sans-first:90012.49 06:05:21 INFO - PID 12753 | Values: 562.2 577.7 581.3 585.3 588.3 22029.7 22986.8 23771.9 23793.5 23804.9 25673.4 26228.7 26254.7 26257.5 26449.5 6582.5 6705.7 6715.0 6725.5 6736.3 6612.1 6643.0 6783.5 7032.5 7097.1 7105.0 7128.2 7128.4 7129.0 7132.0 7086.2 7095.7 7097.0 7110.0 7114.1 6927.9 6928.3 6929.5 6941.5 6953.0 31331.4 31562.7 33012.0 33093.0 33108.5 1911.7 1940.1 1942.7 1946.9 1950.4 20344.9 20866.0 20926.8 20932.5 20935.8 2562.4 2578.8 2592.2 2688.7 2700.7 150122.0 154219.5 154226.0 154310.2 154414.0 20213.7 22608.3 22876.2 23293.9 23527.3 46586.3 46601.3 46751.3 46776.1 46854.0 11988.8 12013.5 12218.0 12302.6 12318.3 8275.4 10040.2 10062.3 10090.1 10224.9 10034.8 11968.5 12001.5 12018.5 12150.6 4519.3 4558.9 4602.5 4620.4 4625.3 948.5 969.0 983.2 988.4 992.6 19307.7 19749.0 19845.9 19974.3 23971.3 1010.2 1043.5 1050.6 1065.0 1067.4 11077.1 11114.8 11149.3 11188.4 11342.9 522538.0 525755.0 529152.0 541490.0 544475.0 120122.0 122790.0 124365.4 124442.0 124691.3 1217.8 1276.3 1278.7 1279.0 1285.2 21180.7 21271.4 21385.9 21398.0 21573.6 59340.7 60814.7 60833.0 60837.7 62339.4 75793.2 75811.0 75855.6 76175.0 76205.2 12331.8 12752.9 14236.9 14595.9 14900.5 23195.2 23486.9 23520.5 23525.0 23532.6 18465.7 18539.6 18635.7 18869.1 18967.1 16380.9 16576.9 16647.2 17082.3 17152.5 18531.5 18933.9 19023.3 19214.1 19215.8 14468.1 14613.9 14614.9 14625.6 14628.7 18069.4 18073.5 18406.9 18455.3 18464.6 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#3] mootools.html Cycles:180 Average:8910.81 Median:2473.65 stddev:6080.99 (245.8%) stddev-sans-first:6071.40 06:05:21 INFO - PID 12753 | Values: 1333.6 1365.7 1404.5 1407.8 1414.8 14272.0 14887.6 14911.6 14913.9 14927.6 14847.6 15163.1 15166.8 15171.8 15172.6 2703.3 2732.3 2741.7 2742.4 2742.7 2509.7 2617.5 2664.1 2664.5 2665.2 2607.0 2651.8 2652.9 2656.3 2670.3 2577.7 2579.8 2586.8 2596.0 2598.3 2407.6 2419.7 2427.7 2429.6 2437.6 13678.0 14112.8 14114.2 14136.6 14140.8 7783.5 8075.2 8095.8 8096.1 8100.1 5260.3 5285.9 5353.8 5409.6 5463.3 1759.5 1784.2 1787.6 1817.1 1823.7 22300.3 22440.3 22457.6 22504.2 22622.3 7100.4 7143.9 7321.1 7394.1 7405.3 16429.4 16445.5 16489.8 16500.3 16512.9 7669.4 7908.5 7919.0 7923.6 7924.7 5711.9 6468.1 6471.7 7291.0 7300.1 5145.5 5308.7 5334.3 5370.7 5443.2 1530.5 1552.3 1565.6 1567.6 1591.8 849.5 870.3 880.9 888.7 900.1 7283.7 7305.5 8134.3 8512.6 8627.9 930.9 946.5 976.7 977.1 1017.8 4881.2 4962.8 4976.2 5100.4 5155.7 18520.5 19324.1 19442.0 19508.2 19618.6 19583.0 19886.0 20333.3 20347.4 20347.5 10963.4 11028.0 11265.9 11273.4 11390.7 7859.6 7862.3 7930.9 7965.4 7993.0 17254.0 17593.8 17802.6 17879.8 17918.5 18182.4 18320.2 18329.2 18506.4 18666.1 10399.3 10428.7 10474.6 10490.4 10490.9 13050.7 13172.1 13174.1 13179.1 13207.5 11066.2 11156.7 11234.9 11346.8 11496.9 10487.5 10729.8 11703.5 11854.2 11977.3 9148.6 9371.0 9371.0 9381.8 9406.3 7213.2 7288.8 7336.2 7336.2 7360.6 7299.7 7353.9 7367.2 7449.9 7478.5 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#4] prototype.html Cycles:180 Average:5682.07 Median:6289.39 stddev:1523.35 (24.2%) stddev-sans-first:1476.96 06:05:21 INFO - PID 12753 | Values: 491.5 512.1 528.4 531.0 537.5 6286.7 6302.0 6365.9 6398.9 6419.3 6292.1 6311.7 6316.3 6323.8 6328.5 5213.6 5219.2 5233.9 5233.9 5241.9 4879.9 5004.0 5188.2 5227.8 5233.2 4967.0 4983.0 4990.1 4998.3 5007.9 4978.3 4994.8 5008.2 5019.0 5032.3 4479.8 4727.5 4843.3 4857.4 4872.6 6177.8 6178.2 6199.5 6224.7 6229.8 6093.7 6105.6 6112.3 6125.5 6128.6 6740.8 6752.0 6763.6 6782.5 6794.4 5381.1 5391.8 5397.4 5405.5 5415.5 6751.7 6888.6 6893.8 6910.8 7062.8 5506.8 5522.9 5524.4 5555.9 5575.6 5619.4 5649.0 5663.0 5668.8 5695.5 6072.8 6081.1 6084.9 6093.6 6097.7 6755.3 6763.5 6778.8 6787.9 6788.8 1969.7 1983.3 1997.5 1999.3 2005.0 1395.0 1453.2 1456.8 1460.8 1474.3 5816.9 5843.2 5853.4 5865.3 5916.8 6749.3 6758.0 6800.3 6840.9 6849.2 5729.1 5802.5 5834.3 5843.1 5871.4 3553.5 3607.1 3656.3 3659.1 3661.2 6553.4 6613.6 6642.7 6676.6 6737.3 6909.3 6998.9 7028.0 7046.7 7070.7 6531.5 6602.5 6646.6 6656.1 6682.4 6730.4 6784.0 6784.6 6881.1 6895.6 6670.8 6681.6 6742.6 6811.8 6829.4 6543.3 6581.4 6607.4 6632.3 6660.3 5487.8 5505.4 5524.8 5525.4 5565.4 6465.0 6528.2 6572.1 6782.3 6814.5 6473.3 6491.9 6524.9 6524.9 6568.9 6437.7 6469.6 6489.1 6535.5 6596.3 6448.0 6473.6 6476.4 6503.6 6508.2 6684.8 6690.8 6704.0 6712.0 6715.6 6465.2 6481.2 6481.8 6510.2 6520.9 06:05:21 INFO - PID 12753 | 06:05:21 INFO - PID 12753 | [#5] yui.html Cycles:180 Average:24523.45 Median:20465.09 stddev:33096.09 (161.7%) stddev-sans-first:33141.41 06:05:21 INFO - PID 12753 | Values: 901.5 912.1 924.2 927.2 928.2 22228.6 23935.0 23985.4 24000.2 24033.3 21298.5 21993.5 22078.4 22136.6 22284.6 1034.6 1052.4 1060.1 1063.9 1065.0 976.7 1062.8 1069.7 1071.2 1071.7 1118.1 1119.4 1120.1 1120.3 1120.5 1117.3 1119.0 1120.1 1120.7 1121.6 821.2 821.6 823.4 823.4 823.8 19977.0 20066.3 20292.4 20443.6 20591.0 20852.8 21211.3 21646.2 21762.7 21810.5 16108.3 16223.0 16286.0 16439.1 16691.8 3611.9 3634.1 3635.8 3636.5 3636.7 124260.4 125989.4 126507.0 128187.7 128435.0 16393.2 16766.5 17184.2 17261.3 17283.5 25219.9 29517.6 29785.3 30357.0 31927.0 8714.1 8751.6 8996.1 9014.6 9032.0 4172.0 4300.1 4308.7 4310.9 4332.8 5191.7 5262.9 5263.3 5274.7 5281.5 1083.5 1111.4 1130.9 1131.9 1132.0 683.2 690.0 696.7 708.5 710.3 11336.3 11779.8 11861.4 12022.4 12221.3 680.4 684.1 685.4 704.2 716.5 5596.9 5672.3 5673.5 5674.2 5704.3 105428.5 112176.4 116694.8 120995.4 123066.4 97271.5 99991.0 100082.0 100612.0 105620.5 86877.6 86929.6 87599.6 89106.6 90893.5 11716.0 12395.7 12407.0 12501.4 12859.0 38290.0 39751.6 40256.6 40761.4 41043.2 74973.6 75131.0 76068.0 76296.0 76721.0 19846.3 20064.9 20126.5 20240.7 20612.9 20053.9 20486.6 20641.0 20644.2 20934.5 18126.5 18251.5 18316.8 18449.5 18507.2 18052.8 18649.1 18829.5 19135.2 19648.1 18945.9 19116.7 19508.8 19534.8 19822.1 13503.9 14314.8 14453.3 14512.3 14599.3 11753.5 13167.5 13638.8 14053.3 14826.4 06:05:21 INFO - PID 12753 | -------- Summary: end -------- 06:05:21 INFO - PID 12753 | 06:05:22 INFO - TEST-INFO | 12753: exit 0 06:05:22 INFO - TEST-OK | dromaeo_css | took 1111749ms 06:05:22 INFO - TEST-START | kraken 06:05:22 INFO - Initialising browser for kraken test... 06:05:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58689/getInfo.html -profile /tmp/tmpDBTO2X/profile 06:05:22 INFO - TEST-INFO | started process 13155 (/builds/slave/test/build/application/firefox/firefox http://localhost:58689/getInfo.html) 06:05:28 INFO - TEST-INFO | 13155: exit 0 06:05:28 INFO - Browser initialized. 06:05:28 INFO - Running cycle 1/1 for kraken test... 06:05:28 INFO - TEST-INFO | started process 13331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDBTO2X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:29 INFO - PID 13331 | 06:05:29 INFO - PID 13331 | (/builds/slave/test/build/application/firefox/firefox:13380): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:05:29 INFO - PID 13331 | 06:05:30 INFO - PID 13331 | 06:05:30 INFO - PID 13331 | (/builds/slave/test/build/application/firefox/firefox:13435): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:05:30 INFO - PID 13331 | 06:05:30 INFO - PID 13331 | __metrics Screen width/height:1600/1200 06:05:30 INFO - PID 13331 | colorDepth:24 06:05:30 INFO - PID 13331 | Browser inner width/height: 1024/768 06:05:30 INFO - PID 13331 | __metrics 06:05:40 INFO - PID 13331 | RSS: Main: 172093440 06:05:40 INFO - PID 13331 | 06:05:42 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58689/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:43 INFO - PID 13331 | RSS: Main: 175730688 06:05:43 INFO - PID 13331 | 06:05:46 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58689/tests/kraken/driver.html?testName=audio-dft) 06:05:46 INFO - PID 13331 | RSS: Main: 175767552 06:05:46 INFO - PID 13331 | 06:05:49 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58689/tests/kraken/driver.html?testName=audio-fft) 06:05:50 INFO - PID 13331 | RSS: Main: 170217472 06:05:50 INFO - PID 13331 | 06:05:52 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58689/tests/kraken/driver.html?testName=audio-oscillator) 06:05:53 INFO - PID 13331 | RSS: Main: 170864640 06:05:53 INFO - PID 13331 | 06:05:55 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:55 INFO - PID 13331 | RSS: Main: 171560960 06:05:55 INFO - PID 13331 | 06:05:59 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58689/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:59 INFO - PID 13331 | RSS: Main: 172400640 06:05:59 INFO - PID 13331 | 06:06:03 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58689/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:03 INFO - PID 13331 | RSS: Main: 172408832 06:06:03 INFO - PID 13331 | 06:06:06 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58689/tests/kraken/driver.html?testName=json-parse-financial) 06:06:07 INFO - PID 13331 | RSS: Main: 173576192 06:06:07 INFO - PID 13331 | 06:06:08 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:09 INFO - PID 13331 | RSS: Main: 172822528 06:06:09 INFO - PID 13331 | 06:06:11 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:11 INFO - PID 13331 | RSS: Main: 172732416 06:06:11 INFO - PID 13331 | 06:06:14 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:14 INFO - PID 13331 | RSS: Main: 173711360 06:06:14 INFO - PID 13331 | 06:06:17 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:18 INFO - PID 13331 | RSS: Main: 173592576 06:06:18 INFO - PID 13331 | 06:06:20 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:21 INFO - PID 13331 | RSS: Main: 173318144 06:06:21 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | Cycle 1(1): loaded http://localhost:58689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58689/tests/kraken/driver.html?testName=ai-astar) 06:06:23 INFO - PID 13331 | RSS: Main: 175661056 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | __start_tp_report 06:06:23 INFO - PID 13331 | _x_x_mozilla_page_load 06:06:23 INFO - PID 13331 | _x_x_mozilla_page_load_details 06:06:23 INFO - PID 13331 | |i|pagename|runs| 06:06:23 INFO - PID 13331 | |0;ai-astar;98;106;100;107;108;108;110;99;106;109 06:06:23 INFO - PID 13331 | |1;audio-beat-detection;144;130;153;185;121;144;143;117;179;119 06:06:23 INFO - PID 13331 | |2;audio-dft;166;162;165;162;161;162;160;168;167;170 06:06:23 INFO - PID 13331 | |3;audio-fft;76;78;76;171;76;76;74;76;163;77 06:06:23 INFO - PID 13331 | |4;audio-oscillator;79;79;136;79;78;78;126;79;79;131 06:06:23 INFO - PID 13331 | |5;imaging-gaussian-blur;113;116;115;114;114;113;114;114;114;114 06:06:23 INFO - PID 13331 | |6;imaging-darkroom;161;156;150;152;150;151;150;151;151;151 06:06:23 INFO - PID 13331 | |7;imaging-desaturate;95;94;94;95;94;94;94;99;94;94 06:06:23 INFO - PID 13331 | |8;json-parse-financial;54;55;55;56;54;55;55;55;55;55 06:06:23 INFO - PID 13331 | |9;json-stringify-tinderbox;54;54;55;54;54;54;54;54;54;55 06:06:23 INFO - PID 13331 | |10;stanford-crypto-aes;88;78;75;75;75;75;76;77;77;77 06:06:23 INFO - PID 13331 | |11;stanford-crypto-ccm;123;129;120;119;120;130;120;122;123;164 06:06:23 INFO - PID 13331 | |12;stanford-crypto-pbkdf2;173;170;169;174;171;169;175;171;184;176 06:06:23 INFO - PID 13331 | |13;stanford-crypto-sha256-iterative;67;66;67;70;71;69;66;66;65;66 06:06:23 INFO - PID 13331 | __end_tp_report 06:06:23 INFO - PID 13331 | __start_cc_report 06:06:23 INFO - PID 13331 | _x_x_mozilla_cycle_collect,1008 06:06:23 INFO - PID 13331 | __end_cc_report 06:06:23 INFO - PID 13331 | __startTimestamp1503320783637__endTimestamp 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | ------- Summary: start ------- 06:06:23 INFO - PID 13331 | Number of tests: 14 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#0] ai-astar Cycles:10 Average:105.10 Median:108.50 stddev:4.41 (4.1%) stddev-sans-first:3.86 06:06:23 INFO - PID 13331 | Values: 98.0 106.0 100.0 107.0 108.0 108.0 110.0 99.0 106.0 109.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:144.00 stddev:23.72 (16.5%) stddev-sans-first:25.16 06:06:23 INFO - PID 13331 | Values: 144.0 130.0 153.0 185.0 121.0 144.0 143.0 117.0 179.0 119.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.50 stddev:3.37 (2.0%) stddev-sans-first:3.52 06:06:23 INFO - PID 13331 | Values: 166.0 162.0 165.0 162.0 161.0 162.0 160.0 168.0 167.0 170.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.38 (50.5%) stddev-sans-first:40.13 06:06:23 INFO - PID 13331 | Values: 76.0 78.0 76.0 171.0 76.0 76.0 74.0 76.0 163.0 77.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:25.37 (32.1%) stddev-sans-first:26.29 06:06:23 INFO - PID 13331 | Values: 79.0 79.0 136.0 79.0 78.0 78.0 126.0 79.0 79.0 131.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.83 06:06:23 INFO - PID 13331 | Values: 113.0 116.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:151.00 stddev:3.53 (2.3%) stddev-sans-first:1.87 06:06:23 INFO - PID 13331 | Values: 161.0 156.0 150.0 152.0 150.0 151.0 150.0 151.0 151.0 151.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.66 06:06:23 INFO - PID 13331 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 99.0 94.0 94.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 06:06:23 INFO - PID 13331 | Values: 54.0 55.0 55.0 56.0 54.0 55.0 55.0 55.0 55.0 55.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 06:06:23 INFO - PID 13331 | Values: 54.0 54.0 55.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:3.92 (5.1%) stddev-sans-first:1.17 06:06:23 INFO - PID 13331 | Values: 88.0 78.0 75.0 75.0 75.0 75.0 76.0 77.0 77.0 77.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.00 stddev:13.54 (11.0%) stddev-sans-first:14.28 06:06:23 INFO - PID 13331 | Values: 123.0 129.0 120.0 119.0 120.0 130.0 120.0 122.0 123.0 164.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:4.52 (2.6%) stddev-sans-first:4.79 06:06:23 INFO - PID 13331 | Values: 173.0 170.0 169.0 174.0 171.0 169.0 175.0 171.0 184.0 176.0 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.00 (3.0%) stddev-sans-first:2.12 06:06:23 INFO - PID 13331 | Values: 67.0 66.0 67.0 70.0 71.0 69.0 66.0 66.0 65.0 66.0 06:06:23 INFO - PID 13331 | -------- Summary: end -------- 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | 06:06:23 INFO - PID 13331 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 06:06:23 INFO - PID 13331 | 06:06:24 INFO - PID 13331 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:06:24 INFO - TEST-INFO | 13331: exit 0 06:06:24 INFO - TEST-OK | kraken | took 62162ms 06:06:24 INFO - SUITE-END | took 1173s 06:06:24 INFO - Completed test suite (00:19:34) 06:06:24 INFO - javascript benchmark 06:06:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8772.33323211335, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.3882092991876, 3172.7144556989865, 3178.4596618574847, 3196.792208506447, 3216.5657636219116, 6157.630542167473, 6203.131561581376, 6253.9687301563545, 6276.937230627693, 6313.589616674924, 6155.907661385083, 6216.502679785618, 6219.0, 6220.098085777571, 6254.749810007605, 5709.457601527848, 5729.197912292282, 5740.512056475204, 5748.683822389767, 5824.621399609012, 5839.357670656224, 5841.094630332305, 5846.093855452412, 5859.238299021143, 5886.735096920649, 5548.72256387179, 5649.971750141223, 5714.5142662873495, 5826.417358264182, 5831.067029275317, 5695.373508914016, 5701.401352857932, 5745.6552606843725, 5760.711964401763, 5784.334801497797, 5665.405132461115, 5684.8294551163535, 5720.856978575569, 5746.310442746855, 5766.163906233573, 5989.0, 6040.788572399945, 6046.697665116771, 6062.030075187993, 6094.329623741385, 6653.201615806134, 6654.70053847578, 6670.39966403026, 6677.699503522354, 6680.432163266129, 6728.93271067288, 6735.562188457735, 6737.124173857367, 6738.494612904003, 6743.19081710193, 6201.6899155042065, 6206.875862482725, 6224.62652240867, 6282.2147231596055, 6286.371362863677, 6945.791626251221, 7013.26360732126, 7036.085308909809, 7044.084269044992, 7051.048108505389, 6606.174228221473, 6609.702563384659, 6689.1972963244725, 6706.027625994204, 6718.697658605374, 6549.214094308713, 6568.244651865001, 6601.53789234749, 6664.900026499607, 6726.058351830748, 6596.241432235259, 6606.042123892009, 6611.702473388709, 6611.966940165268, 6618.834529136714, 6582.670866456754, 6642.202935647753, 6648.8670226595195, 6718.361755633207, 6751.493637977172, 5356.7857285708915, 5396.676199427969, 5397.622166448389, 5417.756200970965, 5419.403865574784, 4601.976990115028, 4604.654650901196, 4685.4143232095985, 4690.319903613957, 4705.576498115118, 5680.4319568042865, 5778.508826749773, 5797.304323481209, 5847.649141051551, 5850.2102216200265, 6637.834054148589, 6639.701213445406, 6693.698783554752, 6706.094677218611, 6726.596404215763, 5809.4771470567, 5828.038373668297, 5838.854028649318, 5853.034249348895, 5872.207252020922, 5879.235699359056, 5882.294124704978, 5966.940330596725, 5980.461758441674, 5994.730237139339, 6494.967525162344, 6507.381798729113, 6572.539922205496, 6574.967125164344, 6578.243501997236, 6592.340765923369, 6616.503762217757, 6679.6994135265, 6688.498362622726, 6746.932530674827, 6443.226812782496, 6499.3175716549085, 6506.41442270198, 6524.0, 6563.949768037091, 6578.0, 6651.7006734698025, 6665.800025999228, 6667.899981500378, 6682.732690692318, 6757.391834734897, 6761.560498567577, 6819.5908245505425, 6822.727090916506, 6826.965865170642, 6375.203099612549, 6441.67791610427, 6476.4495017924, 6499.0, 6604.042413850061, 6451.935480645134, 6521.836954076186, 6542.280349161493, 6544.607323560602, 6544.770933017321, 6391.392817682313, 6505.186851643544, 6507.869842603216, 6509.73961041572, 6510.7721229756735, 6489.221293444817, 6529.053287273414, 6606.933930660824, 6636.867262654817, 6637.867242655217, 6183.227096612924, 6231.937680623136, 6316.368363163647, 6387.297397286202, 6417.422431981144], "value": 6113.581896232308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.3866545429112, 800.46368932815, 828.8922440082787, 832.6378025558882, 1196.3719047500056, 31731.68268317319, 32191.356172876527, 42678.14643707128, 43291.350629740504, 43447.0, 42959.0, 43258.13483730331, 43269.35095973563, 43357.566424335746, 43383.34924976128, 7812.492188007761, 7909.644066017028, 8014.879776803353, 8039.55782431966, 8070.475419097769, 7894.3289820365335, 7999.560024198696, 8000.919990800105, 8003.1996800320085, 8005.67977280911, 8000.599970001505, 8027.638756255982, 8033.678652853879, 8057.59712014397, 8059.194080591952, 7996.160403157672, 8005.359571234288, 8015.038195416529, 8033.678652853879, 8036.919630803675, 7882.763517094496, 7934.166912474165, 7937.523748575104, 7941.96029019857, 7942.920570794276, 38447.0, 38597.42103868444, 38600.42099368512, 38636.0, 38692.226155477016, 3477.930441391158, 3505.9474107888145, 3513.2797776456023, 3516.859325626972, 3523.612402635708, 31358.843205783825, 31425.371492570248, 31448.213794655087, 31464.842675786702, 31474.05577832669, 5102.336696229503, 5122.76947537358, 5134.717590532519, 5150.175971844525, 5151.2530683050745, 196896.03103969063, 197524.0, 198055.0, 199053.0, 199749.0, 48971.02057958892, 48990.51009489859, 49004.75497622489, 49075.26387104196, 49133.50866491289, 52606.47393526016, 52619.473805261456, 52627.210591841154, 52628.15801446931, 52671.0, 14451.927740361441, 16289.837101628833, 16509.6698066038, 16554.58613534671, 16561.337546498005, 12039.75920481603, 13528.255945922872, 13729.107608005448, 13735.24456154901, 13753.312334383241, 14336.283185840666, 14382.41793402725, 14409.855901440851, 14412.0, 14528.927355363367, 5891.703825158458, 5944.078667806497, 5969.134475501115, 5970.373110823301, 6028.788992385245, 1005.3063386263601, 1017.4099022567042, 1019.3272440189439, 1020.6070662794729, 1027.3733022856052, 22751.658725119138, 22970.770292296864, 23157.421064473187, 23253.488523245935, 23261.7673823263, 1089.7765957978595, 1110.1119104716195, 1118.3792994887915, 1121.3608243301403, 1143.2568830260232, 12226.633201003984, 12244.877551224374, 12286.955608773176, 12423.44094515749, 12600.621981340575, 237625.0, 239150.0, 239958.0, 241017.0, 241108.0, 54671.17993230105, 54706.0, 55017.1747423789, 55066.449335506935, 55124.72437637866, 1448.2830998655522, 1466.9339879705226, 1472.2491529320123, 1482.1699848085107, 1501.2643804535699, 23011.424714382276, 23152.53694926126, 23161.768382316634, 23257.0, 23260.767392326536, 38240.61759382371, 38243.0, 38255.617443825206, 38274.0, 38488.61511384962, 201635.0, 202228.0, 202309.0, 202309.0, 202567.0, 33629.32741345208, 35505.64494355127, 35892.461613076346, 36005.0, 36067.63932360748, 46557.53442465532, 47352.28971565498, 47386.289205661255, 47406.762966186325, 47533.28700069433, 34569.65430345664, 34598.30803383968, 34698.826505867306, 34748.131296716776, 35562.28875422425, 33841.83079084589, 34585.135371615914, 34651.13372165716, 34667.826660866536, 35110.473342899364, 38202.617973819906, 38238.0, 38604.22791544097, 38649.0, 38792.224155517295, 33440.66559334376, 34259.0, 34301.65698343085, 34359.828200858836, 34662.30675386528, 24600.384990375383, 24617.876910615334, 24754.87622561948, 25236.116735914155, 25277.115300965113], "value": 17637.059436906184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.1539582927693, 577.6851615869354, 581.255992329818, 585.2976428286058, 588.294047143428, 22029.66955495669, 22986.770132298672, 23771.881140594316, 23793.5241295174, 23804.88097559512, 25673.35816604586, 26228.737712622868, 26254.737452625468, 26257.47485050298, 26449.47101057978, 6582.506312026605, 6705.698243579026, 6715.026321183425, 6725.529212955071, 6736.2590115087305, 6612.107365505667, 6643.036759669845, 6783.525153239275, 7032.50772445929, 7097.112860892388, 7105.0, 7128.215896251409, 7128.394086502628, 7128.964355178243, 7132.037174981363, 7086.185088714812, 7095.716171353166, 7096.964515177391, 7109.9644501777675, 7114.110736157981, 6927.896081558781, 6928.307169283082, 6929.514933954625, 6941.548799328028, 6953.026576279325, 31331.37337253242, 31562.684373156204, 33012.0, 33093.0, 33108.503372449435, 1911.6559019376507, 1940.078462730206, 1942.7085937109405, 1946.883187008784, 1950.414875537333, 20344.898275508676, 20866.0, 20926.790732092635, 20932.47668808292, 20935.790642093536, 2562.4234547226724, 2578.8323758955607, 2592.196419110082, 2688.7042425333198, 2700.729927007303, 150122.0, 154219.45780542164, 154226.0, 154310.22844885816, 154414.0, 20213.6967945478, 22608.321750347517, 22876.199333023596, 23293.883530582578, 23527.29418117459, 46586.30120548195, 46601.30098048532, 46751.29873051907, 46776.06447871092, 46854.0, 11988.820167697491, 12013.519459221534, 12218.0, 12302.569410070604, 12318.322492262832, 8275.379346549033, 10040.246981476419, 10062.345947513388, 10090.09189172978, 10224.948875255575, 10034.849477257847, 11968.521259149711, 12001.459934302977, 12018.519259229533, 12150.635480935585, 4519.254323036728, 4558.931616025762, 4602.514642093299, 4620.3762492063815, 4625.283081122431, 948.5352177433147, 968.977728496443, 983.1790454970037, 988.4316518002033, 992.6277645882794, 19307.710384344246, 19749.0, 19845.900770496344, 19974.30089946845, 23971.28086157418, 1010.1968934696934, 1043.5147656339839, 1050.6427814543092, 1064.973375665599, 1067.4449286371043, 11077.058450031676, 11114.777704445865, 11149.331040137618, 11188.440577971069, 11342.943285283522, 522538.0, 525755.0, 529152.0, 541490.0, 544475.0, 120122.0, 122790.0, 124365.37817310856, 124442.0, 124691.25926222227, 1217.7686239614445, 1276.3363051213503, 1278.7058976435471, 1278.9936050319875, 1285.1582213650074, 21180.682289765973, 21271.36185914425, 21385.89307053455, 21398.0, 21573.568528629654, 59340.70329648324, 60814.695926520086, 60833.0, 60837.69581152066, 62339.37660623336, 75793.24206758082, 75811.0, 75855.62072189603, 76175.0, 76205.23794761981, 12331.75336493283, 12752.87247127554, 14236.857631423552, 14595.85404145945, 14900.478483253035, 23195.188168414024, 23486.882565587064, 23520.529589407775, 23525.0, 23532.647010294517, 18465.723014155068, 18539.609529285088, 18635.72046419278, 18869.056547172862, 18967.146478408227, 16380.918095409446, 16576.917115414344, 16647.167641618114, 17082.316707331567, 17152.48542543726, 18531.536711582317, 18933.90533047326, 19023.33418330352, 19214.135363908936, 19215.807841921403, 14468.131912085308, 14613.85386146125, 14614.85385146135, 14625.561233163022, 14628.707425851211, 18069.367572134914, 18073.548161296072, 18406.907965460086, 18455.261789528267, 18464.630707386044], "value": 13161.15266242132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.6199183232782, 1365.6858922447836, 1404.5294826233212, 1407.7606806842837, 1414.7524183267926, 14272.0, 14887.553373398789, 14911.627209319773, 14913.850861491395, 14927.552173434788, 14847.55457336279, 15163.090214587133, 15166.848331516709, 15171.848281517181, 15172.620684482867, 2703.297142742891, 2732.3442373830235, 2741.684706258776, 2742.437800250954, 2742.684591272009, 2509.6737424134835, 2617.450335429562, 2664.134156399168, 2664.5337066013467, 2665.1604744505516, 2606.986965065172, 2651.827631203975, 2652.9071482498116, 2656.282803643015, 2670.27902466334, 2577.7164511903675, 2579.8452092874395, 2586.767190952823, 2596.0, 2598.2854714953446, 2407.6388541718707, 2419.685440892673, 2427.672264244322, 2429.5626787178303, 2437.6343548467694, 13678.0, 14112.788308175386, 14114.223717695522, 14136.646583835383, 14140.787888181685, 7783.532988020737, 8075.192480751936, 8095.757127286132, 8096.068952070528, 8100.108988011314, 5260.263563101169, 5285.894282114336, 5353.785848566053, 5409.648372855751, 5463.344398672145, 1759.4897479730862, 1784.2060283173994, 1787.5888545634448, 1817.0551313317133, 1823.6899727046434, 22300.330990070324, 22440.32679019632, 22457.550848983094, 22504.21235256758, 22622.321330360115, 7100.431965442752, 7143.857122857514, 7321.084864391951, 7394.149672787591, 7405.333519983227, 16429.424970125987, 16445.506634800975, 16489.752653710202, 16500.33998640041, 16512.917435412746, 7669.424793140537, 7908.485948413335, 7919.0, 7923.643436045391, 7924.722634707758, 5711.885762284731, 6468.094466774655, 6471.741130354733, 7290.9635451822405, 7300.12398512182, 5145.45972672864, 5308.654937429054, 5334.306540149756, 5370.650907690988, 5443.237946687467, 1530.5102367242375, 1552.2859484636967, 1565.5538171621033, 1567.576754276339, 1591.8089829220567, 849.4733265375506, 870.3428911172025, 880.9163129502687, 888.7289376740156, 900.1268769293774, 7283.745068922668, 7305.525140865827, 8134.3085837703275, 8512.574371281411, 8627.870581941275, 930.851063829784, 946.4983558713893, 976.682578162086, 977.1385510602314, 1017.7811770469384, 4881.243407271879, 4962.801487940515, 4976.154053810861, 5100.362454693163, 5155.74221288934, 18520.536986575175, 19324.1304141314, 19442.027898605014, 19508.21967121299, 19618.60762784765, 19583.0, 19886.0, 20333.288334908208, 20347.389578312675, 20347.491312717004, 10963.355496675404, 11028.0, 11265.943670281596, 11273.379964101889, 11390.715232119097, 7859.646315915912, 7862.2923936845955, 7930.920690793018, 7965.442419030613, 7992.960915081002, 17254.0, 17593.82406175922, 17802.5549361267, 17879.821201788334, 17918.462446126636, 18182.36361727333, 18320.175592098654, 18329.175187116878, 18506.352277670754, 18666.066696664842, 10399.32404393712, 10428.739281518023, 10474.633387831389, 10490.370577765358, 10490.947545262225, 13050.673733156747, 13172.07795454309, 13174.07781455289, 13179.077464577771, 13207.537736179187, 11066.170037247077, 11156.721081973015, 11234.887651123385, 11346.773064538827, 11496.94251528737, 10487.52806123711, 10729.839052414063, 11703.531858725555, 11854.170208085696, 11977.341246231541, 9148.63405463774, 9371.0, 9371.0, 9381.812363752822, 9406.341556091282, 7213.20654727969, 7288.817779555554, 7336.156342020736, 7336.229695881855, 7360.631968401452, 7299.708011679686, 7353.852922941618, 7367.189609142883, 7449.888251676338, 7478.513896596922], "value": 6472.49343013267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.51819719173506, 512.0987062769526, 528.4213785904439, 531.0494215354515, 537.4517991648519, 6286.654234017127, 6301.968490157548, 6365.936340636592, 6398.936010639893, 6419.293877673452, 6292.119103325526, 6311.747530098802, 6316.336784637616, 6323.810285691437, 6328.525360597962, 5213.58291336694, 5219.217117432387, 5233.86915327118, 5233.947660523384, 5241.9213711794355, 4879.902401951958, 5003.974980125095, 5188.16989281715, 5227.79088836446, 5233.188855727369, 4966.9751651241695, 4983.028309479653, 4990.126727822635, 4998.325226094467, 5007.949920500803, 4978.278149668296, 4994.800207991676, 5008.24876268559, 5019.038767127376, 5032.32063671407, 4479.843205487825, 4727.5272472752795, 4843.29772183035, 4857.3812509680165, 4872.585830204437, 6177.845553861144, 6178.227721534809, 6199.504039676815, 6224.688765561749, 6229.781957631461, 6093.695315234265, 6105.572609917308, 6112.327643959161, 6125.540584456139, 6128.57100003, 6740.7866584014855, 6752.020956961213, 6763.5941843489545, 6782.5252232343755, 6794.388505034522, 5381.0852155133725, 5391.757370918318, 5397.379301380352, 5405.5135037846385, 5415.512603865632, 6751.729930802762, 6888.621125838077, 6893.827654308632, 6910.792676219721, 7062.788116356517, 5506.807261745819, 5522.917156242579, 5524.4199359067525, 5555.916661250085, 5575.553955683617, 5619.353774316006, 5649.0, 5663.0, 5668.829935101871, 5695.45893140151, 6072.817815465543, 6081.118237855486, 6084.939150608438, 6093.603915745551, 6097.725602347905, 6755.2906944771075, 6763.492738044666, 6778.847595908609, 6787.9272436537685, 6788.796336109925, 1969.6507892093962, 1983.2959299448776, 1997.4806550296737, 1999.2802591067205, 2004.9699254511195, 1395.0, 1453.2443129572564, 1456.8470310617445, 1460.7662773956115, 1474.2555009720022, 5816.941830581724, 5843.217818565378, 5853.443922827325, 5865.3254875689845, 5916.822495325147, 6749.291324410964, 6757.966210168917, 6800.251972283045, 6840.931590684129, 6849.1780986281965, 5729.140628905698, 5802.506786923159, 5834.299884013945, 5843.123531470228, 5871.442212989759, 3553.502509648651, 3607.134287770916, 3656.2504686539196, 3659.121810765397, 3661.2494438640015, 6553.4101930826455, 6613.6362500062, 6642.701078451481, 6676.6327851967635, 6737.258901520829, 6909.30906909305, 6998.860022799516, 7028.0, 7046.718131274692, 7070.717171313193, 6531.452733433965, 6602.471802255712, 6646.60120392778, 6656.134702488645, 6682.365175308338, 6730.360615741497, 6784.0, 6784.5929244243525, 6881.144325105225, 6895.551934093696, 6670.7665231716655, 6681.632510211985, 6742.6291553965, 6811.795646130624, 6829.419499342612, 6543.312952139957, 6581.387560047819, 6607.438367738604, 6632.336766323522, 6660.333966603494, 5487.835364939058, 5505.366882808528, 5524.8342549723575, 5525.419830917695, 5565.443455654402, 6465.0, 6528.183977002875, 6572.09409271306, 6782.253952065367, 6814.488913331421, 6473.320301368289, 6491.870162596816, 6524.902126468011, 6524.934750652433, 6568.930786802142, 6437.742490300336, 6469.5794773339585, 6489.091527186103, 6535.5425120241125, 6596.340365963365, 6447.967760161169, 6473.643949582818, 6476.417122459001, 6503.6422996733745, 6508.186476690414, 6684.799456016132, 6690.799276021728, 6703.966480167763, 6711.966440167768, 6715.597064176165, 6465.22417309907, 6481.189851268591, 6481.837954051187, 6510.18622672166, 6520.869582608227], "value": 5244.9843323621335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.5492253873067, 912.0696889173043, 924.1682485762817, 927.2211342472326, 928.2295694573505, 22228.555428891414, 23935.0, 23985.400364990885, 24000.15999440018, 24033.279001629937, 21298.46753831155, 21993.450163745914, 22078.448038798997, 22136.557268854613, 22284.554308913812, 1034.6327053895852, 1052.41590917041, 1060.1042119409087, 1063.8989296016905, 1064.9574017039308, 976.677696360203, 1062.8352605346145, 1069.6897899609105, 1071.1591400750413, 1071.6892101290655, 1118.1278602689915, 1119.3731510354228, 1120.1318977792234, 1120.2942146447726, 1120.4733775125678, 1117.2961034548223, 1119.0, 1120.1318977792196, 1120.6581992492286, 1121.551379448219, 821.2444551013082, 821.5645707774889, 823.3701218567801, 823.4236034775681, 823.7611092783086, 19977.0, 20066.29767958129, 20292.391228263026, 20443.5911281775, 20591.0, 20852.791472085235, 21211.257605983872, 21646.242381516728, 21762.673559896615, 21810.454738631663, 16108.275127619168, 16223.018004575702, 16286.0, 16439.09584972826, 16691.83308166915, 3611.9097022574647, 3634.1459756957356, 3635.7818530887967, 3636.454531820248, 3636.690881275095, 124260.37869810684, 125989.37005314915, 126507.0, 128187.7181228185, 128435.0, 16393.180340982904, 16766.497005089866, 17184.226709798088, 17261.309547617955, 17283.481495555152, 25219.87390063038, 29517.557236641038, 29785.25536861596, 30357.0, 31927.0, 8714.128587141235, 8751.56242187888, 8996.100389960951, 9014.59434325457, 9032.0, 4171.958280417218, 4300.118475712471, 4308.655307575386, 4310.89222769427, 4332.826686932551, 5191.6884986900905, 5262.868428289246, 5263.289455923478, 5274.736263186825, 5281.471852814765, 1083.4907593431076, 1111.4165063341811, 1130.8699499557492, 1131.9094472442184, 1132.049078773834, 683.1665368250726, 689.9517033807685, 696.6864910790064, 708.5217478202193, 710.2897102897103, 11336.326982212537, 11779.823302650468, 11861.406929653484, 12022.398880055962, 12221.327826969602, 680.4012469027224, 684.1345697692423, 685.372883811307, 704.1620471638734, 716.45907339958, 5596.944030559643, 5672.319321681424, 5673.461021202979, 5674.177244299553, 5704.258446401941, 105428.47285763675, 112176.43911780552, 116694.81616214103, 120995.39502302432, 123066.38466807609, 97271.51364243275, 99991.0, 100082.0, 100611.99999999853, 105620.47189764002, 86877.56561217153, 86929.56535217284, 87599.56200219085, 89106.55446722725, 90893.54553227192, 11716.0, 12395.72464817218, 12407.0, 12501.374931253218, 12858.971282297207, 38290.0, 39751.60248397479, 40256.59743402529, 40761.38857917193, 41043.179136417704, 74973.625131874, 75131.0, 76068.0, 76296.0, 76721.0, 19846.305379311656, 20064.89967550153, 20126.496837579176, 20240.696389553876, 20612.896935515226, 20053.899730501253, 20486.59026819485, 20641.0, 20644.17423303111, 20934.47663808417, 18126.54683632867, 18251.54371140732, 18316.81683183151, 18449.53876153107, 18507.16717747678, 18052.819471805113, 18649.067546622344, 18829.529261768566, 19135.23459061622, 19648.115834787754, 18945.90527047356, 19116.71324930155, 19508.804911950698, 19534.804651953298, 19822.108005140093, 13503.932480337535, 14314.785278220626, 14453.277336132942, 14512.274386280433, 14599.270036497921, 11753.47109380097, 13167.47330106785, 13638.795418068936, 14053.297335132998, 14826.40694372213], "value": 9458.704253420205, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 100.0, 107.0, 108.0, 108.0, 110.0, 99.0, 106.0, 109.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 153.0, 185.0, 121.0, 144.0, 143.0, 117.0, 179.0, 119.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 165.0, 162.0, 161.0, 162.0, 160.0, 168.0, 167.0, 170.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 171.0, 76.0, 76.0, 74.0, 76.0, 163.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 79.0, 78.0, 78.0, 126.0, 79.0, 79.0, 131.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 150.0, 152.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 99.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 56.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 75.0, 75.0, 75.0, 75.0, 76.0, 77.0, 77.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 120.0, 119.0, 120.0, 130.0, 120.0, 122.0, 123.0, 164.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 169.0, 174.0, 171.0, 169.0, 175.0, 171.0, 184.0, 176.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 70.0, 71.0, 69.0, 66.0, 66.0, 65.0, 66.0], "value": 67.3, "unit": "score"}]}]} 06:06:24 INFO - Return code: 0 06:06:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:24 INFO - # TBPL SUCCESS # 06:06:24 INFO - Running post-action listener: _package_coverage_data 06:06:24 INFO - Running post-action listener: _resource_record_post_action 06:06:24 INFO - [mozharness: 2017-08-21 13:06:24.901650Z] Finished run-tests step (success) 06:06:24 INFO - Running post-run listener: _resource_record_post_run 06:06:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433426432; Read time: 12; Write time: 285940 06:06:24 INFO - TinderboxPrint: CPU usage
13.1% 06:06:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:06:24 INFO - TinderboxPrint: I/O write bytes / time
433,426,432 / 285,940 06:06:24 INFO - TinderboxPrint: CPU idle
8,261.4 (86.9%) 06:06:24 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 06:06:24 INFO - TinderboxPrint: Swap in / out
0 / 0 06:06:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107552768; Read time: 0; Write time: 88460 06:06:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:06:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325873664; Read time: 0; Write time: 197480 06:06:25 INFO - Running post-run listener: _upload_blobber_files 06:06:25 INFO - Blob upload gear active. 06:06:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:25 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 06:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:26 INFO - (blobuploader) - INFO - Done attempting. 06:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:27 INFO - (blobuploader) - INFO - Done attempting. 06:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:34 INFO - (blobuploader) - INFO - Done attempting. 06:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:34 INFO - (blobuploader) - INFO - Done attempting. 06:06:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:34 INFO - Return code: 0 06:06:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8b3c04961dc401ba9cf1ea58d30d7ec038bd52e55e3cf9e78c0e98d0e82be8befd71759c560b945b809748e84e1aad7ecabe087555daae0d7e2419ca4e20693", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82dcfb2cf993256de5c266f7bc17415378045aea5702ccc95b30eb1feb063123791e528057a43ddadb9bdb2cb7b30a2c7b79b4f3e4e93751c23e5cbb81a420dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2dbc52a3dc2425e5c9a6cb0a36ec038da26479817a83afeffb9adab4305d5349516f7774098f29e7e4486553d55465085b08ac37ce91dfb6e6928f4497f4c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e803f73933e925620b5757819eb76d2ebaa103153733981e2fea62eb797d10b7527f91af2f4ef760c03b1b514c332293aa590446f5522c32a52a0adb459a7140"} 06:06:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:34 INFO - Contents: 06:06:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8b3c04961dc401ba9cf1ea58d30d7ec038bd52e55e3cf9e78c0e98d0e82be8befd71759c560b945b809748e84e1aad7ecabe087555daae0d7e2419ca4e20693", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82dcfb2cf993256de5c266f7bc17415378045aea5702ccc95b30eb1feb063123791e528057a43ddadb9bdb2cb7b30a2c7b79b4f3e4e93751c23e5cbb81a420dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2dbc52a3dc2425e5c9a6cb0a36ec038da26479817a83afeffb9adab4305d5349516f7774098f29e7e4486553d55465085b08ac37ce91dfb6e6928f4497f4c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e803f73933e925620b5757819eb76d2ebaa103153733981e2fea62eb797d10b7527f91af2f4ef760c03b1b514c332293aa590446f5522c32a52a0adb459a7140"} 06:06:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:34 INFO - Copying logs to upload dir... 06:06:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.257922 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-21 06:06:34.922851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 06:06:34.925951) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8b3c04961dc401ba9cf1ea58d30d7ec038bd52e55e3cf9e78c0e98d0e82be8befd71759c560b945b809748e84e1aad7ecabe087555daae0d7e2419ca4e20693", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82dcfb2cf993256de5c266f7bc17415378045aea5702ccc95b30eb1feb063123791e528057a43ddadb9bdb2cb7b30a2c7b79b4f3e4e93751c23e5cbb81a420dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2dbc52a3dc2425e5c9a6cb0a36ec038da26479817a83afeffb9adab4305d5349516f7774098f29e7e4486553d55465085b08ac37ce91dfb6e6928f4497f4c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e803f73933e925620b5757819eb76d2ebaa103153733981e2fea62eb797d10b7527f91af2f4ef760c03b1b514c332293aa590446f5522c32a52a0adb459a7140"} build_url:https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/G7SN3CghTUOgq49ARGJ-8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8b3c04961dc401ba9cf1ea58d30d7ec038bd52e55e3cf9e78c0e98d0e82be8befd71759c560b945b809748e84e1aad7ecabe087555daae0d7e2419ca4e20693", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82dcfb2cf993256de5c266f7bc17415378045aea5702ccc95b30eb1feb063123791e528057a43ddadb9bdb2cb7b30a2c7b79b4f3e4e93751c23e5cbb81a420dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2dbc52a3dc2425e5c9a6cb0a36ec038da26479817a83afeffb9adab4305d5349516f7774098f29e7e4486553d55465085b08ac37ce91dfb6e6928f4497f4c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e803f73933e925620b5757819eb76d2ebaa103153733981e2fea62eb797d10b7527f91af2f4ef760c03b1b514c332293aa590446f5522c32a52a0adb459a7140"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 06:06:34.952239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 06:06:34.952556) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503319539.188847-226219323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 06:06:35.037333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 06:06:35.037739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 06:06:35.038011) ========= ========= Total master_lag: 0.15 =========