builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-081 starttime: 1506222870.3 results: success (0) revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.300764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.301550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.301903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.398995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.399564) ========= 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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 20:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-09-23 20:14:30 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177840 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.607266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.608021) ========= 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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084104 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.729477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:30.729960) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff40c5dcaa41261b39a4e9795e02a9d51dd30ced --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 ff40c5dcaa41261b39a4e9795e02a9d51dd30ced --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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 20:14:30,794 truncating revision to first 12 chars 2017-09-23 20:14:30,794 Setting DEBUG logging. 2017-09-23 20:14:30,794 attempt 1/10 2017-09-23 20:14:30,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff40c5dcaa41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 20:14:31,148 unpacking tar archive at: mozilla-central-ff40c5dcaa41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630661 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.380473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.380813) ========= script_repo_revision: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.381245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.381551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:14:31.395203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-23 20:14:31.395529) ========= /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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:31 INFO - MultiFileLogger online at 20170923 20:14:31 in /builds/slave/test 20:14:31 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 20:14:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:31 INFO - {'append_to_log': False, 20:14:31 INFO - 'base_work_dir': '/builds/slave/test', 20:14:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:31 INFO - 'branch': 'Firefox-Non-PGO', 20:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:31 INFO - 'code_coverage': False, 20:14:31 INFO - 'config_files': ('talos/linux_config.py',), 20:14:31 INFO - 'default_actions': ('clobber', 20:14:31 INFO - 'read-buildbot-config', 20:14:31 INFO - 'download-and-extract', 20:14:31 INFO - 'populate-webroot', 20:14:31 INFO - 'create-virtualenv', 20:14:31 INFO - 'install', 20:14:31 INFO - 'setup-mitmproxy', 20:14:31 INFO - 'run-tests'), 20:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:31 INFO - 'disable_ccov_upload': False, 20:14:31 INFO - 'disable_stylo': False, 20:14:31 INFO - 'download_minidump_stackwalk': True, 20:14:31 INFO - 'download_symbols': 'ondemand', 20:14:31 INFO - 'enable_stylo': False, 20:14:31 INFO - 'enable_webrender': False, 20:14:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:31 INFO - 'gecko_profile': False, 20:14:31 INFO - 'gecko_profile_interval': 0, 20:14:31 INFO - 'installer_path': 'installer.exe', 20:14:31 INFO - 'log_level': 'info', 20:14:31 INFO - 'log_name': 'talos', 20:14:31 INFO - 'log_to_console': True, 20:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:31 INFO - 'opt_config_files': (), 20:14:31 INFO - 'pip_index': False, 20:14:31 INFO - 'suite': 'dromaeojs-e10s', 20:14:31 INFO - 'system_bits': '32', 20:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:31 INFO - 'title': 'talos-linux64-ix-081', 20:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:31 INFO - 'use_talos_json': True, 20:14:31 INFO - 'verify': 'False', 20:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:31 INFO - 'work_dir': 'build'} 20:14:31 INFO - [mozharness: 2017-09-24 03:14:31.698369Z] Running clobber step. 20:14:31 INFO - Running pre-action listener: _resource_record_pre_action 20:14:31 INFO - Running main action method: clobber 20:14:31 INFO - rmtree: /builds/slave/test/build 20:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:33 INFO - Running post-action listener: _resource_record_post_action 20:14:33 INFO - [mozharness: 2017-09-24 03:14:33.478662Z] Finished clobber step (success) 20:14:33 INFO - [mozharness: 2017-09-24 03:14:33.478812Z] Running read-buildbot-config step. 20:14:33 INFO - Running pre-action listener: _resource_record_pre_action 20:14:33 INFO - Running main action method: read_buildbot_config 20:14:33 INFO - Using buildbot properties: 20:14:33 INFO - { 20:14:33 INFO - "project": "", 20:14:33 INFO - "product": "firefox", 20:14:33 INFO - "who": "philringnalda@gmail.com", 20:14:33 INFO - "installer_path": "public/build/target.tar.bz2", 20:14:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:14:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:14:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 20:14:33 INFO - "stage_platform": "linux64", 20:14:33 INFO - "basedir": "/builds/slave/test", 20:14:33 INFO - "buildnumber": 1173, 20:14:33 INFO - "platform": "ubuntu64_hw", 20:14:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:14:33 INFO - "slavebuilddir": "test", 20:14:33 INFO - "taskId": "GXQUClZnTSa72C_bcS837A", 20:14:33 INFO - "branch": "mozilla-central", 20:14:33 INFO - "script_repo_revision": "production", 20:14:33 INFO - "revision": "ff40c5dcaa41261b39a4e9795e02a9d51dd30ced", 20:14:33 INFO - "slavename": "talos-linux64-ix-081", 20:14:33 INFO - "repo_path": "mozilla-central" 20:14:33 INFO - } 20:14:33 INFO - Finding installer, test and symbols from parent task. 20:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXQUClZnTSa72C_bcS837A'}, attempt #1 20:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXQUClZnTSa72C_bcS837A'}, attempt #1 20:14:34 INFO - Task dependencies: ShKXziekTvWG-QSzPkbAOw 20:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw'}, attempt #1 20:14:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:14:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip 20:14:34 INFO - Running post-action listener: _resource_record_post_action 20:14:34 INFO - [mozharness: 2017-09-24 03:14:34.837932Z] Finished read-buildbot-config step (success) 20:14:34 INFO - [mozharness: 2017-09-24 03:14:34.838154Z] Running download-and-extract step. 20:14:34 INFO - Running pre-action listener: _resource_record_pre_action 20:14:34 INFO - Running main action method: download_and_extract 20:14:34 INFO - mkdir: /builds/slave/test/build/tests 20:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:34 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json 20:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:14:35 INFO - Downloaded 989 bytes. 20:14:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:14:35 INFO - Using the following test package requirements: 20:14:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:14:35 INFO - u'common': [u'target.common.tests.zip'], 20:14:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:14:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:14:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:14:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:14:35 INFO - u'mozbase': [u'target.common.tests.zip'], 20:14:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:14:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:14:35 INFO - u'web-platform': [u'target.common.tests.zip', 20:14:35 INFO - u'target.web-platform.tests.tar.gz'], 20:14:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:14:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:14:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip 20:14:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:14:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.common.tests.zip into memory 20:14:37 INFO - Content-Length response header: 54943875 20:14:37 INFO - Bytes received: 54943875 20:14:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip 20:14:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:14:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.talos.tests.zip into memory 20:14:49 INFO - Content-Length response header: 14513823 20:14:49 INFO - Bytes received: 14513823 20:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:49 INFO - trying https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:14:52 INFO - Downloaded 61526248 bytes. 20:14:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:52 INFO - mkdir: /builds/slave/test/properties 20:14:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:52 INFO - Contents: 20:14:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 20:14:52 INFO - Running post-action listener: _resource_record_post_action 20:14:52 INFO - Running post-action listener: find_tests_for_verification 20:14:52 INFO - Running post-action listener: set_extra_try_arguments 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.062853Z] Finished download-and-extract step (success) 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.062953Z] Running populate-webroot step. 20:14:52 INFO - Running pre-action listener: _resource_record_pre_action 20:14:52 INFO - Running main action method: populate_webroot 20:14:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tresize', 20:14:52 INFO - 'tcanvasmark']}, 20:14:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['dromaeo_css', 20:14:52 INFO - 'kraken']}, 20:14:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['damp', 'tps']}, 20:14:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['damp', 'tps']}, 20:14:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['dromaeo_dom']}, 20:14:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:14:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['basic_compositor_video', 20:14:52 INFO - 'glvideo']}, 20:14:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:14:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['ts_paint_webext', 20:14:52 INFO - 'tp5o_webext']}, 20:14:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:52 INFO - 'ts_paint', 20:14:52 INFO - 'tpaint', 20:14:52 INFO - 'sessionrestore', 20:14:52 INFO - 'sessionrestore_many_windows', 20:14:52 INFO - 'sessionrestore_no_auto_restore', 20:14:52 INFO - 'tabpaint']}, 20:14:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['a11yr', 20:14:52 INFO - 'ts_paint', 20:14:52 INFO - 'tpaint', 20:14:52 INFO - 'sessionrestore', 20:14:52 INFO - 'sessionrestore_many_windows', 20:14:52 INFO - 'sessionrestore_no_auto_restore', 20:14:52 INFO - 'tabpaint']}, 20:14:52 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 20:14:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:14:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['perf_reftest_singletons']}, 20:14:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['perf_reftest']}, 20:14:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:52 INFO - 'tsvgr_opacity', 20:14:52 INFO - 'tart', 20:14:52 INFO - 'tscrollx', 20:14:52 INFO - 'tsvg_static']}, 20:14:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tsvgx', 20:14:52 INFO - 'tsvgr_opacity', 20:14:52 INFO - 'tart', 20:14:52 INFO - 'tscrollx', 20:14:52 INFO - 'tsvg_static']}, 20:14:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:14:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo'], 20:14:52 INFO - 'tests': ['tp5o']}, 20:14:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--disable-stylo', 20:14:52 INFO - '--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:14:52 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:14:52 INFO - 'talos_options': ['--stylo-threads=1', 20:14:52 INFO - '--mitmproxy', 20:14:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:14:52 INFO - '--firstNonBlankPaint'], 20:14:52 INFO - 'tests': ['tp6_google', 20:14:52 INFO - 'tp6_youtube', 20:14:52 INFO - 'tp6_amazon', 20:14:52 INFO - 'tp6_facebook']}, 20:14:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--xperf_path', 20:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:52 INFO - 'tests': ['tp5n']}, 20:14:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:14:52 INFO - 'talos_options': ['--disable-stylo', 20:14:52 INFO - '--xperf_path', 20:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:52 INFO - 'tests': ['tp5n']}}} 20:14:52 INFO - Running post-action listener: _resource_record_post_action 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.078389Z] Finished populate-webroot step (success) 20:14:52 INFO - [mozharness: 2017-09-24 03:14:52.078478Z] Running create-virtualenv step. 20:14:52 INFO - Running pre-action listener: _resource_record_pre_action 20:14:52 INFO - Running main action method: create_virtualenv 20:14:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:14:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:14:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:14:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:53 INFO - Installing pip...............done. 20:14:53 INFO - Return code: 0 20:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:14:53 INFO - Reading from file tmpfile_stdout 20:14:53 INFO - Output received: 20:14:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 20:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:53 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')]} 20:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:53 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')]} 20:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:53 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:14:53 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 20:14:53 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 20:14:53 INFO - Using env: {'DISPLAY': ':0', 20:14:53 INFO - 'HOME': '/home/cltbld', 20:14:53 INFO - 'LANG': 'en_US.UTF-8', 20:14:53 INFO - 'LANGUAGE': 'en_US:en', 20:14:53 INFO - 'LOGNAME': 'cltbld', 20:14:53 INFO - 'MAIL': '/var/mail/cltbld', 20:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:53 INFO - 'MOZ_NO_REMOTE': '1', 20:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:53 INFO - 'NO_EM_RESTART': '1', 20:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:53 INFO - 'PWD': '/builds/slave/test', 20:14:53 INFO - 'SHELL': '/bin/bash', 20:14:53 INFO - 'SHLVL': '1', 20:14:53 INFO - 'TERM': 'linux', 20:14:53 INFO - 'TMOUT': '86400', 20:14:53 INFO - 'USER': 'cltbld', 20:14:53 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:53 INFO - '_': '/tools/buildbot/bin/python'} 20:14:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:14:54 INFO - Downloading/unpacking pip>=1.5 20:14:54 INFO - Running setup.py egg_info for package pip 20:14:54 INFO - warning: no files found matching 'pip/cacert.pem' 20:14:54 INFO - warning: no files found matching '*.html' under directory 'docs' 20:14:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:14:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:14:54 INFO - Installing collected packages: pip 20:14:54 INFO - Found existing installation: pip 1.1 20:14:54 INFO - Uninstalling pip: 20:14:54 INFO - Successfully uninstalled pip 20:14:54 INFO - Running setup.py install for pip 20:14:54 INFO - warning: no files found matching 'pip/cacert.pem' 20:14:54 INFO - warning: no files found matching '*.html' under directory 'docs' 20:14:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:14:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:14:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:14:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:14:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:14:54 INFO - Successfully installed pip 20:14:54 INFO - Cleaning up... 20:14:54 INFO - Return code: 0 20:14:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:14:54 INFO - Using env: {'DISPLAY': ':0', 20:14:54 INFO - 'HOME': '/home/cltbld', 20:14:54 INFO - 'LANG': 'en_US.UTF-8', 20:14:54 INFO - 'LANGUAGE': 'en_US:en', 20:14:54 INFO - 'LOGNAME': 'cltbld', 20:14:54 INFO - 'MAIL': '/var/mail/cltbld', 20:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:54 INFO - 'MOZ_NO_REMOTE': '1', 20:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:54 INFO - 'NO_EM_RESTART': '1', 20:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:54 INFO - 'PWD': '/builds/slave/test', 20:14:54 INFO - 'SHELL': '/bin/bash', 20:14:54 INFO - 'SHLVL': '1', 20:14:54 INFO - 'TERM': 'linux', 20:14:54 INFO - 'TMOUT': '86400', 20:14:54 INFO - 'USER': 'cltbld', 20:14:54 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:54 INFO - '_': '/tools/buildbot/bin/python'} 20:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:54 INFO - Downloading/unpacking psutil>=3.1.1 20:14:54 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 20:14:54 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 20:14:54 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 20:14:54 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 20:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:56 INFO - Installing collected packages: psutil 20:14:56 INFO - Running setup.py install for psutil 20:14:56 INFO - building 'psutil._psutil_linux' extension 20:14:56 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 20:14:57 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 20:14:57 INFO - building 'psutil._psutil_posix' extension 20:14:57 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 20:14:57 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 20:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:57 INFO - Successfully installed psutil 20:14:57 INFO - Cleaning up... 20:14:57 INFO - Return code: 0 20:14:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:57 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')]} 20:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:57 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')]} 20:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:57 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:14:57 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 20:14:57 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 20:14:57 INFO - Using env: {'DISPLAY': ':0', 20:14:57 INFO - 'HOME': '/home/cltbld', 20:14:57 INFO - 'LANG': 'en_US.UTF-8', 20:14:57 INFO - 'LANGUAGE': 'en_US:en', 20:14:57 INFO - 'LOGNAME': 'cltbld', 20:14:57 INFO - 'MAIL': '/var/mail/cltbld', 20:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:57 INFO - 'MOZ_NO_REMOTE': '1', 20:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:57 INFO - 'NO_EM_RESTART': '1', 20:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:57 INFO - 'PWD': '/builds/slave/test', 20:14:57 INFO - 'SHELL': '/bin/bash', 20:14:57 INFO - 'SHLVL': '1', 20:14:57 INFO - 'TERM': 'linux', 20:14:57 INFO - 'TMOUT': '86400', 20:14:57 INFO - 'USER': 'cltbld', 20:14:57 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:57 INFO - '_': '/tools/buildbot/bin/python'} 20:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:57 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 20:14:57 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 20:14:57 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 20:14:57 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 20:14:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:58 INFO - Installing collected packages: mozsystemmonitor 20:14:58 INFO - Running setup.py install for mozsystemmonitor 20:14:59 INFO - Successfully installed mozsystemmonitor 20:14:59 INFO - Cleaning up... 20:14:59 INFO - Return code: 0 20:14:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:59 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')]} 20:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:59 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')]} 20:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:59 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:14:59 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 20:14:59 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 20:14:59 INFO - Using env: {'DISPLAY': ':0', 20:14:59 INFO - 'HOME': '/home/cltbld', 20:14:59 INFO - 'LANG': 'en_US.UTF-8', 20:14:59 INFO - 'LANGUAGE': 'en_US:en', 20:14:59 INFO - 'LOGNAME': 'cltbld', 20:14:59 INFO - 'MAIL': '/var/mail/cltbld', 20:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:59 INFO - 'MOZ_NO_REMOTE': '1', 20:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:59 INFO - 'NO_EM_RESTART': '1', 20:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:59 INFO - 'PWD': '/builds/slave/test', 20:14:59 INFO - 'SHELL': '/bin/bash', 20:14:59 INFO - 'SHLVL': '1', 20:14:59 INFO - 'TERM': 'linux', 20:14:59 INFO - 'TMOUT': '86400', 20:14:59 INFO - 'USER': 'cltbld', 20:14:59 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:59 INFO - '_': '/tools/buildbot/bin/python'} 20:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:59 INFO - Downloading/unpacking jsonschema==2.5.1 20:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:00 INFO - warning: no files found matching '*.txt' 20:15:00 INFO - no previously-included directories found matching 'build' 20:15:00 INFO - no previously-included directories found matching 'dist' 20:15:00 INFO - no previously-included directories found matching '.git*' 20:15:00 INFO - Installing collected packages: jsonschema, functools32 20:15:00 INFO - Running setup.py install for functools32 20:15:00 INFO - warning: no files found matching '*.txt' 20:15:00 INFO - no previously-included directories found matching 'build' 20:15:00 INFO - no previously-included directories found matching 'dist' 20:15:00 INFO - no previously-included directories found matching '.git*' 20:15:00 INFO - Successfully installed jsonschema functools32 20:15:00 INFO - Cleaning up... 20:15:00 INFO - Return code: 0 20:15:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:15:00 INFO - Using env: {'DISPLAY': ':0', 20:15:00 INFO - 'HOME': '/home/cltbld', 20:15:00 INFO - 'LANG': 'en_US.UTF-8', 20:15:00 INFO - 'LANGUAGE': 'en_US:en', 20:15:00 INFO - 'LOGNAME': 'cltbld', 20:15:00 INFO - 'MAIL': '/var/mail/cltbld', 20:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:00 INFO - 'MOZ_NO_REMOTE': '1', 20:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:00 INFO - 'NO_EM_RESTART': '1', 20:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:00 INFO - 'PWD': '/builds/slave/test', 20:15:00 INFO - 'SHELL': '/bin/bash', 20:15:00 INFO - 'SHLVL': '1', 20:15:00 INFO - 'TERM': 'linux', 20:15:00 INFO - 'TMOUT': '86400', 20:15:00 INFO - 'USER': 'cltbld', 20:15:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:00 INFO - '_': '/tools/buildbot/bin/python'} 20:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:00 INFO - Cleaning up... 20:15:00 INFO - Return code: 0 20:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:15:01 INFO - Using env: {'DISPLAY': ':0', 20:15:01 INFO - 'HOME': '/home/cltbld', 20:15:01 INFO - 'LANG': 'en_US.UTF-8', 20:15:01 INFO - 'LANGUAGE': 'en_US:en', 20:15:01 INFO - 'LOGNAME': 'cltbld', 20:15:01 INFO - 'MAIL': '/var/mail/cltbld', 20:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:01 INFO - 'MOZ_NO_REMOTE': '1', 20:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:01 INFO - 'NO_EM_RESTART': '1', 20:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:01 INFO - 'PWD': '/builds/slave/test', 20:15:01 INFO - 'SHELL': '/bin/bash', 20:15:01 INFO - 'SHLVL': '1', 20:15:01 INFO - 'TERM': 'linux', 20:15:01 INFO - 'TMOUT': '86400', 20:15:01 INFO - 'USER': 'cltbld', 20:15:01 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:01 INFO - '_': '/tools/buildbot/bin/python'} 20:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:01 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 20:15:01 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 20:15:01 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 20:15:01 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 20:15:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:02 INFO - Downloading docopt-0.6.1.tar.gz 20:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:02 INFO - Running setup.py install for blobuploader 20:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:03 INFO - Running setup.py install for requests 20:15:03 INFO - Running setup.py install for docopt 20:15:03 INFO - Successfully installed blobuploader requests docopt 20:15:03 INFO - Cleaning up... 20:15:03 INFO - Return code: 0 20:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:03 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')]} 20:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:03 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')]} 20:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:03 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:03 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 20:15:03 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 20:15:03 INFO - Using env: {'DISPLAY': ':0', 20:15:03 INFO - 'HOME': '/home/cltbld', 20:15:03 INFO - 'LANG': 'en_US.UTF-8', 20:15:03 INFO - 'LANGUAGE': 'en_US:en', 20:15:03 INFO - 'LOGNAME': 'cltbld', 20:15:03 INFO - 'MAIL': '/var/mail/cltbld', 20:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:03 INFO - 'MOZ_NO_REMOTE': '1', 20:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:03 INFO - 'NO_EM_RESTART': '1', 20:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:03 INFO - 'PWD': '/builds/slave/test', 20:15:03 INFO - 'SHELL': '/bin/bash', 20:15:03 INFO - 'SHLVL': '1', 20:15:03 INFO - 'TERM': 'linux', 20:15:03 INFO - 'TMOUT': '86400', 20:15:03 INFO - 'USER': 'cltbld', 20:15:03 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:03 INFO - '_': '/tools/buildbot/bin/python'} 20:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:03 INFO - Running setup.py (path:/tmp/pip-WVgqAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:03 INFO - Running setup.py (path:/tmp/pip-wkk0Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:03 INFO - Running setup.py (path:/tmp/pip-XSpUjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:03 INFO - Running setup.py (path:/tmp/pip-bSYI93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:04 INFO - Running setup.py (path:/tmp/pip-ztwAQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:04 INFO - Running setup.py (path:/tmp/pip-6DH0lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:04 INFO - Running setup.py (path:/tmp/pip-3R36wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:04 INFO - Running setup.py (path:/tmp/pip-_8BYop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:04 INFO - Running setup.py (path:/tmp/pip-HDHw4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:04 INFO - Running setup.py (path:/tmp/pip-a90x0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:04 INFO - Running setup.py (path:/tmp/pip-4NKP3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:04 INFO - Running setup.py (path:/tmp/pip-TCDvci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:04 INFO - Running setup.py (path:/tmp/pip-kNKniM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:04 INFO - Running setup.py (path:/tmp/pip-GaDN8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:04 INFO - Running setup.py (path:/tmp/pip-rYmbgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:04 INFO - Running setup.py (path:/tmp/pip-zBPoSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:04 INFO - Running setup.py (path:/tmp/pip-lWnLbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:04 INFO - Running setup.py install for manifestparser 20:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for mozcrash 20:15:05 INFO - Running setup.py install for mozdebug 20:15:05 INFO - Running setup.py install for mozdevice 20:15:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for mozfile 20:15:05 INFO - Running setup.py install for mozhttpd 20:15:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for mozinfo 20:15:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for mozInstall 20:15:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for mozleak 20:15:05 INFO - Running setup.py install for mozlog 20:15:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:05 INFO - Running setup.py install for moznetwork 20:15:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozprocess 20:15:06 INFO - Running setup.py install for mozprofile 20:15:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozrunner 20:15:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Running setup.py install for mozscreenshot 20:15:06 INFO - Running setup.py install for moztest 20:15:06 INFO - Running setup.py install for mozversion 20:15:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:06 INFO - Cleaning up... 20:15:06 INFO - Return code: 0 20:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:06 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:06 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 20:15:06 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 20:15:06 INFO - Using env: {'DISPLAY': ':0', 20:15:06 INFO - 'HOME': '/home/cltbld', 20:15:06 INFO - 'LANG': 'en_US.UTF-8', 20:15:06 INFO - 'LANGUAGE': 'en_US:en', 20:15:06 INFO - 'LOGNAME': 'cltbld', 20:15:06 INFO - 'MAIL': '/var/mail/cltbld', 20:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:06 INFO - 'MOZ_NO_REMOTE': '1', 20:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:06 INFO - 'NO_EM_RESTART': '1', 20:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:06 INFO - 'PWD': '/builds/slave/test', 20:15:06 INFO - 'SHELL': '/bin/bash', 20:15:06 INFO - 'SHLVL': '1', 20:15:06 INFO - 'TERM': 'linux', 20:15:06 INFO - 'TMOUT': '86400', 20:15:06 INFO - 'USER': 'cltbld', 20:15:06 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:06 INFO - '_': '/tools/buildbot/bin/python'} 20:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:06 INFO - Running setup.py (path:/tmp/pip-fvyUfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:07 INFO - Running setup.py (path:/tmp/pip-j52Xos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:07 INFO - Running setup.py (path:/tmp/pip-sHodKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:07 INFO - Running setup.py (path:/tmp/pip-ieejZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:07 INFO - Running setup.py (path:/tmp/pip-pSchBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:07 INFO - Running setup.py (path:/tmp/pip-GwIlmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:07 INFO - Running setup.py (path:/tmp/pip-_WJzEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:07 INFO - Running setup.py (path:/tmp/pip-xE0vwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:07 INFO - Running setup.py (path:/tmp/pip-Gh0y8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:07 INFO - Running setup.py (path:/tmp/pip-7KWJdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:07 INFO - Running setup.py (path:/tmp/pip-nG8vpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:07 INFO - Running setup.py (path:/tmp/pip-rO7SVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:07 INFO - Running setup.py (path:/tmp/pip-JuJhQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:07 INFO - Running setup.py (path:/tmp/pip-IcL8cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:07 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)) 20:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:07 INFO - Running setup.py (path:/tmp/pip-xLos2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:08 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)) 20:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:08 INFO - Running setup.py (path:/tmp/pip-Fqzd2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:08 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)) 20:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:08 INFO - Running setup.py (path:/tmp/pip-b2dkXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:08 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)) 20:15:08 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)) 20:15:08 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)) 20:15:08 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)) 20:15:08 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)) 20:15:08 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)) 20:15:08 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)) 20:15:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:09 INFO - Downloading blessings-1.6.tar.gz 20:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:09 INFO - Installing collected packages: blessings 20:15:09 INFO - Running setup.py install for blessings 20:15:09 INFO - Successfully installed blessings 20:15:09 INFO - Cleaning up... 20:15:09 INFO - Return code: 0 20:15:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:09 INFO - Reading from file tmpfile_stdout 20:15:09 INFO - Current package versions: 20:15:09 INFO - argparse == 1.2.1 20:15:09 INFO - blessings == 1.6 20:15:09 INFO - blobuploader == 1.2.4 20:15:09 INFO - docopt == 0.6.1 20:15:09 INFO - functools32 == 3.2.3-2 20:15:09 INFO - jsonschema == 2.5.1 20:15:09 INFO - manifestparser == 1.1 20:15:09 INFO - mozInstall == 1.13 20:15:09 INFO - mozcrash == 1.0 20:15:09 INFO - mozdebug == 0.1 20:15:09 INFO - mozdevice == 0.51 20:15:09 INFO - mozfile == 1.2 20:15:09 INFO - mozhttpd == 0.7 20:15:09 INFO - mozinfo == 0.10 20:15:09 INFO - mozleak == 0.1 20:15:09 INFO - mozlog == 3.5 20:15:09 INFO - moznetwork == 0.27 20:15:09 INFO - mozprocess == 0.25 20:15:09 INFO - mozprofile == 0.28 20:15:09 INFO - mozrunner == 6.13 20:15:09 INFO - mozscreenshot == 0.1 20:15:09 INFO - mozsystemmonitor == 0.3 20:15:09 INFO - moztest == 0.8 20:15:09 INFO - mozversion == 1.4 20:15:09 INFO - psutil == 3.1.1 20:15:09 INFO - requests == 1.2.3 20:15:09 INFO - wsgiref == 0.1.2 20:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:09 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')]} 20:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:09 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')]} 20:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:09 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:09 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 20:15:09 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 20:15:09 INFO - Using env: {'DISPLAY': ':0', 20:15:09 INFO - 'HOME': '/home/cltbld', 20:15:09 INFO - 'LANG': 'en_US.UTF-8', 20:15:09 INFO - 'LANGUAGE': 'en_US:en', 20:15:09 INFO - 'LOGNAME': 'cltbld', 20:15:09 INFO - 'MAIL': '/var/mail/cltbld', 20:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:09 INFO - 'MOZ_NO_REMOTE': '1', 20:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:09 INFO - 'NO_EM_RESTART': '1', 20:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:09 INFO - 'PWD': '/builds/slave/test', 20:15:09 INFO - 'SHELL': '/bin/bash', 20:15:09 INFO - 'SHLVL': '1', 20:15:09 INFO - 'TERM': 'linux', 20:15:09 INFO - 'TMOUT': '86400', 20:15:09 INFO - 'USER': 'cltbld', 20:15:09 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:09 INFO - '_': '/tools/buildbot/bin/python'} 20:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 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)) 20:15:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:15:11 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)) 20:15:11 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)) 20:15:11 INFO - Installing collected packages: simplejson 20:15:11 INFO - Running setup.py install for simplejson 20:15:11 INFO - building 'simplejson._speedups' extension 20:15:11 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 20:15:12 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 20:15:12 INFO - Successfully installed simplejson 20:15:12 INFO - Cleaning up... 20:15:12 INFO - Return code: 0 20:15:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15:12 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')]} 20:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:12 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')]} 20:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:12 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 0x1dbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f84b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21299c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, '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': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', '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 20:15:12 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 20:15:12 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 20:15:12 INFO - Using env: {'DISPLAY': ':0', 20:15:12 INFO - 'HOME': '/home/cltbld', 20:15:12 INFO - 'LANG': 'en_US.UTF-8', 20:15:12 INFO - 'LANGUAGE': 'en_US:en', 20:15:12 INFO - 'LOGNAME': 'cltbld', 20:15:12 INFO - 'MAIL': '/var/mail/cltbld', 20:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:12 INFO - 'MOZ_NO_REMOTE': '1', 20:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:12 INFO - 'NO_EM_RESTART': '1', 20:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:12 INFO - 'PWD': '/builds/slave/test', 20:15:12 INFO - 'SHELL': '/bin/bash', 20:15:12 INFO - 'SHLVL': '1', 20:15:12 INFO - 'TERM': 'linux', 20:15:12 INFO - 'TMOUT': '86400', 20:15:12 INFO - 'USER': 'cltbld', 20:15:12 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:12 INFO - '_': '/tools/buildbot/bin/python'} 20:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:15:12 INFO - Cleaning up... 20:15:12 INFO - Return code: 0 20:15:12 INFO - Running post-action listener: _resource_record_post_action 20:15:12 INFO - Running post-action listener: _start_resource_monitoring 20:15:12 INFO - Starting resource monitoring. 20:15:12 INFO - [mozharness: 2017-09-24 03:15:12.492275Z] Finished create-virtualenv step (success) 20:15:12 INFO - [mozharness: 2017-09-24 03:15:12.493286Z] Running install step. 20:15:12 INFO - Running pre-action listener: _resource_record_pre_action 20:15:12 INFO - Running main action method: install 20:15:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:12 INFO - Reading from file tmpfile_stdout 20:15:12 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:12 INFO - Reading from file tmpfile_stdout 20:15:12 INFO - Output received: 20:15:12 INFO - Usage: mozinstall [options] installer 20:15:12 INFO - Options: 20:15:12 INFO - -h, --help show this help message and exit 20:15:12 INFO - -d DEST, --destination=DEST 20:15:12 INFO - Directory to install application into. [default: 20:15:12 INFO - "/builds/slave/test"] 20:15:12 INFO - --app=APP Application being installed. [default: firefox] 20:15:12 INFO - mkdir: /builds/slave/test/build/application 20:15:12 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'] 20:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:15:30 INFO - Reading from file tmpfile_stdout 20:15:30 INFO - Output received: 20:15:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:30 INFO - Running post-action listener: _resource_record_post_action 20:15:30 INFO - [mozharness: 2017-09-24 03:15:30.788042Z] Finished install step (success) 20:15:30 INFO - [mozharness: 2017-09-24 03:15:30.788295Z] Running setup-mitmproxy step. 20:15:30 INFO - Running pre-action listener: _resource_record_pre_action 20:15:30 INFO - Running main action method: setup_mitmproxy 20:15:30 INFO - Skipping: mitmproxy is not required 20:15:30 INFO - Running post-action listener: _resource_record_post_action 20:15:30 INFO - [mozharness: 2017-09-24 03:15:30.789421Z] Finished setup-mitmproxy step (success) 20:15:30 INFO - [mozharness: 2017-09-24 03:15:30.789641Z] Running run-tests step. 20:15:30 INFO - Running pre-action listener: _resource_record_pre_action 20:15:30 INFO - Running pre-action listener: _set_gcov_prefix 20:15:30 INFO - Running main action method: run_tests 20:15:30 WARNING - Try message not found. 20:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:30 INFO - Python 2.7.3 20:15:30 INFO - Return code: 0 20:15:30 INFO - grabbing minidump binary from tooltool 20:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2126d60>, '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 0x2127a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2127ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:15:30 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:15:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:30 INFO - Return code: 0 20:15:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:30 INFO - ENV: RUST_BACKTRACE is now full 20:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:30 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/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 20:15:30 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/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 20:15:30 INFO - Using env: {'DISPLAY': ':0', 20:15:30 INFO - 'HOME': '/home/cltbld', 20:15:30 INFO - 'LANG': 'en_US.UTF-8', 20:15:30 INFO - 'LANGUAGE': 'en_US:en', 20:15:30 INFO - 'LOGNAME': 'cltbld', 20:15:30 INFO - 'MAIL': '/var/mail/cltbld', 20:15:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:30 INFO - 'MOZ_NO_REMOTE': '1', 20:15:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:30 INFO - 'NO_EM_RESTART': '1', 20:15:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:30 INFO - 'PWD': '/builds/slave/test', 20:15:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:30 INFO - 'RUST_BACKTRACE': 'full', 20:15:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:15:30 INFO - 'SHELL': '/bin/bash', 20:15:30 INFO - 'SHLVL': '1', 20:15:30 INFO - 'TERM': 'linux', 20:15:30 INFO - 'TMOUT': '86400', 20:15:30 INFO - 'USER': 'cltbld', 20:15:30 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:30 INFO - '_': '/tools/buildbot/bin/python'} 20:15:30 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/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 20:15:31 INFO - mozversion application_buildid: 20170924022042 20:15:31 INFO - mozversion application_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:15:31 INFO - mozversion application_display_name: Nightly 20:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:31 INFO - mozversion application_name: Firefox 20:15:31 INFO - mozversion application_remotingname: firefox 20:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:15:31 INFO - mozversion application_vendor: Mozilla 20:15:31 INFO - mozversion application_version: 58.0a1 20:15:31 INFO - mozversion platform_buildid: 20170924022042 20:15:31 INFO - mozversion platform_changeset: ff40c5dcaa41261b39a4e9795e02a9d51dd30ced 20:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:15:31 INFO - mozversion platform_version: 58.0a1 20:15:31 INFO - using testdate: 1506222931 20:15:31 INFO - actual date: 1506222931 20:15:31 INFO - starting webserver on 'localhost:33530' 20:15:31 INFO - SUITE-START | Running 2 tests 20:15:31 INFO - TEST-START | dromaeo_css 20:15:31 INFO - Initialising browser for dromaeo_css test... 20:15:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33530/getInfo.html -profile /tmp/tmpBqDMXr/profile 20:15:31 INFO - TEST-INFO | started process 3558 (/builds/slave/test/build/application/firefox/firefox http://localhost:33530/getInfo.html) 20:15:37 INFO - TEST-INFO | 3558: exit 0 20:15:37 INFO - Browser initialized. 20:15:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:37 INFO - Using env: {'DISPLAY': ':0', 20:15:37 INFO - 'HOME': '/home/cltbld', 20:15:37 INFO - 'JSGC_DISABLE_POISONING': '1', 20:15:37 INFO - 'LANG': 'en_US.UTF-8', 20:15:37 INFO - 'LANGUAGE': 'en_US:en', 20:15:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:15:37 INFO - 'LOGNAME': 'cltbld', 20:15:37 INFO - 'MAIL': '/var/mail/cltbld', 20:15:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:37 INFO - 'MOZ_CRASHREPORTER': '1', 20:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:15:37 INFO - 'MOZ_NO_REMOTE': '1', 20:15:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:37 INFO - 'NO_EM_RESTART': '1', 20:15:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:37 INFO - 'PWD': '/builds/slave/test', 20:15:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:37 INFO - 'RUST_BACKTRACE': 'full', 20:15:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:15:37 INFO - 'SHELL': '/bin/bash', 20:15:37 INFO - 'SHLVL': '1', 20:15:37 INFO - 'TERM': 'linux', 20:15:37 INFO - 'TMOUT': '86400', 20:15:37 INFO - 'USER': 'cltbld', 20:15:37 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:37 INFO - '_': '/tools/buildbot/bin/python'} 20:15:37 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBqDMXr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:38 INFO - PID 3794 | 20:15:38 INFO - PID 3794 | (/builds/slave/test/build/application/firefox/firefox:3844): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:15:38 INFO - PID 3794 | 20:15:49 INFO - PID 3794 | RSS: Main: 152047616 20:15:49 INFO - PID 3794 | 20:18:46 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33530/tests/dromaeo/cssquery-ext.html) 20:18:48 INFO - PID 3794 | RSS: Main: 153260032 20:18:48 INFO - PID 3794 | 20:21:49 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-ext.html (next: http://localhost:33530/tests/dromaeo/cssquery-jquery.html) 20:21:50 INFO - PID 3794 | RSS: Main: 152883200 20:21:50 INFO - PID 3794 | 20:24:52 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33530/tests/dromaeo/cssquery-mootools.html) 20:24:52 INFO - PID 3794 | RSS: Main: 155197440 20:24:52 INFO - PID 3794 | 20:27:54 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33530/tests/dromaeo/cssquery-prototype.html) 20:27:55 INFO - PID 3794 | RSS: Main: 153468928 20:27:55 INFO - PID 3794 | 20:30:58 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33530/tests/dromaeo/cssquery-yui.html) 20:30:59 INFO - PID 3794 | RSS: Main: 153325568 20:30:59 INFO - PID 3794 | 20:34:00 INFO - PID 3794 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-yui.html (next: http://localhost:33530/tests/dromaeo/cssquery-dojo.html) 20:34:01 INFO - PID 3794 | RSS: Main: 157065216 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | __start_tp_report 20:34:01 INFO - PID 3794 | _x_x_mozilla_page_load 20:34:01 INFO - PID 3794 | _x_x_mozilla_page_load_details 20:34:01 INFO - PID 3794 | |i|pagename|runs| 20:34:01 INFO - PID 3794 | |0;dojo.html;3145.1822526143205;3170.4451720948837;3185.8407079646026;3192.0902542775316;3205.6634053424377;6270.31026587075;6404.775832845851;6467.191601049869;6474.643894585802;6491.935080649192;6337.841553961153;6358.650274234915;6383.265924418693;6392.712327945242;6405.4875609951205;5813.157092221625;5852.561057920651;5875.970620146893;5892.852678683024;5917.467427931485;5911.142884281798;5915.704214789243;5984.491318237955;5992.041273396258;6034.426729460694;5947.821565353046;5964.582479226456;6024.2770867495965;6028.336882942895;6053.092036194584;5681.801136960228;5793.565482588822;5804.419558044204;5926.199963005025;5957.821265362046;5866.413358664142;5876.794312199053;5939.07944268639;5939.2575928009;5960.403959604005;6194.194754681863;6316.210473690789;6398.104265402847;6478.190226221723;6490.415862572391;6734.865302693918;6787.592744435349;6789.966050169767;6790.898136527956;6816.420604248645;6931.3415225554;6935.133108361455;6943.270956549591;6944;6945.305469453065;6318.147050148263;6320.525960552977;6392.7123279452535;6398.16823812906;6398.808035758934;6947.826304342432;7002.754903578452;7095.538789978635;7110.5022648414115;7114.430845532345;6482.027695845567;6563.245226798884;6626.039224312448;6628;6651.933480665228;6799.218089919624;6809.659517024228;6911.827204319831;6913.5506192097355;6933.0986971693355;6788.660566971632;6829.214640316328;6873.553219040747;6881.380675739208;6887.2079710832895;6833.965830170818;6836.316368363124;6916.757913473004;6923.134608173978;6934.063901373351;5217.660852044605;5327.600429967768;5346;5346.224797404432;5395.649282796684;4655.86032419028;4712.976435117803;4750.8337208197545;4782.282657601318;4799.016201678717;5787.479126878601;5881.941180588139;5912.73392697321;5916.526677865761;5917.970410147922;6841.2132604750095;6845.657717114224;6876.587404755731;6946.826329341807;6947.861042779217;5742.598018138774;5834.854128646818;5848.64908105515;5908.379620139824;5923.644581325134;5823.7379317929945;5841.912371314434;5851.210086638334;5853;5925.73334199962;6642.202935647753;6697.129373181455;6723.428508576826;6729.25978142404;6741.022551729971;6880.346367095118;6905;6977.406920411822;6991.475639327173;7004.089468369079;6457.515686323639;6638.269790323157;6647.401733843977;6734.461243100638;6740.528163028541;6667.833304167435;6729.495287853332;6778.8644227116165;6780;6783.59298442095;6863.725450981905;6933.341332573397;6943;6974.476914231352;6981.860362792614;6656;6684.766033188815;6726.3609957054005;6748.426383757239;6753.966230168818;6519.054737063005;6624.9337506624315;6649.966750166218;6711.4966377520905;6745.5952642841585;6599.901001485077;6620.3710647488415;6627.403533681992;6632.336766323329;6647.069410282467;6528.771492997722;6692.966535167293;6758.222804377559;6766.830829229309;6773.221079575912;6198.6280823150755;6405.551611387158;6447.065175549613;6517.120188774645;6528.314526974599 20:34:01 INFO - PID 3794 | |1;ext.html;762.1540090499547;780.2938340801574;782.3623746646484;786.594903624633;791.5171745235409;42665.78667106664;44214.33678494825;44238.33642495357;44282.55717442824;44378.778106109465;39796.403053954215;39864.40203396951;39955.800220998855;40035.59964400355;40071.59928400715;7112.786616401516;7233.855322893539;7235.855282894339;7239.6742146603265;7241.927580724205;7164.068671072753;7246.420286377077;7250.637468126599;7255.129384473844;7257.8911316330295;8024.277814996649;8190.017197936226;8201.917980820204;8210.096889342167;8223.917760822405;8097.51414915104;8141.22658347456;8174.141715119946;8184.263416292562;8189.3857960652895;7745.651445684957;7917.406194535433;7952.483088599222;7954.085280192736;7979.241972012649;38142.42786358207;38513.22973540513;38545.421818672745;38549.42175867364;38633.42049869254;3518.2787528556582;3558.946615800765;3569.196930690574;3575.0704816747575;3576.0344706929245;31000.53499197514;31027.689723102932;31102.37795244105;31195.064148075366;31285.530717039263;5235.58115350771;5236.554892834114;5241.659292146036;5261.842144735664;5284.682919024871;177936.1103194476;187823.0608846947;189961;190653;190952;42840;49020.26469602959;49995.250071248964;50044.249336259985;50049.74975125101;51600.48399515957;51962.740186298826;51992;52005.7399712999;52039;16586.336546538005;16623;16660.41688540895;16662.66674666524;16755.664886702198;13782.65543361424;13793;13806.585802425943;13809.723805523834;13834.169949802843;14381.64045898861;14527.184101987252;14538.709225815424;14576.635584110481;14632.926835365755;5770.740316685759;5965.403459654087;5985.700714964234;5998.130271110665;6032.125341825411;1006.2754816532085;1022.4989755019986;1024.656739992111;1028.4908970059869;1029.9382037077798;23635.88182059079;23763.762362376154;23788.643170352458;23803.642945355834;23852.880735596213;1120.641394753671;1126.4480404601686;1127.4193790198055;1135.8750537440874;1141.0757286597882;12373;12548.68628284282;12593.748125037448;12609.495620175274;12688.17526860751;222605;224711;224722;224734;225008;54641.726791366586;54898;55156.72421637866;55255.44744552583;55381.169282460796;1445.8843292536571;1459.810224670786;1486.9776953345709;1491.7986071880375;1495.5887131038833;23571.41071473227;23582.528349433258;23721.051157953487;23764;23831.761682382956;39830;39885;39907.40138897861;39949.60050399459;39975.600243997185;200044;200146;200190;200474;200617;31381.52927706132;32131.357372851944;35439;35713.64286357207;36459.45310820287;42550.57449425466;44565;44852;44980.32529511995;45076;32131;32262.354752904343;32288.192795180308;32476.675233248312;32687.50968735423;31814;31855.36289274248;32557.02328930136;32616.34767304688;32650.183745406553;36180.4572931401;36212.63787362093;36250.456243155844;36528.45207321839;36588.26823463569;31716.442140070776;31906.840465797522;32038.679613204502;32239;32320.676793231767;23449.648255275843;23834.761652383255;24021.27936161918;24223.75776242215;24289 20:34:01 INFO - PID 3794 | |2;jquery.html;568.8890666320069;577.8728679690472;595.6009473652653;602.3735315272116;603.0923460192411;21903.561928761414;22644.207452739156;22657.54684906301;22826.885865570668;22832.315030549067;22718;24143.275701728933;24235.151769688066;24347;24388;6584.604923704581;6651.135352404181;6672.799816005503;6673.0991316172185;6689.163854518185;6392.137061496708;6551.377619126175;6573.046908198308;6657.167854018247;6722.3613756693285;6642.6014439133805;6657.068010478537;6658.400743933045;6663.366980136903;6672.466202703797;6641.468682505436;6649.667516624174;6658.234303055162;6664.266930637626;6686.465082793389;5777.826665200051;5998.4601385875485;6001.699915004276;6002.2197114375285;6003.159557661931;27072.86463567689;27476.58785118225;27512.862435687894;27514.587281190597;27603.447931041468;2083.6041152181187;2088.853780235384;2094.7381577302835;2098.3390232077;2106.631339515594;18972.241110355706;19251.61496770071;19487.22051117968;19564.217431302874;19593.314234001886;2462.212092130519;2473.146764366291;2509.222141136235;2532.898684052636;2543.872806359693;116288;122659.38670306592;132009.33995330057;137362.3131884344;138233;14640.341184646717;14711.014013108308;14989.852131052383;15383.846161538466;15846.920765396098;23520.411989700395;23541;23568.29295121149;23632.645510317358;23701;9945.602175912882;9980;10098.596056157818;10244.795104097877;10271.589136434459;9140.771480713036;9152.771180720401;9158.95420522893;9250.074992500831;9367.765805854908;9155;9162.633494660273;9187.724368268962;9207.90792092084;9318.30112741547;2731.713170117149;2777.3056735816044;2807.8455684937526;2876.395956849085;2886.1774394297945;957.5547370472764;964.840801267797;975.9170470510086;987.2792861211356;990.6978371596732;18907.810921890607;19048.142833572245;19156.616867662848;19524.902375488033;19602.607947840963;1036.3678156324636;1039.3452125161252;1040.3653771199563;1042.5621239079605;1047.1308813684623;10479.47602619866;10493;10520.526576304084;10627.202959778047;10685.198610104118;455773;467893;469243;471398;471859;110029.44985275023;110600;111823;113649;114613.42693286647;1147.0995268714018;1163.0985985860857;1186.6677330347516;1187.3350923482876;1187.5606025770521;16860.57848553796;16865;16935.121029425274;16992.66014679675;17124.14379281056;52292;53097.20354194613;53380;53722.73138634282;56283.71858140683;68354.65822670855;68576.6571167141;68681.65659171873;69247.65376173086;69360.30639693538;14231.64420889486;14236.928815355857;14411.207383594003;14455.927720361751;14534.127952322895;21876.78123218811;21986.340409787732;22336.77663223347;22552.097916083174;22624.886875565517;16878.66242675115;16932.238049287564;17014.744778828575;17622.559436014202;18055.00697461652;15768.211589420713;16089.75865361997;16230.756538651693;16698.165091745606;16930.238139284007;17236.310547577956;17743.20155593027;17770.822291777433;18539.90730046395;18615.720764188278;14058.78911816344;14120.50578229757;14128.646783830487;14193.29033548339;14255.50105746294;17156.656866862344;17215.053172075655;17380.39168629092;17776.37782677652;18081.547961301072 20:34:01 INFO - PID 3794 | |3;mootools.html;1285.8778416050477;1364.4951367993845;1387.0221493846836;1388.9722205555888;1397.7693680542711;15114.697706045887;15762.921185394058;15786.210689465524;15794.210289485509;15813.999999999985;15327.846721532782;15536.22318884057;15567.065976041446;15570;15576.143312117829;2816.2677703796953;2818.3095141690264;2876.209042513315;2879.640044994376;2880.2367372646268;2750.8899644014214;2812.70466601007;2813.7186281371905;2824.4209936962875;2831.1223520708545;2772.88908443662;2775.264554892955;2798.1605518344413;2871.5405535114387;2871.698471660477;2810.7610853077513;2851.2159156231996;2853.343730941895;2853.6147620071233;2867.9713202868015;2664.9067282645015;2704.0806125917284;2723.1694333228356;2724.6866610339866;2732.53546897028;15230.923845380814;15369.154696491689;15387.846121538865;15392.846071539254;15393.923030384889;7871.645775940096;8093.069297030858;8142.47073940192;8143.226393492609;8168.632411541435;5356.1430171172815;5523.4200408956885;5581.079121944874;5641.746121424546;5646.604737668365;1907.1513176636402;1914.818092281231;1953.9023048847644;1993.2027189124321;2011.7384739983854;26885.596716049276;27088.729112708817;27127.593086103527;27266.727332726616;27411.725882741117;6899.206591242071;7074.186468556182;7104.609246491493;7204.855902881913;7267.963660181666;16939.830601693826;16961;16969.406070787463;16988.74516882248;17093.914530427268;8141.185881411811;8324.833503329899;8328.042275138316;8328.500289982621;8329.708460203863;7543.47195696307;7624.466287359943;7671.923280767232;7771.222877712184;7771.961140194376;5099.260607211933;5217.921731174036;5237.6071794615555;5243.2659427680155;5282.075636763551;1464.421553486367;1550.1474189195897;1559.5165498695442;1579.3287852662572;1612.11333766428;924.4129977464224;935.9157675809209;944.7024187380953;949.7340744591526;950.6577632052456;8713.738587842376;8767.868481972775;8784.516851573097;8864.64541418349;8891.822163556693;989.569537251298;1011.3072545306488;1011.726833754882;1016.913562347194;1036.6371769880482;4805.879853003633;5265.6309359566785;5342.358916929993;5640.830775076754;5719.7140142992685;21491.67762483564;21631.67552486714;22244.66633000474;22582.20962266313;22984.65523017156;22449.775502245095;22478.438039048826;22512.21207257771;22543.210987615355;22647.320580382613;11398.886011139783;11574.710632234093;11859.16985810985;11891.583794567148;11926.88073119275;8596.226339629464;8596.656133754579;8668.869966950628;8736.213740763362;8827.779305517157;18339.449816505527;18977.43067707971;18987;19287.035648217814;19649.115789789208;19607.215711371384;19791.208351665773;19936;20380.980950952096;20434.59130817405;11119.666410007712;11144.387058711849;11231.606893758679;11294.322340659586;11363;14023.789643155565;14096.78854817158;14180.14919104857;14197.716045678822;14213.289335532974;11234.213605047567;11254.662360129209;11459.770804584028;11463.31220126795;11588.362640054878;10965.232433729563;10975.780484390427;10976.890231097586;11072.557097716;11313.660590182308;10060.245481589056;10255.84616230772;10273.691789246335;10276.640317588848;10281.588736450758;6865.41643960269;6920.9307906920285;6947.44420446353;6990.860182796418;7052.5063245574365;6702.296258892746;6787.151606049244;6845.828854278484;6936.445084393337;6955.791326260221 20:34:01 INFO - PID 3794 | |4;prototype.html;499.9850004499865;507.7715028237294;538.7252501224376;539.344696194124;541.320642593545;6343.74625015;6369.394907483793;6379.425851673354;6454.677266136686;6455.22537295524;6131.417515336036;6175.258968923736;6226.533010024244;6283.246010478749;6297.984644913629;4993.275974983625;5042.218456139304;5095;5145.536901678848;5162.716050617215;4863.708177509343;5081.8475445736685;5093.236014597803;5101.923471147918;5114.565261952738;5024.9748751256375;5047;5069.949300506984;5075.492450754932;5084.593232541388;5002.77487513061;5005.374328208974;5034.974825125869;5042.168042273021;5063.493650634944;4486.932696009562;4557.632710186964;4596.49438561758;4600.2869555218995;4618.861434156981;6225.439710426083;6234.407731265568;6283.622982621012;6284;6307.653079080649;5836.38717934615;5837.664934026381;5838.824835254949;5845.09401042839;5876.823695289148;6626.123717625195;6701.095352127498;6712.597244165366;6722.865542689119;6758.763443279511;4983.25251212321;4987.251912213161;4996.9500304996845;5002.52476014778;5015.874603134915;6938.236793952661;6991.428057625815;7029.8945515816795;7037.542559733601;7101.86943916828;5077.517635824591;5115.386153661584;5117.488251174853;5133.715496603975;5134.922976155286;5175.870603234949;5184.7926082956255;5193.688378697215;5202.687838729688;5203.141481655484;5717.656940583578;5724.790440698944;5741.45456181662;5788.681622510802;5820.243368362086;6599.571027883172;6622.2715501294815;6639.170103737033;6677.165354330708;6696.229933557605;1686.2411914638217;1740.7649967254258;1743.1632816248273;1772.3442326339336;1796;1210.1710328425056;1248.8126780982743;1253.6239128261484;1253.9184952978028;1257.69186549296;5739.569532285095;5741;5751.597388182787;5795.507381872588;5802.448767367094;6407.359264073649;6557.639329836809;6620.66896655175;6694;6717.16035495563;5803.100519419497;5827.446392592697;5837.591368604157;5847.94152058474;5882.117682347682;3557.079177244311;3573.356795776733;3590.838412271454;3610.819459027038;3634.1459756957092;6245.96877015612;6434.324395938359;6477.449416799531;6502.544821862424;6578.243501997236;6946.444284457231;6997.370236678622;7000.2999700030605;7015.263397343206;7023.438124949992;6502.6748662567625;6507.902381464377;6520.347965203537;6535.444871858882;6553.475721942328;6590.472762178918;6698;6702.229243637044;6734.966325168539;6743.88622940016;6660.234073081464;6683.7660681875905;6692.4903161314505;6693.389578064462;6715.56348837324;6402.551821372459;6442.710078046405;6475.902861456988;6502.3172566881685;6509.902351464637;5022.171341728574;5022.347094877789;5045.5459008689395;5070.138076527073;5124.615653826053;6873.759418420332;6893.896976483939;6912.066870972354;6914.5159838812815;6938.132733408324;6564.4748420127235;6577.408033277028;6587.9670601646685;6616.7022483987375;6647.4682025438815;6302;6406.981800732754;6506.49499942535;6510.014445594139;6580.835479112869;6219.937800621936;6374.139491168633;6476.996065609649;6565.277819439762;6608.43828274602;6651.667416629246;6676.298988606127;6688.966555167388;6719.361660642231;6738.6967586459705;6264.718087686157;6319.778807741707;6377.808665740035;6386.904196436964;6396.200474940632 20:34:01 INFO - PID 3794 | |5;yui.html;902.5397047505775;910.0853642089698;913.7167478081791;922.6493932305727;936.793905340825;16610.16949152542;17178.141092945367;17249.13754312284;19966.90016549915;20344.593108137866;19254.326098586553;19289.710654340197;19659.31192408266;20907;21218.787812121875;954.2652157838478;967.9419234845897;973.2068364283122;973.3819024919156;975.4098770244007;949.6106596295521;978.9755256118618;990.1385794358918;990.4404011733384;991.4844280973925;1052.489542571852;1053.2469284461608;1054.098745572536;1054.1356088007838;1054.96307629233;1030.9072183503445;1036.8548403223556;1038.9844152337682;1041.1358572384902;1043.2071625564588;760.3536993555433;762.3481922955904;763.118598019283;763.2253262938123;764.8967389402416;17966.101694915204;18006.549836254067;18154.364597239164;18200.908995454938;18234.270629174818;20818.27136050231;21543.569128617495;21843;21849.67225491619;21857.344279671634;17100.657986840193;17437.651246975118;17589.912050439794;17687.115644217865;17718.02550859702;3697.722670799674;3716.7026637868908;3717;3727.0682329417646;3732.216234590739;142170.28914855464;143404;144815.99999999895;146575;146644.26677866542;16761.329546818233;17069.48791536256;17073.40243091486;17182.65634687299;17228.91385543064;31184.688153118634;31269.061928142193;31400.05799826009;31451;31619.84190079035;7515.549067055994;8173.427860049739;9407.247420206504;9457.243420526342;9538.284628652878;4216.957830421657;4317.84887528935;4329.653627709776;4334.371516130143;4358.738475691469;5408.02655522002;5511.448855114537;5555.2778138841695;5573.637713548606;5646.181303711021;1031.0771859185986;1052.6947185316174;1058.9894101058892;1062.4156713807374;1063.5107850388754;654.653033892038;672.3780503034772;687.6252442418894;689.1489011071322;690.1235431002599;11902.285862848257;11923;12018.639440816789;12873.163244389085;12873.613791586267;646.809191288571;650.4666173737489;653.3368630839701;662.5560874214192;677.5663575311804;5453.318335208099;5458.1266997280245;5507.173923911365;5584.274044374205;5644.01229784786;117218.41390793162;122549.38725306316;125241.37379313045;126452;127282.36358818147;109794.45102774595;113670;114196.42901785437;115401;115804.42097789457;92861;93771;94191.52904235435;97206.51396742971;97213.02786972182;10503.737406564896;10574.41840698769;10617.575296988343;10673.57305707763;10741.785164296827;43586.782066089465;43606.12787744291;43720.78139609282;44492.33261501016;44971.32543011792;56230;57160;57768;58687.82624347575;58696.706516468854;15286.694266114839;15759.68480630404;15776;15838.68322633564;15839.445619403266;17178.656426871643;17330;17398.73901891498;17472.91263543674;17606.735898961782;15644.765328519854;16059.357625694842;16108.516744497216;16221.837781622033;16230.918845405697;15323.157226352658;15535.611609709847;15580.68838623244;15729.68540629204;15746.763798542803;15895.205239738198;15987.200639968187;16157;16177.11025893587;16191.10948897822;11457.885421146015;11624;11856.11079169083;11871.109666774853;11875.703107422383;11650.30098194111;11832.112591555495;11912.98739607143;11945.761084778429;12046.337451440255 20:34:01 INFO - PID 3794 | __end_tp_report 20:34:01 INFO - PID 3794 | __start_cc_report 20:34:01 INFO - PID 3794 | _x_x_mozilla_cycle_collect,289 20:34:01 INFO - PID 3794 | __end_cc_report 20:34:01 INFO - PID 3794 | __startTimestamp1506224041074__endTimestamp 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | ------- Summary: start ------- 20:34:01 INFO - PID 3794 | Number of tests: 6 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#0] dojo.html Cycles:165 Average:6301.40 Median:6528.31 stddev:763.16 (11.7%) stddev-sans-first:724.23 20:34:01 INFO - PID 3794 | Values: 3145.2 3170.4 3185.8 3192.1 3205.7 6270.3 6404.8 6467.2 6474.6 6491.9 6337.8 6358.7 6383.3 6392.7 6405.5 5813.2 5852.6 5876.0 5892.9 5917.5 5911.1 5915.7 5984.5 5992.0 6034.4 5947.8 5964.6 6024.3 6028.3 6053.1 5681.8 5793.6 5804.4 5926.2 5957.8 5866.4 5876.8 5939.1 5939.3 5960.4 6194.2 6316.2 6398.1 6478.2 6490.4 6734.9 6787.6 6790.0 6790.9 6816.4 6931.3 6935.1 6943.3 6944.0 6945.3 6318.1 6320.5 6392.7 6398.2 6398.8 6947.8 7002.8 7095.5 7110.5 7114.4 6482.0 6563.2 6626.0 6628.0 6651.9 6799.2 6809.7 6911.8 6913.6 6933.1 6788.7 6829.2 6873.6 6881.4 6887.2 6834.0 6836.3 6916.8 6923.1 6934.1 5217.7 5327.6 5346.0 5346.2 5395.6 4655.9 4713.0 4750.8 4782.3 4799.0 5787.5 5881.9 5912.7 5916.5 5918.0 6841.2 6845.7 6876.6 6946.8 6947.9 5742.6 5834.9 5848.6 5908.4 5923.6 5823.7 5841.9 5851.2 5853.0 5925.7 6642.2 6697.1 6723.4 6729.3 6741.0 6880.3 6905.0 6977.4 6991.5 7004.1 6457.5 6638.3 6647.4 6734.5 6740.5 6667.8 6729.5 6778.9 6780.0 6783.6 6863.7 6933.3 6943.0 6974.5 6981.9 6656.0 6684.8 6726.4 6748.4 6754.0 6519.1 6624.9 6650.0 6711.5 6745.6 6599.9 6620.4 6627.4 6632.3 6647.1 6528.8 6693.0 6758.2 6766.8 6773.2 6198.6 6405.6 6447.1 6517.1 6528.3 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#1] ext.html Cycles:180 Average:37762.07 Median:19641.42 stddev:52967.88 (269.7%) stddev-sans-first:53043.61 20:34:01 INFO - PID 3794 | Values: 762.2 780.3 782.4 786.6 791.5 42665.8 44214.3 44238.3 44282.6 44378.8 39796.4 39864.4 39955.8 40035.6 40071.6 7112.8 7233.9 7235.9 7239.7 7241.9 7164.1 7246.4 7250.6 7255.1 7257.9 8024.3 8190.0 8201.9 8210.1 8223.9 8097.5 8141.2 8174.1 8184.3 8189.4 7745.7 7917.4 7952.5 7954.1 7979.2 38142.4 38513.2 38545.4 38549.4 38633.4 3518.3 3558.9 3569.2 3575.1 3576.0 31000.5 31027.7 31102.4 31195.1 31285.5 5235.6 5236.6 5241.7 5261.8 5284.7 177936.1 187823.1 189961.0 190653.0 190952.0 42840.0 49020.3 49995.3 50044.2 50049.7 51600.5 51962.7 51992.0 52005.7 52039.0 16586.3 16623.0 16660.4 16662.7 16755.7 13782.7 13793.0 13806.6 13809.7 13834.2 14381.6 14527.2 14538.7 14576.6 14632.9 5770.7 5965.4 5985.7 5998.1 6032.1 1006.3 1022.5 1024.7 1028.5 1029.9 23635.9 23763.8 23788.6 23803.6 23852.9 1120.6 1126.4 1127.4 1135.9 1141.1 12373.0 12548.7 12593.7 12609.5 12688.2 222605.0 224711.0 224722.0 224734.0 225008.0 54641.7 54898.0 55156.7 55255.4 55381.2 1445.9 1459.8 1487.0 1491.8 1495.6 23571.4 23582.5 23721.1 23764.0 23831.8 39830.0 39885.0 39907.4 39949.6 39975.6 200044.0 200146.0 200190.0 200474.0 200617.0 31381.5 32131.4 35439.0 35713.6 36459.5 42550.6 44565.0 44852.0 44980.3 45076.0 32131.0 32262.4 32288.2 32476.7 32687.5 31814.0 31855.4 32557.0 32616.3 32650.2 36180.5 36212.6 36250.5 36528.5 36588.3 31716.4 31906.8 32038.7 32239.0 32320.7 23449.6 23834.8 24021.3 24223.8 24289.0 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#2] jquery.html Cycles:180 Average:33396.85 Median:22687.77 stddev:78670.49 (346.8%) stddev-sans-first:78852.57 20:34:01 INFO - PID 3794 | Values: 568.9 577.9 595.6 602.4 603.1 21903.6 22644.2 22657.5 22826.9 22832.3 22718.0 24143.3 24235.2 24347.0 24388.0 6584.6 6651.1 6672.8 6673.1 6689.2 6392.1 6551.4 6573.0 6657.2 6722.4 6642.6 6657.1 6658.4 6663.4 6672.5 6641.5 6649.7 6658.2 6664.3 6686.5 5777.8 5998.5 6001.7 6002.2 6003.2 27072.9 27476.6 27512.9 27514.6 27603.4 2083.6 2088.9 2094.7 2098.3 2106.6 18972.2 19251.6 19487.2 19564.2 19593.3 2462.2 2473.1 2509.2 2532.9 2543.9 116288.0 122659.4 132009.3 137362.3 138233.0 14640.3 14711.0 14989.9 15383.8 15846.9 23520.4 23541.0 23568.3 23632.6 23701.0 9945.6 9980.0 10098.6 10244.8 10271.6 9140.8 9152.8 9159.0 9250.1 9367.8 9155.0 9162.6 9187.7 9207.9 9318.3 2731.7 2777.3 2807.8 2876.4 2886.2 957.6 964.8 975.9 987.3 990.7 18907.8 19048.1 19156.6 19524.9 19602.6 1036.4 1039.3 1040.4 1042.6 1047.1 10479.5 10493.0 10520.5 10627.2 10685.2 455773.0 467893.0 469243.0 471398.0 471859.0 110029.4 110600.0 111823.0 113649.0 114613.4 1147.1 1163.1 1186.7 1187.3 1187.6 16860.6 16865.0 16935.1 16992.7 17124.1 52292.0 53097.2 53380.0 53722.7 56283.7 68354.7 68576.7 68681.7 69247.7 69360.3 14231.6 14236.9 14411.2 14455.9 14534.1 21876.8 21986.3 22336.8 22552.1 22624.9 16878.7 16932.2 17014.7 17622.6 18055.0 15768.2 16089.8 16230.8 16698.2 16930.2 17236.3 17743.2 17770.8 18539.9 18615.7 14058.8 14120.5 14128.6 14193.3 14255.5 17156.7 17215.1 17380.4 17776.4 18081.5 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#3] mootools.html Cycles:180 Average:9547.03 Median:14794.84 stddev:6849.83 (46.3%) stddev-sans-first:6840.93 20:34:01 INFO - PID 3794 | Values: 1285.9 1364.5 1387.0 1389.0 1397.8 15114.7 15762.9 15786.2 15794.2 15814.0 15327.8 15536.2 15567.1 15570.0 15576.1 2816.3 2818.3 2876.2 2879.6 2880.2 2750.9 2812.7 2813.7 2824.4 2831.1 2772.9 2775.3 2798.2 2871.5 2871.7 2810.8 2851.2 2853.3 2853.6 2868.0 2664.9 2704.1 2723.2 2724.7 2732.5 15230.9 15369.2 15387.8 15392.8 15393.9 7871.6 8093.1 8142.5 8143.2 8168.6 5356.1 5523.4 5581.1 5641.7 5646.6 1907.2 1914.8 1953.9 1993.2 2011.7 26885.6 27088.7 27127.6 27266.7 27411.7 6899.2 7074.2 7104.6 7204.9 7268.0 16939.8 16961.0 16969.4 16988.7 17093.9 8141.2 8324.8 8328.0 8328.5 8329.7 7543.5 7624.5 7671.9 7771.2 7772.0 5099.3 5217.9 5237.6 5243.3 5282.1 1464.4 1550.1 1559.5 1579.3 1612.1 924.4 935.9 944.7 949.7 950.7 8713.7 8767.9 8784.5 8864.6 8891.8 989.6 1011.3 1011.7 1016.9 1036.6 4805.9 5265.6 5342.4 5640.8 5719.7 21491.7 21631.7 22244.7 22582.2 22984.7 22449.8 22478.4 22512.2 22543.2 22647.3 11398.9 11574.7 11859.2 11891.6 11926.9 8596.2 8596.7 8668.9 8736.2 8827.8 18339.4 18977.4 18987.0 19287.0 19649.1 19607.2 19791.2 19936.0 20381.0 20434.6 11119.7 11144.4 11231.6 11294.3 11363.0 14023.8 14096.8 14180.1 14197.7 14213.3 11234.2 11254.7 11459.8 11463.3 11588.4 10965.2 10975.8 10976.9 11072.6 11313.7 10060.2 10255.8 10273.7 10276.6 10281.6 6865.4 6920.9 6947.4 6990.9 7052.5 6702.3 6787.2 6845.8 6936.4 6955.8 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#4] prototype.html Cycles:180 Average:5572.88 Median:6240.19 stddev:1554.55 (24.9%) stddev-sans-first:1511.57 20:34:01 INFO - PID 3794 | Values: 500.0 507.8 538.7 539.3 541.3 6343.7 6369.4 6379.4 6454.7 6455.2 6131.4 6175.3 6226.5 6283.2 6298.0 4993.3 5042.2 5095.0 5145.5 5162.7 4863.7 5081.8 5093.2 5101.9 5114.6 5025.0 5047.0 5069.9 5075.5 5084.6 5002.8 5005.4 5035.0 5042.2 5063.5 4486.9 4557.6 4596.5 4600.3 4618.9 6225.4 6234.4 6283.6 6284.0 6307.7 5836.4 5837.7 5838.8 5845.1 5876.8 6626.1 6701.1 6712.6 6722.9 6758.8 4983.3 4987.3 4997.0 5002.5 5015.9 6938.2 6991.4 7029.9 7037.5 7101.9 5077.5 5115.4 5117.5 5133.7 5134.9 5175.9 5184.8 5193.7 5202.7 5203.1 5717.7 5724.8 5741.5 5788.7 5820.2 6599.6 6622.3 6639.2 6677.2 6696.2 1686.2 1740.8 1743.2 1772.3 1796.0 1210.2 1248.8 1253.6 1253.9 1257.7 5739.6 5741.0 5751.6 5795.5 5802.4 6407.4 6557.6 6620.7 6694.0 6717.2 5803.1 5827.4 5837.6 5847.9 5882.1 3557.1 3573.4 3590.8 3610.8 3634.1 6246.0 6434.3 6477.4 6502.5 6578.2 6946.4 6997.4 7000.3 7015.3 7023.4 6502.7 6507.9 6520.3 6535.4 6553.5 6590.5 6698.0 6702.2 6735.0 6743.9 6660.2 6683.8 6692.5 6693.4 6715.6 6402.6 6442.7 6475.9 6502.3 6509.9 5022.2 5022.3 5045.5 5070.1 5124.6 6873.8 6893.9 6912.1 6914.5 6938.1 6564.5 6577.4 6588.0 6616.7 6647.5 6302.0 6407.0 6506.5 6510.0 6580.8 6219.9 6374.1 6477.0 6565.3 6608.4 6651.7 6676.3 6689.0 6719.4 6738.7 6264.7 6319.8 6377.8 6386.9 6396.2 20:34:01 INFO - PID 3794 | 20:34:01 INFO - PID 3794 | [#5] yui.html Cycles:180 Average:24623.88 Median:18177.64 stddev:36177.35 (199.0%) stddev-sans-first:36234.99 20:34:01 INFO - PID 3794 | Values: 902.5 910.1 913.7 922.6 936.8 16610.2 17178.1 17249.1 19966.9 20344.6 19254.3 19289.7 19659.3 20907.0 21218.8 954.3 967.9 973.2 973.4 975.4 949.6 979.0 990.1 990.4 991.5 1052.5 1053.2 1054.1 1054.1 1055.0 1030.9 1036.9 1039.0 1041.1 1043.2 760.4 762.3 763.1 763.2 764.9 17966.1 18006.5 18154.4 18200.9 18234.3 20818.3 21543.6 21843.0 21849.7 21857.3 17100.7 17437.7 17589.9 17687.1 17718.0 3697.7 3716.7 3717.0 3727.1 3732.2 142170.3 143404.0 144816.0 146575.0 146644.3 16761.3 17069.5 17073.4 17182.7 17228.9 31184.7 31269.1 31400.1 31451.0 31619.8 7515.5 8173.4 9407.2 9457.2 9538.3 4217.0 4317.8 4329.7 4334.4 4358.7 5408.0 5511.4 5555.3 5573.6 5646.2 1031.1 1052.7 1059.0 1062.4 1063.5 654.7 672.4 687.6 689.1 690.1 11902.3 11923.0 12018.6 12873.2 12873.6 646.8 650.5 653.3 662.6 677.6 5453.3 5458.1 5507.2 5584.3 5644.0 117218.4 122549.4 125241.4 126452.0 127282.4 109794.5 113670.0 114196.4 115401.0 115804.4 92861.0 93771.0 94191.5 97206.5 97213.0 10503.7 10574.4 10617.6 10673.6 10741.8 43586.8 43606.1 43720.8 44492.3 44971.3 56230.0 57160.0 57768.0 58687.8 58696.7 15286.7 15759.7 15776.0 15838.7 15839.4 17178.7 17330.0 17398.7 17472.9 17606.7 15644.8 16059.4 16108.5 16221.8 16230.9 15323.2 15535.6 15580.7 15729.7 15746.8 15895.2 15987.2 16157.0 16177.1 16191.1 11457.9 11624.0 11856.1 11871.1 11875.7 11650.3 11832.1 11913.0 11945.8 12046.3 20:34:01 INFO - PID 3794 | -------- Summary: end -------- 20:34:01 INFO - PID 3794 | 20:34:01 INFO - TEST-INFO | 3794: exit 0 20:34:01 INFO - TEST-OK | dromaeo_css | took 1110420ms 20:34:01 INFO - TEST-START | kraken 20:34:01 INFO - Initialising browser for kraken test... 20:34:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33530/getInfo.html -profile /tmp/tmpjE5VT3/profile 20:34:01 INFO - TEST-INFO | started process 4174 (/builds/slave/test/build/application/firefox/firefox http://localhost:33530/getInfo.html) 20:34:06 INFO - TEST-INFO | 4174: exit 0 20:34:06 INFO - Browser initialized. 20:34:06 INFO - Running cycle 1/1 for kraken test... 20:34:06 INFO - Using env: {'DISPLAY': ':0', 20:34:06 INFO - 'HOME': '/home/cltbld', 20:34:06 INFO - 'JSGC_DISABLE_POISONING': '1', 20:34:06 INFO - 'LANG': 'en_US.UTF-8', 20:34:06 INFO - 'LANGUAGE': 'en_US:en', 20:34:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:34:06 INFO - 'LOGNAME': 'cltbld', 20:34:06 INFO - 'MAIL': '/var/mail/cltbld', 20:34:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:34:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:34:06 INFO - 'MOZ_CRASHREPORTER': '1', 20:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:34:06 INFO - 'MOZ_NO_REMOTE': '1', 20:34:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:06 INFO - 'NO_EM_RESTART': '1', 20:34:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:06 INFO - 'PWD': '/builds/slave/test', 20:34:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:34:06 INFO - 'RUST_BACKTRACE': 'full', 20:34:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:34:06 INFO - 'SHELL': '/bin/bash', 20:34:06 INFO - 'SHLVL': '1', 20:34:06 INFO - 'TERM': 'linux', 20:34:06 INFO - 'TMOUT': '86400', 20:34:06 INFO - 'USER': 'cltbld', 20:34:06 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506205436.627620-186675469', 20:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:06 INFO - '_': '/tools/buildbot/bin/python'} 20:34:06 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjE5VT3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:07 INFO - PID 4404 | 20:34:07 INFO - PID 4404 | (/builds/slave/test/build/application/firefox/firefox:4453): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:34:07 INFO - PID 4404 | 20:34:17 INFO - PID 4404 | RSS: Main: 153280512 20:34:17 INFO - PID 4404 | 20:34:20 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:21 INFO - PID 4404 | RSS: Main: 159461376 20:34:21 INFO - PID 4404 | 20:34:24 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-dft) 20:34:24 INFO - PID 4404 | RSS: Main: 159879168 20:34:24 INFO - PID 4404 | 20:34:27 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-fft) 20:34:28 INFO - PID 4404 | RSS: Main: 156278784 20:34:28 INFO - PID 4404 | 20:34:30 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-oscillator) 20:34:30 INFO - PID 4404 | RSS: Main: 156803072 20:34:30 INFO - PID 4404 | 20:34:32 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:33 INFO - PID 4404 | RSS: Main: 156766208 20:34:33 INFO - PID 4404 | 20:34:36 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:37 INFO - PID 4404 | RSS: Main: 158945280 20:34:37 INFO - PID 4404 | 20:34:41 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:41 INFO - PID 4404 | RSS: Main: 159678464 20:34:41 INFO - PID 4404 | 20:34:44 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33530/tests/kraken/driver.html?testName=json-parse-financial) 20:34:45 INFO - PID 4404 | RSS: Main: 159281152 20:34:45 INFO - PID 4404 | 20:34:46 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:47 INFO - PID 4404 | RSS: Main: 159555584 20:34:47 INFO - PID 4404 | 20:34:49 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:49 INFO - PID 4404 | RSS: Main: 159866880 20:34:49 INFO - PID 4404 | 20:34:51 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:52 INFO - PID 4404 | RSS: Main: 156430336 20:34:52 INFO - PID 4404 | 20:34:55 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:55 INFO - PID 4404 | RSS: Main: 156540928 20:34:55 INFO - PID 4404 | 20:34:58 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:59 INFO - PID 4404 | RSS: Main: 157323264 20:34:59 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33530/tests/kraken/driver.html?testName=ai-astar) 20:35:01 INFO - PID 4404 | RSS: Main: 158576640 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | __start_tp_report 20:35:01 INFO - PID 4404 | _x_x_mozilla_page_load 20:35:01 INFO - PID 4404 | _x_x_mozilla_page_load_details 20:35:01 INFO - PID 4404 | |i|pagename|runs| 20:35:01 INFO - PID 4404 | |0;ai-astar;110;108;109;109;109;108;108;107;110;108 20:35:01 INFO - PID 4404 | |1;audio-beat-detection;120;118;118;120;116;116;121;118;140;116 20:35:01 INFO - PID 4404 | |2;audio-dft;163;161;162;163;160;162;162;163;168;165 20:35:01 INFO - PID 4404 | |3;audio-fft;74;75;74;75;76;73;79;74;73;75 20:35:01 INFO - PID 4404 | |4;audio-oscillator;81;80;79;79;78;80;79;79;80;80 20:35:01 INFO - PID 4404 | |5;imaging-gaussian-blur;113;114;114;113;114;113;114;113;114;115 20:35:01 INFO - PID 4404 | |6;imaging-darkroom;154;148;148;148;148;147;148;149;149;149 20:35:01 INFO - PID 4404 | |7;imaging-desaturate;94;100;94;94;95;94;94;94;97;95 20:35:01 INFO - PID 4404 | |8;json-parse-financial;58;59;54;54;55;56;54;55;57;53 20:35:01 INFO - PID 4404 | |9;json-stringify-tinderbox;39;38;38;37;36;42;38;37;38;37 20:35:01 INFO - PID 4404 | |10;stanford-crypto-aes;80;77;73;74;73;75;75;75;76;74 20:35:01 INFO - PID 4404 | |11;stanford-crypto-ccm;111;116;110;113;122;114;121;109;123;110 20:35:01 INFO - PID 4404 | |12;stanford-crypto-pbkdf2;173;171;172;169;175;168;166;170;183;168 20:35:01 INFO - PID 4404 | |13;stanford-crypto-sha256-iterative;68;77;67;65;67;68;66;65;63;65 20:35:01 INFO - PID 4404 | __end_tp_report 20:35:01 INFO - PID 4404 | __start_cc_report 20:35:01 INFO - PID 4404 | _x_x_mozilla_cycle_collect,734 20:35:01 INFO - PID 4404 | __end_cc_report 20:35:01 INFO - PID 4404 | __startTimestamp1506224101266__endTimestamp 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | ------- Summary: start ------- 20:35:01 INFO - PID 4404 | Number of tests: 14 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 20:35:01 INFO - PID 4404 | Values: 110.0 108.0 109.0 109.0 109.0 108.0 108.0 107.0 110.0 108.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:119.00 stddev:7.15 (6.0%) stddev-sans-first:7.58 20:35:01 INFO - PID 4404 | Values: 120.0 118.0 118.0 120.0 116.0 116.0 121.0 118.0 140.0 116.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.23 (1.4%) stddev-sans-first:2.37 20:35:01 INFO - PID 4404 | Values: 163.0 161.0 162.0 163.0 160.0 162.0 162.0 163.0 168.0 165.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#3] audio-fft Cycles:10 Average:74.80 Median:75.00 stddev:1.75 (2.3%) stddev-sans-first:1.83 20:35:01 INFO - PID 4404 | Values: 74.0 75.0 74.0 75.0 76.0 73.0 79.0 74.0 73.0 75.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:80.00 stddev:0.85 (1.1%) stddev-sans-first:0.71 20:35:01 INFO - PID 4404 | Values: 81.0 80.0 79.0 79.0 78.0 80.0 79.0 79.0 80.0 80.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 20:35:01 INFO - PID 4404 | Values: 113.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 114.0 115.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.93 (1.3%) stddev-sans-first:0.67 20:35:01 INFO - PID 4404 | Values: 154.0 148.0 148.0 148.0 148.0 147.0 148.0 149.0 149.0 149.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:1.97 (2.1%) stddev-sans-first:2.05 20:35:01 INFO - PID 4404 | Values: 94.0 100.0 94.0 94.0 95.0 94.0 94.0 94.0 97.0 95.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:1.96 (3.5%) stddev-sans-first:1.86 20:35:01 INFO - PID 4404 | Values: 58.0 59.0 54.0 54.0 55.0 56.0 54.0 55.0 57.0 53.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:1.63 (4.3%) stddev-sans-first:1.69 20:35:01 INFO - PID 4404 | Values: 39.0 38.0 38.0 37.0 36.0 42.0 38.0 37.0 38.0 37.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.10 (2.8%) stddev-sans-first:1.32 20:35:01 INFO - PID 4404 | Values: 80.0 77.0 73.0 74.0 73.0 75.0 75.0 75.0 76.0 74.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:115.00 stddev:5.34 (4.6%) stddev-sans-first:5.48 20:35:01 INFO - PID 4404 | Values: 111.0 116.0 110.0 113.0 122.0 114.0 121.0 109.0 123.0 110.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.50 stddev:4.84 (2.8%) stddev-sans-first:5.10 20:35:01 INFO - PID 4404 | Values: 173.0 171.0 172.0 169.0 175.0 168.0 166.0 170.0 183.0 168.0 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:3.81 (5.7%) stddev-sans-first:4.03 20:35:01 INFO - PID 4404 | Values: 68.0 77.0 67.0 65.0 67.0 68.0 66.0 65.0 63.0 65.0 20:35:01 INFO - PID 4404 | -------- Summary: end -------- 20:35:01 INFO - PID 4404 | 20:35:01 INFO - PID 4404 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:35:01 INFO - TEST-INFO | 4404: exit 0 20:35:01 INFO - TEST-OK | kraken | took 60223ms 20:35:01 INFO - SUITE-END | took 1170s 20:35:02 INFO - Completed test suite (00:19:31) 20:35:02 INFO - javascript benchmark 20:35:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8585.528706077046, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.1822526143205, 3170.4451720948837, 3185.8407079646026, 3192.0902542775316, 3205.6634053424377, 6270.31026587075, 6404.775832845851, 6467.191601049869, 6474.643894585802, 6491.935080649192, 6337.841553961153, 6358.650274234915, 6383.265924418693, 6392.712327945242, 6405.4875609951205, 5813.157092221625, 5852.561057920651, 5875.970620146893, 5892.852678683024, 5917.467427931485, 5911.142884281798, 5915.704214789243, 5984.491318237955, 5992.041273396258, 6034.426729460694, 5947.821565353046, 5964.582479226456, 6024.2770867495965, 6028.336882942895, 6053.092036194584, 5681.801136960228, 5793.565482588822, 5804.419558044204, 5926.199963005025, 5957.821265362046, 5866.413358664142, 5876.794312199053, 5939.07944268639, 5939.2575928009, 5960.403959604005, 6194.194754681863, 6316.210473690789, 6398.104265402847, 6478.190226221723, 6490.415862572391, 6734.865302693918, 6787.592744435349, 6789.966050169767, 6790.898136527956, 6816.420604248645, 6931.3415225554, 6935.133108361455, 6943.270956549591, 6944.0, 6945.305469453065, 6318.147050148263, 6320.525960552977, 6392.7123279452535, 6398.16823812906, 6398.808035758934, 6947.826304342432, 7002.754903578452, 7095.538789978635, 7110.5022648414115, 7114.430845532345, 6482.027695845567, 6563.245226798884, 6626.039224312448, 6628.0, 6651.933480665228, 6799.218089919624, 6809.659517024228, 6911.827204319831, 6913.5506192097355, 6933.0986971693355, 6788.660566971632, 6829.214640316328, 6873.553219040747, 6881.380675739208, 6887.2079710832895, 6833.965830170818, 6836.316368363124, 6916.757913473004, 6923.134608173978, 6934.063901373351, 5217.660852044605, 5327.600429967768, 5346.0, 5346.224797404432, 5395.649282796684, 4655.86032419028, 4712.976435117803, 4750.8337208197545, 4782.282657601318, 4799.016201678717, 5787.479126878601, 5881.941180588139, 5912.73392697321, 5916.526677865761, 5917.970410147922, 6841.2132604750095, 6845.657717114224, 6876.587404755731, 6946.826329341807, 6947.861042779217, 5742.598018138774, 5834.854128646818, 5848.64908105515, 5908.379620139824, 5923.644581325134, 5823.7379317929945, 5841.912371314434, 5851.210086638334, 5853.0, 5925.73334199962, 6642.202935647753, 6697.129373181455, 6723.428508576826, 6729.25978142404, 6741.022551729971, 6880.346367095118, 6905.0, 6977.406920411822, 6991.475639327173, 7004.089468369079, 6457.515686323639, 6638.269790323157, 6647.401733843977, 6734.461243100638, 6740.528163028541, 6667.833304167435, 6729.495287853332, 6778.8644227116165, 6780.0, 6783.59298442095, 6863.725450981905, 6933.341332573397, 6943.0, 6974.476914231352, 6981.860362792614, 6656.0, 6684.766033188815, 6726.3609957054005, 6748.426383757239, 6753.966230168818, 6519.054737063005, 6624.9337506624315, 6649.966750166218, 6711.4966377520905, 6745.5952642841585, 6599.901001485077, 6620.3710647488415, 6627.403533681992, 6632.336766323329, 6647.069410282467, 6528.771492997722, 6692.966535167293, 6758.222804377559, 6766.830829229309, 6773.221079575912, 6198.6280823150755, 6405.551611387158, 6447.065175549613, 6517.120188774645, 6528.314526974599], "value": 6242.454599774584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.1540090499547, 780.2938340801574, 782.3623746646484, 786.594903624633, 791.5171745235409, 42665.78667106664, 44214.33678494825, 44238.33642495357, 44282.55717442824, 44378.778106109465, 39796.403053954215, 39864.40203396951, 39955.800220998855, 40035.59964400355, 40071.59928400715, 7112.786616401516, 7233.855322893539, 7235.855282894339, 7239.6742146603265, 7241.927580724205, 7164.068671072753, 7246.420286377077, 7250.637468126599, 7255.129384473844, 7257.8911316330295, 8024.277814996649, 8190.017197936226, 8201.917980820204, 8210.096889342167, 8223.917760822405, 8097.51414915104, 8141.22658347456, 8174.141715119946, 8184.263416292562, 8189.3857960652895, 7745.651445684957, 7917.406194535433, 7952.483088599222, 7954.085280192736, 7979.241972012649, 38142.42786358207, 38513.22973540513, 38545.421818672745, 38549.42175867364, 38633.42049869254, 3518.2787528556582, 3558.946615800765, 3569.196930690574, 3575.0704816747575, 3576.0344706929245, 31000.53499197514, 31027.689723102932, 31102.37795244105, 31195.064148075366, 31285.530717039263, 5235.58115350771, 5236.554892834114, 5241.659292146036, 5261.842144735664, 5284.682919024871, 177936.1103194476, 187823.0608846947, 189961.0, 190653.0, 190952.0, 42840.0, 49020.26469602959, 49995.250071248964, 50044.249336259985, 50049.74975125101, 51600.48399515957, 51962.740186298826, 51992.0, 52005.7399712999, 52039.0, 16586.336546538005, 16623.0, 16660.41688540895, 16662.66674666524, 16755.664886702198, 13782.65543361424, 13793.0, 13806.585802425943, 13809.723805523834, 13834.169949802843, 14381.64045898861, 14527.184101987252, 14538.709225815424, 14576.635584110481, 14632.926835365755, 5770.740316685759, 5965.403459654087, 5985.700714964234, 5998.130271110665, 6032.125341825411, 1006.2754816532085, 1022.4989755019986, 1024.656739992111, 1028.4908970059869, 1029.9382037077798, 23635.88182059079, 23763.762362376154, 23788.643170352458, 23803.642945355834, 23852.880735596213, 1120.641394753671, 1126.4480404601686, 1127.4193790198055, 1135.8750537440874, 1141.0757286597882, 12373.0, 12548.68628284282, 12593.748125037448, 12609.495620175274, 12688.17526860751, 222605.0, 224711.0, 224722.0, 224734.0, 225008.0, 54641.726791366586, 54898.0, 55156.72421637866, 55255.44744552583, 55381.169282460796, 1445.8843292536571, 1459.810224670786, 1486.9776953345709, 1491.7986071880375, 1495.5887131038833, 23571.41071473227, 23582.528349433258, 23721.051157953487, 23764.0, 23831.761682382956, 39830.0, 39885.0, 39907.40138897861, 39949.60050399459, 39975.600243997185, 200044.0, 200146.0, 200190.0, 200474.0, 200617.0, 31381.52927706132, 32131.357372851944, 35439.0, 35713.64286357207, 36459.45310820287, 42550.57449425466, 44565.0, 44852.0, 44980.32529511995, 45076.0, 32131.0, 32262.354752904343, 32288.192795180308, 32476.675233248312, 32687.50968735423, 31814.0, 31855.36289274248, 32557.02328930136, 32616.34767304688, 32650.183745406553, 36180.4572931401, 36212.63787362093, 36250.456243155844, 36528.45207321839, 36588.26823463569, 31716.442140070776, 31906.840465797522, 32038.679613204502, 32239.0, 32320.676793231767, 23449.648255275843, 23834.761652383255, 24021.27936161918, 24223.75776242215, 24289.0], "value": 17358.73234953442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8890666320069, 577.8728679690472, 595.6009473652653, 602.3735315272116, 603.0923460192411, 21903.561928761414, 22644.207452739156, 22657.54684906301, 22826.885865570668, 22832.315030549067, 22718.0, 24143.275701728933, 24235.151769688066, 24347.0, 24388.0, 6584.604923704581, 6651.135352404181, 6672.799816005503, 6673.0991316172185, 6689.163854518185, 6392.137061496708, 6551.377619126175, 6573.046908198308, 6657.167854018247, 6722.3613756693285, 6642.6014439133805, 6657.068010478537, 6658.400743933045, 6663.366980136903, 6672.466202703797, 6641.468682505436, 6649.667516624174, 6658.234303055162, 6664.266930637626, 6686.465082793389, 5777.826665200051, 5998.4601385875485, 6001.699915004276, 6002.2197114375285, 6003.159557661931, 27072.86463567689, 27476.58785118225, 27512.862435687894, 27514.587281190597, 27603.447931041468, 2083.6041152181187, 2088.853780235384, 2094.7381577302835, 2098.3390232077, 2106.631339515594, 18972.241110355706, 19251.61496770071, 19487.22051117968, 19564.217431302874, 19593.314234001886, 2462.212092130519, 2473.146764366291, 2509.222141136235, 2532.898684052636, 2543.872806359693, 116288.0, 122659.38670306592, 132009.33995330057, 137362.3131884344, 138233.0, 14640.341184646717, 14711.014013108308, 14989.852131052383, 15383.846161538466, 15846.920765396098, 23520.411989700395, 23541.0, 23568.29295121149, 23632.645510317358, 23701.0, 9945.602175912882, 9980.0, 10098.596056157818, 10244.795104097877, 10271.589136434459, 9140.771480713036, 9152.771180720401, 9158.95420522893, 9250.074992500831, 9367.765805854908, 9155.0, 9162.633494660273, 9187.724368268962, 9207.90792092084, 9318.30112741547, 2731.713170117149, 2777.3056735816044, 2807.8455684937526, 2876.395956849085, 2886.1774394297945, 957.5547370472764, 964.840801267797, 975.9170470510086, 987.2792861211356, 990.6978371596732, 18907.810921890607, 19048.142833572245, 19156.616867662848, 19524.902375488033, 19602.607947840963, 1036.3678156324636, 1039.3452125161252, 1040.3653771199563, 1042.5621239079605, 1047.1308813684623, 10479.47602619866, 10493.0, 10520.526576304084, 10627.202959778047, 10685.198610104118, 455773.0, 467893.0, 469243.0, 471398.0, 471859.0, 110029.44985275023, 110600.0, 111823.0, 113649.0, 114613.42693286647, 1147.0995268714018, 1163.0985985860857, 1186.6677330347516, 1187.3350923482876, 1187.5606025770521, 16860.57848553796, 16865.0, 16935.121029425274, 16992.66014679675, 17124.14379281056, 52292.0, 53097.20354194613, 53380.0, 53722.73138634282, 56283.71858140683, 68354.65822670855, 68576.6571167141, 68681.65659171873, 69247.65376173086, 69360.30639693538, 14231.64420889486, 14236.928815355857, 14411.207383594003, 14455.927720361751, 14534.127952322895, 21876.78123218811, 21986.340409787732, 22336.77663223347, 22552.097916083174, 22624.886875565517, 16878.66242675115, 16932.238049287564, 17014.744778828575, 17622.559436014202, 18055.00697461652, 15768.211589420713, 16089.75865361997, 16230.756538651693, 16698.165091745606, 16930.238139284007, 17236.310547577956, 17743.20155593027, 17770.822291777433, 18539.90730046395, 18615.720764188278, 14058.78911816344, 14120.50578229757, 14128.646783830487, 14193.29033548339, 14255.50105746294, 17156.656866862344, 17215.053172075655, 17380.39168629092, 17776.37782677652, 18081.547961301072], "value": 11785.305389410758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.8778416050477, 1364.4951367993845, 1387.0221493846836, 1388.9722205555888, 1397.7693680542711, 15114.697706045887, 15762.921185394058, 15786.210689465524, 15794.210289485509, 15813.999999999985, 15327.846721532782, 15536.22318884057, 15567.065976041446, 15570.0, 15576.143312117829, 2816.2677703796953, 2818.3095141690264, 2876.209042513315, 2879.640044994376, 2880.2367372646268, 2750.8899644014214, 2812.70466601007, 2813.7186281371905, 2824.4209936962875, 2831.1223520708545, 2772.88908443662, 2775.264554892955, 2798.1605518344413, 2871.5405535114387, 2871.698471660477, 2810.7610853077513, 2851.2159156231996, 2853.343730941895, 2853.6147620071233, 2867.9713202868015, 2664.9067282645015, 2704.0806125917284, 2723.1694333228356, 2724.6866610339866, 2732.53546897028, 15230.923845380814, 15369.154696491689, 15387.846121538865, 15392.846071539254, 15393.923030384889, 7871.645775940096, 8093.069297030858, 8142.47073940192, 8143.226393492609, 8168.632411541435, 5356.1430171172815, 5523.4200408956885, 5581.079121944874, 5641.746121424546, 5646.604737668365, 1907.1513176636402, 1914.818092281231, 1953.9023048847644, 1993.2027189124321, 2011.7384739983854, 26885.596716049276, 27088.729112708817, 27127.593086103527, 27266.727332726616, 27411.725882741117, 6899.206591242071, 7074.186468556182, 7104.609246491493, 7204.855902881913, 7267.963660181666, 16939.830601693826, 16961.0, 16969.406070787463, 16988.74516882248, 17093.914530427268, 8141.185881411811, 8324.833503329899, 8328.042275138316, 8328.500289982621, 8329.708460203863, 7543.47195696307, 7624.466287359943, 7671.923280767232, 7771.222877712184, 7771.961140194376, 5099.260607211933, 5217.921731174036, 5237.6071794615555, 5243.2659427680155, 5282.075636763551, 1464.421553486367, 1550.1474189195897, 1559.5165498695442, 1579.3287852662572, 1612.11333766428, 924.4129977464224, 935.9157675809209, 944.7024187380953, 949.7340744591526, 950.6577632052456, 8713.738587842376, 8767.868481972775, 8784.516851573097, 8864.64541418349, 8891.822163556693, 989.569537251298, 1011.3072545306488, 1011.726833754882, 1016.913562347194, 1036.6371769880482, 4805.879853003633, 5265.6309359566785, 5342.358916929993, 5640.830775076754, 5719.7140142992685, 21491.67762483564, 21631.67552486714, 22244.66633000474, 22582.20962266313, 22984.65523017156, 22449.775502245095, 22478.438039048826, 22512.21207257771, 22543.210987615355, 22647.320580382613, 11398.886011139783, 11574.710632234093, 11859.16985810985, 11891.583794567148, 11926.88073119275, 8596.226339629464, 8596.656133754579, 8668.869966950628, 8736.213740763362, 8827.779305517157, 18339.449816505527, 18977.43067707971, 18987.0, 19287.035648217814, 19649.115789789208, 19607.215711371384, 19791.208351665773, 19936.0, 20380.980950952096, 20434.59130817405, 11119.666410007712, 11144.387058711849, 11231.606893758679, 11294.322340659586, 11363.0, 14023.789643155565, 14096.78854817158, 14180.14919104857, 14197.716045678822, 14213.289335532974, 11234.213605047567, 11254.662360129209, 11459.770804584028, 11463.31220126795, 11588.362640054878, 10965.232433729563, 10975.780484390427, 10976.890231097586, 11072.557097716, 11313.660590182308, 10060.245481589056, 10255.84616230772, 10273.691789246335, 10276.640317588848, 10281.588736450758, 6865.41643960269, 6920.9307906920285, 6947.44420446353, 6990.860182796418, 7052.5063245574365, 6702.296258892746, 6787.151606049244, 6845.828854278484, 6936.445084393337, 6955.791326260221], "value": 6835.164964220333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.9850004499865, 507.7715028237294, 538.7252501224376, 539.344696194124, 541.320642593545, 6343.74625015, 6369.394907483793, 6379.425851673354, 6454.677266136686, 6455.22537295524, 6131.417515336036, 6175.258968923736, 6226.533010024244, 6283.246010478749, 6297.984644913629, 4993.275974983625, 5042.218456139304, 5095.0, 5145.536901678848, 5162.716050617215, 4863.708177509343, 5081.8475445736685, 5093.236014597803, 5101.923471147918, 5114.565261952738, 5024.9748751256375, 5047.0, 5069.949300506984, 5075.492450754932, 5084.593232541388, 5002.77487513061, 5005.374328208974, 5034.974825125869, 5042.168042273021, 5063.493650634944, 4486.932696009562, 4557.632710186964, 4596.49438561758, 4600.2869555218995, 4618.861434156981, 6225.439710426083, 6234.407731265568, 6283.622982621012, 6284.0, 6307.653079080649, 5836.38717934615, 5837.664934026381, 5838.824835254949, 5845.09401042839, 5876.823695289148, 6626.123717625195, 6701.095352127498, 6712.597244165366, 6722.865542689119, 6758.763443279511, 4983.25251212321, 4987.251912213161, 4996.9500304996845, 5002.52476014778, 5015.874603134915, 6938.236793952661, 6991.428057625815, 7029.8945515816795, 7037.542559733601, 7101.86943916828, 5077.517635824591, 5115.386153661584, 5117.488251174853, 5133.715496603975, 5134.922976155286, 5175.870603234949, 5184.7926082956255, 5193.688378697215, 5202.687838729688, 5203.141481655484, 5717.656940583578, 5724.790440698944, 5741.45456181662, 5788.681622510802, 5820.243368362086, 6599.571027883172, 6622.2715501294815, 6639.170103737033, 6677.165354330708, 6696.229933557605, 1686.2411914638217, 1740.7649967254258, 1743.1632816248273, 1772.3442326339336, 1796.0, 1210.1710328425056, 1248.8126780982743, 1253.6239128261484, 1253.9184952978028, 1257.69186549296, 5739.569532285095, 5741.0, 5751.597388182787, 5795.507381872588, 5802.448767367094, 6407.359264073649, 6557.639329836809, 6620.66896655175, 6694.0, 6717.16035495563, 5803.100519419497, 5827.446392592697, 5837.591368604157, 5847.94152058474, 5882.117682347682, 3557.079177244311, 3573.356795776733, 3590.838412271454, 3610.819459027038, 3634.1459756957092, 6245.96877015612, 6434.324395938359, 6477.449416799531, 6502.544821862424, 6578.243501997236, 6946.444284457231, 6997.370236678622, 7000.2999700030605, 7015.263397343206, 7023.438124949992, 6502.6748662567625, 6507.902381464377, 6520.347965203537, 6535.444871858882, 6553.475721942328, 6590.472762178918, 6698.0, 6702.229243637044, 6734.966325168539, 6743.88622940016, 6660.234073081464, 6683.7660681875905, 6692.4903161314505, 6693.389578064462, 6715.56348837324, 6402.551821372459, 6442.710078046405, 6475.902861456988, 6502.3172566881685, 6509.902351464637, 5022.171341728574, 5022.347094877789, 5045.5459008689395, 5070.138076527073, 5124.615653826053, 6873.759418420332, 6893.896976483939, 6912.066870972354, 6914.5159838812815, 6938.132733408324, 6564.4748420127235, 6577.408033277028, 6587.9670601646685, 6616.7022483987375, 6647.4682025438815, 6302.0, 6406.981800732754, 6506.49499942535, 6510.014445594139, 6580.835479112869, 6219.937800621936, 6374.139491168633, 6476.996065609649, 6565.277819439762, 6608.43828274602, 6651.667416629246, 6676.298988606127, 6688.966555167388, 6719.361660642231, 6738.6967586459705, 6264.718087686157, 6319.778807741707, 6377.808665740035, 6386.904196436964, 6396.200474940632], "value": 5115.873328869982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.5397047505775, 910.0853642089698, 913.7167478081791, 922.6493932305727, 936.793905340825, 16610.16949152542, 17178.141092945367, 17249.13754312284, 19966.90016549915, 20344.593108137866, 19254.326098586553, 19289.710654340197, 19659.31192408266, 20907.0, 21218.787812121875, 954.2652157838478, 967.9419234845897, 973.2068364283122, 973.3819024919156, 975.4098770244007, 949.6106596295521, 978.9755256118618, 990.1385794358918, 990.4404011733384, 991.4844280973925, 1052.489542571852, 1053.2469284461608, 1054.098745572536, 1054.1356088007838, 1054.96307629233, 1030.9072183503445, 1036.8548403223556, 1038.9844152337682, 1041.1358572384902, 1043.2071625564588, 760.3536993555433, 762.3481922955904, 763.118598019283, 763.2253262938123, 764.8967389402416, 17966.101694915204, 18006.549836254067, 18154.364597239164, 18200.908995454938, 18234.270629174818, 20818.27136050231, 21543.569128617495, 21843.0, 21849.67225491619, 21857.344279671634, 17100.657986840193, 17437.651246975118, 17589.912050439794, 17687.115644217865, 17718.02550859702, 3697.722670799674, 3716.7026637868908, 3717.0, 3727.0682329417646, 3732.216234590739, 142170.28914855464, 143404.0, 144815.99999999895, 146575.0, 146644.26677866542, 16761.329546818233, 17069.48791536256, 17073.40243091486, 17182.65634687299, 17228.91385543064, 31184.688153118634, 31269.061928142193, 31400.05799826009, 31451.0, 31619.84190079035, 7515.549067055994, 8173.427860049739, 9407.247420206504, 9457.243420526342, 9538.284628652878, 4216.957830421657, 4317.84887528935, 4329.653627709776, 4334.371516130143, 4358.738475691469, 5408.02655522002, 5511.448855114537, 5555.2778138841695, 5573.637713548606, 5646.181303711021, 1031.0771859185986, 1052.6947185316174, 1058.9894101058892, 1062.4156713807374, 1063.5107850388754, 654.653033892038, 672.3780503034772, 687.6252442418894, 689.1489011071322, 690.1235431002599, 11902.285862848257, 11923.0, 12018.639440816789, 12873.163244389085, 12873.613791586267, 646.809191288571, 650.4666173737489, 653.3368630839701, 662.5560874214192, 677.5663575311804, 5453.318335208099, 5458.1266997280245, 5507.173923911365, 5584.274044374205, 5644.01229784786, 117218.41390793162, 122549.38725306316, 125241.37379313045, 126452.0, 127282.36358818147, 109794.45102774595, 113670.0, 114196.42901785437, 115401.0, 115804.42097789457, 92861.0, 93771.0, 94191.52904235435, 97206.51396742971, 97213.02786972182, 10503.737406564896, 10574.41840698769, 10617.575296988343, 10673.57305707763, 10741.785164296827, 43586.782066089465, 43606.12787744291, 43720.78139609282, 44492.33261501016, 44971.32543011792, 56230.0, 57160.0, 57768.0, 58687.82624347575, 58696.706516468854, 15286.694266114839, 15759.68480630404, 15776.0, 15838.68322633564, 15839.445619403266, 17178.656426871643, 17330.0, 17398.73901891498, 17472.91263543674, 17606.735898961782, 15644.765328519854, 16059.357625694842, 16108.516744497216, 16221.837781622033, 16230.918845405697, 15323.157226352658, 15535.611609709847, 15580.68838623244, 15729.68540629204, 15746.763798542803, 15895.205239738198, 15987.200639968187, 16157.0, 16177.11025893587, 16191.10948897822, 11457.885421146015, 11624.0, 11856.11079169083, 11871.109666774853, 11875.703107422383, 11650.30098194111, 11832.112591555495, 11912.98739607143, 11945.761084778429, 12046.337451440255], "value": 8967.976461512095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 109.0, 109.0, 109.0, 108.0, 108.0, 107.0, 110.0, 108.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 120.0, 116.0, 116.0, 121.0, 118.0, 140.0, 116.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 160.0, 162.0, 162.0, 163.0, 168.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 75.0, 76.0, 73.0, 79.0, 74.0, 73.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 78.0, 80.0, 79.0, 79.0, 80.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 97.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 54.0, 54.0, 55.0, 56.0, 54.0, 55.0, 57.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 37.0, 36.0, 42.0, 38.0, 37.0, 38.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 73.0, 74.0, 73.0, 75.0, 75.0, 75.0, 76.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 110.0, 113.0, 122.0, 114.0, 121.0, 109.0, 123.0, 110.0], "value": 114.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 172.0, 169.0, 175.0, 168.0, 166.0, 170.0, 183.0, 168.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 67.0, 65.0, 67.0, 68.0, 66.0, 65.0, 63.0, 65.0], "value": 67.1, "unit": "score"}]}]} 20:35:02 INFO - Return code: 0 20:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:02 INFO - # TBPL SUCCESS # 20:35:02 INFO - Running post-action listener: _package_coverage_data 20:35:02 INFO - Running post-action listener: _resource_record_post_action 20:35:02 INFO - [mozharness: 2017-09-24 03:35:02.531030Z] Finished run-tests step (success) 20:35:02 INFO - Running post-run listener: _resource_record_post_run 20:35:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 9035776; Write bytes: 525250560; Read time: 2624; Write time: 320460 20:35:02 INFO - TinderboxPrint: CPU usage
13.1% 20:35:02 INFO - TinderboxPrint: I/O read bytes / time
9,035,776 / 2,624 20:35:02 INFO - TinderboxPrint: I/O write bytes / time
525,250,560 / 320,460 20:35:02 INFO - TinderboxPrint: CPU idle
8,234.2 (86.9%) 20:35:02 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 20:35:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 197365760; Read time: 152; Write time: 131508 20:35:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:35:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 6799360; Write bytes: 327884800; Read time: 2284; Write time: 188952 20:35:03 INFO - Running post-run listener: _upload_blobber_files 20:35:03 INFO - Blob upload gear active. 20:35:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:03 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 20:35:03 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'] 20:35:03 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 20:35:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:04 INFO - (blobuploader) - INFO - Done attempting. 20:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:05 INFO - (blobuploader) - INFO - Done attempting. 20:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:12 INFO - (blobuploader) - INFO - Done attempting. 20:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:13 INFO - (blobuploader) - INFO - Done attempting. 20:35:13 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:13 INFO - Return code: 0 20:35:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c7394232e79cb1bf274c40bbadde65c7e9517d4f6ac63b98acbc9b98c0b7abd4df33fafb0f29c7518cc89a57f2c12d11cdbbc82f6d175b22fe66128f79fea0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dde4754c2a9bc06e081d4c48cb1fa2fe6e429e977eb7b43ec3aa8f4985be1062840483ab6068889ce9cd7e7efdc5b59146eb5d236769505d2a0853d54772de08", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86bbf50c918affc798fc7fcf58fbf346e93dabb9eccc813e30a0cc19b11161a55f51180e622f889d08068c04d96fc1120f75981e1268a722a1640528d29a230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8919b4a22f9de939b447c1204755d5460437e3bdcb163ddf0f74283e0fe751d52e71bc676f425039cdf1cb48bd0a0c52ff851ca06ac9d0338795c4347f7735d"} 20:35:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:13 INFO - Contents: 20:35:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c7394232e79cb1bf274c40bbadde65c7e9517d4f6ac63b98acbc9b98c0b7abd4df33fafb0f29c7518cc89a57f2c12d11cdbbc82f6d175b22fe66128f79fea0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dde4754c2a9bc06e081d4c48cb1fa2fe6e429e977eb7b43ec3aa8f4985be1062840483ab6068889ce9cd7e7efdc5b59146eb5d236769505d2a0853d54772de08", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86bbf50c918affc798fc7fcf58fbf346e93dabb9eccc813e30a0cc19b11161a55f51180e622f889d08068c04d96fc1120f75981e1268a722a1640528d29a230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8919b4a22f9de939b447c1204755d5460437e3bdcb163ddf0f74283e0fe751d52e71bc676f425039cdf1cb48bd0a0c52ff851ca06ac9d0338795c4347f7735d"} 20:35:13 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:13 INFO - Copying logs to upload dir... 20:35:13 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.496101 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-23 20:35:13.926159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:13.930087) ========= 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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c7394232e79cb1bf274c40bbadde65c7e9517d4f6ac63b98acbc9b98c0b7abd4df33fafb0f29c7518cc89a57f2c12d11cdbbc82f6d175b22fe66128f79fea0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dde4754c2a9bc06e081d4c48cb1fa2fe6e429e977eb7b43ec3aa8f4985be1062840483ab6068889ce9cd7e7efdc5b59146eb5d236769505d2a0853d54772de08", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86bbf50c918affc798fc7fcf58fbf346e93dabb9eccc813e30a0cc19b11161a55f51180e622f889d08068c04d96fc1120f75981e1268a722a1640528d29a230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8919b4a22f9de939b447c1204755d5460437e3bdcb163ddf0f74283e0fe751d52e71bc676f425039cdf1cb48bd0a0c52ff851ca06ac9d0338795c4347f7735d"} build_url:https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/ShKXziekTvWG-QSzPkbAOw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c7394232e79cb1bf274c40bbadde65c7e9517d4f6ac63b98acbc9b98c0b7abd4df33fafb0f29c7518cc89a57f2c12d11cdbbc82f6d175b22fe66128f79fea0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dde4754c2a9bc06e081d4c48cb1fa2fe6e429e977eb7b43ec3aa8f4985be1062840483ab6068889ce9cd7e7efdc5b59146eb5d236769505d2a0853d54772de08", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86bbf50c918affc798fc7fcf58fbf346e93dabb9eccc813e30a0cc19b11161a55f51180e622f889d08068c04d96fc1120f75981e1268a722a1640528d29a230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8919b4a22f9de939b447c1204755d5460437e3bdcb163ddf0f74283e0fe751d52e71bc676f425039cdf1cb48bd0a0c52ff851ca06ac9d0338795c4347f7735d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:13.958124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:13.958453) ========= 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=483e410453545d07cca6935c000001ab-1506205436.627620-186675469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:35:14.040504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:35:14.040885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:35:14.041203) ========= ========= Total master_lag: 0.22 =========