builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1503452496.45 results: success (0) revision: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.452807) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.453264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.453604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.469540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.469826) ========= 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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 18:41:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-08-22 18:41:36 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.604831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.605133) ========= 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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018989 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:36.654365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 18:41:36.654712) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae --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 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae --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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 18:41:37,021 truncating revision to first 12 chars 2017-08-22 18:41:37,021 Setting DEBUG logging. 2017-08-22 18:41:37,021 attempt 1/10 2017-08-22 18:41:37,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c50f0c999c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 18:41:38,090 unpacking tar archive at: mozilla-central-7c50f0c999c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383957 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 18:41:38.053331) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:38.053669) ========= script_repo_revision: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:38.054059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:38.054325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 18:41:38.064756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-22 18:41:38.065040) ========= /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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:41:38 INFO - MultiFileLogger online at 20170822 18:41:38 in /builds/slave/test 18:41:38 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 18:41:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:38 INFO - {'append_to_log': False, 18:41:38 INFO - 'base_work_dir': '/builds/slave/test', 18:41:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:41:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:38 INFO - 'branch': 'Firefox-Non-PGO', 18:41:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:38 INFO - 'code_coverage': False, 18:41:38 INFO - 'config_files': ('talos/linux_config.py',), 18:41:38 INFO - 'default_actions': ('clobber', 18:41:38 INFO - 'read-buildbot-config', 18:41:38 INFO - 'download-and-extract', 18:41:38 INFO - 'populate-webroot', 18:41:38 INFO - 'create-virtualenv', 18:41:38 INFO - 'install', 18:41:38 INFO - 'setup-mitmproxy', 18:41:38 INFO - 'run-tests'), 18:41:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:38 INFO - 'disable_ccov_upload': False, 18:41:38 INFO - 'download_minidump_stackwalk': True, 18:41:38 INFO - 'download_symbols': 'ondemand', 18:41:38 INFO - 'enable_stylo': False, 18:41:38 INFO - 'enable_webrender': False, 18:41:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:41:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:41:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:41:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:41:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:38 INFO - 'gecko_profile': False, 18:41:38 INFO - 'gecko_profile_interval': 0, 18:41:38 INFO - 'installer_path': 'installer.exe', 18:41:38 INFO - 'log_level': 'info', 18:41:38 INFO - 'log_name': 'talos', 18:41:38 INFO - 'log_to_console': True, 18:41:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:41:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:41:38 INFO - 'opt_config_files': (), 18:41:38 INFO - 'pip_index': False, 18:41:38 INFO - 'suite': 'dromaeojs-e10s', 18:41:38 INFO - 'system_bits': '32', 18:41:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:38 INFO - 'title': 'talos-linux64-ix-059', 18:41:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:38 INFO - 'use_talos_json': True, 18:41:38 INFO - 'verify': 'False', 18:41:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:38 INFO - 'work_dir': 'build'} 18:41:38 INFO - [mozharness: 2017-08-23 01:41:38.578645Z] Running clobber step. 18:41:38 INFO - Running pre-action listener: _resource_record_pre_action 18:41:38 INFO - Running main action method: clobber 18:41:38 INFO - rmtree: /builds/slave/test/build 18:41:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:40 INFO - Running post-action listener: _resource_record_post_action 18:41:40 INFO - [mozharness: 2017-08-23 01:41:40.116973Z] Finished clobber step (success) 18:41:40 INFO - [mozharness: 2017-08-23 01:41:40.117071Z] Running read-buildbot-config step. 18:41:40 INFO - Running pre-action listener: _resource_record_pre_action 18:41:40 INFO - Running main action method: read_buildbot_config 18:41:40 INFO - Using buildbot properties: 18:41:40 INFO - { 18:41:40 INFO - "project": "", 18:41:40 INFO - "product": "firefox", 18:41:40 INFO - "who": "ryanvm@gmail.com", 18:41:40 INFO - "installer_path": "public/build/target.tar.bz2", 18:41:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:41:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:41:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:41:40 INFO - "stage_platform": "linux64", 18:41:40 INFO - "basedir": "/builds/slave/test", 18:41:40 INFO - "buildnumber": 1094, 18:41:40 INFO - "platform": "ubuntu64_hw", 18:41:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:41:40 INFO - "slavebuilddir": "test", 18:41:40 INFO - "taskId": "PCXip_D5RHieinZAY3FfYQ", 18:41:40 INFO - "branch": "mozilla-central", 18:41:40 INFO - "script_repo_revision": "production", 18:41:40 INFO - "revision": "7c50f0c999c5bf8ee915261997597a5a9b8fb2ae", 18:41:40 INFO - "slavename": "talos-linux64-ix-059", 18:41:40 INFO - "repo_path": "mozilla-central" 18:41:40 INFO - } 18:41:40 INFO - Finding installer, test and symbols from parent task. 18:41:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCXip_D5RHieinZAY3FfYQ'}, attempt #1 18:41:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCXip_D5RHieinZAY3FfYQ'}, attempt #1 18:41:41 INFO - Task dependencies: B13Ixl9iTias4oEEpdFzUg 18:41:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg'}, attempt #1 18:41:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:41:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json 18:41:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip 18:41:42 INFO - Running post-action listener: _resource_record_post_action 18:41:42 INFO - [mozharness: 2017-08-23 01:41:42.094608Z] Finished read-buildbot-config step (success) 18:41:42 INFO - [mozharness: 2017-08-23 01:41:42.094827Z] Running download-and-extract step. 18:41:42 INFO - Running pre-action listener: _resource_record_pre_action 18:41:42 INFO - Running main action method: download_and_extract 18:41:42 INFO - mkdir: /builds/slave/test/build/tests 18:41:42 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')]} 18:41:42 INFO - trying https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json 18:41:42 INFO - Downloading https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:41:42 INFO - Downloaded 989 bytes. 18:41:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:41:42 INFO - Using the following test package requirements: 18:41:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:41:42 INFO - u'common': [u'target.common.tests.zip'], 18:41:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:41:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:41:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:41:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:41:42 INFO - u'mozbase': [u'target.common.tests.zip'], 18:41:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:41:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:41:42 INFO - u'web-platform': [u'target.common.tests.zip', 18:41:42 INFO - u'target.web-platform.tests.tar.gz'], 18:41:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:41:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:41:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip 18:41:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:41:42 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip into memory 18:41:43 INFO - Content-Length response header: 54949693 18:41:43 INFO - Bytes received: 54949693 18:41:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:41:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip 18:41:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:41:54 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.common.tests.zip into memory 18:41:55 INFO - Content-Length response header: 54949693 18:41:55 INFO - Bytes received: 54949693 18:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip 18:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.talos.tests.zip into memory 18:42:08 INFO - Content-Length response header: 14496256 18:42:08 INFO - Bytes received: 14496256 18:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:08 INFO - trying https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:42:08 INFO - Downloading https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:42:09 INFO - Downloaded 61164089 bytes. 18:42:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:42:09 INFO - mkdir: /builds/slave/test/properties 18:42:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:42:09 INFO - Writing to file /builds/slave/test/properties/build_url 18:42:09 INFO - Contents: 18:42:09 INFO - build_url:https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 18:42:09 INFO - Running post-action listener: _resource_record_post_action 18:42:09 INFO - Running post-action listener: find_tests_for_verification 18:42:09 INFO - Running post-action listener: set_extra_try_arguments 18:42:09 INFO - [mozharness: 2017-08-23 01:42:09.777242Z] Finished download-and-extract step (success) 18:42:09 INFO - [mozharness: 2017-08-23 01:42:09.777341Z] Running populate-webroot step. 18:42:09 INFO - Running pre-action listener: _resource_record_pre_action 18:42:09 INFO - Running main action method: populate_webroot 18:42:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:42:09 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:42:09 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:42:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:09 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'tests': ['damp', 'tps']}, 18:42:09 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['damp', 'tps']}, 18:42:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:42:09 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:42:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:42:09 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:42:09 INFO - 'other-e10s': {'tests': ['a11yr', 18:42:09 INFO - 'ts_paint', 18:42:09 INFO - 'tpaint', 18:42:09 INFO - 'sessionrestore', 18:42:09 INFO - 'sessionrestore_many_windows', 18:42:09 INFO - 'sessionrestore_no_auto_restore', 18:42:09 INFO - 'tabpaint']}, 18:42:09 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['a11yr', 18:42:09 INFO - 'ts_paint', 18:42:09 INFO - 'tpaint', 18:42:09 INFO - 'sessionrestore', 18:42:09 INFO - 'sessionrestore_many_windows', 18:42:09 INFO - 'sessionrestore_no_auto_restore', 18:42:09 INFO - 'tabpaint']}, 18:42:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:42:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:42:09 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['bloom_basic_singleton']}, 18:42:09 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['bloom_basic']}, 18:42:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:42:09 INFO - 'tsvgr_opacity', 18:42:09 INFO - 'tart', 18:42:09 INFO - 'tscrollx', 18:42:09 INFO - 'tsvg_static']}, 18:42:09 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['tsvgx', 18:42:09 INFO - 'tsvgr_opacity', 18:42:09 INFO - 'tart', 18:42:09 INFO - 'tscrollx', 18:42:09 INFO - 'tsvg_static']}, 18:42:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:42:09 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--stylo'], 18:42:09 INFO - 'tests': ['tp5o']}, 18:42:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:42:09 INFO - 'talos_options': ['--mitmproxy', 18:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:42:09 INFO - '--firstNonBlankPaint'], 18:42:09 INFO - 'tests': ['tp6_google', 18:42:09 INFO - 'tp6_youtube', 18:42:09 INFO - 'tp6_amazon', 18:42:09 INFO - 'tp6_facebook']}, 18:42:09 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:42:09 INFO - 'talos_options': ['--stylo', 18:42:09 INFO - '--mitmproxy', 18:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:42:09 INFO - '--firstNonBlankPaint'], 18:42:09 INFO - 'tests': ['tp6_google', 18:42:09 INFO - 'tp6_youtube', 18:42:09 INFO - 'tp6_amazon', 18:42:09 INFO - 'tp6_facebook']}, 18:42:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:42:09 INFO - 'talos_options': ['--stylo', 18:42:09 INFO - '--stylo-threads=1', 18:42:09 INFO - '--mitmproxy', 18:42:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:42:09 INFO - '--firstNonBlankPaint'], 18:42:09 INFO - 'tests': ['tp6_google', 18:42:09 INFO - 'tp6_youtube', 18:42:09 INFO - 'tp6_amazon', 18:42:09 INFO - 'tp6_facebook']}, 18:42:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--xperf_path', 18:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:09 INFO - 'tests': ['tp5n']}, 18:42:09 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:42:09 INFO - 'talos_options': ['--stylo', 18:42:09 INFO - '--xperf_path', 18:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:09 INFO - 'tests': ['tp5n']}}} 18:42:09 INFO - Running post-action listener: _resource_record_post_action 18:42:09 INFO - [mozharness: 2017-08-23 01:42:09.791625Z] Finished populate-webroot step (success) 18:42:09 INFO - [mozharness: 2017-08-23 01:42:09.791714Z] Running create-virtualenv step. 18:42:09 INFO - Running pre-action listener: _resource_record_pre_action 18:42:09 INFO - Running main action method: create_virtualenv 18:42:09 INFO - Creating virtualenv /builds/slave/test/build/venv 18:42:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:42:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:42:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:42:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:09 INFO - Using real prefix '/usr' 18:42:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:42:10 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:12 INFO - Installing pip.................done. 18:42:12 INFO - Return code: 0 18:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:42:12 INFO - Reading from file tmpfile_stdout 18:42:12 INFO - Output received: 18:42:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:42:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:42: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')]} 18:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42: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')]} 18:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42: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', 'pip>=1.5'] in /builds/slave/test/build 18:42: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 pip>=1.5 18:42:12 INFO - Using env: {'DISPLAY': ':0', 18:42:12 INFO - 'HOME': '/home/cltbld', 18:42:12 INFO - 'LANG': 'en_US.UTF-8', 18:42:12 INFO - 'LANGUAGE': 'en_US:en', 18:42:12 INFO - 'LOGNAME': 'cltbld', 18:42:12 INFO - 'MAIL': '/var/mail/cltbld', 18:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:12 INFO - 'MOZ_NO_REMOTE': '1', 18:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:12 INFO - 'NO_EM_RESTART': '1', 18:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:12 INFO - 'PWD': '/builds/slave/test', 18:42:12 INFO - 'SHELL': '/bin/bash', 18:42:12 INFO - 'SHLVL': '1', 18:42:12 INFO - 'TERM': 'linux', 18:42:12 INFO - 'TMOUT': '86400', 18:42:12 INFO - 'USER': 'cltbld', 18:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:12 INFO - '_': '/tools/buildbot/bin/python'} 18:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:42:12 INFO - Cleaning up... 18:42:12 INFO - Return code: 0 18:42:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:42: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')]} 18:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42: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')]} 18:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42: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', '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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:42: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 psutil>=3.1.1 18:42:12 INFO - Using env: {'DISPLAY': ':0', 18:42:12 INFO - 'HOME': '/home/cltbld', 18:42:12 INFO - 'LANG': 'en_US.UTF-8', 18:42:12 INFO - 'LANGUAGE': 'en_US:en', 18:42:12 INFO - 'LOGNAME': 'cltbld', 18:42:12 INFO - 'MAIL': '/var/mail/cltbld', 18:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:12 INFO - 'MOZ_NO_REMOTE': '1', 18:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:12 INFO - 'NO_EM_RESTART': '1', 18:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:12 INFO - 'PWD': '/builds/slave/test', 18:42:12 INFO - 'SHELL': '/bin/bash', 18:42:12 INFO - 'SHLVL': '1', 18:42:12 INFO - 'TERM': 'linux', 18:42:12 INFO - 'TMOUT': '86400', 18:42:12 INFO - 'USER': 'cltbld', 18:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:12 INFO - '_': '/tools/buildbot/bin/python'} 18:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:13 INFO - Downloading/unpacking psutil>=3.1.1 18:42:13 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 18:42:13 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 18:42:13 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 18:42:13 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 18:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:14 INFO - Installing collected packages: psutil 18:42:14 INFO - Running setup.py install for psutil 18:42:14 INFO - building 'psutil._psutil_linux' extension 18:42:14 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 18:42:14 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 18:42:14 INFO - building 'psutil._psutil_posix' extension 18:42:14 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 18:42:14 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 18:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:14 INFO - Successfully installed psutil 18:42:14 INFO - Cleaning up... 18:42:14 INFO - Return code: 0 18:42:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:42:14 INFO - Using env: {'DISPLAY': ':0', 18:42:14 INFO - 'HOME': '/home/cltbld', 18:42:14 INFO - 'LANG': 'en_US.UTF-8', 18:42:14 INFO - 'LANGUAGE': 'en_US:en', 18:42:14 INFO - 'LOGNAME': 'cltbld', 18:42:14 INFO - 'MAIL': '/var/mail/cltbld', 18:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:14 INFO - 'MOZ_NO_REMOTE': '1', 18:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:14 INFO - 'NO_EM_RESTART': '1', 18:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:14 INFO - 'PWD': '/builds/slave/test', 18:42:14 INFO - 'SHELL': '/bin/bash', 18:42:14 INFO - 'SHLVL': '1', 18:42:14 INFO - 'TERM': 'linux', 18:42:14 INFO - 'TMOUT': '86400', 18:42:14 INFO - 'USER': 'cltbld', 18:42:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:14 INFO - '_': '/tools/buildbot/bin/python'} 18:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:42:15 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 18:42:15 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 18:42:15 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 18:42:15 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 18:42:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:42:16 INFO - Installing collected packages: mozsystemmonitor 18:42:16 INFO - Running setup.py install for mozsystemmonitor 18:42:16 INFO - Successfully installed mozsystemmonitor 18:42:16 INFO - Cleaning up... 18:42:16 INFO - Return code: 0 18:42:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:42:16 INFO - Using env: {'DISPLAY': ':0', 18:42:16 INFO - 'HOME': '/home/cltbld', 18:42:16 INFO - 'LANG': 'en_US.UTF-8', 18:42:16 INFO - 'LANGUAGE': 'en_US:en', 18:42:16 INFO - 'LOGNAME': 'cltbld', 18:42:16 INFO - 'MAIL': '/var/mail/cltbld', 18:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:16 INFO - 'MOZ_NO_REMOTE': '1', 18:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:16 INFO - 'NO_EM_RESTART': '1', 18:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:16 INFO - 'PWD': '/builds/slave/test', 18:42:16 INFO - 'SHELL': '/bin/bash', 18:42:16 INFO - 'SHLVL': '1', 18:42:16 INFO - 'TERM': 'linux', 18:42:16 INFO - 'TMOUT': '86400', 18:42:16 INFO - 'USER': 'cltbld', 18:42:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:16 INFO - '_': '/tools/buildbot/bin/python'} 18:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:16 INFO - Downloading/unpacking jsonschema==2.5.1 18:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:42:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:42:17 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 18:42:17 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 18:42:17 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 18:42:17 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 18:42:17 INFO - Downloading functools32-3.2.3-2.tar.gz 18:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:42:17 INFO - warning: no files found matching '*.txt' 18:42:17 INFO - no previously-included directories found matching 'build' 18:42:17 INFO - no previously-included directories found matching 'dist' 18:42:17 INFO - no previously-included directories found matching '.git*' 18:42:17 INFO - Installing collected packages: jsonschema, functools32 18:42:17 INFO - Running setup.py install for functools32 18:42:17 INFO - warning: no files found matching '*.txt' 18:42:17 INFO - no previously-included directories found matching 'build' 18:42:17 INFO - no previously-included directories found matching 'dist' 18:42:17 INFO - no previously-included directories found matching '.git*' 18:42:17 INFO - Successfully installed jsonschema functools32 18:42:17 INFO - Cleaning up... 18:42:18 INFO - Return code: 0 18:42:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:42:18 INFO - Using env: {'DISPLAY': ':0', 18:42:18 INFO - 'HOME': '/home/cltbld', 18:42:18 INFO - 'LANG': 'en_US.UTF-8', 18:42:18 INFO - 'LANGUAGE': 'en_US:en', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MAIL': '/var/mail/cltbld', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SHLVL': '1', 18:42:18 INFO - 'TERM': 'linux', 18:42:18 INFO - 'TMOUT': '86400', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - '_': '/tools/buildbot/bin/python'} 18:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:42:18 INFO - Cleaning up... 18:42:18 INFO - Return code: 0 18:42:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:42:18 INFO - Using env: {'DISPLAY': ':0', 18:42:18 INFO - 'HOME': '/home/cltbld', 18:42:18 INFO - 'LANG': 'en_US.UTF-8', 18:42:18 INFO - 'LANGUAGE': 'en_US:en', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MAIL': '/var/mail/cltbld', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SHLVL': '1', 18:42:18 INFO - 'TERM': 'linux', 18:42:18 INFO - 'TMOUT': '86400', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - '_': '/tools/buildbot/bin/python'} 18:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:18 INFO - Downloading/unpacking blobuploader==1.2.4 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:42:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:42:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:20 INFO - Downloading docopt-0.6.1.tar.gz 18:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:42:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:42:20 INFO - Running setup.py install for blobuploader 18:42:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:42:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:42:20 INFO - Running setup.py install for requests 18:42:20 INFO - Running setup.py install for docopt 18:42:20 INFO - Successfully installed blobuploader requests docopt 18:42:20 INFO - Cleaning up... 18:42:20 INFO - Return code: 0 18:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:20 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')]} 18:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:20 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')]} 18:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:20 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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:20 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 18:42:20 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 18:42:20 INFO - Using env: {'DISPLAY': ':0', 18:42:20 INFO - 'HOME': '/home/cltbld', 18:42:20 INFO - 'LANG': 'en_US.UTF-8', 18:42:20 INFO - 'LANGUAGE': 'en_US:en', 18:42:20 INFO - 'LOGNAME': 'cltbld', 18:42:20 INFO - 'MAIL': '/var/mail/cltbld', 18:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:20 INFO - 'MOZ_NO_REMOTE': '1', 18:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:20 INFO - 'NO_EM_RESTART': '1', 18:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:20 INFO - 'PWD': '/builds/slave/test', 18:42:20 INFO - 'SHELL': '/bin/bash', 18:42:20 INFO - 'SHLVL': '1', 18:42:20 INFO - 'TERM': 'linux', 18:42:20 INFO - 'TMOUT': '86400', 18:42:20 INFO - 'USER': 'cltbld', 18:42:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:20 INFO - '_': '/tools/buildbot/bin/python'} 18:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:20 INFO - Running setup.py (path:/tmp/pip-utTp04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:21 INFO - Running setup.py (path:/tmp/pip-8qnPq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:21 INFO - Running setup.py (path:/tmp/pip-4DCpCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:21 INFO - Running setup.py (path:/tmp/pip-vHaxRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:21 INFO - Running setup.py (path:/tmp/pip-Fm6RLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:21 INFO - Running setup.py (path:/tmp/pip-Magkdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:21 INFO - Running setup.py (path:/tmp/pip-rw_Aav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:21 INFO - Running setup.py (path:/tmp/pip-z3edfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:21 INFO - Running setup.py (path:/tmp/pip-OqJRBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:21 INFO - Running setup.py (path:/tmp/pip-LicsTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:21 INFO - Running setup.py (path:/tmp/pip-AFvG8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:21 INFO - Running setup.py (path:/tmp/pip-NJ8K74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:21 INFO - Running setup.py (path:/tmp/pip-jOJh4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:21 INFO - Running setup.py (path:/tmp/pip-Faigmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:21 INFO - Running setup.py (path:/tmp/pip-KztAko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:22 INFO - Running setup.py (path:/tmp/pip-oYmQbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:22 INFO - Running setup.py (path:/tmp/pip-2On5wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:42:22 INFO - Running setup.py install for manifestparser 18:42:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Running setup.py install for mozcrash 18:42:22 INFO - Running setup.py install for mozdebug 18:42:22 INFO - Running setup.py install for mozdevice 18:42:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Running setup.py install for mozfile 18:42:22 INFO - Running setup.py install for mozhttpd 18:42:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Running setup.py install for mozinfo 18:42:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Running setup.py install for mozInstall 18:42:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:42:22 INFO - Running setup.py install for mozleak 18:42:23 INFO - Running setup.py install for mozlog 18:42:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Running setup.py install for moznetwork 18:42:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Running setup.py install for mozprocess 18:42:23 INFO - Running setup.py install for mozprofile 18:42:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Running setup.py install for mozrunner 18:42:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Running setup.py install for mozscreenshot 18:42:23 INFO - Running setup.py install for moztest 18:42:23 INFO - Running setup.py install for mozversion 18:42:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:42:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:23 INFO - Cleaning up... 18:42:23 INFO - Return code: 0 18:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:23 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')]} 18:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:23 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')]} 18:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:23 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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:23 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 18:42:23 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 18:42:24 INFO - Using env: {'DISPLAY': ':0', 18:42:24 INFO - 'HOME': '/home/cltbld', 18:42:24 INFO - 'LANG': 'en_US.UTF-8', 18:42:24 INFO - 'LANGUAGE': 'en_US:en', 18:42:24 INFO - 'LOGNAME': 'cltbld', 18:42:24 INFO - 'MAIL': '/var/mail/cltbld', 18:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:24 INFO - 'MOZ_NO_REMOTE': '1', 18:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:24 INFO - 'NO_EM_RESTART': '1', 18:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:24 INFO - 'PWD': '/builds/slave/test', 18:42:24 INFO - 'SHELL': '/bin/bash', 18:42:24 INFO - 'SHLVL': '1', 18:42:24 INFO - 'TERM': 'linux', 18:42:24 INFO - 'TMOUT': '86400', 18:42:24 INFO - 'USER': 'cltbld', 18:42:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:24 INFO - '_': '/tools/buildbot/bin/python'} 18:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:24 INFO - Running setup.py (path:/tmp/pip-nkcwtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:24 INFO - Running setup.py (path:/tmp/pip-SBzpty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:24 INFO - Running setup.py (path:/tmp/pip-zPhoZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:24 INFO - Running setup.py (path:/tmp/pip-38QIkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:24 INFO - Running setup.py (path:/tmp/pip-rirPS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:24 INFO - Running setup.py (path:/tmp/pip-7V7L6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:24 INFO - Running setup.py (path:/tmp/pip-Gs7noh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:24 INFO - Running setup.py (path:/tmp/pip-RjEQNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:24 INFO - Running setup.py (path:/tmp/pip-oJNKOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:24 INFO - Running setup.py (path:/tmp/pip-Ntetc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:24 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)) 18:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:24 INFO - Running setup.py (path:/tmp/pip-dzmR77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:25 INFO - Running setup.py (path:/tmp/pip-Yy8Qz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:25 INFO - Running setup.py (path:/tmp/pip-f0ZJKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:25 INFO - Running setup.py (path:/tmp/pip-PqGqNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:25 INFO - Running setup.py (path:/tmp/pip-OAg7bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:25 INFO - Running setup.py (path:/tmp/pip-uINqJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:25 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)) 18:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:25 INFO - Running setup.py (path:/tmp/pip-r6F31g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:25 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)) 18:42:25 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)) 18:42:25 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)) 18:42:25 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)) 18:42:25 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)) 18:42:25 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)) 18:42:25 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)) 18:42:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:26 INFO - Downloading blessings-1.6.tar.gz 18:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:26 INFO - Installing collected packages: blessings 18:42:26 INFO - Running setup.py install for blessings 18:42:26 INFO - Successfully installed blessings 18:42:26 INFO - Cleaning up... 18:42:26 INFO - Return code: 0 18:42:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:26 INFO - Reading from file tmpfile_stdout 18:42:26 INFO - Current package versions: 18:42:26 INFO - argparse == 1.2.1 18:42:26 INFO - blessings == 1.6 18:42:26 INFO - blobuploader == 1.2.4 18:42:26 INFO - docopt == 0.6.1 18:42:26 INFO - functools32 == 3.2.3-2 18:42:26 INFO - jsonschema == 2.5.1 18:42:26 INFO - manifestparser == 1.1 18:42:26 INFO - mozInstall == 1.13 18:42:26 INFO - mozcrash == 1.0 18:42:26 INFO - mozdebug == 0.1 18:42:26 INFO - mozdevice == 0.51 18:42:26 INFO - mozfile == 1.2 18:42:26 INFO - mozhttpd == 0.7 18:42:26 INFO - mozinfo == 0.10 18:42:26 INFO - mozleak == 0.1 18:42:26 INFO - mozlog == 3.5 18:42:26 INFO - moznetwork == 0.27 18:42:26 INFO - mozprocess == 0.25 18:42:26 INFO - mozprofile == 0.28 18:42:26 INFO - mozrunner == 6.13 18:42:26 INFO - mozscreenshot == 0.1 18:42:26 INFO - mozsystemmonitor == 0.3 18:42:26 INFO - moztest == 0.8 18:42:26 INFO - mozversion == 1.4 18:42:26 INFO - psutil == 3.1.1 18:42:26 INFO - requests == 1.2.3 18:42:26 INFO - wsgiref == 0.1.2 18:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:26 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')]} 18:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:26 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')]} 18:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:26 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 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:26 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 18:42:27 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 18:42:27 INFO - Using env: {'DISPLAY': ':0', 18:42:27 INFO - 'HOME': '/home/cltbld', 18:42:27 INFO - 'LANG': 'en_US.UTF-8', 18:42:27 INFO - 'LANGUAGE': 'en_US:en', 18:42:27 INFO - 'LOGNAME': 'cltbld', 18:42:27 INFO - 'MAIL': '/var/mail/cltbld', 18:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:27 INFO - 'MOZ_NO_REMOTE': '1', 18:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:27 INFO - 'NO_EM_RESTART': '1', 18:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:27 INFO - 'PWD': '/builds/slave/test', 18:42:27 INFO - 'SHELL': '/bin/bash', 18:42:27 INFO - 'SHLVL': '1', 18:42:27 INFO - 'TERM': 'linux', 18:42:27 INFO - 'TMOUT': '86400', 18:42:27 INFO - 'USER': 'cltbld', 18:42:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:27 INFO - '_': '/tools/buildbot/bin/python'} 18:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 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)) 18:42:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:42:28 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)) 18:42:28 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)) 18:42:28 INFO - Installing collected packages: simplejson 18:42:28 INFO - Running setup.py install for simplejson 18:42:28 INFO - building 'simplejson._speedups' extension 18:42:28 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 18:42:29 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 18:42:29 INFO - Successfully installed simplejson 18:42:29 INFO - Cleaning up... 18:42:29 INFO - Return code: 0 18:42:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, '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': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', '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 18:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:42:29 INFO - Using env: {'DISPLAY': ':0', 18:42:29 INFO - 'HOME': '/home/cltbld', 18:42:29 INFO - 'LANG': 'en_US.UTF-8', 18:42:29 INFO - 'LANGUAGE': 'en_US:en', 18:42:29 INFO - 'LOGNAME': 'cltbld', 18:42:29 INFO - 'MAIL': '/var/mail/cltbld', 18:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:29 INFO - 'MOZ_NO_REMOTE': '1', 18:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:29 INFO - 'NO_EM_RESTART': '1', 18:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:29 INFO - 'PWD': '/builds/slave/test', 18:42:29 INFO - 'SHELL': '/bin/bash', 18:42:29 INFO - 'SHLVL': '1', 18:42:29 INFO - 'TERM': 'linux', 18:42:29 INFO - 'TMOUT': '86400', 18:42:29 INFO - 'USER': 'cltbld', 18:42:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:29 INFO - '_': '/tools/buildbot/bin/python'} 18:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:42:29 INFO - Cleaning up... 18:42:29 INFO - Return code: 0 18:42:29 INFO - Running post-action listener: _resource_record_post_action 18:42:29 INFO - Running post-action listener: _start_resource_monitoring 18:42:29 INFO - Starting resource monitoring. 18:42:29 INFO - [mozharness: 2017-08-23 01:42:29.695064Z] Finished create-virtualenv step (success) 18:42:29 INFO - [mozharness: 2017-08-23 01:42:29.695536Z] Running install step. 18:42:29 INFO - Running pre-action listener: _resource_record_pre_action 18:42:29 INFO - Running main action method: install 18:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:29 INFO - Reading from file tmpfile_stdout 18:42:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:30 INFO - Reading from file tmpfile_stdout 18:42:30 INFO - Output received: 18:42:30 INFO - Usage: mozinstall [options] installer 18:42:30 INFO - Options: 18:42:30 INFO - -h, --help show this help message and exit 18:42:30 INFO - -d DEST, --destination=DEST 18:42:30 INFO - Directory to install application into. [default: 18:42:30 INFO - "/builds/slave/test"] 18:42:30 INFO - --app=APP Application being installed. [default: firefox] 18:42:30 INFO - mkdir: /builds/slave/test/build/application 18:42:30 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'] 18:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:42:47 INFO - Reading from file tmpfile_stdout 18:42:47 INFO - Output received: 18:42:47 INFO - /builds/slave/test/build/application/firefox/firefox 18:42:47 INFO - Running post-action listener: _resource_record_post_action 18:42:47 INFO - [mozharness: 2017-08-23 01:42:47.736332Z] Finished install step (success) 18:42:47 INFO - [mozharness: 2017-08-23 01:42:47.736618Z] Running setup-mitmproxy step. 18:42:47 INFO - Running pre-action listener: _resource_record_pre_action 18:42:47 INFO - Running main action method: setup_mitmproxy 18:42:47 INFO - Skipping: mitmproxy is not required 18:42:47 INFO - Running post-action listener: _resource_record_post_action 18:42:47 INFO - [mozharness: 2017-08-23 01:42:47.737866Z] Finished setup-mitmproxy step (success) 18:42:47 INFO - [mozharness: 2017-08-23 01:42:47.738086Z] Running run-tests step. 18:42:47 INFO - Running pre-action listener: _resource_record_pre_action 18:42:47 INFO - Running pre-action listener: _set_gcov_prefix 18:42:47 INFO - Running main action method: run_tests 18:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:47 INFO - Python 2.7.3 18:42:47 INFO - Return code: 0 18:42:47 INFO - grabbing minidump binary from tooltool 18:42:47 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')]} 18:42:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1294130>, '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 0x1295030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12954c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:42:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:42:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:42:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:47 INFO - Return code: 0 18:42:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:42:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:47 INFO - ENV: RUST_BACKTRACE is now full 18:42:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:42:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:47 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 18:42:47 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 18:42:47 INFO - Using env: {'DISPLAY': ':0', 18:42:47 INFO - 'HOME': '/home/cltbld', 18:42:47 INFO - 'LANG': 'en_US.UTF-8', 18:42:47 INFO - 'LANGUAGE': 'en_US:en', 18:42:47 INFO - 'LOGNAME': 'cltbld', 18:42:47 INFO - 'MAIL': '/var/mail/cltbld', 18:42:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:47 INFO - 'MOZ_NO_REMOTE': '1', 18:42:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:47 INFO - 'NO_EM_RESTART': '1', 18:42:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:47 INFO - 'PWD': '/builds/slave/test', 18:42:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:47 INFO - 'RUST_BACKTRACE': 'full', 18:42:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:42:47 INFO - 'SHELL': '/bin/bash', 18:42:47 INFO - 'SHLVL': '1', 18:42:47 INFO - 'TERM': 'linux', 18:42:47 INFO - 'TMOUT': '86400', 18:42:47 INFO - 'USER': 'cltbld', 18:42:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313', 18:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:47 INFO - '_': '/tools/buildbot/bin/python'} 18:42:47 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/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 18:42:48 INFO - mozversion application_buildid: 20170823004655 18:42:48 INFO - mozversion application_changeset: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae 18:42:48 INFO - mozversion application_display_name: Nightly 18:42:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:48 INFO - mozversion application_name: Firefox 18:42:48 INFO - mozversion application_remotingname: firefox 18:42:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:42:48 INFO - mozversion application_vendor: Mozilla 18:42:48 INFO - mozversion application_version: 57.0a1 18:42:48 INFO - mozversion platform_buildid: 20170823004655 18:42:48 INFO - mozversion platform_changeset: 7c50f0c999c5bf8ee915261997597a5a9b8fb2ae 18:42:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:42:48 INFO - mozversion platform_version: 57.0a1 18:42:48 INFO - using testdate: 1503452568 18:42:48 INFO - actual date: 1503452568 18:42:48 INFO - starting webserver on 'localhost:51518' 18:42:48 INFO - SUITE-START | Running 2 tests 18:42:48 INFO - TEST-START | dromaeo_css 18:42:48 INFO - Initialising browser for dromaeo_css test... 18:42:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51518/getInfo.html -profile /tmp/tmpKdoXn9/profile 18:42:48 INFO - TEST-INFO | started process 9112 (/builds/slave/test/build/application/firefox/firefox http://localhost:51518/getInfo.html) 18:42:53 INFO - TEST-INFO | 9112: exit 0 18:42:53 INFO - Browser initialized. 18:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 18:42:53 INFO - TEST-INFO | started process 9290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdoXn9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:54 INFO - PID 9290 | 18:42:54 INFO - PID 9290 | (/builds/slave/test/build/application/firefox/firefox:9339): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:42:54 INFO - PID 9290 | 18:42:54 INFO - PID 9290 | 18:42:54 INFO - PID 9290 | (/builds/slave/test/build/application/firefox/firefox:9393): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:42:54 INFO - PID 9290 | 18:42:55 INFO - PID 9290 | __metrics Screen width/height:1600/1200 18:42:55 INFO - PID 9290 | colorDepth:24 18:42:55 INFO - PID 9290 | Browser inner width/height: 1024/768 18:42:55 INFO - PID 9290 | __metrics 18:43:04 INFO - PID 9290 | RSS: Main: 172240896 18:43:04 INFO - PID 9290 | 18:46:03 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51518/tests/dromaeo/cssquery-ext.html) 18:46:04 INFO - PID 9290 | RSS: Main: 176115712 18:46:04 INFO - PID 9290 | 18:49:06 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-ext.html (next: http://localhost:51518/tests/dromaeo/cssquery-jquery.html) 18:49:06 INFO - PID 9290 | RSS: Main: 172711936 18:49:06 INFO - PID 9290 | 18:52:08 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51518/tests/dromaeo/cssquery-mootools.html) 18:52:09 INFO - PID 9290 | RSS: Main: 175276032 18:52:09 INFO - PID 9290 | 18:55:10 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51518/tests/dromaeo/cssquery-prototype.html) 18:55:11 INFO - PID 9290 | RSS: Main: 172605440 18:55:11 INFO - PID 9290 | 18:58:15 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51518/tests/dromaeo/cssquery-yui.html) 18:58:15 INFO - PID 9290 | RSS: Main: 177045504 18:58:15 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | Cycle 1(1): loaded http://localhost:51518/tests/dromaeo/cssquery-yui.html (next: http://localhost:51518/tests/dromaeo/cssquery-dojo.html) 19:01:17 INFO - PID 9290 | RSS: Main: 177381376 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | __start_tp_report 19:01:17 INFO - PID 9290 | _x_x_mozilla_page_load 19:01:17 INFO - PID 9290 | _x_x_mozilla_page_load_details 19:01:17 INFO - PID 9290 | |i|pagename|runs| 19:01:17 INFO - PID 9290 | |0;dojo.html;3240.092774023273;3272.590926134233;3303.0256074458034;3307.999999999999;3321.9335613287735;6176;6235.657038862861;6255.061740738885;6268.341824108471;6311.873762524747;6057.151998720183;6191.071339299107;6214.06788981653;6217.285012223596;6222.688865556726;5754.625949313302;5772.480476757101;5800.7679692812235;5817.941820581782;5827.592068555203;5529.115341545354;5661.348944871331;5717.056685646863;5741.942580574203;5845.181674565564;5272.367315922075;5695.14572814077;5702.116171993348;5752.482276595085;5789.8552536186935;5683.204351390808;5720.370759216483;5754.136879468113;5763.971180144114;5770.79802206925;5556.472135147195;5678.659280443146;5687.459691329317;5702.429757024306;5748.741306641211;6116.847078823021;6122.724477398528;6139.50883929289;6150.231221097363;6183.9381606183815;6548.083268342436;6604.405603495708;6612.471002319803;6674.132362792854;6716.3955244028275;6470.288268290485;6584.473242140617;6623.437007854338;6676.93323066768;6696.029075783984;6209.59637623553;6251.687415629246;6254.312025677172;6261.186045814015;6268.373162683741;6833.487488438387;6845.212800527904;6845.452363810883;6897.896531552031;6932.549384290005;6416.7754128605275;6523.412892839668;6550.050242714779;6614.669266536654;6633.635150066696;6562.475001999828;6650.567713098633;6695.163104611924;6729.8654026919185;6743.730250790011;6564.967175164189;6593.637349945703;6600.933990660128;6602.570832895846;6605.735770569219;6491.383318584727;6502.707378167899;6573.5398522103;6680.699368528428;6699.9665001674675;5225.372955245395;5235.188545775411;5238.895222095537;5243.528082472596;5247.763850626731;4610.2854057621125;4643.653340531208;4698.389209402756;4713;4713;5767.279090113736;5843.5909486336395;5857.062869940789;5859.560532960045;5876.265466816648;6660.567063140978;6678.799636010927;6680.432163266177;6686.7993960181275;6749.8650026999185;5710.114932185518;5784.305883294031;5788.363280039192;5800.9419905800405;5854.034084376115;5746.971265143731;5756.884862302814;5813.79651712188;5829.242198514166;5831.154482599999;6342.23893132827;6450.096986421905;6481.708323125471;6517.315681853337;6536.084948107269;6675.666216689243;6685.799426017227;6695.899561506484;6750.25747167821;6779.35596118368;6441.71012304438;6461.160049193575;6464.256610489854;6510.967445162744;6562;6601.801945941629;6692.765753198614;6701.396874281338;6715.5299129060495;6717.932820671731;6715.160604924385;6721.428678562182;6748.763793267409;6760.188777346553;6842.965785171043;6379.96810015947;6460.289368169404;6476.708548115252;6525.445337146396;6560.901586476111;6493.383128602775;6520.054592084027;6535.803925882231;6541.672916354068;6550.344965503412;6300.338464461165;6388.425041746265;6450.903236451363;6470.126532917996;6482.222133344029;6414.390632889868;6522.28254891952;6529.8694026120165;6534.379233972765;6618;6270.2475702915945;6305.684715764285;6361.14124593174;6376.330485298977;6383.616982981036 19:01:17 INFO - PID 9290 | |1;ext.html;801.7113839017957;842.7092653034704;871.6644092024569;876.3821505838389;1130.909527237821;38603.227935441275;42309.57690423095;42444;42455.3631695524;42527;41053.17893642125;41488.79255603725;41533.58466415335;41535.79232103835;41672.374914376305;7752.953351297573;7881.014873140857;7882.132965373804;7885.211478852127;7896.723614673488;7763.107242667081;7839.568823714693;7842.647080881374;7842.686292548291;7881.645325960346;7207.315305046039;7849.058113026416;7892.40806939479;7896.368290536772;7896.723614673488;7768.689252429925;7832.56920869352;7832.765017049498;7837.059552853694;7839.804004899895;7439.702411903518;7575.3182213600485;7625.313721765067;7664.770056898302;7672.194419585919;38578.80710596457;38859.41710874339;38977.80511097427;38992.41511377331;38995.61004389948;3514.7012503937194;3557.7331700122595;3563.465480177968;3563.750537462379;3564.750467467278;32083.51874721881;32248.355032899446;32282.838585807156;32311.838440807645;32357.352852943044;5164.354455693038;5179.2749015137915;5186.896262074775;5192.896142077175;5196.948030519684;192078;193593;194695.99999999857;194818;194978;48725.26912096321;48842.75578622084;48853.51146488561;48875.51124488709;48932.510674892794;50994.49005509898;50997.490025100014;51018;51063.74468127636;51074.48925510697;15261.23693815327;15508.069515829086;15568.766468502981;15586.06483610987;15591.922040389725;12580.308083055337;12586.24482531051;12591.24452532851;12602.369881505889;12620.684482888002;12312.938435307766;13972.580822575339;14013.248343957006;14096.50662226817;14220.288985550887;4997.675151115239;5553.8333849984565;5572.944270557324;5636.887262254814;5757.625754325955;1015.8019186258756;1020.3928662445982;1039.142707266508;1045.1273186889032;1046.7173863056933;23070.077196912272;23155.884220579126;23180.304590862303;23218.419539511648;23249.7675023251;1111.9110471162287;1122.2649164797072;1122.4668282565879;1123.466353482106;1124.4602590756483;12124.57563985274;12383.69040773988;12457.875421245672;12496.562620308245;12496.87503124957;230194;231590;232510;233019;233233;53654.73172634112;54019.18971215435;54020.18969715457;54026.729866351205;54080;1437.9712405751827;1467.8091848059685;1469.4709904434394;1473.2191938272733;1477.5124209011;22132.778672213073;22359.77640223577;22367.888160559094;22651.43371415728;22755.431114222276;37770;37858.43212351872;37886;37918.24163516659;37989.43015854709;202815;203091;203534;204141;204774;33804;33806.830965845016;33926.66073339235;34002.829985849916;34061;43010;43104.78447607742;43150.568494315914;43414.56585434105;43509.347359789;31472.527912081794;33106;33225.833870830495;33324;33426.33147337088;32586.34827303488;32676.673233267364;32816.34367312593;32847.17882052872;33554.83222583871;37908.05229869275;37917.81041094777;38041.809790950865;38187.2362552753;38271;32141.35717285688;32428.513572295964;32452.83773581117;32608.184795380304;32649.510257346636;23595.29214123579;23691.1708090216;23980.28059158228;24181.032758689456;24461.38846528851 19:01:17 INFO - PID 9290 | |2;jquery.html;563.1187192044448;568.5792513539982;572.1446437575823;579.2961551714668;580.7938181945409;21463.67804482932;21877.234296799616;22314.21900233492;22385.999999999978;22397.10411583537;24598.63102053466;25237.242882713548;25298.2410527684;25310.36724081899;25325.74674253257;6556.311587283338;6693.665316734168;6699.3300669933105;6700.865982680343;6708.262091169968;6360.840978975516;6537.5423720339595;6660.467162626978;6670.899936500957;6676.599404035774;6623.768168114117;6633.104530888317;6634.038064480647;6634.170728658918;6635.435987941007;6595.670216489204;6605.834854128685;6624.93375066248;6629.469642428594;6629.933700663004;6067.484263837579;6116.3577824328695;6118.418750218722;6119.479844213202;6145.231846019247;27807.86096069527;28417.715822841714;28850.278743031384;29133.56299655507;29305;2003.6293285742183;2045.856790024684;2046.9181232750673;2048.9692654610194;2050.712900193974;18988.335408260646;19534.70697939532;19566.21735130593;19585;19648.214071437127;2385.832622670399;2412.529556736437;2450.0689737899484;2464.2730394533655;2468.7160976487753;135251;140389;140580;140790;140865;13961.650958726113;14748.63128421798;14773.670369666781;14786.630334241514;15234.466793662168;22310.665340019914;22662.206822761123;22723.318300451014;22803.88598057032;23205;9624.855627165598;9661.758456038655;9679.564419600994;9764.658236961814;9806.65676701312;9106.908930910738;9127.90872091284;9230.676926307548;9243.2143267823;9276.350655454053;8806.339524535686;8861.556922153866;8933.687320943865;9181.311401644904;9278.675246366345;2593.9610905836425;2595.7793587544893;2663.4007348346468;2665.65346504957;2743.533599288086;940.210223412337;966.367029595616;972.7908499672604;979.7305740921161;984.4683870709737;19701.40895773129;23726.406839828796;24673.25980220596;24704.13535526284;25135.24594262175;1027;1051.1853313681959;1051.673981065872;1058.296233005043;1062.9362238265728;11121.110311175087;11242.7189320266;11322.943385283186;11339.14956378275;11352.48913798881;555491;561034;564304;565156;571703;123991;124406;126175.36912315563;127145;127426;1204.903607711381;1236.190295356543;1249.0195196770674;1250.987490125087;1254.1158483269273;18160.72758908591;18601;18671.533211669816;21106.89446552819;22356;48579.27131092966;49134.508654914425;56062;59839.1024134647;60432;69278.30721692719;69333;69562;69598;69939;14422.927885360506;14769.556913292618;14780.556583302518;14787.186704730913;14788.926055369655;22756.772432276128;22779.430514237276;22781.202657906895;23012.884935575214;23024.4243893904;18276.360327388476;18698.906505467385;18769.624607508045;18804.811951880853;19001.80998190056;16143.434979775651;16270.349186032427;16702.081385523914;17081.40215092466;17292.481225563253;18988.525286867385;19087.61824763469;19192.328268510537;19275.903620482368;19305.131269092642;14210.857891420954;14254.073485223427;14399.136051836924;14418.279086045446;14580.052296600687;18213.54466138357;19542.413727588195;19648.410547683594;19716;19761.40715778529 19:01:17 INFO - PID 9290 | |3;mootools.html;1329.3286890120487;1365.5084169698907;1369.7260547890412;1378.6277705019638;1387.0775934003884;14390.856091439082;14667.633309167277;15032.549023529298;15064.322105505238;15186.620334491643;14852.55442336729;15029.92485037576;15040.699186016273;15111;15152.318145683443;2642.9471410571778;2701.972980270202;2703.6350092737525;2705.742954419327;2710.430809529991;2585.121058839994;2669.546177149889;2718.877650505732;2719.157061311;2719.360950176707;2622.134695550473;2650.3109191610224;2661.4544018476167;2719.1162872066557;2719.619253304539;2626.9080582179627;2640.2739246707115;2651.4299425623585;2660.827046241998;2661.5342315094977;2607.4263661994332;2637.6966648835437;2642.6828780546457;2645.061003343824;2651.6420283261705;14231.928840355835;14568.198749068797;14571.19858407787;14595.562133136023;14619.488317908823;7675.616219189074;7937.761867143995;7978.441509094366;7980.2817746402525;7990.200979902022;5224.738763061831;5313.9734301328635;5373.247745315659;5472.2338872557875;5501.697406642633;1929.1318906492136;1936.3997160880172;1943.2518480385154;1953.8143876331726;2010.98994505028;25376.36559086019;25625.487490250278;25651.615225771628;25667.614985775042;25673;6517.967410162919;6545.672716364163;6672.099266599044;6679.098321726505;6691.26396096429;16464.094474803762;16469.423570175226;16479.670406591802;16497.670046599;16538.25577849;7607.65765540552;7754.844903101906;7755.922440775633;7762.650680719381;7762.961185194038;5635.584777844176;5952.494038006818;6205.844853878689;6217.564770466024;7168.17565979919;5012.370979431699;5122.615803814729;5177.663451875616;5204.1673332266655;5204.635675502755;1521.8249901261274;1539.0611726846614;1544.667896402279;1557.7118233126907;1572.4575021617525;855.2858363266741;886.1360173830464;896.3232759266712;901.9188273055456;906.8549032154824;7285.490015698851;7309.744158954411;8293.95853020731;8714.825703485894;8758.211760941418;962.8940816510178;981.3130808434124;986.7779749556292;1005.7837564923576;1024.7182024943052;4894.608431325485;4963.379577552806;4995.25071239317;5002.274670172805;5234.685918844882;20280.188792448433;20888.268910588056;21366.679499807517;21634.459138521663;21639.56720865574;20591.58816823655;20670.48323791887;20846.166153353697;20972.37082887516;21098.578028439344;10565.63020294286;10659.147268218523;10966.835497467544;10969.670909872717;10993.175511836644;7884.5413598484465;8213;8303.875441868257;8360.665573376997;8679.305655547414;18170.182341794385;18598.721019184453;18884.150213240162;19110.426687199408;19181.328653497618;18548.536286592942;18721.625567488845;18826.24695012184;18827.15277812529;18938.715919261496;11557.364344961108;11935.224210426295;11984.76030479403;12099.939500302442;12332.383380831103;12595.74808503843;12641.115121941375;12646.177998430072;12647.367631618567;12720.04599655011;10954.397508137128;11048.613298534512;11130.944345278222;11133.220674552704;11413.657590272305;10329.380237185793;10453.84319235197;10471.581136754445;10784.676459706221;10830.945845270724;10070.8489372658;10290;10291.485425728833;10293.53679084428;10306.484675766033;7062.576245425291;7081;7089.326513981164;7094.858102837811;7102.467314951503;7025.297470252934;7159.391451726661;7160.355567998697;7233.529820561646;7238.0952380952385 19:01:17 INFO - PID 9290 | |4;prototype.html;493.01561216105165;494.0624969607376;514.9459306772789;521.5045706578751;523.1211564571523;6126.816195514136;6168.969155154218;6170.228721409824;6254.374562543749;6373.235211774582;5908.468237858592;6027.306859711123;6038.245219347582;6096.35988221237;6107.175531303273;5010.123228435018;5010.498950104997;5036.320096786942;5059.241113832936;5075.949240507584;4855.975720121394;4967.379077615298;4979.551840334388;5050.116229659795;5064.139096353629;4972.378452693413;4988;4991.975040124794;5033.345665063536;5043.621728370368;4875.95124048762;4935.80256789728;4939.876503087416;4945.752712364403;5005.124103281929;4456.8885777855485;4463.174312752151;4477.171723231213;4492.303692927601;4495.291789120146;6019.277686677627;6098.725557349885;6117.847053823645;6128;6128.295246046717;5679.545636349082;5704.857378565527;5724.914126288109;5741.224934633855;5750.971245143789;6399.200099987502;6415.550911436201;6465.450436712885;6544.869102617921;6567.605943643397;4830.2030165022725;4853.975730121362;4879.292247713307;4879.707217566957;4886.755662216875;6830.863382732317;6875.209350924608;6880.827979300508;6907.896381554281;6941.826454338682;4930;4946.109700253917;4950.8267210647455;4958.876028099255;4975.800967961313;5010.749462526932;5038.949610503922;5040.899182016413;5052.9242061369105;5078.7460626968505;5633.183188437735;5690.77236910519;5699;5709.628874123168;5743.253377061039;6438.356164383524;6518.902216466757;6535.738570457129;6636.867262654817;6651.567648102858;1627.886047976654;1664.625459271654;1692.2976964559816;1730.3597668862349;1730.9480715578552;1164.2665120973732;1198.940052997364;1203.3080978437433;1223.1254652923203;1234.7160153164823;5659.858503537444;5682.176084467729;5731.512821410143;5746.080627099727;5810.331811841692;6460;6558.409743123047;6609.992453433676;6704.832379190461;6757.155355580552;5677.574181936371;5711.515975255091;5758.62568933018;5808.5933984621515;5844.766209351664;3534.717222622184;3561.5191949086543;3577.713782897362;3581.874634387836;3602.8110723461195;6478.384553467413;6556.737730490822;6583.242927063353;6592.8351791205605;6610.3720146586;6849.280825513349;6924.792256232321;6968.198657154391;6992.650367481606;7000.334968178015;6385.521085918482;6481.643509607017;6486.156799616019;6518.57629254097;6564.606123632502;6669.998500674813;6686.966565167143;6710.865782684416;6765.830854228684;6765.9661701691175;6568.47452203813;6570.277269500447;6627.304133066152;6684.192639091691;6724.899126513008;6316.684165791784;6420.165378500765;6433.555249005348;6446.484281257582;6561.901571476527;4907.754612269444;4939.802407903644;4975.228839529878;4984.725840078685;4994.051130285234;6534.509911756732;6818.522703410912;6830.965845170742;6848.486363522856;6852.177738671391;6299.937000630119;6459.354064593503;6503.934960650333;6556.704948277244;6572.309907459648;6454.5159113065765;6471.741130354733;6476.384743449365;6503.577267477788;6567.802965911031;6350.650714210763;6375.585586936834;6377.556119695498;6390.712417941111;6472.546921715435;6474.741010359533;6480.675966201766;6498.415142637185;6530.575512591667;6633.6019838809825;6322.810315690536;6329.620222786648;6331.841703957438;6339.873202536016;6473.2232132144445 19:01:17 INFO - PID 9290 | |5;yui.html;885.0883589902403;888.156251561017;908.5684299957517;913.821804748074;919.2875521470858;18960.431187064376;18987.71518427225;19966.101525431353;19978.7003194952;19994.600107997867;20272.18911243552;21048.89475552624;21087.789122108774;21217;21262.468438289052;924.5284904698601;948.3882895532378;953.2850362228329;953.4374718915839;955.47926380123;854.9615267312986;938.6667732954771;951.0822056715268;954.0221273194961;954.2890546542801;1007.7329507680471;1019.0370100255262;1020.1685626214648;1022.7852151048289;1023.2888142740799;1010.196893469686;1011.3476807459184;1012.9971328384846;1013.204634362026;1014.5028935821468;729.8905164225356;730.1493759769915;738.4166508458311;739.0946091038488;739.6560599321341;16831.495055148363;18198.363057293063;19292;19494.610107797766;19568.608627827365;20653.4836629084;20699.79300206994;21109.577808443744;21175.894120529454;21189;17072.146392680315;17086.40197593091;17119.572010699707;17475.47573572795;17477.038762868036;3691.5201023866994;3766.8681596144;3777.7355585109053;3777.8299976501125;3780.319542482352;120988;121962;123441.38279308636;123538;125544.37227813802;16169.59576010609;16421.096839673693;16535.917320413322;16626.334946602;16628.83371166273;29128.271793204916;30029.699703003127;30049.399012020076;30051.098467046024;30353.24116897051;8992.820143597222;9170.174684278314;9257.49083800384;9258.675946341846;9265.166135047743;4183.4979802423295;4234.407182994383;4255.148970205972;4283.550227226158;4302.333138363559;4751.382320298339;4896.363472748591;4918.5573298403315;4926.433460152057;4940.851774446773;1045.5399624165343;1045.5974449836715;1072.5816931396762;1073.7584043590286;1078.2883297024084;686.7802303263007;713.7644577289482;717.125107369009;719.0975325965879;738.0405472885228;11299.887001129884;11694.239874408137;12029.939850300867;12531.87468125307;12627.368631568568;691.1774987764544;701.0780823217555;706.156143408632;707.6886170085146;716.3803310136799;5690;5876.500497457679;6115.908261376083;6215.378462153839;6354.23749150105;117118;117189;118319;120733.39633301778;125435;91746.08253917508;100136;103000.48499757453;103426;104212.47893760483;84249;86893.56553217194;88781.9999999987;90466;90711;12120.393980300772;12575.68560785951;12753;12937.935310323388;13514.79727804064;39512.60487395089;39564;40950.59049409468;41284.38073428841;43345.566544335416;69689;71339.28660713327;71722;72914.63542682253;73961.6301918487;19141.521461963563;19537;19544.413667589994;19790;19814.40556783299;20204.494887627927;20765.68851467199;21085.05117269696;21552.24567140205;21601.567968640225;18379.81620183781;18500.629987400447;18614.34849780251;19241.90379048096;19254.903725481283;18100.72848907294;18130.45608631743;18249.0875456224;18881.527961801065;19071.332503362315;18045.548861278574;18228.635427291647;18352.541186470444;18432.907835460737;18526.444206673823;14085.507007254697;14114.717705646035;14125.576232713034;14160.140642480488;14200.573982780534;13315.267660278778;13462.46150154022;13580.45678172862;13604.455821767018;13722.65693357674 19:01:17 INFO - PID 9290 | __end_tp_report 19:01:17 INFO - PID 9290 | __start_cc_report 19:01:17 INFO - PID 9290 | _x_x_mozilla_cycle_collect,374 19:01:17 INFO - PID 9290 | __end_cc_report 19:01:17 INFO - PID 9290 | __startTimestamp1503453677595__endTimestamp 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | ------- Summary: start ------- 19:01:17 INFO - PID 9290 | Number of tests: 6 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#0] dojo.html Cycles:165 Average:6139.80 Median:6383.62 stddev:707.96 (11.1%) stddev-sans-first:672.59 19:01:17 INFO - PID 9290 | Values: 3240.1 3272.6 3303.0 3308.0 3321.9 6176.0 6235.7 6255.1 6268.3 6311.9 6057.2 6191.1 6214.1 6217.3 6222.7 5754.6 5772.5 5800.8 5817.9 5827.6 5529.1 5661.3 5717.1 5741.9 5845.2 5272.4 5695.1 5702.1 5752.5 5789.9 5683.2 5720.4 5754.1 5764.0 5770.8 5556.5 5678.7 5687.5 5702.4 5748.7 6116.8 6122.7 6139.5 6150.2 6183.9 6548.1 6604.4 6612.5 6674.1 6716.4 6470.3 6584.5 6623.4 6676.9 6696.0 6209.6 6251.7 6254.3 6261.2 6268.4 6833.5 6845.2 6845.5 6897.9 6932.5 6416.8 6523.4 6550.1 6614.7 6633.6 6562.5 6650.6 6695.2 6729.9 6743.7 6565.0 6593.6 6600.9 6602.6 6605.7 6491.4 6502.7 6573.5 6680.7 6700.0 5225.4 5235.2 5238.9 5243.5 5247.8 4610.3 4643.7 4698.4 4713.0 4713.0 5767.3 5843.6 5857.1 5859.6 5876.3 6660.6 6678.8 6680.4 6686.8 6749.9 5710.1 5784.3 5788.4 5800.9 5854.0 5747.0 5756.9 5813.8 5829.2 5831.2 6342.2 6450.1 6481.7 6517.3 6536.1 6675.7 6685.8 6695.9 6750.3 6779.4 6441.7 6461.2 6464.3 6511.0 6562.0 6601.8 6692.8 6701.4 6715.5 6717.9 6715.2 6721.4 6748.8 6760.2 6843.0 6380.0 6460.3 6476.7 6525.4 6560.9 6493.4 6520.1 6535.8 6541.7 6550.3 6300.3 6388.4 6450.9 6470.1 6482.2 6414.4 6522.3 6529.9 6534.4 6618.0 6270.2 6305.7 6361.1 6376.3 6383.6 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#1] ext.html Cycles:180 Average:38075.86 Median:18787.85 stddev:54564.44 (290.4%) stddev-sans-first:54645.73 19:01:17 INFO - PID 9290 | Values: 801.7 842.7 871.7 876.4 1130.9 38603.2 42309.6 42444.0 42455.4 42527.0 41053.2 41488.8 41533.6 41535.8 41672.4 7753.0 7881.0 7882.1 7885.2 7896.7 7763.1 7839.6 7842.6 7842.7 7881.6 7207.3 7849.1 7892.4 7896.4 7896.7 7768.7 7832.6 7832.8 7837.1 7839.8 7439.7 7575.3 7625.3 7664.8 7672.2 38578.8 38859.4 38977.8 38992.4 38995.6 3514.7 3557.7 3563.5 3563.8 3564.8 32083.5 32248.4 32282.8 32311.8 32357.4 5164.4 5179.3 5186.9 5192.9 5196.9 192078.0 193593.0 194696.0 194818.0 194978.0 48725.3 48842.8 48853.5 48875.5 48932.5 50994.5 50997.5 51018.0 51063.7 51074.5 15261.2 15508.1 15568.8 15586.1 15591.9 12580.3 12586.2 12591.2 12602.4 12620.7 12312.9 13972.6 14013.2 14096.5 14220.3 4997.7 5553.8 5572.9 5636.9 5757.6 1015.8 1020.4 1039.1 1045.1 1046.7 23070.1 23155.9 23180.3 23218.4 23249.8 1111.9 1122.3 1122.5 1123.5 1124.5 12124.6 12383.7 12457.9 12496.6 12496.9 230194.0 231590.0 232510.0 233019.0 233233.0 53654.7 54019.2 54020.2 54026.7 54080.0 1438.0 1467.8 1469.5 1473.2 1477.5 22132.8 22359.8 22367.9 22651.4 22755.4 37770.0 37858.4 37886.0 37918.2 37989.4 202815.0 203091.0 203534.0 204141.0 204774.0 33804.0 33806.8 33926.7 34002.8 34061.0 43010.0 43104.8 43150.6 43414.6 43509.3 31472.5 33106.0 33225.8 33324.0 33426.3 32586.3 32676.7 32816.3 32847.2 33554.8 37908.1 37917.8 38041.8 38187.2 38271.0 32141.4 32428.5 32452.8 32608.2 32649.5 23595.3 23691.2 23980.3 24181.0 24461.4 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#2] jquery.html Cycles:180 Average:37171.83 Median:23465.70 stddev:94247.73 (401.6%) stddev-sans-first:94472.04 19:01:17 INFO - PID 9290 | Values: 563.1 568.6 572.1 579.3 580.8 21463.7 21877.2 22314.2 22386.0 22397.1 24598.6 25237.2 25298.2 25310.4 25325.7 6556.3 6693.7 6699.3 6700.9 6708.3 6360.8 6537.5 6660.5 6670.9 6676.6 6623.8 6633.1 6634.0 6634.2 6635.4 6595.7 6605.8 6624.9 6629.5 6629.9 6067.5 6116.4 6118.4 6119.5 6145.2 27807.9 28417.7 28850.3 29133.6 29305.0 2003.6 2045.9 2046.9 2049.0 2050.7 18988.3 19534.7 19566.2 19585.0 19648.2 2385.8 2412.5 2450.1 2464.3 2468.7 135251.0 140389.0 140580.0 140790.0 140865.0 13961.7 14748.6 14773.7 14786.6 15234.5 22310.7 22662.2 22723.3 22803.9 23205.0 9624.9 9661.8 9679.6 9764.7 9806.7 9106.9 9127.9 9230.7 9243.2 9276.4 8806.3 8861.6 8933.7 9181.3 9278.7 2594.0 2595.8 2663.4 2665.7 2743.5 940.2 966.4 972.8 979.7 984.5 19701.4 23726.4 24673.3 24704.1 25135.2 1027.0 1051.2 1051.7 1058.3 1062.9 11121.1 11242.7 11322.9 11339.1 11352.5 555491.0 561034.0 564304.0 565156.0 571703.0 123991.0 124406.0 126175.4 127145.0 127426.0 1204.9 1236.2 1249.0 1251.0 1254.1 18160.7 18601.0 18671.5 21106.9 22356.0 48579.3 49134.5 56062.0 59839.1 60432.0 69278.3 69333.0 69562.0 69598.0 69939.0 14422.9 14769.6 14780.6 14787.2 14788.9 22756.8 22779.4 22781.2 23012.9 23024.4 18276.4 18698.9 18769.6 18804.8 19001.8 16143.4 16270.3 16702.1 17081.4 17292.5 18988.5 19087.6 19192.3 19275.9 19305.1 14210.9 14254.1 14399.1 14418.3 14580.1 18213.5 19542.4 19648.4 19716.0 19761.4 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#3] mootools.html Cycles:180 Average:9117.41 Median:25670.31 stddev:6494.03 (25.3%) stddev-sans-first:6485.88 19:01:17 INFO - PID 9290 | Values: 1329.3 1365.5 1369.7 1378.6 1387.1 14390.9 14667.6 15032.5 15064.3 15186.6 14852.6 15029.9 15040.7 15111.0 15152.3 2642.9 2702.0 2703.6 2705.7 2710.4 2585.1 2669.5 2718.9 2719.2 2719.4 2622.1 2650.3 2661.5 2719.1 2719.6 2626.9 2640.3 2651.4 2660.8 2661.5 2607.4 2637.7 2642.7 2645.1 2651.6 14231.9 14568.2 14571.2 14595.6 14619.5 7675.6 7937.8 7978.4 7980.3 7990.2 5224.7 5314.0 5373.2 5472.2 5501.7 1929.1 1936.4 1943.3 1953.8 2011.0 25376.4 25625.5 25651.6 25667.6 25673.0 6518.0 6545.7 6672.1 6679.1 6691.3 16464.1 16469.4 16479.7 16497.7 16538.3 7607.7 7754.8 7755.9 7762.7 7763.0 5635.6 5952.5 6205.8 6217.6 7168.2 5012.4 5122.6 5177.7 5204.2 5204.6 1521.8 1539.1 1544.7 1557.7 1572.5 855.3 886.1 896.3 901.9 906.9 7285.5 7309.7 8294.0 8714.8 8758.2 962.9 981.3 986.8 1005.8 1024.7 4894.6 4963.4 4995.3 5002.3 5234.7 20280.2 20888.3 21366.7 21634.5 21639.6 20591.6 20670.5 20846.2 20972.4 21098.6 10565.6 10659.1 10966.8 10969.7 10993.2 7884.5 8213.0 8303.9 8360.7 8679.3 18170.2 18598.7 18884.2 19110.4 19181.3 18548.5 18721.6 18826.2 18827.2 18938.7 11557.4 11935.2 11984.8 12099.9 12332.4 12595.7 12641.1 12646.2 12647.4 12720.0 10954.4 11048.6 11130.9 11133.2 11413.7 10329.4 10453.8 10471.6 10784.7 10830.9 10070.8 10290.0 10291.5 10293.5 10306.5 7062.6 7081.0 7089.3 7094.9 7102.5 7025.3 7159.4 7160.4 7233.5 7238.1 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#4] prototype.html Cycles:180 Average:5495.95 Median:6102.95 stddev:1546.52 (25.3%) stddev-sans-first:1504.59 19:01:17 INFO - PID 9290 | Values: 493.0 494.1 514.9 521.5 523.1 6126.8 6169.0 6170.2 6254.4 6373.2 5908.5 6027.3 6038.2 6096.4 6107.2 5010.1 5010.5 5036.3 5059.2 5075.9 4856.0 4967.4 4979.6 5050.1 5064.1 4972.4 4988.0 4992.0 5033.3 5043.6 4876.0 4935.8 4939.9 4945.8 5005.1 4456.9 4463.2 4477.2 4492.3 4495.3 6019.3 6098.7 6117.8 6128.0 6128.3 5679.5 5704.9 5724.9 5741.2 5751.0 6399.2 6415.6 6465.5 6544.9 6567.6 4830.2 4854.0 4879.3 4879.7 4886.8 6830.9 6875.2 6880.8 6907.9 6941.8 4930.0 4946.1 4950.8 4958.9 4975.8 5010.7 5038.9 5040.9 5052.9 5078.7 5633.2 5690.8 5699.0 5709.6 5743.3 6438.4 6518.9 6535.7 6636.9 6651.6 1627.9 1664.6 1692.3 1730.4 1730.9 1164.3 1198.9 1203.3 1223.1 1234.7 5659.9 5682.2 5731.5 5746.1 5810.3 6460.0 6558.4 6610.0 6704.8 6757.2 5677.6 5711.5 5758.6 5808.6 5844.8 3534.7 3561.5 3577.7 3581.9 3602.8 6478.4 6556.7 6583.2 6592.8 6610.4 6849.3 6924.8 6968.2 6992.7 7000.3 6385.5 6481.6 6486.2 6518.6 6564.6 6670.0 6687.0 6710.9 6765.8 6766.0 6568.5 6570.3 6627.3 6684.2 6724.9 6316.7 6420.2 6433.6 6446.5 6561.9 4907.8 4939.8 4975.2 4984.7 4994.1 6534.5 6818.5 6831.0 6848.5 6852.2 6299.9 6459.4 6503.9 6556.7 6572.3 6454.5 6471.7 6476.4 6503.6 6567.8 6350.7 6375.6 6377.6 6390.7 6472.5 6474.7 6480.7 6498.4 6530.6 6633.6 6322.8 6329.6 6331.8 6339.9 6473.2 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [#5] yui.html Cycles:180 Average:24254.02 Median:20462.84 stddev:32965.14 (161.1%) stddev-sans-first:33010.92 19:01:17 INFO - PID 9290 | Values: 885.1 888.2 908.6 913.8 919.3 18960.4 18987.7 19966.1 19978.7 19994.6 20272.2 21048.9 21087.8 21217.0 21262.5 924.5 948.4 953.3 953.4 955.5 855.0 938.7 951.1 954.0 954.3 1007.7 1019.0 1020.2 1022.8 1023.3 1010.2 1011.3 1013.0 1013.2 1014.5 729.9 730.1 738.4 739.1 739.7 16831.5 18198.4 19292.0 19494.6 19568.6 20653.5 20699.8 21109.6 21175.9 21189.0 17072.1 17086.4 17119.6 17475.5 17477.0 3691.5 3766.9 3777.7 3777.8 3780.3 120988.0 121962.0 123441.4 123538.0 125544.4 16169.6 16421.1 16535.9 16626.3 16628.8 29128.3 30029.7 30049.4 30051.1 30353.2 8992.8 9170.2 9257.5 9258.7 9265.2 4183.5 4234.4 4255.1 4283.6 4302.3 4751.4 4896.4 4918.6 4926.4 4940.9 1045.5 1045.6 1072.6 1073.8 1078.3 686.8 713.8 717.1 719.1 738.0 11299.9 11694.2 12029.9 12531.9 12627.4 691.2 701.1 706.2 707.7 716.4 5690.0 5876.5 6115.9 6215.4 6354.2 117118.0 117189.0 118319.0 120733.4 125435.0 91746.1 100136.0 103000.5 103426.0 104212.5 84249.0 86893.6 88782.0 90466.0 90711.0 12120.4 12575.7 12753.0 12937.9 13514.8 39512.6 39564.0 40950.6 41284.4 43345.6 69689.0 71339.3 71722.0 72914.6 73961.6 19141.5 19537.0 19544.4 19790.0 19814.4 20204.5 20765.7 21085.1 21552.2 21601.6 18379.8 18500.6 18614.3 19241.9 19254.9 18100.7 18130.5 18249.1 18881.5 19071.3 18045.5 18228.6 18352.5 18432.9 18526.4 14085.5 14114.7 14125.6 14160.1 14200.6 13315.3 13462.5 13580.5 13604.5 13722.7 19:01:17 INFO - PID 9290 | -------- Summary: end -------- 19:01:17 INFO - PID 9290 | 19:01:17 INFO - PID 9290 | [Parent 9290] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 19:01:18 INFO - TEST-INFO | 9290: exit 0 19:01:18 INFO - TEST-OK | dromaeo_css | took 1110262ms 19:01:18 INFO - TEST-START | kraken 19:01:18 INFO - Initialising browser for kraken test... 19:01:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51518/getInfo.html -profile /tmp/tmpb43w7m/profile 19:01:18 INFO - TEST-INFO | started process 9702 (/builds/slave/test/build/application/firefox/firefox http://localhost:51518/getInfo.html) 19:01:23 INFO - TEST-INFO | 9702: exit 0 19:01:23 INFO - Browser initialized. 19:01:23 INFO - Running cycle 1/1 for kraken test... 19:01:23 INFO - TEST-INFO | started process 9877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb43w7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:24 INFO - PID 9877 | 19:01:24 INFO - PID 9877 | (/builds/slave/test/build/application/firefox/firefox:9927): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:01:24 INFO - PID 9877 | 19:01:25 INFO - PID 9877 | 19:01:25 INFO - PID 9877 | (/builds/slave/test/build/application/firefox/firefox:9981): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:01:25 INFO - PID 9877 | 19:01:25 INFO - PID 9877 | __metrics Screen width/height:1600/1200 19:01:25 INFO - PID 9877 | colorDepth:24 19:01:25 INFO - PID 9877 | Browser inner width/height: 1024/768 19:01:25 INFO - PID 9877 | __metrics 19:01:34 INFO - PID 9877 | RSS: Main: 171298816 19:01:34 INFO - PID 9877 | 19:01:37 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51518/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:38 INFO - PID 9877 | RSS: Main: 175697920 19:01:38 INFO - PID 9877 | 19:01:41 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51518/tests/kraken/driver.html?testName=audio-dft) 19:01:41 INFO - PID 9877 | RSS: Main: 175857664 19:01:41 INFO - PID 9877 | 19:01:44 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51518/tests/kraken/driver.html?testName=audio-fft) 19:01:45 INFO - PID 9877 | RSS: Main: 170700800 19:01:45 INFO - PID 9877 | 19:01:47 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51518/tests/kraken/driver.html?testName=audio-oscillator) 19:01:48 INFO - PID 9877 | RSS: Main: 171479040 19:01:48 INFO - PID 9877 | 19:01:50 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:50 INFO - PID 9877 | RSS: Main: 171978752 19:01:50 INFO - PID 9877 | 19:01:53 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51518/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:54 INFO - PID 9877 | RSS: Main: 172871680 19:01:54 INFO - PID 9877 | 19:01:58 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51518/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:58 INFO - PID 9877 | RSS: Main: 172929024 19:01:58 INFO - PID 9877 | 19:02:01 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51518/tests/kraken/driver.html?testName=json-parse-financial) 19:02:02 INFO - PID 9877 | RSS: Main: 173391872 19:02:02 INFO - PID 9877 | 19:02:03 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:04 INFO - PID 9877 | RSS: Main: 173228032 19:02:04 INFO - PID 9877 | 19:02:06 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:06 INFO - PID 9877 | RSS: Main: 173436928 19:02:06 INFO - PID 9877 | 19:02:08 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:09 INFO - PID 9877 | RSS: Main: 173727744 19:02:09 INFO - PID 9877 | 19:02:12 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:12 INFO - PID 9877 | RSS: Main: 173883392 19:02:12 INFO - PID 9877 | 19:02:15 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:02:16 INFO - PID 9877 | RSS: Main: 173588480 19:02:16 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | Cycle 1(1): loaded http://localhost:51518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51518/tests/kraken/driver.html?testName=ai-astar) 19:02:18 INFO - PID 9877 | RSS: Main: 175562752 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | __start_tp_report 19:02:18 INFO - PID 9877 | _x_x_mozilla_page_load 19:02:18 INFO - PID 9877 | _x_x_mozilla_page_load_details 19:02:18 INFO - PID 9877 | |i|pagename|runs| 19:02:18 INFO - PID 9877 | |0;ai-astar;100;107;96;106;108;108;110;105;106;110 19:02:18 INFO - PID 9877 | |1;audio-beat-detection;150;119;144;167;117;151;148;121;172;119 19:02:18 INFO - PID 9877 | |2;audio-dft;167;167;165;165;170;166;164;168;191;167 19:02:18 INFO - PID 9877 | |3;audio-fft;73;74;73;177;74;74;73;90;96;74 19:02:18 INFO - PID 9877 | |4;audio-oscillator;79;79;134;80;79;79;135;79;82;131 19:02:18 INFO - PID 9877 | |5;imaging-gaussian-blur;113;114;114;114;127;114;114;115;114;114 19:02:18 INFO - PID 9877 | |6;imaging-darkroom;148;148;148;148;147;150;149;149;150;148 19:02:18 INFO - PID 9877 | |7;imaging-desaturate;94;94;94;94;93;94;95;94;94;94 19:02:18 INFO - PID 9877 | |8;json-parse-financial;51;51;54;52;56;52;51;51;52;51 19:02:18 INFO - PID 9877 | |9;json-stringify-tinderbox;55;55;55;55;54;56;55;55;56;55 19:02:18 INFO - PID 9877 | |10;stanford-crypto-aes;75;77;74;73;75;78;74;74;76;76 19:02:18 INFO - PID 9877 | |11;stanford-crypto-ccm;119;118;124;115;118;118;118;115;123;156 19:02:18 INFO - PID 9877 | |12;stanford-crypto-pbkdf2;175;174;169;171;167;170;168;167;166;168 19:02:18 INFO - PID 9877 | |13;stanford-crypto-sha256-iterative;69;64;67;65;64;63;64;67;67;69 19:02:18 INFO - PID 9877 | __end_tp_report 19:02:18 INFO - PID 9877 | __start_cc_report 19:02:18 INFO - PID 9877 | _x_x_mozilla_cycle_collect,939 19:02:18 INFO - PID 9877 | __end_cc_report 19:02:18 INFO - PID 9877 | __startTimestamp1503453738446__endTimestamp 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | ------- Summary: start ------- 19:02:18 INFO - PID 9877 | Number of tests: 14 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#0] ai-astar Cycles:10 Average:105.60 Median:108.00 stddev:4.43 (4.1%) stddev-sans-first:4.21 19:02:18 INFO - PID 9877 | Values: 100.0 107.0 96.0 106.0 108.0 108.0 110.0 105.0 106.0 110.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:149.00 stddev:20.60 (13.8%) stddev-sans-first:21.58 19:02:18 INFO - PID 9877 | Values: 150.0 119.0 144.0 167.0 117.0 151.0 148.0 121.0 172.0 119.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#2] audio-dft Cycles:10 Average:169.00 Median:167.00 stddev:7.92 (4.7%) stddev-sans-first:8.36 19:02:18 INFO - PID 9877 | Values: 167.0 167.0 165.0 165.0 170.0 166.0 164.0 168.0 191.0 167.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:32.40 (43.8%) stddev-sans-first:33.92 19:02:18 INFO - PID 9877 | Values: 73.0 74.0 73.0 177.0 74.0 74.0 73.0 90.0 96.0 74.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:26.00 (32.9%) stddev-sans-first:26.87 19:02:18 INFO - PID 9877 | Values: 79.0 79.0 134.0 80.0 79.0 79.0 135.0 79.0 82.0 131.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.00 stddev:4.14 (3.6%) stddev-sans-first:4.30 19:02:18 INFO - PID 9877 | Values: 113.0 114.0 114.0 114.0 127.0 114.0 114.0 115.0 114.0 114.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 19:02:18 INFO - PID 9877 | Values: 148.0 148.0 148.0 148.0 147.0 150.0 149.0 149.0 150.0 148.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:02:18 INFO - PID 9877 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 94.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.66 (3.2%) stddev-sans-first:1.72 19:02:18 INFO - PID 9877 | Values: 51.0 51.0 54.0 52.0 56.0 52.0 51.0 51.0 52.0 51.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 19:02:18 INFO - PID 9877 | Values: 55.0 55.0 55.0 55.0 54.0 56.0 55.0 55.0 56.0 55.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.50 stddev:1.55 (2.1%) stddev-sans-first:1.64 19:02:18 INFO - PID 9877 | Values: 75.0 77.0 74.0 73.0 75.0 78.0 74.0 74.0 76.0 76.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:118.50 stddev:12.16 (10.3%) stddev-sans-first:12.83 19:02:18 INFO - PID 9877 | Values: 119.0 118.0 124.0 115.0 118.0 118.0 118.0 115.0 123.0 156.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:169.50 stddev:3.03 (1.8%) stddev-sans-first:2.47 19:02:18 INFO - PID 9877 | Values: 175.0 174.0 169.0 171.0 167.0 170.0 168.0 167.0 166.0 168.0 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:67.00 stddev:2.18 (3.3%) stddev-sans-first:2.01 19:02:18 INFO - PID 9877 | Values: 69.0 64.0 67.0 65.0 64.0 63.0 64.0 67.0 67.0 69.0 19:02:18 INFO - PID 9877 | -------- Summary: end -------- 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 19:02:18 INFO - PID 9877 | 19:02:18 INFO - PID 9877 | [Parent 9877] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 19:02:18 INFO - PID 9877 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:02:19 INFO - TEST-INFO | 9877: exit 0 19:02:19 INFO - TEST-OK | kraken | took 60935ms 19:02:19 INFO - SUITE-END | took 1171s 19:02:19 INFO - Completed test suite (00:19:31) 19:02:19 INFO - javascript benchmark 19:02:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8545.89221204574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.092774023273, 3272.590926134233, 3303.0256074458034, 3307.999999999999, 3321.9335613287735, 6176.0, 6235.657038862861, 6255.061740738885, 6268.341824108471, 6311.873762524747, 6057.151998720183, 6191.071339299107, 6214.06788981653, 6217.285012223596, 6222.688865556726, 5754.625949313302, 5772.480476757101, 5800.7679692812235, 5817.941820581782, 5827.592068555203, 5529.115341545354, 5661.348944871331, 5717.056685646863, 5741.942580574203, 5845.181674565564, 5272.367315922075, 5695.14572814077, 5702.116171993348, 5752.482276595085, 5789.8552536186935, 5683.204351390808, 5720.370759216483, 5754.136879468113, 5763.971180144114, 5770.79802206925, 5556.472135147195, 5678.659280443146, 5687.459691329317, 5702.429757024306, 5748.741306641211, 6116.847078823021, 6122.724477398528, 6139.50883929289, 6150.231221097363, 6183.9381606183815, 6548.083268342436, 6604.405603495708, 6612.471002319803, 6674.132362792854, 6716.3955244028275, 6470.288268290485, 6584.473242140617, 6623.437007854338, 6676.93323066768, 6696.029075783984, 6209.59637623553, 6251.687415629246, 6254.312025677172, 6261.186045814015, 6268.373162683741, 6833.487488438387, 6845.212800527904, 6845.452363810883, 6897.896531552031, 6932.549384290005, 6416.7754128605275, 6523.412892839668, 6550.050242714779, 6614.669266536654, 6633.635150066696, 6562.475001999828, 6650.567713098633, 6695.163104611924, 6729.8654026919185, 6743.730250790011, 6564.967175164189, 6593.637349945703, 6600.933990660128, 6602.570832895846, 6605.735770569219, 6491.383318584727, 6502.707378167899, 6573.5398522103, 6680.699368528428, 6699.9665001674675, 5225.372955245395, 5235.188545775411, 5238.895222095537, 5243.528082472596, 5247.763850626731, 4610.2854057621125, 4643.653340531208, 4698.389209402756, 4713.0, 4713.0, 5767.279090113736, 5843.5909486336395, 5857.062869940789, 5859.560532960045, 5876.265466816648, 6660.567063140978, 6678.799636010927, 6680.432163266177, 6686.7993960181275, 6749.8650026999185, 5710.114932185518, 5784.305883294031, 5788.363280039192, 5800.9419905800405, 5854.034084376115, 5746.971265143731, 5756.884862302814, 5813.79651712188, 5829.242198514166, 5831.154482599999, 6342.23893132827, 6450.096986421905, 6481.708323125471, 6517.315681853337, 6536.084948107269, 6675.666216689243, 6685.799426017227, 6695.899561506484, 6750.25747167821, 6779.35596118368, 6441.71012304438, 6461.160049193575, 6464.256610489854, 6510.967445162744, 6562.0, 6601.801945941629, 6692.765753198614, 6701.396874281338, 6715.5299129060495, 6717.932820671731, 6715.160604924385, 6721.428678562182, 6748.763793267409, 6760.188777346553, 6842.965785171043, 6379.96810015947, 6460.289368169404, 6476.708548115252, 6525.445337146396, 6560.901586476111, 6493.383128602775, 6520.054592084027, 6535.803925882231, 6541.672916354068, 6550.344965503412, 6300.338464461165, 6388.425041746265, 6450.903236451363, 6470.126532917996, 6482.222133344029, 6414.390632889868, 6522.28254891952, 6529.8694026120165, 6534.379233972765, 6618.0, 6270.2475702915945, 6305.684715764285, 6361.14124593174, 6376.330485298977, 6383.616982981036], "value": 6089.184445430447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.7113839017957, 842.7092653034704, 871.6644092024569, 876.3821505838389, 1130.909527237821, 38603.227935441275, 42309.57690423095, 42444.0, 42455.3631695524, 42527.0, 41053.17893642125, 41488.79255603725, 41533.58466415335, 41535.79232103835, 41672.374914376305, 7752.953351297573, 7881.014873140857, 7882.132965373804, 7885.211478852127, 7896.723614673488, 7763.107242667081, 7839.568823714693, 7842.647080881374, 7842.686292548291, 7881.645325960346, 7207.315305046039, 7849.058113026416, 7892.40806939479, 7896.368290536772, 7896.723614673488, 7768.689252429925, 7832.56920869352, 7832.765017049498, 7837.059552853694, 7839.804004899895, 7439.702411903518, 7575.3182213600485, 7625.313721765067, 7664.770056898302, 7672.194419585919, 38578.80710596457, 38859.41710874339, 38977.80511097427, 38992.41511377331, 38995.61004389948, 3514.7012503937194, 3557.7331700122595, 3563.465480177968, 3563.750537462379, 3564.750467467278, 32083.51874721881, 32248.355032899446, 32282.838585807156, 32311.838440807645, 32357.352852943044, 5164.354455693038, 5179.2749015137915, 5186.896262074775, 5192.896142077175, 5196.948030519684, 192078.0, 193593.0, 194695.99999999857, 194818.0, 194978.0, 48725.26912096321, 48842.75578622084, 48853.51146488561, 48875.51124488709, 48932.510674892794, 50994.49005509898, 50997.490025100014, 51018.0, 51063.74468127636, 51074.48925510697, 15261.23693815327, 15508.069515829086, 15568.766468502981, 15586.06483610987, 15591.922040389725, 12580.308083055337, 12586.24482531051, 12591.24452532851, 12602.369881505889, 12620.684482888002, 12312.938435307766, 13972.580822575339, 14013.248343957006, 14096.50662226817, 14220.288985550887, 4997.675151115239, 5553.8333849984565, 5572.944270557324, 5636.887262254814, 5757.625754325955, 1015.8019186258756, 1020.3928662445982, 1039.142707266508, 1045.1273186889032, 1046.7173863056933, 23070.077196912272, 23155.884220579126, 23180.304590862303, 23218.419539511648, 23249.7675023251, 1111.9110471162287, 1122.2649164797072, 1122.4668282565879, 1123.466353482106, 1124.4602590756483, 12124.57563985274, 12383.69040773988, 12457.875421245672, 12496.562620308245, 12496.87503124957, 230194.0, 231590.0, 232510.0, 233019.0, 233233.0, 53654.73172634112, 54019.18971215435, 54020.18969715457, 54026.729866351205, 54080.0, 1437.9712405751827, 1467.8091848059685, 1469.4709904434394, 1473.2191938272733, 1477.5124209011, 22132.778672213073, 22359.77640223577, 22367.888160559094, 22651.43371415728, 22755.431114222276, 37770.0, 37858.43212351872, 37886.0, 37918.24163516659, 37989.43015854709, 202815.0, 203091.0, 203534.0, 204141.0, 204774.0, 33804.0, 33806.830965845016, 33926.66073339235, 34002.829985849916, 34061.0, 43010.0, 43104.78447607742, 43150.568494315914, 43414.56585434105, 43509.347359789, 31472.527912081794, 33106.0, 33225.833870830495, 33324.0, 33426.33147337088, 32586.34827303488, 32676.673233267364, 32816.34367312593, 32847.17882052872, 33554.83222583871, 37908.05229869275, 37917.81041094777, 38041.809790950865, 38187.2362552753, 38271.0, 32141.35717285688, 32428.513572295964, 32452.83773581117, 32608.184795380304, 32649.510257346636, 23595.29214123579, 23691.1708090216, 23980.28059158228, 24181.032758689456, 24461.38846528851], "value": 17291.22286558508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.1187192044448, 568.5792513539982, 572.1446437575823, 579.2961551714668, 580.7938181945409, 21463.67804482932, 21877.234296799616, 22314.21900233492, 22385.999999999978, 22397.10411583537, 24598.63102053466, 25237.242882713548, 25298.2410527684, 25310.36724081899, 25325.74674253257, 6556.311587283338, 6693.665316734168, 6699.3300669933105, 6700.865982680343, 6708.262091169968, 6360.840978975516, 6537.5423720339595, 6660.467162626978, 6670.899936500957, 6676.599404035774, 6623.768168114117, 6633.104530888317, 6634.038064480647, 6634.170728658918, 6635.435987941007, 6595.670216489204, 6605.834854128685, 6624.93375066248, 6629.469642428594, 6629.933700663004, 6067.484263837579, 6116.3577824328695, 6118.418750218722, 6119.479844213202, 6145.231846019247, 27807.86096069527, 28417.715822841714, 28850.278743031384, 29133.56299655507, 29305.0, 2003.6293285742183, 2045.856790024684, 2046.9181232750673, 2048.9692654610194, 2050.712900193974, 18988.335408260646, 19534.70697939532, 19566.21735130593, 19585.0, 19648.214071437127, 2385.832622670399, 2412.529556736437, 2450.0689737899484, 2464.2730394533655, 2468.7160976487753, 135251.0, 140389.0, 140580.0, 140790.0, 140865.0, 13961.650958726113, 14748.63128421798, 14773.670369666781, 14786.630334241514, 15234.466793662168, 22310.665340019914, 22662.206822761123, 22723.318300451014, 22803.88598057032, 23205.0, 9624.855627165598, 9661.758456038655, 9679.564419600994, 9764.658236961814, 9806.65676701312, 9106.908930910738, 9127.90872091284, 9230.676926307548, 9243.2143267823, 9276.350655454053, 8806.339524535686, 8861.556922153866, 8933.687320943865, 9181.311401644904, 9278.675246366345, 2593.9610905836425, 2595.7793587544893, 2663.4007348346468, 2665.65346504957, 2743.533599288086, 940.210223412337, 966.367029595616, 972.7908499672604, 979.7305740921161, 984.4683870709737, 19701.40895773129, 23726.406839828796, 24673.25980220596, 24704.13535526284, 25135.24594262175, 1027.0, 1051.1853313681959, 1051.673981065872, 1058.296233005043, 1062.9362238265728, 11121.110311175087, 11242.7189320266, 11322.943385283186, 11339.14956378275, 11352.48913798881, 555491.0, 561034.0, 564304.0, 565156.0, 571703.0, 123991.0, 124406.0, 126175.36912315563, 127145.0, 127426.0, 1204.903607711381, 1236.190295356543, 1249.0195196770674, 1250.987490125087, 1254.1158483269273, 18160.72758908591, 18601.0, 18671.533211669816, 21106.89446552819, 22356.0, 48579.27131092966, 49134.508654914425, 56062.0, 59839.1024134647, 60432.0, 69278.30721692719, 69333.0, 69562.0, 69598.0, 69939.0, 14422.927885360506, 14769.556913292618, 14780.556583302518, 14787.186704730913, 14788.926055369655, 22756.772432276128, 22779.430514237276, 22781.202657906895, 23012.884935575214, 23024.4243893904, 18276.360327388476, 18698.906505467385, 18769.624607508045, 18804.811951880853, 19001.80998190056, 16143.434979775651, 16270.349186032427, 16702.081385523914, 17081.40215092466, 17292.481225563253, 18988.525286867385, 19087.61824763469, 19192.328268510537, 19275.903620482368, 19305.131269092642, 14210.857891420954, 14254.073485223427, 14399.136051836924, 14418.279086045446, 14580.052296600687, 18213.54466138357, 19542.413727588195, 19648.410547683594, 19716.0, 19761.40715778529], "value": 12130.817303530459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.3286890120487, 1365.5084169698907, 1369.7260547890412, 1378.6277705019638, 1387.0775934003884, 14390.856091439082, 14667.633309167277, 15032.549023529298, 15064.322105505238, 15186.620334491643, 14852.55442336729, 15029.92485037576, 15040.699186016273, 15111.0, 15152.318145683443, 2642.9471410571778, 2701.972980270202, 2703.6350092737525, 2705.742954419327, 2710.430809529991, 2585.121058839994, 2669.546177149889, 2718.877650505732, 2719.157061311, 2719.360950176707, 2622.134695550473, 2650.3109191610224, 2661.4544018476167, 2719.1162872066557, 2719.619253304539, 2626.9080582179627, 2640.2739246707115, 2651.4299425623585, 2660.827046241998, 2661.5342315094977, 2607.4263661994332, 2637.6966648835437, 2642.6828780546457, 2645.061003343824, 2651.6420283261705, 14231.928840355835, 14568.198749068797, 14571.19858407787, 14595.562133136023, 14619.488317908823, 7675.616219189074, 7937.761867143995, 7978.441509094366, 7980.2817746402525, 7990.200979902022, 5224.738763061831, 5313.9734301328635, 5373.247745315659, 5472.2338872557875, 5501.697406642633, 1929.1318906492136, 1936.3997160880172, 1943.2518480385154, 1953.8143876331726, 2010.98994505028, 25376.36559086019, 25625.487490250278, 25651.615225771628, 25667.614985775042, 25673.0, 6517.967410162919, 6545.672716364163, 6672.099266599044, 6679.098321726505, 6691.26396096429, 16464.094474803762, 16469.423570175226, 16479.670406591802, 16497.670046599, 16538.25577849, 7607.65765540552, 7754.844903101906, 7755.922440775633, 7762.650680719381, 7762.961185194038, 5635.584777844176, 5952.494038006818, 6205.844853878689, 6217.564770466024, 7168.17565979919, 5012.370979431699, 5122.615803814729, 5177.663451875616, 5204.1673332266655, 5204.635675502755, 1521.8249901261274, 1539.0611726846614, 1544.667896402279, 1557.7118233126907, 1572.4575021617525, 855.2858363266741, 886.1360173830464, 896.3232759266712, 901.9188273055456, 906.8549032154824, 7285.490015698851, 7309.744158954411, 8293.95853020731, 8714.825703485894, 8758.211760941418, 962.8940816510178, 981.3130808434124, 986.7779749556292, 1005.7837564923576, 1024.7182024943052, 4894.608431325485, 4963.379577552806, 4995.25071239317, 5002.274670172805, 5234.685918844882, 20280.188792448433, 20888.268910588056, 21366.679499807517, 21634.459138521663, 21639.56720865574, 20591.58816823655, 20670.48323791887, 20846.166153353697, 20972.37082887516, 21098.578028439344, 10565.63020294286, 10659.147268218523, 10966.835497467544, 10969.670909872717, 10993.175511836644, 7884.5413598484465, 8213.0, 8303.875441868257, 8360.665573376997, 8679.305655547414, 18170.182341794385, 18598.721019184453, 18884.150213240162, 19110.426687199408, 19181.328653497618, 18548.536286592942, 18721.625567488845, 18826.24695012184, 18827.15277812529, 18938.715919261496, 11557.364344961108, 11935.224210426295, 11984.76030479403, 12099.939500302442, 12332.383380831103, 12595.74808503843, 12641.115121941375, 12646.177998430072, 12647.367631618567, 12720.04599655011, 10954.397508137128, 11048.613298534512, 11130.944345278222, 11133.220674552704, 11413.657590272305, 10329.380237185793, 10453.84319235197, 10471.581136754445, 10784.676459706221, 10830.945845270724, 10070.8489372658, 10290.0, 10291.485425728833, 10293.53679084428, 10306.484675766033, 7062.576245425291, 7081.0, 7089.326513981164, 7094.858102837811, 7102.467314951503, 7025.297470252934, 7159.391451726661, 7160.355567998697, 7233.529820561646, 7238.0952380952385], "value": 6554.06555094185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.01561216105165, 494.0624969607376, 514.9459306772789, 521.5045706578751, 523.1211564571523, 6126.816195514136, 6168.969155154218, 6170.228721409824, 6254.374562543749, 6373.235211774582, 5908.468237858592, 6027.306859711123, 6038.245219347582, 6096.35988221237, 6107.175531303273, 5010.123228435018, 5010.498950104997, 5036.320096786942, 5059.241113832936, 5075.949240507584, 4855.975720121394, 4967.379077615298, 4979.551840334388, 5050.116229659795, 5064.139096353629, 4972.378452693413, 4988.0, 4991.975040124794, 5033.345665063536, 5043.621728370368, 4875.95124048762, 4935.80256789728, 4939.876503087416, 4945.752712364403, 5005.124103281929, 4456.8885777855485, 4463.174312752151, 4477.171723231213, 4492.303692927601, 4495.291789120146, 6019.277686677627, 6098.725557349885, 6117.847053823645, 6128.0, 6128.295246046717, 5679.545636349082, 5704.857378565527, 5724.914126288109, 5741.224934633855, 5750.971245143789, 6399.200099987502, 6415.550911436201, 6465.450436712885, 6544.869102617921, 6567.605943643397, 4830.2030165022725, 4853.975730121362, 4879.292247713307, 4879.707217566957, 4886.755662216875, 6830.863382732317, 6875.209350924608, 6880.827979300508, 6907.896381554281, 6941.826454338682, 4930.0, 4946.109700253917, 4950.8267210647455, 4958.876028099255, 4975.800967961313, 5010.749462526932, 5038.949610503922, 5040.899182016413, 5052.9242061369105, 5078.7460626968505, 5633.183188437735, 5690.77236910519, 5699.0, 5709.628874123168, 5743.253377061039, 6438.356164383524, 6518.902216466757, 6535.738570457129, 6636.867262654817, 6651.567648102858, 1627.886047976654, 1664.625459271654, 1692.2976964559816, 1730.3597668862349, 1730.9480715578552, 1164.2665120973732, 1198.940052997364, 1203.3080978437433, 1223.1254652923203, 1234.7160153164823, 5659.858503537444, 5682.176084467729, 5731.512821410143, 5746.080627099727, 5810.331811841692, 6460.0, 6558.409743123047, 6609.992453433676, 6704.832379190461, 6757.155355580552, 5677.574181936371, 5711.515975255091, 5758.62568933018, 5808.5933984621515, 5844.766209351664, 3534.717222622184, 3561.5191949086543, 3577.713782897362, 3581.874634387836, 3602.8110723461195, 6478.384553467413, 6556.737730490822, 6583.242927063353, 6592.8351791205605, 6610.3720146586, 6849.280825513349, 6924.792256232321, 6968.198657154391, 6992.650367481606, 7000.334968178015, 6385.521085918482, 6481.643509607017, 6486.156799616019, 6518.57629254097, 6564.606123632502, 6669.998500674813, 6686.966565167143, 6710.865782684416, 6765.830854228684, 6765.9661701691175, 6568.47452203813, 6570.277269500447, 6627.304133066152, 6684.192639091691, 6724.899126513008, 6316.684165791784, 6420.165378500765, 6433.555249005348, 6446.484281257582, 6561.901571476527, 4907.754612269444, 4939.802407903644, 4975.228839529878, 4984.725840078685, 4994.051130285234, 6534.509911756732, 6818.522703410912, 6830.965845170742, 6848.486363522856, 6852.177738671391, 6299.937000630119, 6459.354064593503, 6503.934960650333, 6556.704948277244, 6572.309907459648, 6454.5159113065765, 6471.741130354733, 6476.384743449365, 6503.577267477788, 6567.802965911031, 6350.650714210763, 6375.585586936834, 6377.556119695498, 6390.712417941111, 6472.546921715435, 6474.741010359533, 6480.675966201766, 6498.415142637185, 6530.575512591667, 6633.6019838809825, 6322.810315690536, 6329.620222786648, 6331.841703957438, 6339.873202536016, 6473.2232132144445], "value": 5037.279762292459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.0883589902403, 888.156251561017, 908.5684299957517, 913.821804748074, 919.2875521470858, 18960.431187064376, 18987.71518427225, 19966.101525431353, 19978.7003194952, 19994.600107997867, 20272.18911243552, 21048.89475552624, 21087.789122108774, 21217.0, 21262.468438289052, 924.5284904698601, 948.3882895532378, 953.2850362228329, 953.4374718915839, 955.47926380123, 854.9615267312986, 938.6667732954771, 951.0822056715268, 954.0221273194961, 954.2890546542801, 1007.7329507680471, 1019.0370100255262, 1020.1685626214648, 1022.7852151048289, 1023.2888142740799, 1010.196893469686, 1011.3476807459184, 1012.9971328384846, 1013.204634362026, 1014.5028935821468, 729.8905164225356, 730.1493759769915, 738.4166508458311, 739.0946091038488, 739.6560599321341, 16831.495055148363, 18198.363057293063, 19292.0, 19494.610107797766, 19568.608627827365, 20653.4836629084, 20699.79300206994, 21109.577808443744, 21175.894120529454, 21189.0, 17072.146392680315, 17086.40197593091, 17119.572010699707, 17475.47573572795, 17477.038762868036, 3691.5201023866994, 3766.8681596144, 3777.7355585109053, 3777.8299976501125, 3780.319542482352, 120988.0, 121962.0, 123441.38279308636, 123538.0, 125544.37227813802, 16169.59576010609, 16421.096839673693, 16535.917320413322, 16626.334946602, 16628.83371166273, 29128.271793204916, 30029.699703003127, 30049.399012020076, 30051.098467046024, 30353.24116897051, 8992.820143597222, 9170.174684278314, 9257.49083800384, 9258.675946341846, 9265.166135047743, 4183.4979802423295, 4234.407182994383, 4255.148970205972, 4283.550227226158, 4302.333138363559, 4751.382320298339, 4896.363472748591, 4918.5573298403315, 4926.433460152057, 4940.851774446773, 1045.5399624165343, 1045.5974449836715, 1072.5816931396762, 1073.7584043590286, 1078.2883297024084, 686.7802303263007, 713.7644577289482, 717.125107369009, 719.0975325965879, 738.0405472885228, 11299.887001129884, 11694.239874408137, 12029.939850300867, 12531.87468125307, 12627.368631568568, 691.1774987764544, 701.0780823217555, 706.156143408632, 707.6886170085146, 716.3803310136799, 5690.0, 5876.500497457679, 6115.908261376083, 6215.378462153839, 6354.23749150105, 117118.0, 117189.0, 118319.0, 120733.39633301778, 125435.0, 91746.08253917508, 100136.0, 103000.48499757453, 103426.0, 104212.47893760483, 84249.0, 86893.56553217194, 88781.9999999987, 90466.0, 90711.0, 12120.393980300772, 12575.68560785951, 12753.0, 12937.935310323388, 13514.79727804064, 39512.60487395089, 39564.0, 40950.59049409468, 41284.38073428841, 43345.566544335416, 69689.0, 71339.28660713327, 71722.0, 72914.63542682253, 73961.6301918487, 19141.521461963563, 19537.0, 19544.413667589994, 19790.0, 19814.40556783299, 20204.494887627927, 20765.68851467199, 21085.05117269696, 21552.24567140205, 21601.567968640225, 18379.81620183781, 18500.629987400447, 18614.34849780251, 19241.90379048096, 19254.903725481283, 18100.72848907294, 18130.45608631743, 18249.0875456224, 18881.527961801065, 19071.332503362315, 18045.548861278574, 18228.635427291647, 18352.541186470444, 18432.907835460737, 18526.444206673823, 14085.507007254697, 14114.717705646035, 14125.576232713034, 14160.140642480488, 14200.573982780534, 13315.267660278778, 13462.46150154022, 13580.45678172862, 13604.455821767018, 13722.65693357674], "value": 9237.105384573175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 96.0, 106.0, 108.0, 108.0, 110.0, 105.0, 106.0, 110.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 144.0, 167.0, 117.0, 151.0, 148.0, 121.0, 172.0, 119.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 165.0, 165.0, 170.0, 166.0, 164.0, 168.0, 191.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 177.0, 74.0, 74.0, 73.0, 90.0, 96.0, 74.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 134.0, 80.0, 79.0, 79.0, 135.0, 79.0, 82.0, 131.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 127.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 150.0, 149.0, 149.0, 150.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 54.0, 52.0, 56.0, 52.0, 51.0, 51.0, 52.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 54.0, 56.0, 55.0, 55.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 73.0, 75.0, 78.0, 74.0, 74.0, 76.0, 76.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 124.0, 115.0, 118.0, 118.0, 118.0, 115.0, 123.0, 156.0], "value": 122.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 169.0, 171.0, 167.0, 170.0, 168.0, 167.0, 166.0, 168.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 67.0, 65.0, 64.0, 63.0, 64.0, 67.0, 67.0, 69.0], "value": 65.9, "unit": "score"}]}]} 19:02:19 INFO - Return code: 0 19:02:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:02:19 INFO - # TBPL SUCCESS # 19:02:19 INFO - Running post-action listener: _package_coverage_data 19:02:19 INFO - Running post-action listener: _resource_record_post_action 19:02:19 INFO - [mozharness: 2017-08-23 02:02:19.729410Z] Finished run-tests step (success) 19:02:19 INFO - Running post-run listener: _resource_record_post_run 19:02:19 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 446009344; Read time: 12; Write time: 332992 19:02:19 INFO - TinderboxPrint: CPU usage
13.1% 19:02:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:02:19 INFO - TinderboxPrint: I/O write bytes / time
446,009,344 / 332,992 19:02:19 INFO - TinderboxPrint: CPU idle
8,236.8 (86.9%) 19:02:19 INFO - TinderboxPrint: CPU user
1,194.6 (12.6%) 19:02:19 INFO - TinderboxPrint: Swap in / out
0 / 0 19:02:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107094016; Read time: 0; Write time: 105104 19:02:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:02:19 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 337252352; Read time: 0; Write time: 227744 19:02:20 INFO - Running post-run listener: _upload_blobber_files 19:02:20 INFO - Blob upload gear active. 19:02:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:02:20 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 19:02:20 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'] 19:02:20 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 19:02:20 INFO - (blobuploader) - INFO - Open directory for files ... 19:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:02:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:21 INFO - (blobuploader) - INFO - Done attempting. 19:02:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:02:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:28 INFO - (blobuploader) - INFO - Done attempting. 19:02:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:02:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:28 INFO - (blobuploader) - INFO - Done attempting. 19:02:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:02:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:02:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:29 INFO - (blobuploader) - INFO - Done attempting. 19:02:29 INFO - (blobuploader) - INFO - Iteration through files over. 19:02:29 INFO - Return code: 0 19:02:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:02:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:02:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/934e223246591efa645ff9d4c8b8d766704196ecf09a2d242007d176526250eef9f40861d256be0723e3b09f6e6a5e0c2646f8b25accf118666c7885f782c386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445d5ef0a5ed7a8955fd0a6ac726ded1ee8fbc9796b57779c05d9002c421d63af91d426934b98fc19fe6c546855a1ee093df28c583c7f23e6fa0dbc0686a2107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd2b4cc65fa7995436f49100075a80a8151df21b338c77bb29023bc72f4930fc3825073bbef32fe7939a68e39f9819ab77453d25b8c359ed4995f1546e738da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde82ba32852b372c097ab3ca3d362dbd6d75043846e31ce06e272dd6a42be2be8e2741d1efd75e07dc87d4c9673cb0e3c0e751af7c6c11887788acc4863819e"} 19:02:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:02:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:02:29 INFO - Contents: 19:02:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/934e223246591efa645ff9d4c8b8d766704196ecf09a2d242007d176526250eef9f40861d256be0723e3b09f6e6a5e0c2646f8b25accf118666c7885f782c386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445d5ef0a5ed7a8955fd0a6ac726ded1ee8fbc9796b57779c05d9002c421d63af91d426934b98fc19fe6c546855a1ee093df28c583c7f23e6fa0dbc0686a2107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd2b4cc65fa7995436f49100075a80a8151df21b338c77bb29023bc72f4930fc3825073bbef32fe7939a68e39f9819ab77453d25b8c359ed4995f1546e738da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde82ba32852b372c097ab3ca3d362dbd6d75043846e31ce06e272dd6a42be2be8e2741d1efd75e07dc87d4c9673cb0e3c0e751af7c6c11887788acc4863819e"} 19:02:29 INFO - Running post-run listener: copy_logs_to_upload_dir 19:02:29 INFO - Copying logs to upload dir... 19:02:29 INFO - mkdir: /builds/slave/test/build/upload/logs 19:02:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.545271 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-22 19:02:29.609107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 19:02:29.612895) ========= 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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/934e223246591efa645ff9d4c8b8d766704196ecf09a2d242007d176526250eef9f40861d256be0723e3b09f6e6a5e0c2646f8b25accf118666c7885f782c386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445d5ef0a5ed7a8955fd0a6ac726ded1ee8fbc9796b57779c05d9002c421d63af91d426934b98fc19fe6c546855a1ee093df28c583c7f23e6fa0dbc0686a2107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd2b4cc65fa7995436f49100075a80a8151df21b338c77bb29023bc72f4930fc3825073bbef32fe7939a68e39f9819ab77453d25b8c359ed4995f1546e738da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde82ba32852b372c097ab3ca3d362dbd6d75043846e31ce06e272dd6a42be2be8e2741d1efd75e07dc87d4c9673cb0e3c0e751af7c6c11887788acc4863819e"} build_url:https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/B13Ixl9iTias4oEEpdFzUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/934e223246591efa645ff9d4c8b8d766704196ecf09a2d242007d176526250eef9f40861d256be0723e3b09f6e6a5e0c2646f8b25accf118666c7885f782c386", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445d5ef0a5ed7a8955fd0a6ac726ded1ee8fbc9796b57779c05d9002c421d63af91d426934b98fc19fe6c546855a1ee093df28c583c7f23e6fa0dbc0686a2107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd2b4cc65fa7995436f49100075a80a8151df21b338c77bb29023bc72f4930fc3825073bbef32fe7939a68e39f9819ab77453d25b8c359ed4995f1546e738da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde82ba32852b372c097ab3ca3d362dbd6d75043846e31ce06e272dd6a42be2be8e2741d1efd75e07dc87d4c9673cb0e3c0e751af7c6c11887788acc4863819e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 19:02:29.639892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 19:02:29.640291) ========= 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=3a3620fb28aea1604ab609ef000001d2-1503452494.644872-1388512313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 19:02:29.723620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 19:02:29.724029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 19:02:29.724382) ========= ========= Total master_lag: 0.15 =========