builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1503501675.64 results: success (0) revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.643699) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.644225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.644558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.661142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.661519) ========= 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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 08:21:15-- 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% 229M=0s 2017-08-23 08:21:15 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.762591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.762958) ========= 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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018279 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.815853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:15.816207) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 446cd9f4b0f5684adaf275a999e0361988a95cfe --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 446cd9f4b0f5684adaf275a999e0361988a95cfe --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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 08:21:16,003 truncating revision to first 12 chars 2017-08-23 08:21:16,003 Setting DEBUG logging. 2017-08-23 08:21:16,003 attempt 1/10 2017-08-23 08:21:16,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/446cd9f4b0f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 08:21:16,317 unpacking tar archive at: mozilla-central-446cd9f4b0f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:16.465245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:16.465562) ========= script_repo_revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:16.465969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:16.466239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:21:16.478386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-23 08:21:16.478766) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:16 INFO - MultiFileLogger online at 20170823 08:21:16 in /builds/slave/test 08:21:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:16 INFO - {'append_to_log': False, 08:21:16 INFO - 'base_work_dir': '/builds/slave/test', 08:21:16 INFO - 'blob_upload_branch': 'Firefox', 08:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:16 INFO - 'branch': 'Firefox', 08:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:16 INFO - 'code_coverage': False, 08:21:16 INFO - 'config_files': ('talos/linux_config.py',), 08:21:16 INFO - 'default_actions': ('clobber', 08:21:16 INFO - 'read-buildbot-config', 08:21:16 INFO - 'download-and-extract', 08:21:16 INFO - 'populate-webroot', 08:21:16 INFO - 'create-virtualenv', 08:21:16 INFO - 'install', 08:21:16 INFO - 'setup-mitmproxy', 08:21:16 INFO - 'run-tests'), 08:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:16 INFO - 'disable_ccov_upload': False, 08:21:16 INFO - 'download_minidump_stackwalk': True, 08:21:16 INFO - 'download_symbols': 'ondemand', 08:21:16 INFO - 'enable_stylo': False, 08:21:16 INFO - 'enable_webrender': False, 08:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:16 INFO - 'gecko_profile': False, 08:21:16 INFO - 'gecko_profile_interval': 0, 08:21:16 INFO - 'installer_path': 'installer.exe', 08:21:16 INFO - 'log_level': 'info', 08:21:16 INFO - 'log_name': 'talos', 08:21:16 INFO - 'log_to_console': True, 08:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:16 INFO - 'opt_config_files': (), 08:21:16 INFO - 'pip_index': False, 08:21:16 INFO - 'suite': 'dromaeojs-e10s', 08:21:16 INFO - 'system_bits': '32', 08:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:16 INFO - 'title': 'talos-linux64-ix-031', 08:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:16 INFO - 'use_talos_json': True, 08:21:16 INFO - 'verify': 'False', 08:21:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:16 INFO - 'work_dir': 'build'} 08:21:16 INFO - [mozharness: 2017-08-23 15:21:16.815097Z] Running clobber step. 08:21:16 INFO - Running pre-action listener: _resource_record_pre_action 08:21:16 INFO - Running main action method: clobber 08:21:16 INFO - rmtree: /builds/slave/test/build 08:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:17 INFO - Running post-action listener: _resource_record_post_action 08:21:17 INFO - [mozharness: 2017-08-23 15:21:17.835582Z] Finished clobber step (success) 08:21:17 INFO - [mozharness: 2017-08-23 15:21:17.835678Z] Running read-buildbot-config step. 08:21:17 INFO - Running pre-action listener: _resource_record_pre_action 08:21:17 INFO - Running main action method: read_buildbot_config 08:21:17 INFO - Using buildbot properties: 08:21:17 INFO - { 08:21:17 INFO - "project": "", 08:21:17 INFO - "product": "firefox", 08:21:17 INFO - "who": "archaeopteryx@coole-files.de", 08:21:17 INFO - "installer_path": "public/build/target.tar.bz2", 08:21:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:21:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:21:17 INFO - "stage_platform": "linux64-stylo", 08:21:17 INFO - "basedir": "/builds/slave/test", 08:21:17 INFO - "buildnumber": 52, 08:21:17 INFO - "platform": "ubuntu64_hw_stylo", 08:21:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:21:17 INFO - "slavebuilddir": "test", 08:21:17 INFO - "taskId": "Fck9KMMJTuq-OvikMKrc0Q", 08:21:17 INFO - "branch": "mozilla-central", 08:21:17 INFO - "script_repo_revision": "production", 08:21:17 INFO - "revision": "446cd9f4b0f5684adaf275a999e0361988a95cfe", 08:21:17 INFO - "slavename": "talos-linux64-ix-031", 08:21:17 INFO - "repo_path": "mozilla-central" 08:21:17 INFO - } 08:21:17 INFO - Finding installer, test and symbols from parent task. 08:21:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fck9KMMJTuq-OvikMKrc0Q'}, attempt #1 08:21:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fck9KMMJTuq-OvikMKrc0Q'}, attempt #1 08:21:18 INFO - Task dependencies: b8HvYVIUQ8S4HNJ3UL126w 08:21:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w'}, attempt #1 08:21:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:21:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json 08:21:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.crashreporter-symbols.zip 08:21:19 INFO - Running post-action listener: _resource_record_post_action 08:21:19 INFO - [mozharness: 2017-08-23 15:21:19.339189Z] Finished read-buildbot-config step (success) 08:21:19 INFO - [mozharness: 2017-08-23 15:21:19.339407Z] Running download-and-extract step. 08:21:19 INFO - Running pre-action listener: _resource_record_pre_action 08:21:19 INFO - Running main action method: download_and_extract 08:21:19 INFO - mkdir: /builds/slave/test/build/tests 08:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:19 INFO - trying https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json 08:21:19 INFO - Downloading https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:21:19 INFO - Downloaded 989 bytes. 08:21:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:21:19 INFO - Using the following test package requirements: 08:21:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:21:19 INFO - u'common': [u'target.common.tests.zip'], 08:21:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:21:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:21:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:21:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:21:19 INFO - u'mozbase': [u'target.common.tests.zip'], 08:21:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:21:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:21:19 INFO - u'web-platform': [u'target.common.tests.zip', 08:21:19 INFO - u'target.web-platform.tests.tar.gz'], 08:21:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:21:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:21:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip 08:21:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:21:19 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip into memory 08:21:21 INFO - Content-Length response header: 54949361 08:21:21 INFO - Bytes received: 54949361 08:21:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:21:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip 08:21:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:21:31 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip into memory 08:21:32 INFO - Content-Length response header: 54949361 08:21:32 INFO - Bytes received: 54949361 08:21:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.talos.tests.zip 08:21:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:21:44 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.talos.tests.zip into memory 08:21:45 INFO - Content-Length response header: 14496261 08:21:45 INFO - Bytes received: 14496261 08:21:45 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')]} 08:21:45 INFO - trying https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:21:45 INFO - Downloading https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:21:47 INFO - Downloaded 61144598 bytes. 08:21:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:21:47 INFO - mkdir: /builds/slave/test/properties 08:21:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:47 INFO - Contents: 08:21:47 INFO - build_url:https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:21:47 INFO - Running post-action listener: _resource_record_post_action 08:21:47 INFO - Running post-action listener: find_tests_for_verification 08:21:47 INFO - Running post-action listener: set_extra_try_arguments 08:21:47 INFO - [mozharness: 2017-08-23 15:21:47.032808Z] Finished download-and-extract step (success) 08:21:47 INFO - [mozharness: 2017-08-23 15:21:47.032905Z] Running populate-webroot step. 08:21:47 INFO - Running pre-action listener: _resource_record_pre_action 08:21:47 INFO - Running main action method: populate_webroot 08:21:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:47 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:47 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:47 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'tests': ['damp', 'tps']}, 08:21:47 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['damp', 'tps']}, 08:21:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:21:47 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:21:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:21:47 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:21:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:47 INFO - 'ts_paint', 08:21:47 INFO - 'tpaint', 08:21:47 INFO - 'sessionrestore', 08:21:47 INFO - 'sessionrestore_many_windows', 08:21:47 INFO - 'sessionrestore_no_auto_restore', 08:21:47 INFO - 'tabpaint']}, 08:21:47 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['a11yr', 08:21:47 INFO - 'ts_paint', 08:21:47 INFO - 'tpaint', 08:21:47 INFO - 'sessionrestore', 08:21:47 INFO - 'sessionrestore_many_windows', 08:21:47 INFO - 'sessionrestore_no_auto_restore', 08:21:47 INFO - 'tabpaint']}, 08:21:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:21:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:21:47 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['bloom_basic_singleton']}, 08:21:47 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['bloom_basic']}, 08:21:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:47 INFO - 'tsvgr_opacity', 08:21:47 INFO - 'tart', 08:21:47 INFO - 'tscrollx', 08:21:47 INFO - 'tsvg_static']}, 08:21:47 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['tsvgx', 08:21:47 INFO - 'tsvgr_opacity', 08:21:47 INFO - 'tart', 08:21:47 INFO - 'tscrollx', 08:21:47 INFO - 'tsvg_static']}, 08:21:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:21:47 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--stylo'], 08:21:47 INFO - 'tests': ['tp5o']}, 08:21:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:21:47 INFO - 'talos_options': ['--mitmproxy', 08:21:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:21:47 INFO - '--firstNonBlankPaint'], 08:21:47 INFO - 'tests': ['tp6_google', 08:21:47 INFO - 'tp6_youtube', 08:21:47 INFO - 'tp6_amazon', 08:21:47 INFO - 'tp6_facebook']}, 08:21:47 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:21:47 INFO - 'talos_options': ['--stylo', 08:21:47 INFO - '--mitmproxy', 08:21:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:21:47 INFO - '--firstNonBlankPaint'], 08:21:47 INFO - 'tests': ['tp6_google', 08:21:47 INFO - 'tp6_youtube', 08:21:47 INFO - 'tp6_amazon', 08:21:47 INFO - 'tp6_facebook']}, 08:21:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:21:47 INFO - 'talos_options': ['--stylo', 08:21:47 INFO - '--stylo-threads=1', 08:21:47 INFO - '--mitmproxy', 08:21:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:21:47 INFO - '--firstNonBlankPaint'], 08:21:47 INFO - 'tests': ['tp6_google', 08:21:47 INFO - 'tp6_youtube', 08:21:47 INFO - 'tp6_amazon', 08:21:47 INFO - 'tp6_facebook']}, 08:21:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--xperf_path', 08:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:47 INFO - 'tests': ['tp5n']}, 08:21:47 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:21:47 INFO - 'talos_options': ['--stylo', 08:21:47 INFO - '--xperf_path', 08:21:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:47 INFO - 'tests': ['tp5n']}}} 08:21:47 INFO - Running post-action listener: _resource_record_post_action 08:21:47 INFO - [mozharness: 2017-08-23 15:21:47.047080Z] Finished populate-webroot step (success) 08:21:47 INFO - [mozharness: 2017-08-23 15:21:47.047170Z] Running create-virtualenv step. 08:21:47 INFO - Running pre-action listener: _resource_record_pre_action 08:21:47 INFO - Running main action method: create_virtualenv 08:21:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:47 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 08:21:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:21:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:47 INFO - Using real prefix '/usr' 08:21:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:49 INFO - Installing pip.................done. 08:21:49 INFO - Return code: 0 08:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:21:49 INFO - Reading from file tmpfile_stdout 08:21:49 INFO - Output received: 08:21:49 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) 08:21:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:49 INFO - Using env: {'DISPLAY': ':0', 08:21:49 INFO - 'HOME': '/home/cltbld', 08:21:49 INFO - 'LANG': 'en_US.UTF-8', 08:21:49 INFO - 'LANGUAGE': 'en_US:en', 08:21:49 INFO - 'LOGNAME': 'cltbld', 08:21:49 INFO - 'MAIL': '/var/mail/cltbld', 08:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:49 INFO - 'MOZ_NO_REMOTE': '1', 08:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:49 INFO - 'NO_EM_RESTART': '1', 08:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:49 INFO - 'PWD': '/builds/slave/test', 08:21:49 INFO - 'SHELL': '/bin/bash', 08:21:49 INFO - 'SHLVL': '1', 08:21:49 INFO - 'TERM': 'linux', 08:21:49 INFO - 'TMOUT': '86400', 08:21:49 INFO - 'USER': 'cltbld', 08:21:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:49 INFO - '_': '/tools/buildbot/bin/python'} 08:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:50 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 08:21:50 INFO - Cleaning up... 08:21:50 INFO - Return code: 0 08:21:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:50 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:50 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 08:21:50 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 08:21:50 INFO - Using env: {'DISPLAY': ':0', 08:21:50 INFO - 'HOME': '/home/cltbld', 08:21:50 INFO - 'LANG': 'en_US.UTF-8', 08:21:50 INFO - 'LANGUAGE': 'en_US:en', 08:21:50 INFO - 'LOGNAME': 'cltbld', 08:21:50 INFO - 'MAIL': '/var/mail/cltbld', 08:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:50 INFO - 'MOZ_NO_REMOTE': '1', 08:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:50 INFO - 'NO_EM_RESTART': '1', 08:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:50 INFO - 'PWD': '/builds/slave/test', 08:21:50 INFO - 'SHELL': '/bin/bash', 08:21:50 INFO - 'SHLVL': '1', 08:21:50 INFO - 'TERM': 'linux', 08:21:50 INFO - 'TMOUT': '86400', 08:21:50 INFO - 'USER': 'cltbld', 08:21:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:50 INFO - '_': '/tools/buildbot/bin/python'} 08:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:50 INFO - Downloading/unpacking psutil>=3.1.1 08:21:50 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 08:21:50 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 08:21:50 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 08:21:50 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 08:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:51 INFO - Installing collected packages: psutil 08:21:51 INFO - Running setup.py install for psutil 08:21:51 INFO - building 'psutil._psutil_linux' extension 08:21:51 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 08:21:51 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 08:21:51 INFO - building 'psutil._psutil_posix' extension 08:21:51 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 08:21:51 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 08:21:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:51 INFO - Successfully installed psutil 08:21:51 INFO - Cleaning up... 08:21:52 INFO - Return code: 0 08:21:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:52 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')]} 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:52 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')]} 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:52 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:52 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 08:21:52 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 08:21:52 INFO - Using env: {'DISPLAY': ':0', 08:21:52 INFO - 'HOME': '/home/cltbld', 08:21:52 INFO - 'LANG': 'en_US.UTF-8', 08:21:52 INFO - 'LANGUAGE': 'en_US:en', 08:21:52 INFO - 'LOGNAME': 'cltbld', 08:21:52 INFO - 'MAIL': '/var/mail/cltbld', 08:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:52 INFO - 'MOZ_NO_REMOTE': '1', 08:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:52 INFO - 'NO_EM_RESTART': '1', 08:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:52 INFO - 'PWD': '/builds/slave/test', 08:21:52 INFO - 'SHELL': '/bin/bash', 08:21:52 INFO - 'SHLVL': '1', 08:21:52 INFO - 'TERM': 'linux', 08:21:52 INFO - 'TMOUT': '86400', 08:21:52 INFO - 'USER': 'cltbld', 08:21:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:52 INFO - '_': '/tools/buildbot/bin/python'} 08:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:52 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 08:21:52 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 08:21:52 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 08:21:52 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 08:21:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:53 INFO - Installing collected packages: mozsystemmonitor 08:21:53 INFO - Running setup.py install for mozsystemmonitor 08:21:53 INFO - Successfully installed mozsystemmonitor 08:21:53 INFO - Cleaning up... 08:21:53 INFO - Return code: 0 08:21:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:53 INFO - Using env: {'DISPLAY': ':0', 08:21:53 INFO - 'HOME': '/home/cltbld', 08:21:53 INFO - 'LANG': 'en_US.UTF-8', 08:21:53 INFO - 'LANGUAGE': 'en_US:en', 08:21:53 INFO - 'LOGNAME': 'cltbld', 08:21:53 INFO - 'MAIL': '/var/mail/cltbld', 08:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:53 INFO - 'MOZ_NO_REMOTE': '1', 08:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:53 INFO - 'NO_EM_RESTART': '1', 08:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:53 INFO - 'PWD': '/builds/slave/test', 08:21:53 INFO - 'SHELL': '/bin/bash', 08:21:53 INFO - 'SHLVL': '1', 08:21:53 INFO - 'TERM': 'linux', 08:21:53 INFO - 'TMOUT': '86400', 08:21:53 INFO - 'USER': 'cltbld', 08:21:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:53 INFO - '_': '/tools/buildbot/bin/python'} 08:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:53 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 08:21:53 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 08:21:53 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 08:21:53 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 08:21:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:55 INFO - warning: no files found matching '*.txt' 08:21:55 INFO - no previously-included directories found matching 'build' 08:21:55 INFO - no previously-included directories found matching 'dist' 08:21:55 INFO - no previously-included directories found matching '.git*' 08:21:55 INFO - Installing collected packages: jsonschema, functools32 08:21:55 INFO - Running setup.py install for functools32 08:21:55 INFO - warning: no files found matching '*.txt' 08:21:55 INFO - no previously-included directories found matching 'build' 08:21:55 INFO - no previously-included directories found matching 'dist' 08:21:55 INFO - no previously-included directories found matching '.git*' 08:21:55 INFO - Successfully installed jsonschema functools32 08:21:55 INFO - Cleaning up... 08:21:55 INFO - Return code: 0 08:21:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:21:55 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')]} 08:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:55 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')]} 08:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:55 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:55 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 08:21:55 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 08:21:55 INFO - Using env: {'DISPLAY': ':0', 08:21:55 INFO - 'HOME': '/home/cltbld', 08:21:55 INFO - 'LANG': 'en_US.UTF-8', 08:21:55 INFO - 'LANGUAGE': 'en_US:en', 08:21:55 INFO - 'LOGNAME': 'cltbld', 08:21:55 INFO - 'MAIL': '/var/mail/cltbld', 08:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:55 INFO - 'MOZ_NO_REMOTE': '1', 08:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:55 INFO - 'NO_EM_RESTART': '1', 08:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:55 INFO - 'PWD': '/builds/slave/test', 08:21:55 INFO - 'SHELL': '/bin/bash', 08:21:55 INFO - 'SHLVL': '1', 08:21:55 INFO - 'TERM': 'linux', 08:21:55 INFO - 'TMOUT': '86400', 08:21:55 INFO - 'USER': 'cltbld', 08:21:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:55 INFO - '_': '/tools/buildbot/bin/python'} 08:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:21:55 INFO - Cleaning up... 08:21:55 INFO - Return code: 0 08:21:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:55 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')]} 08:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:55 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')]} 08:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:55 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:55 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 08:21:55 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 08:21:55 INFO - Using env: {'DISPLAY': ':0', 08:21:55 INFO - 'HOME': '/home/cltbld', 08:21:55 INFO - 'LANG': 'en_US.UTF-8', 08:21:55 INFO - 'LANGUAGE': 'en_US:en', 08:21:55 INFO - 'LOGNAME': 'cltbld', 08:21:55 INFO - 'MAIL': '/var/mail/cltbld', 08:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:55 INFO - 'MOZ_NO_REMOTE': '1', 08:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:55 INFO - 'NO_EM_RESTART': '1', 08:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:55 INFO - 'PWD': '/builds/slave/test', 08:21:55 INFO - 'SHELL': '/bin/bash', 08:21:55 INFO - 'SHLVL': '1', 08:21:55 INFO - 'TERM': 'linux', 08:21:55 INFO - 'TMOUT': '86400', 08:21:55 INFO - 'USER': 'cltbld', 08:21:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:55 INFO - '_': '/tools/buildbot/bin/python'} 08:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:55 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 08:21:55 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 08:21:55 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 08:21:55 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 08:21:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:56 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 08:21:56 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 08:21:56 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 08:21:56 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 08:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:57 INFO - Downloading docopt-0.6.1.tar.gz 08:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:57 INFO - Running setup.py install for blobuploader 08:21:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:57 INFO - Running setup.py install for requests 08:21:57 INFO - Running setup.py install for docopt 08:21:57 INFO - Successfully installed blobuploader requests docopt 08:21:57 INFO - Cleaning up... 08:21:57 INFO - Return code: 0 08:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:57 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:21:57 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 08:21:57 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 08:21:57 INFO - Using env: {'DISPLAY': ':0', 08:21:57 INFO - 'HOME': '/home/cltbld', 08:21:57 INFO - 'LANG': 'en_US.UTF-8', 08:21:57 INFO - 'LANGUAGE': 'en_US:en', 08:21:57 INFO - 'LOGNAME': 'cltbld', 08:21:57 INFO - 'MAIL': '/var/mail/cltbld', 08:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:57 INFO - 'MOZ_NO_REMOTE': '1', 08:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:57 INFO - 'NO_EM_RESTART': '1', 08:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:57 INFO - 'PWD': '/builds/slave/test', 08:21:57 INFO - 'SHELL': '/bin/bash', 08:21:57 INFO - 'SHLVL': '1', 08:21:57 INFO - 'TERM': 'linux', 08:21:57 INFO - 'TMOUT': '86400', 08:21:57 INFO - 'USER': 'cltbld', 08:21:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:57 INFO - '_': '/tools/buildbot/bin/python'} 08:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:58 INFO - Running setup.py (path:/tmp/pip-KHrrdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:58 INFO - Running setup.py (path:/tmp/pip-DZjyxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:58 INFO - Running setup.py (path:/tmp/pip-x_FCjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:58 INFO - Running setup.py (path:/tmp/pip-OyhjIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:58 INFO - Running setup.py (path:/tmp/pip-8zEdGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:58 INFO - Running setup.py (path:/tmp/pip-uKte5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:58 INFO - Running setup.py (path:/tmp/pip-kf9Cpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:58 INFO - Running setup.py (path:/tmp/pip-fnomjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:58 INFO - Running setup.py (path:/tmp/pip-VzETRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:58 INFO - Running setup.py (path:/tmp/pip-5NFpwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:58 INFO - Running setup.py (path:/tmp/pip-IIxLe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:58 INFO - Running setup.py (path:/tmp/pip-JKNpLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:59 INFO - Running setup.py (path:/tmp/pip-A6USTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:59 INFO - Running setup.py (path:/tmp/pip-kOQoLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:59 INFO - Running setup.py (path:/tmp/pip-g0g0sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:59 INFO - Running setup.py (path:/tmp/pip-tLoBFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:59 INFO - Running setup.py (path:/tmp/pip-Tnqonk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:59 INFO - Running setup.py install for manifestparser 08:21:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:59 INFO - Running setup.py install for mozcrash 08:21:59 INFO - Running setup.py install for mozdebug 08:21:59 INFO - Running setup.py install for mozdevice 08:21:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:59 INFO - Running setup.py install for mozfile 08:21:59 INFO - Running setup.py install for mozhttpd 08:21:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:59 INFO - Running setup.py install for mozinfo 08:22:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for mozInstall 08:22:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for mozleak 08:22:00 INFO - Running setup.py install for mozlog 08:22:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for moznetwork 08:22:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for mozprocess 08:22:00 INFO - Running setup.py install for mozprofile 08:22:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for mozrunner 08:22:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Running setup.py install for mozscreenshot 08:22:00 INFO - Running setup.py install for moztest 08:22:01 INFO - Running setup.py install for mozversion 08:22:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:01 INFO - Cleaning up... 08:22:01 INFO - Return code: 0 08:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:01 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')]} 08:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:01 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')]} 08:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:01 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:22:01 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 08:22:01 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 08:22:01 INFO - Using env: {'DISPLAY': ':0', 08:22:01 INFO - 'HOME': '/home/cltbld', 08:22:01 INFO - 'LANG': 'en_US.UTF-8', 08:22:01 INFO - 'LANGUAGE': 'en_US:en', 08:22:01 INFO - 'LOGNAME': 'cltbld', 08:22:01 INFO - 'MAIL': '/var/mail/cltbld', 08:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:01 INFO - 'MOZ_NO_REMOTE': '1', 08:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:01 INFO - 'NO_EM_RESTART': '1', 08:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:01 INFO - 'PWD': '/builds/slave/test', 08:22:01 INFO - 'SHELL': '/bin/bash', 08:22:01 INFO - 'SHLVL': '1', 08:22:01 INFO - 'TERM': 'linux', 08:22:01 INFO - 'TMOUT': '86400', 08:22:01 INFO - 'USER': 'cltbld', 08:22:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:01 INFO - '_': '/tools/buildbot/bin/python'} 08:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:01 INFO - Running setup.py (path:/tmp/pip-4OPtgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:01 INFO - Running setup.py (path:/tmp/pip-a1RQF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:01 INFO - Running setup.py (path:/tmp/pip-1ojfUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:01 INFO - Running setup.py (path:/tmp/pip-9Zmj1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:01 INFO - Running setup.py (path:/tmp/pip-vkIp2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:01 INFO - Running setup.py (path:/tmp/pip-Iddp9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:01 INFO - Running setup.py (path:/tmp/pip-zaao1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:01 INFO - Running setup.py (path:/tmp/pip-omO0z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:01 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)) 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:01 INFO - Running setup.py (path:/tmp/pip-1T5kY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:02 INFO - Running setup.py (path:/tmp/pip-lIiljJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:02 INFO - Running setup.py (path:/tmp/pip-9Q5acg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:02 INFO - Running setup.py (path:/tmp/pip-iZfTsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:02 INFO - Running setup.py (path:/tmp/pip-DRxsQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:02 INFO - Running setup.py (path:/tmp/pip-zlzkpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:02 INFO - Running setup.py (path:/tmp/pip-We6Xbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:02 INFO - Running setup.py (path:/tmp/pip-5IDn0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:02 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)) 08:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:02 INFO - Running setup.py (path:/tmp/pip-ChYLDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:02 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)) 08:22:02 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)) 08:22:02 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)) 08:22:02 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)) 08:22:02 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)) 08:22:02 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)) 08:22:02 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)) 08:22:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:03 INFO - Downloading blessings-1.6.tar.gz 08:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:03 INFO - Installing collected packages: blessings 08:22:03 INFO - Running setup.py install for blessings 08:22:03 INFO - Successfully installed blessings 08:22:03 INFO - Cleaning up... 08:22:03 INFO - Return code: 0 08:22:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:04 INFO - Reading from file tmpfile_stdout 08:22:04 INFO - Current package versions: 08:22:04 INFO - argparse == 1.2.1 08:22:04 INFO - blessings == 1.6 08:22:04 INFO - blobuploader == 1.2.4 08:22:04 INFO - docopt == 0.6.1 08:22:04 INFO - functools32 == 3.2.3-2 08:22:04 INFO - jsonschema == 2.5.1 08:22:04 INFO - manifestparser == 1.1 08:22:04 INFO - mozInstall == 1.13 08:22:04 INFO - mozcrash == 1.0 08:22:04 INFO - mozdebug == 0.1 08:22:04 INFO - mozdevice == 0.51 08:22:04 INFO - mozfile == 1.2 08:22:04 INFO - mozhttpd == 0.7 08:22:04 INFO - mozinfo == 0.10 08:22:04 INFO - mozleak == 0.1 08:22:04 INFO - mozlog == 3.5 08:22:04 INFO - moznetwork == 0.27 08:22:04 INFO - mozprocess == 0.25 08:22:04 INFO - mozprofile == 0.28 08:22:04 INFO - mozrunner == 6.13 08:22:04 INFO - mozscreenshot == 0.1 08:22:04 INFO - mozsystemmonitor == 0.3 08:22:04 INFO - moztest == 0.8 08:22:04 INFO - mozversion == 1.4 08:22:04 INFO - psutil == 3.1.1 08:22:04 INFO - requests == 1.2.3 08:22:04 INFO - wsgiref == 0.1.2 08:22:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:04 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:22:04 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 08:22:04 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 08:22:04 INFO - Using env: {'DISPLAY': ':0', 08:22:04 INFO - 'HOME': '/home/cltbld', 08:22:04 INFO - 'LANG': 'en_US.UTF-8', 08:22:04 INFO - 'LANGUAGE': 'en_US:en', 08:22:04 INFO - 'LOGNAME': 'cltbld', 08:22:04 INFO - 'MAIL': '/var/mail/cltbld', 08:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:04 INFO - 'MOZ_NO_REMOTE': '1', 08:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:04 INFO - 'NO_EM_RESTART': '1', 08:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:04 INFO - 'PWD': '/builds/slave/test', 08:22:04 INFO - 'SHELL': '/bin/bash', 08:22:04 INFO - 'SHLVL': '1', 08:22:04 INFO - 'TERM': 'linux', 08:22:04 INFO - 'TMOUT': '86400', 08:22:04 INFO - 'USER': 'cltbld', 08:22:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:04 INFO - '_': '/tools/buildbot/bin/python'} 08:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:22:05 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)) 08:22:05 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)) 08:22:05 INFO - Installing collected packages: simplejson 08:22:05 INFO - Running setup.py install for simplejson 08:22:05 INFO - building 'simplejson._speedups' extension 08:22:05 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 08:22:06 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 08:22:06 INFO - Successfully installed simplejson 08:22:06 INFO - Cleaning up... 08:22:06 INFO - Return code: 0 08:22:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:06 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 0xd731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, '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': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', '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 08:22:06 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 08:22:06 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 08:22:06 INFO - Using env: {'DISPLAY': ':0', 08:22:06 INFO - 'HOME': '/home/cltbld', 08:22:06 INFO - 'LANG': 'en_US.UTF-8', 08:22:06 INFO - 'LANGUAGE': 'en_US:en', 08:22:06 INFO - 'LOGNAME': 'cltbld', 08:22:06 INFO - 'MAIL': '/var/mail/cltbld', 08:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:06 INFO - 'MOZ_NO_REMOTE': '1', 08:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:06 INFO - 'NO_EM_RESTART': '1', 08:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:06 INFO - 'PWD': '/builds/slave/test', 08:22:06 INFO - 'SHELL': '/bin/bash', 08:22:06 INFO - 'SHLVL': '1', 08:22:06 INFO - 'TERM': 'linux', 08:22:06 INFO - 'TMOUT': '86400', 08:22:06 INFO - 'USER': 'cltbld', 08:22:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:06 INFO - '_': '/tools/buildbot/bin/python'} 08:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:06 INFO - Cleaning up... 08:22:06 INFO - Return code: 0 08:22:06 INFO - Running post-action listener: _resource_record_post_action 08:22:06 INFO - Running post-action listener: _start_resource_monitoring 08:22:06 INFO - Starting resource monitoring. 08:22:06 INFO - [mozharness: 2017-08-23 15:22:06.851453Z] Finished create-virtualenv step (success) 08:22:06 INFO - [mozharness: 2017-08-23 15:22:06.851970Z] Running install step. 08:22:06 INFO - Running pre-action listener: _resource_record_pre_action 08:22:06 INFO - Running main action method: install 08:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:07 INFO - Reading from file tmpfile_stdout 08:22:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:07 INFO - Reading from file tmpfile_stdout 08:22:07 INFO - Output received: 08:22:07 INFO - Usage: mozinstall [options] installer 08:22:07 INFO - Options: 08:22:07 INFO - -h, --help show this help message and exit 08:22:07 INFO - -d DEST, --destination=DEST 08:22:07 INFO - Directory to install application into. [default: 08:22:07 INFO - "/builds/slave/test"] 08:22:07 INFO - --app=APP Application being installed. [default: firefox] 08:22:07 INFO - mkdir: /builds/slave/test/build/application 08:22:07 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'] 08:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:22:24 INFO - Reading from file tmpfile_stdout 08:22:24 INFO - Output received: 08:22:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:24 INFO - Running post-action listener: _resource_record_post_action 08:22:24 INFO - [mozharness: 2017-08-23 15:22:24.897521Z] Finished install step (success) 08:22:24 INFO - [mozharness: 2017-08-23 15:22:24.897669Z] Running setup-mitmproxy step. 08:22:24 INFO - Running pre-action listener: _resource_record_pre_action 08:22:24 INFO - Running main action method: setup_mitmproxy 08:22:24 INFO - Skipping: mitmproxy is not required 08:22:24 INFO - Running post-action listener: _resource_record_post_action 08:22:24 INFO - [mozharness: 2017-08-23 15:22:24.898203Z] Finished setup-mitmproxy step (success) 08:22:24 INFO - [mozharness: 2017-08-23 15:22:24.898307Z] Running run-tests step. 08:22:24 INFO - Running pre-action listener: _resource_record_pre_action 08:22:24 INFO - Running pre-action listener: _set_gcov_prefix 08:22:24 INFO - Running main action method: run_tests 08:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:24 INFO - Python 2.7.3 08:22:24 INFO - Return code: 0 08:22:24 INFO - grabbing minidump binary from tooltool 08:22:24 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')]} 08:22:24 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 0x10df130>, '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 0x10e0030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e04c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:24 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 08:22:24 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 08:22:24 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 08:22:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:25 INFO - Return code: 0 08:22:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - ENV: RUST_BACKTRACE is now full 08:22:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 08:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 08:22:25 INFO - Using env: {'DISPLAY': ':0', 08:22:25 INFO - 'HOME': '/home/cltbld', 08:22:25 INFO - 'LANG': 'en_US.UTF-8', 08:22:25 INFO - 'LANGUAGE': 'en_US:en', 08:22:25 INFO - 'LOGNAME': 'cltbld', 08:22:25 INFO - 'MAIL': '/var/mail/cltbld', 08:22:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:25 INFO - 'MOZ_NO_REMOTE': '1', 08:22:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:25 INFO - 'NO_EM_RESTART': '1', 08:22:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:25 INFO - 'PWD': '/builds/slave/test', 08:22:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:25 INFO - 'RUST_BACKTRACE': 'full', 08:22:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:22:25 INFO - 'SHELL': '/bin/bash', 08:22:25 INFO - 'SHLVL': '1', 08:22:25 INFO - 'STYLO_FORCE_ENABLED': '1', 08:22:25 INFO - 'TERM': 'linux', 08:22:25 INFO - 'TMOUT': '86400', 08:22:25 INFO - 'USER': 'cltbld', 08:22:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905', 08:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:25 INFO - '_': '/tools/buildbot/bin/python'} 08:22:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 08:22:25 INFO - mozversion application_buildid: 20170823143012 08:22:25 INFO - mozversion application_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:22:25 INFO - mozversion application_display_name: Nightly 08:22:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:25 INFO - mozversion application_name: Firefox 08:22:25 INFO - mozversion application_remotingname: firefox 08:22:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:22:25 INFO - mozversion application_vendor: Mozilla 08:22:25 INFO - mozversion application_version: 57.0a1 08:22:25 INFO - mozversion platform_buildid: 20170823143012 08:22:25 INFO - mozversion platform_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:22:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:22:25 INFO - mozversion platform_version: 57.0a1 08:22:25 INFO - using testdate: 1503501745 08:22:25 INFO - actual date: 1503501745 08:22:25 INFO - starting webserver on 'localhost:44935' 08:22:25 INFO - SUITE-START | Running 2 tests 08:22:25 INFO - TEST-START | dromaeo_css 08:22:25 INFO - Initialising browser for dromaeo_css test... 08:22:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html -profile /tmp/tmpYc7KTY/profile 08:22:25 INFO - TEST-INFO | started process 15472 (/builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html) 08:22:31 INFO - TEST-INFO | 15472: exit 0 08:22:31 INFO - Browser initialized. 08:22:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:31 INFO - TEST-INFO | started process 15659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYc7KTY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:32 INFO - PID 15659 | 08:22:32 INFO - PID 15659 | (/builds/slave/test/build/application/firefox/firefox:15708): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:22:32 INFO - PID 15659 | 08:22:32 INFO - PID 15659 | 08:22:32 INFO - PID 15659 | (/builds/slave/test/build/application/firefox/firefox:15768): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:22:32 INFO - PID 15659 | 08:22:32 INFO - PID 15659 | __metrics Screen width/height:1600/1200 08:22:32 INFO - PID 15659 | colorDepth:24 08:22:32 INFO - PID 15659 | Browser inner width/height: 1024/768 08:22:32 INFO - PID 15659 | __metrics 08:22:42 INFO - PID 15659 | RSS: Main: 174133248 08:22:42 INFO - PID 15659 | 08:25:41 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44935/tests/dromaeo/cssquery-ext.html) 08:25:43 INFO - PID 15659 | RSS: Main: 177733632 08:25:43 INFO - PID 15659 | 08:28:45 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-ext.html (next: http://localhost:44935/tests/dromaeo/cssquery-jquery.html) 08:28:45 INFO - PID 15659 | RSS: Main: 174891008 08:28:45 INFO - PID 15659 | 08:31:47 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44935/tests/dromaeo/cssquery-mootools.html) 08:31:48 INFO - PID 15659 | RSS: Main: 177299456 08:31:48 INFO - PID 15659 | 08:34:49 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44935/tests/dromaeo/cssquery-prototype.html) 08:34:50 INFO - PID 15659 | RSS: Main: 175263744 08:34:50 INFO - PID 15659 | 08:37:54 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44935/tests/dromaeo/cssquery-yui.html) 08:37:54 INFO - PID 15659 | RSS: Main: 179113984 08:37:54 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-yui.html (next: http://localhost:44935/tests/dromaeo/cssquery-dojo.html) 08:40:56 INFO - PID 15659 | RSS: Main: 179617792 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | __start_tp_report 08:40:56 INFO - PID 15659 | _x_x_mozilla_page_load 08:40:56 INFO - PID 15659 | _x_x_mozilla_page_load_details 08:40:56 INFO - PID 15659 | |i|pagename|runs| 08:40:56 INFO - PID 15659 | |0;dojo.html;3233.3533293341306;3255.365203785263;3262.5921759780026;3308.6360500344967;3316.8507417166225;6174.351693072224;6301.684915754206;6304.71628776705;6307.968460157698;6323.20959880015;6097.207363042809;6208.286047104573;6242.0948962400425;6252.781152659646;6302.4012718791755;5726.914096288559;5738.512226460756;5740.7703691852275;5750.856228594277;5755.136729490568;5739.540836733051;5756.769729210827;5762.51018663412;5781.248437703092;5830.766769329243;5780.335261444946;5785.739641716112;5788.160716696077;5807.535397168238;5829;5722.113072473752;5744.396838331957;5760.193572899798;5806.535477161817;5833.999999999979;5499.560035197214;5519.668819870781;5592.384837667853;5601.971990140064;5614.185943038277;6097.390260973912;6159.692015399257;6175.536834737368;6220.68896555175;6223.43989040984;6578.736850525973;6596.472282217459;6672.332766723337;6679.031540426659;6699.062131301622;6606.207255129367;6669.633170175638;6706.530542862001;6707.463402927754;6715.093462382565;6211.2857021442205;6216.129741836146;6224.408681175281;6229.626222426669;6233.0338797486465;6824;6888.070110535114;6903.482238832108;6906.965465172642;6913.446924246048;6586.538942274091;6600.438962688129;6667.499937504706;6694.799156025327;6697.9665101675155;6681.5656982296;6685.565438246498;6710.83222919431;6792.286809884891;6825.180978282638;6502.154719886385;6564.4420224281475;6573.1783527059115;6609.07489725739;6682;6710.496712746563;6712.530122891449;6720.126383570105;6720.764773232913;6738.35985581369;5295.099833028395;5337.306150200527;5347.0909945309395;5348.491893270211;5356.276902618175;4686.437627484724;4689.906201876011;4702.294655801588;4702.858914232578;4748.145333839873;5655.717214139277;5778.711064446761;5784.59507834456;5785.30576330843;5786.594938354275;6662.56693314933;6675.632840193739;6679.833004174838;6682.599044057275;6759.459243260528;5756.107803290497;5830.47525722687;5834.883302333929;5835.649861008268;5837.7664893404635;5777.6822274775295;5838.941610583925;5843.3864444233595;5847.473727364558;5849.970750146222;6346.079818426395;6361.554691171574;6414.9679251604375;6454.354564543508;6458.806235812933;6523.478121750343;6664.900026499703;6669.199696036507;6673.733050677918;6784.08414863987;6354.142190804368;6367.044943258363;6377.457916077;6377.649229292433;6378.266499352449;6556.409923106943;6582.80251592453;6586.407223349922;6586.5389422739945;6641.501887358564;6688.899666505104;6699.631520266432;6769.526133170631;6794.694238759366;6798.558093723892;6294.181756371642;6378.74485020594;6383.9361606383345;6435.678216089271;6549.541532092708;6393.936060639334;6393.968030159819;6409.551331406757;6411.7755878545895;6413.454856337264;6260.718267677874;6299.464545513682;6315.431611155018;6337.90493142594;6340.71466784005;6526.412622863775;6545.770898018546;6566.9014964776525;6593.934060659524;6605.339466053356;6333.90499142504;6341.556091073765;6382.93617063842;6396.872062558629;6402.327755585597 08:40:56 INFO - PID 15659 | |1;ext.html;838.5974732128578;866.8526350520409;1098.0227597438277;1114.7714718482707;1175.1773758369143;34707.82646086769;36985;37223.441648375265;37272.81363593185;37291;35795.284094318165;36043;36099;36101.2779744405;36217.27565448696;6979.685914133864;7074.151101867783;7102.112235970504;7173.461990350718;7312.744053958112;7616.6572504237165;7691.653875575613;7713.652885620132;7761.185075567068;7761.301482866541;7740.845183096335;7788.4937479063965;7797.103333116679;7798;7814.218578142197;7734.613269336511;7750.496217745828;7752.108507521651;7775.1447340792465;7781.494202876852;7649.9617501912135;7665.923340766577;7704.537727736298;7706.537607743498;7707.768766936945;35333.29333413317;35481.46777798335;35508.28983420343;35509.28981420357;35534.822325888206;3518.2963407318384;3540.522029526007;3549.9112522186892;3555.2711694102645;3556.9644303556893;28965.275868103254;29031;29062.854685726437;29150.416991660048;29224.123276301743;4968.925466118011;5179.948200517984;5208.583313334924;5211.791528338862;5216.947830521684;188367;189063;189156;190018;190278;39303.80348098241;40211;46138.538614614095;46160.5383946163;46517.53482465132;48231;48902.26646600233;49087.50912490829;49287.75356123196;49307.75346123247;14231.573052808433;14284.357203925849;14319.14085154894;14322.57032289033;14343.426262949573;11663.475143618558;11663.591774288028;11668.066554675606;11691.064714822794;11700.473478693479;13151.53969611059;13240.271785051722;13309.40107695156;13405.932970335087;13449.932750336186;5413.133898576209;5449.618526703092;5453.509184173444;5521.475459831309;5560.388357280696;984.1437948984286;1000.8748906386702;1004.477671610773;1014.8325526288228;1022.1822541966397;22387.32838014862;22454;22598.661020084714;22684.65973010406;22745.886270568542;1098.373926861697;1104.364990130662;1104.7514309280348;1108.7837871615118;1115.3029356652091;11971.52113915451;11974.922256996912;12009.579664711693;12032.939835300767;12073.456694448596;223311;223852;224342;224571;225616;47747;47926.520734792204;47988.520114798404;48043;48244.27633585499;1379.2207402817576;1428.9428422862968;1436.920969346696;1437.094630382852;1443.6246575890343;21880;22025.889870550545;22079.66880496826;22199.77800221977;22561.661575076057;46164.7691761539;47296;47589.52410475851;47666.52333476621;47677.28484072672;208680;209144;209235;209813;210793;30112.84943575268;30618.540721888745;30627.693723062483;32840;33472.66527334695;40307.1938561233;40372;40587.59412405838;40638;40870.79564602158;30262.69737302599;30398.240043999078;30417;30466;30843.074707758802;30182.54726179153;30259.546106807975;30794.38411231718;30797.38405231838;30945.8452707735;34000.65999339975;34006.65993340134;34008.48987265144;34062.65937340694;34308.31383372368;29284.56073158947;29618.259543511584;29824.701752982193;30068.24829379283;30212.84893575518;21983.670244946657;22649.2072777452;24216.51566968686;24329;25160.119395821057 08:40:56 INFO - PID 15659 | |2;jquery.html;550.2324257660564;552.5938435250092;556.4241010554077;556.8719194585243;573.6357413042718;20747.585048299024;21302.147914083456;21332.8933355333;21401.14395424183;21491.892540537294;24216;24671.62992555113;24818;24821.875890620566;24831.62752558713;6294.150289710888;6487.578307410027;6491.935080649204;6496.545241833073;6504.804855854332;5840.328362238333;6406.295307516193;6426.2931077581425;6456.22525296965;6511.706973186194;6381.074744162093;6407.871842563146;6411.48708103353;6413.326600706929;6413.615183089007;6356.523260755415;6403.391677790602;6403.871922561546;6409.67951602418;6412.294647588761;5967.492763115097;5977.7608895644125;5985.431384018511;5987.1019347097845;5999.910001349983;27535.586966195522;27591.448171036667;28037;28126.43747125046;28130.859345703346;2062.2060506704875;2106.3786183075877;2106.947326316839;2107.683847422899;2108.325335892515;18771.718424223647;19240.80759192404;19304.420867374;19312;19358.322458713876;2141.839362047837;2155.7628660847295;2181.1166477576608;2197.110170380998;2214.4795972946345;132842;136077.3196134013;140994.2950285242;143135;143415;13875.669839238712;14243.85756142446;14338.283085845875;14445.566633001026;14599.708005839824;22206.222782202545;22220.888895555418;22279.331620051424;22294.331170064925;22301;9190.90809091914;9342.205912497513;9510.1440870322;9541.99236320747;9622.29541626479;8596.914030859736;8646.351523635753;8659.826803464022;8701.47791132534;8714.825703486022;7391.895403930363;8282.875756863652;8906.777330566658;9068.138526839939;9144.954275228714;2558.2453176313034;2559.833610815291;2582.3156863431204;2597.8567681662703;2672.9599056014176;931.4411353188168;948.5826236455937;949.5157469690507;964.0311486955565;968.8740463739668;19057.523561911064;19168.62463397231;19190.13644386006;19372;19795.406137815888;1004.2869562610629;1008.9798204035878;1018.994905025485;1022.99488502557;1029.3103620574234;10647.627333043461;10665.146788256921;10714.410707411167;10753.89246107529;10797.62208322705;434916;444452;447234;449651;451680;106537.46731266294;110083.44958275158;110228;111622;111833.44083279694;1147.5639257082255;1147.8679951805482;1176.1531697177847;1177.2818580665787;1177.617274385811;16970.490885272968;17127.400540981005;17530.12349382551;17588.472345829647;17738.5565360867;52502.47497524976;53141.4685853152;53354;54214;55548.72225638846;65627.34372656212;65745;66102.66948665226;66689;68078;11642.94178529102;12267.018638509076;13505.594832155051;13667;14124.011319207557;21645.891770541046;21849.563008740053;22088.66866996964;22202.777972220072;22303.219387321366;17679.469615911545;17754.11229438497;17964.281428742703;17965;18141.365052223107;15928.362865485251;16637.168141593113;16676.916615416845;17119.48641540756;17718.46844594664;19577.412677619694;19702.21191152338;19711.70432443543;19918.50203744918;20074.698879516527;14301.141931484144;14411;14484;14492.710145797237;14566.271686415848;18268.634627307645;18290.176942037375;18327.450176494727;18366.949867047406;18461.81538184601 08:40:56 INFO - PID 15659 | |3;mootools.html;1289.561549073315;1366.2007725480594;1374.0999645232364;1378.6829029323255;1380.0960370957027;14372.784408233872;14507.92746036271;14993.17537535435;15007.549773506813;15023;14811.925940370284;14961.925190374033;14990.325435355408;15016.924915375408;15027.474038408658;2708.6614173228295;2761.6962134165224;2763.9170824875287;2766.8201566898188;2773.500769861424;2615.986920065397;2681.691605465367;2701.3651791828906;2770.9030183943564;2775.3339198592294;2685.355514676483;2700.216937088252;2700.486907487581;2700.8649567521643;2700.9459810803774;2591.572390555556;2622.0429543216683;2622.344413896526;2638.340414896276;2695.865206739655;2607.9869600651873;2635.486080214359;2652.5092857821173;2668.6397336359537;2683.73162683732;14320.42718291267;14451;14452.638684032878;14458.27708614565;14458.421663133462;7699.538027718355;7964.1637628049375;7964.8407031859615;7970.681172753083;7976.800579985489;4955.157623204064;5097.974510127463;5216.895662086775;5218.8695282617855;5226.1638137898135;1804.864635152369;1831.8442932350765;1854.3139038555685;1897.3359324236544;1902.838258748008;24460.266192014267;24516.877415612988;24704.876475617686;24705;25828.483430331475;6628.734850605922;6659.4006539411685;6690.498212634072;6790.966045169743;6857.108575885103;16523.173841307886;16637.667246655;16642.3343066276;16654.333826647042;16665;7545.471816972869;7769.72805951789;7772.106207786177;7774.455788094779;7785.598592253449;6934.826629334307;7050.541714788523;7062.3996960258955;7135;7191.89212161818;5068.417132029864;5185.066687996122;5196.45437229093;5201.973990130101;5227.686338819683;1505.781661659075;1508.4644951042442;1510.7884896114554;1526.8778497720377;1527.2592792495632;897.0760117079419;914.0448231597996;916.7387294621001;925.319889880937;927.420362273579;7607.087149542091;7615.809604759815;7753.224677532202;8526.87209691855;8744.912550874536;694.1323345817727;721.6031182849412;728.7230852276207;736.4145504324075;737.2885165814907;5406.8918621627345;5595.300587426572;5631.1271752878365;5859.44335288147;6023.126646636213;20054.097565609292;20906.37280881576;21008.26471073505;21013.054412551166;21035.263765768126;19274.903625481784;20175.798242017685;20285.49286267855;20302.49243768888;20413;9456.101670341306;9844;10347.844782328271;10501.737456563495;10815;8569.528675922884;8628.870566941376;8760.211580957744;8883.466991980502;8988.146126118008;17577.560560985567;17717.29130834752;18240.17919193666;18542.629147416705;18554.350597729015;18125.274989000292;18388.908055459637;18391.448256552325;18690.813091868906;18695.158717857455;13338.799918001432;13651.453941842215;13679.521216757366;13709.588712338646;13709.588712338646;13335.733285334432;13608.115472494255;13713.108647937852;13783.173009619053;13790.862091378958;10534.26260161812;10548.734151901821;10694.14446844235;10853.294535855144;10987.066099381322;10396.324238924748;10683.89316106829;10752.623658171926;10829.837552436562;10896.78206435851;9881.407115573089;9882.752931176778;9917.057879501435;10028.147607453157;10034.899651003689;7391.704331826667;7476.925230747841;7492.175860655215;7524.548527088392;7594.088709354913;7323.780286591411;7424.814379640552;7438.776836694908;7451;7506.849863002819 08:40:56 INFO - PID 15659 | |4;prototype.html;500.59201750573305;501.410842260344;523.2047288122054;529.4546616984508;530.1332321654095;6466.515011374154;6466.935330646692;6472.482201423886;6498.577592456493;6510.739570417183;6114.847128821782;6231.1276421300945;6240.282367527736;6294.7482100715915;6330.272018717849;4962.478939711333;4985;4985.800567977277;5030.195168772979;5104.2088476286235;4897.363342765453;4983.800647974077;5008.799648014094;5029.547340739333;5038.370203724535;4965.428975667808;4971.825986090487;5034.773435195425;5080.542751152396;5080.872978175556;4939.777710003059;4983.302337672729;4992.326035985132;5023.874403139914;5061.721605311706;4471.731696098244;4491.146682130385;4508.323751437278;4536.523665015159;4541.137183935075;6236.538721009838;6273.654948977804;6319.936800631981;6324.620522768649;6344.524160687921;5751.223584816038;5793.507551858097;5818.4763371296785;5825.15535247391;5838.241028666289;6634.668266586651;6636.871731805604;6637.137172167636;6638.535302528825;6698.5980841149685;4857.562819346241;4911.975440122812;4937.8271760488215;4954.355933728628;4957.776900039471;6958.686859091353;6987.82530436738;7003.789886303368;7022.192447868459;7087.610181440019;4977.282837421084;5032.672876263031;5039.4708555601865;5068.543831055223;5070.873228169252;5080.517350851663;5097.490250974947;5106.821261255838;5119.180931051088;5124.359455068116;5734;5765.740541675635;5798.246227990418;5808.593398462067;5808.82573522795;6611.702473388709;6632.4745308579295;6713.878046708206;6734.635769198061;6779.322067793181;1640.6636639488877;1642.7782249396178;1699.2438364927737;1742.520806778121;1754.298280687735;1189.9107566932514;1202.5310129049678;1203.8022167942952;1207.4445754952644;1225.3873063468266;5726.740117174215;5728.656280623176;5769.221155144086;5780.421957804186;5878.177055212273;6644.435223006002;6717.16035495563;6772.255051944282;6804.353586409283;6814.693338799766;5874;5891.499222566044;5907.822765317047;5937.139114828412;5971.19388882504;3552.928941421209;3599.9640003600152;3652.6164752701116;3661.176235347079;3667.064898450931;6501.837454063591;6540.378664027005;6552.868942621216;6553.672316384162;6581.670916454158;7146.2496437874315;7157.284271572905;7166.247544007804;7166.677499512534;7173.89239161413;6473;6527.477801775942;6573.868522629521;6614.503912206604;6616.4376028037195;6902.378785909293;6909.516333856582;6911.550749201286;6934.7226110955;6946.2011868635755;6768.763093291711;6787.62668053242;6860.6912688930115;6893.448524117958;6908.44732421395;6421.8715625688155;6545.247296560766;6556.377144171296;6605.570637908713;6607.339266073546;4974.303597496426;4983.227599722049;4983.426905905867;5024.773885175249;5033.728076750142;6475.546711730133;6804.21751498584;6864.553804002724;6892.724845903524;6900.413464855343;6459.289478157305;6467;6497.642629655415;6566.146400967844;6588.8352791180605;6441.710123044568;6515.348465153446;6515.54391192612;6532;6576.007916397932;6424.550281480251;6430.035494675836;6432.388923052303;6536.725338558936;6554.246261679968;6610.867782644416;6614;6635.966820165868;6665.200175978914;6706.362895524917;6332.145160403286;6418.935810641834;6427.614343139427;6438.484921206198;6471.417572418505 08:40:56 INFO - PID 15659 | |5;yui.html;873.0527377795088;881.0836729801006;887.3034667785789;897.1342654338564;897.2866571075994;18385.264589416423;19220.13509392079;19268.807311926877;19284.228630854766;20822.271220507286;17439.476815695518;18583.53541161468;21812.672809907865;21913.452163695874;22001.779982200173;926.7729406295467;939.1829108675462;943.4103685196752;943.5329511891589;943.8489841625342;865.4980111535326;945.7304668169573;951.281782254397;971.771633666088;972.2319367699508;1008.9798204035915;1011.8785745710525;1011.9342242754234;1012.367270455965;1016.7254841192873;1006.5219020965056;1006.9345492542961;1008.5814387029374;1008.9394636321845;1009.1573536097368;742.8625704244678;742.9628518574103;743.1379599664417;743.7843025522592;744.0104660801121;17659;17701.557461063447;17860.55348616295;18058.819411805845;19953.70069448945;20031.799682003286;20221.191152353887;20478.18087276507;20561.177552898014;20650.27724029667;16729.749053764204;16784.916075419544;16923;16943.830561694347;17052.48842534726;3631.8728844490315;3655.853765849363;3665.9633403666157;3669.6697297243377;3670.779753214789;118469.40765296205;124739;124972.9999999991;125514.37242813727;127364.36317818351;15989.920050399905;16292.266847991868;16330.428435004718;16378.918105409635;16406.1796910154;29781.85109074484;29988.700112999028;30539.2365190872;30592.69407305943;30627.846860765552;8740.78148046304;8747;8839.646414143363;8856.8671469928;8894.688685895962;4453.933191002137;4566.06395688883;4576.336431217522;4576.931346029813;4577.931331030038;5073.949260507421;5159.484051594811;5174.353205849269;5180.611454140879;5211.192265198824;882.1311008656468;894.9239314658197;913.0595486648763;914.29599208609;917.6467060181878;621.4313902778906;692.1244625548685;703.7572037647003;704.5702121705756;711.6228398948566;11242.606508772154;11956.52173913051;12453.564125255754;12492.25046497213;14079.929600351932;679.4474625480752;681.0737397139886;693.542262107017;701.7017767448814;719.1873183302835;5710.828675139753;5789.247397838254;6039.607425517327;6167.599106058092;6185.536084793658;106276.46861765796;106857;106865.93134068715;106899.46550267354;113099;94298.63801074597;94736;96733.51633241789;98054.5097274509;99764.50117749364;84777.57611212028;86209;86568.56715716381;87563.12436875678;87566.12433875707;12223.69440763988;12300.261984280973;12380.938095309466;12688.302143382203;13012.869871301165;39139.6086039136;39664.80167599144;40360.39459408053;40737.38893916653;42452.787736061124;69689;70000.6499967497;70479;72189;72397;18339.083045847387;18549.2580296792;18637.347692830685;18643.72034419512;18706.719399208752;20935;21705.34883953484;21736.565268694852;21809;22080.116795328006;18439.354622588144;18557.793743406637;18606.44180674582;19516.31692890742;19557.11992960292;16181.271842767339;16202.108884011492;16341.182940853148;16544.75182872234;17569.385071522436;18458.261669533604;18601;18788.436346909613;18840.717389239446;18919;11632.88367116352;12023;12099.395030248628;13094.345282736016;13501.122427042212;13950.302484875918;13985.44058237659;14104;14128.293585320487;14151.292435377984 08:40:56 INFO - PID 15659 | __end_tp_report 08:40:56 INFO - PID 15659 | __start_cc_report 08:40:56 INFO - PID 15659 | _x_x_mozilla_cycle_collect,359 08:40:56 INFO - PID 15659 | __end_cc_report 08:40:56 INFO - PID 15659 | __startTimestamp1503502856915__endTimestamp 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | ------- Summary: start ------- 08:40:56 INFO - PID 15659 | Number of tests: 6 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#0] dojo.html Cycles:165 Average:6143.25 Median:6341.56 stddev:702.02 (11.1%) stddev-sans-first:666.03 08:40:56 INFO - PID 15659 | Values: 3233.4 3255.4 3262.6 3308.6 3316.9 6174.4 6301.7 6304.7 6308.0 6323.2 6097.2 6208.3 6242.1 6252.8 6302.4 5726.9 5738.5 5740.8 5750.9 5755.1 5739.5 5756.8 5762.5 5781.2 5830.8 5780.3 5785.7 5788.2 5807.5 5829.0 5722.1 5744.4 5760.2 5806.5 5834.0 5499.6 5519.7 5592.4 5602.0 5614.2 6097.4 6159.7 6175.5 6220.7 6223.4 6578.7 6596.5 6672.3 6679.0 6699.1 6606.2 6669.6 6706.5 6707.5 6715.1 6211.3 6216.1 6224.4 6229.6 6233.0 6824.0 6888.1 6903.5 6907.0 6913.4 6586.5 6600.4 6667.5 6694.8 6698.0 6681.6 6685.6 6710.8 6792.3 6825.2 6502.2 6564.4 6573.2 6609.1 6682.0 6710.5 6712.5 6720.1 6720.8 6738.4 5295.1 5337.3 5347.1 5348.5 5356.3 4686.4 4689.9 4702.3 4702.9 4748.1 5655.7 5778.7 5784.6 5785.3 5786.6 6662.6 6675.6 6679.8 6682.6 6759.5 5756.1 5830.5 5834.9 5835.6 5837.8 5777.7 5838.9 5843.4 5847.5 5850.0 6346.1 6361.6 6415.0 6454.4 6458.8 6523.5 6664.9 6669.2 6673.7 6784.1 6354.1 6367.0 6377.5 6377.6 6378.3 6556.4 6582.8 6586.4 6586.5 6641.5 6688.9 6699.6 6769.5 6794.7 6798.6 6294.2 6378.7 6383.9 6435.7 6549.5 6393.9 6394.0 6409.6 6411.8 6413.5 6260.7 6299.5 6315.4 6337.9 6340.7 6526.4 6545.8 6566.9 6593.9 6605.3 6333.9 6341.6 6382.9 6396.9 6402.3 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#1] ext.html Cycles:180 Average:36722.09 Median:33156.33 stddev:53975.96 (162.8%) stddev-sans-first:54060.13 08:40:56 INFO - PID 15659 | Values: 838.6 866.9 1098.0 1114.8 1175.2 34707.8 36985.0 37223.4 37272.8 37291.0 35795.3 36043.0 36099.0 36101.3 36217.3 6979.7 7074.2 7102.1 7173.5 7312.7 7616.7 7691.7 7713.7 7761.2 7761.3 7740.8 7788.5 7797.1 7798.0 7814.2 7734.6 7750.5 7752.1 7775.1 7781.5 7650.0 7665.9 7704.5 7706.5 7707.8 35333.3 35481.5 35508.3 35509.3 35534.8 3518.3 3540.5 3549.9 3555.3 3557.0 28965.3 29031.0 29062.9 29150.4 29224.1 4968.9 5179.9 5208.6 5211.8 5216.9 188367.0 189063.0 189156.0 190018.0 190278.0 39303.8 40211.0 46138.5 46160.5 46517.5 48231.0 48902.3 49087.5 49287.8 49307.8 14231.6 14284.4 14319.1 14322.6 14343.4 11663.5 11663.6 11668.1 11691.1 11700.5 13151.5 13240.3 13309.4 13405.9 13449.9 5413.1 5449.6 5453.5 5521.5 5560.4 984.1 1000.9 1004.5 1014.8 1022.2 22387.3 22454.0 22598.7 22684.7 22745.9 1098.4 1104.4 1104.8 1108.8 1115.3 11971.5 11974.9 12009.6 12032.9 12073.5 223311.0 223852.0 224342.0 224571.0 225616.0 47747.0 47926.5 47988.5 48043.0 48244.3 1379.2 1428.9 1436.9 1437.1 1443.6 21880.0 22025.9 22079.7 22199.8 22561.7 46164.8 47296.0 47589.5 47666.5 47677.3 208680.0 209144.0 209235.0 209813.0 210793.0 30112.8 30618.5 30627.7 32840.0 33472.7 40307.2 40372.0 40587.6 40638.0 40870.8 30262.7 30398.2 30417.0 30466.0 30843.1 30182.5 30259.5 30794.4 30797.4 30945.8 34000.7 34006.7 34008.5 34062.7 34308.3 29284.6 29618.3 29824.7 30068.2 30212.8 21983.7 22649.2 24216.5 24329.0 25160.1 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#2] jquery.html Cycles:180 Average:32869.39 Median:12142.89 stddev:75650.23 (623.0%) stddev-sans-first:75823.53 08:40:56 INFO - PID 15659 | Values: 550.2 552.6 556.4 556.9 573.6 20747.6 21302.1 21332.9 21401.1 21491.9 24216.0 24671.6 24818.0 24821.9 24831.6 6294.2 6487.6 6491.9 6496.5 6504.8 5840.3 6406.3 6426.3 6456.2 6511.7 6381.1 6407.9 6411.5 6413.3 6413.6 6356.5 6403.4 6403.9 6409.7 6412.3 5967.5 5977.8 5985.4 5987.1 5999.9 27535.6 27591.4 28037.0 28126.4 28130.9 2062.2 2106.4 2106.9 2107.7 2108.3 18771.7 19240.8 19304.4 19312.0 19358.3 2141.8 2155.8 2181.1 2197.1 2214.5 132842.0 136077.3 140994.3 143135.0 143415.0 13875.7 14243.9 14338.3 14445.6 14599.7 22206.2 22220.9 22279.3 22294.3 22301.0 9190.9 9342.2 9510.1 9542.0 9622.3 8596.9 8646.4 8659.8 8701.5 8714.8 7391.9 8282.9 8906.8 9068.1 9145.0 2558.2 2559.8 2582.3 2597.9 2673.0 931.4 948.6 949.5 964.0 968.9 19057.5 19168.6 19190.1 19372.0 19795.4 1004.3 1009.0 1019.0 1023.0 1029.3 10647.6 10665.1 10714.4 10753.9 10797.6 434916.0 444452.0 447234.0 449651.0 451680.0 106537.5 110083.4 110228.0 111622.0 111833.4 1147.6 1147.9 1176.2 1177.3 1177.6 16970.5 17127.4 17530.1 17588.5 17738.6 52502.5 53141.5 53354.0 54214.0 55548.7 65627.3 65745.0 66102.7 66689.0 68078.0 11642.9 12267.0 13505.6 13667.0 14124.0 21645.9 21849.6 22088.7 22202.8 22303.2 17679.5 17754.1 17964.3 17965.0 18141.4 15928.4 16637.2 16676.9 17119.5 17718.5 19577.4 19702.2 19711.7 19918.5 20074.7 14301.1 14411.0 14484.0 14492.7 14566.3 18268.6 18290.2 18327.5 18366.9 18461.8 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#3] mootools.html Cycles:180 Average:9138.40 Median:2636.91 stddev:6365.97 (241.4%) stddev-sans-first:6356.51 08:40:56 INFO - PID 15659 | Values: 1289.6 1366.2 1374.1 1378.7 1380.1 14372.8 14507.9 14993.2 15007.5 15023.0 14811.9 14961.9 14990.3 15016.9 15027.5 2708.7 2761.7 2763.9 2766.8 2773.5 2616.0 2681.7 2701.4 2770.9 2775.3 2685.4 2700.2 2700.5 2700.9 2700.9 2591.6 2622.0 2622.3 2638.3 2695.9 2608.0 2635.5 2652.5 2668.6 2683.7 14320.4 14451.0 14452.6 14458.3 14458.4 7699.5 7964.2 7964.8 7970.7 7976.8 4955.2 5098.0 5216.9 5218.9 5226.2 1804.9 1831.8 1854.3 1897.3 1902.8 24460.3 24516.9 24704.9 24705.0 25828.5 6628.7 6659.4 6690.5 6791.0 6857.1 16523.2 16637.7 16642.3 16654.3 16665.0 7545.5 7769.7 7772.1 7774.5 7785.6 6934.8 7050.5 7062.4 7135.0 7191.9 5068.4 5185.1 5196.5 5202.0 5227.7 1505.8 1508.5 1510.8 1526.9 1527.3 897.1 914.0 916.7 925.3 927.4 7607.1 7615.8 7753.2 8526.9 8744.9 694.1 721.6 728.7 736.4 737.3 5406.9 5595.3 5631.1 5859.4 6023.1 20054.1 20906.4 21008.3 21013.1 21035.3 19274.9 20175.8 20285.5 20302.5 20413.0 9456.1 9844.0 10347.8 10501.7 10815.0 8569.5 8628.9 8760.2 8883.5 8988.1 17577.6 17717.3 18240.2 18542.6 18554.4 18125.3 18388.9 18391.4 18690.8 18695.2 13338.8 13651.5 13679.5 13709.6 13709.6 13335.7 13608.1 13713.1 13783.2 13790.9 10534.3 10548.7 10694.1 10853.3 10987.1 10396.3 10683.9 10752.6 10829.8 10896.8 9881.4 9882.8 9917.1 10028.1 10034.9 7391.7 7476.9 7492.2 7524.5 7594.1 7323.8 7424.8 7438.8 7451.0 7506.8 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#4] prototype.html Cycles:180 Average:5583.54 Median:6307.34 stddev:1584.69 (25.1%) stddev-sans-first:1542.53 08:40:56 INFO - PID 15659 | Values: 500.6 501.4 523.2 529.5 530.1 6466.5 6466.9 6472.5 6498.6 6510.7 6114.8 6231.1 6240.3 6294.7 6330.3 4962.5 4985.0 4985.8 5030.2 5104.2 4897.4 4983.8 5008.8 5029.5 5038.4 4965.4 4971.8 5034.8 5080.5 5080.9 4939.8 4983.3 4992.3 5023.9 5061.7 4471.7 4491.1 4508.3 4536.5 4541.1 6236.5 6273.7 6319.9 6324.6 6344.5 5751.2 5793.5 5818.5 5825.2 5838.2 6634.7 6636.9 6637.1 6638.5 6698.6 4857.6 4912.0 4937.8 4954.4 4957.8 6958.7 6987.8 7003.8 7022.2 7087.6 4977.3 5032.7 5039.5 5068.5 5070.9 5080.5 5097.5 5106.8 5119.2 5124.4 5734.0 5765.7 5798.2 5808.6 5808.8 6611.7 6632.5 6713.9 6734.6 6779.3 1640.7 1642.8 1699.2 1742.5 1754.3 1189.9 1202.5 1203.8 1207.4 1225.4 5726.7 5728.7 5769.2 5780.4 5878.2 6644.4 6717.2 6772.3 6804.4 6814.7 5874.0 5891.5 5907.8 5937.1 5971.2 3552.9 3600.0 3652.6 3661.2 3667.1 6501.8 6540.4 6552.9 6553.7 6581.7 7146.2 7157.3 7166.2 7166.7 7173.9 6473.0 6527.5 6573.9 6614.5 6616.4 6902.4 6909.5 6911.6 6934.7 6946.2 6768.8 6787.6 6860.7 6893.4 6908.4 6421.9 6545.2 6556.4 6605.6 6607.3 4974.3 4983.2 4983.4 5024.8 5033.7 6475.5 6804.2 6864.6 6892.7 6900.4 6459.3 6467.0 6497.6 6566.1 6588.8 6441.7 6515.3 6515.5 6532.0 6576.0 6424.6 6430.0 6432.4 6536.7 6554.2 6610.9 6614.0 6636.0 6665.2 6706.4 6332.1 6418.9 6427.6 6438.5 6471.4 08:40:56 INFO - PID 15659 | 08:40:56 INFO - PID 15659 | [#5] yui.html Cycles:180 Average:23629.89 Median:21810.84 stddev:31793.72 (145.8%) stddev-sans-first:31836.99 08:40:56 INFO - PID 15659 | Values: 873.1 881.1 887.3 897.1 897.3 18385.3 19220.1 19268.8 19284.2 20822.3 17439.5 18583.5 21812.7 21913.5 22001.8 926.8 939.2 943.4 943.5 943.8 865.5 945.7 951.3 971.8 972.2 1009.0 1011.9 1011.9 1012.4 1016.7 1006.5 1006.9 1008.6 1008.9 1009.2 742.9 743.0 743.1 743.8 744.0 17659.0 17701.6 17860.6 18058.8 19953.7 20031.8 20221.2 20478.2 20561.2 20650.3 16729.7 16784.9 16923.0 16943.8 17052.5 3631.9 3655.9 3666.0 3669.7 3670.8 118469.4 124739.0 124973.0 125514.4 127364.4 15989.9 16292.3 16330.4 16378.9 16406.2 29781.9 29988.7 30539.2 30592.7 30627.8 8740.8 8747.0 8839.6 8856.9 8894.7 4453.9 4566.1 4576.3 4576.9 4577.9 5073.9 5159.5 5174.4 5180.6 5211.2 882.1 894.9 913.1 914.3 917.6 621.4 692.1 703.8 704.6 711.6 11242.6 11956.5 12453.6 12492.3 14079.9 679.4 681.1 693.5 701.7 719.2 5710.8 5789.2 6039.6 6167.6 6185.5 106276.5 106857.0 106865.9 106899.5 113099.0 94298.6 94736.0 96733.5 98054.5 99764.5 84777.6 86209.0 86568.6 87563.1 87566.1 12223.7 12300.3 12380.9 12688.3 13012.9 39139.6 39664.8 40360.4 40737.4 42452.8 69689.0 70000.6 70479.0 72189.0 72397.0 18339.1 18549.3 18637.3 18643.7 18706.7 20935.0 21705.3 21736.6 21809.0 22080.1 18439.4 18557.8 18606.4 19516.3 19557.1 16181.3 16202.1 16341.2 16544.8 17569.4 18458.3 18601.0 18788.4 18840.7 18919.0 11632.9 12023.0 12099.4 13094.3 13501.1 13950.3 13985.4 14104.0 14128.3 14151.3 08:40:56 INFO - PID 15659 | -------- Summary: end -------- 08:40:56 INFO - PID 15659 | 08:40:57 INFO - TEST-INFO | 15659: exit 0 08:40:57 INFO - TEST-OK | dromaeo_css | took 1112495ms 08:40:57 INFO - TEST-START | kraken 08:40:57 INFO - Initialising browser for kraken test... 08:40:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html -profile /tmp/tmp0qTXTT/profile 08:40:57 INFO - TEST-INFO | started process 16075 (/builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html) 08:41:03 INFO - TEST-INFO | 16075: exit 0 08:41:03 INFO - Browser initialized. 08:41:03 INFO - Running cycle 1/1 for kraken test... 08:41:03 INFO - TEST-INFO | started process 16262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qTXTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:04 INFO - PID 16262 | 08:41:04 INFO - PID 16262 | (/builds/slave/test/build/application/firefox/firefox:16312): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:41:04 INFO - PID 16262 | 08:41:05 INFO - PID 16262 | 08:41:05 INFO - PID 16262 | (/builds/slave/test/build/application/firefox/firefox:16373): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:41:05 INFO - PID 16262 | 08:41:05 INFO - PID 16262 | __metrics Screen width/height:1600/1200 08:41:05 INFO - PID 16262 | colorDepth:24 08:41:05 INFO - PID 16262 | Browser inner width/height: 1024/768 08:41:05 INFO - PID 16262 | __metrics 08:41:15 INFO - PID 16262 | RSS: Main: 174739456 08:41:15 INFO - PID 16262 | 08:41:17 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:18 INFO - PID 16262 | RSS: Main: 179019776 08:41:18 INFO - PID 16262 | 08:41:21 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-dft) 08:41:22 INFO - PID 16262 | RSS: Main: 181252096 08:41:22 INFO - PID 16262 | 08:41:25 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-fft) 08:41:25 INFO - PID 16262 | RSS: Main: 174604288 08:41:25 INFO - PID 16262 | 08:41:27 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-oscillator) 08:41:28 INFO - PID 16262 | RSS: Main: 174845952 08:41:28 INFO - PID 16262 | 08:41:30 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:31 INFO - PID 16262 | RSS: Main: 175628288 08:41:31 INFO - PID 16262 | 08:41:34 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:35 INFO - PID 16262 | RSS: Main: 176558080 08:41:35 INFO - PID 16262 | 08:41:38 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:39 INFO - PID 16262 | RSS: Main: 176627712 08:41:39 INFO - PID 16262 | 08:41:42 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44935/tests/kraken/driver.html?testName=json-parse-financial) 08:41:42 INFO - PID 16262 | RSS: Main: 177041408 08:41:42 INFO - PID 16262 | 08:41:44 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:45 INFO - PID 16262 | RSS: Main: 177233920 08:41:45 INFO - PID 16262 | 08:41:47 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:47 INFO - PID 16262 | RSS: Main: 177102848 08:41:47 INFO - PID 16262 | 08:41:49 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:50 INFO - PID 16262 | RSS: Main: 176955392 08:41:50 INFO - PID 16262 | 08:41:53 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:53 INFO - PID 16262 | RSS: Main: 177192960 08:41:53 INFO - PID 16262 | 08:41:56 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:57 INFO - PID 16262 | RSS: Main: 177373184 08:41:57 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44935/tests/kraken/driver.html?testName=ai-astar) 08:41:59 INFO - PID 16262 | RSS: Main: 178909184 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | __start_tp_report 08:41:59 INFO - PID 16262 | _x_x_mozilla_page_load 08:41:59 INFO - PID 16262 | _x_x_mozilla_page_load_details 08:41:59 INFO - PID 16262 | |i|pagename|runs| 08:41:59 INFO - PID 16262 | |0;ai-astar;99;107;103;112;106;109;110;100;108;106 08:41:59 INFO - PID 16262 | |1;audio-beat-detection;150;116;151;172;119;149;140;121;182;129 08:41:59 INFO - PID 16262 | |2;audio-dft;161;161;168;160;162;164;162;164;175;163 08:41:59 INFO - PID 16262 | |3;audio-fft;75;83;74;182;78;74;75;90;98;78 08:41:59 INFO - PID 16262 | |4;audio-oscillator;77;79;135;80;79;80;126;80;79;128 08:41:59 INFO - PID 16262 | |5;imaging-gaussian-blur;115;115;114;113;114;114;113;114;115;114 08:41:59 INFO - PID 16262 | |6;imaging-darkroom;149;148;147;147;148;147;151;150;148;149 08:41:59 INFO - PID 16262 | |7;imaging-desaturate;94;93;93;95;95;94;94;94;97;98 08:41:59 INFO - PID 16262 | |8;json-parse-financial;53;57;55;56;57;53;57;62;57;55 08:41:59 INFO - PID 16262 | |9;json-stringify-tinderbox;56;56;56;60;56;56;57;63;57;61 08:41:59 INFO - PID 16262 | |10;stanford-crypto-aes;77;74;75;75;73;78;75;74;76;77 08:41:59 INFO - PID 16262 | |11;stanford-crypto-ccm;123;124;123;120;120;116;123;133;120;159 08:41:59 INFO - PID 16262 | |12;stanford-crypto-pbkdf2;169;169;186;165;171;170;166;173;172;168 08:41:59 INFO - PID 16262 | |13;stanford-crypto-sha256-iterative;67;68;68;65;68;68;64;63;67;67 08:41:59 INFO - PID 16262 | __end_tp_report 08:41:59 INFO - PID 16262 | __start_cc_report 08:41:59 INFO - PID 16262 | _x_x_mozilla_cycle_collect,955 08:41:59 INFO - PID 16262 | __end_cc_report 08:41:59 INFO - PID 16262 | __startTimestamp1503502919661__endTimestamp 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | ------- Summary: start ------- 08:41:59 INFO - PID 16262 | Number of tests: 14 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#0] ai-astar Cycles:10 Average:106.00 Median:108.50 stddev:4.22 (3.9%) stddev-sans-first:3.63 08:41:59 INFO - PID 16262 | Values: 99.0 107.0 103.0 112.0 106.0 109.0 110.0 100.0 108.0 106.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.50 stddev:22.37 (15.0%) stddev-sans-first:23.58 08:41:59 INFO - PID 16262 | Values: 150.0 116.0 151.0 172.0 119.0 149.0 140.0 121.0 182.0 129.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:4.47 (2.7%) stddev-sans-first:4.61 08:41:59 INFO - PID 16262 | Values: 161.0 161.0 168.0 160.0 162.0 164.0 162.0 164.0 175.0 163.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#3] audio-fft Cycles:10 Average:90.70 Median:78.00 stddev:33.04 (42.4%) stddev-sans-first:34.55 08:41:59 INFO - PID 16262 | Values: 75.0 83.0 74.0 182.0 78.0 74.0 75.0 90.0 98.0 78.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:24.52 (31.0%) stddev-sans-first:25.20 08:41:59 INFO - PID 16262 | Values: 77.0 79.0 135.0 80.0 79.0 80.0 126.0 80.0 79.0 128.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 08:41:59 INFO - PID 16262 | Values: 115.0 115.0 114.0 113.0 114.0 114.0 113.0 114.0 115.0 114.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 08:41:59 INFO - PID 16262 | Values: 149.0 148.0 147.0 147.0 148.0 147.0 151.0 150.0 148.0 149.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.64 (1.7%) stddev-sans-first:1.72 08:41:59 INFO - PID 16262 | Values: 94.0 93.0 93.0 95.0 95.0 94.0 94.0 94.0 97.0 98.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:2.57 (4.5%) stddev-sans-first:2.46 08:41:59 INFO - PID 16262 | Values: 53.0 57.0 55.0 56.0 57.0 53.0 57.0 62.0 57.0 55.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:57.00 stddev:2.57 (4.5%) stddev-sans-first:2.65 08:41:59 INFO - PID 16262 | Values: 56.0 56.0 56.0 60.0 56.0 56.0 57.0 63.0 57.0 61.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:1.58 (2.1%) stddev-sans-first:1.56 08:41:59 INFO - PID 16262 | Values: 77.0 74.0 75.0 75.0 73.0 78.0 75.0 74.0 76.0 77.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:123.00 stddev:12.37 (10.1%) stddev-sans-first:13.07 08:41:59 INFO - PID 16262 | Values: 123.0 124.0 123.0 120.0 120.0 116.0 123.0 133.0 120.0 159.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:170.50 stddev:5.86 (3.4%) stddev-sans-first:6.17 08:41:59 INFO - PID 16262 | Values: 169.0 169.0 186.0 165.0 171.0 170.0 166.0 173.0 172.0 168.0 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.94 08:41:59 INFO - PID 16262 | Values: 67.0 68.0 68.0 65.0 68.0 68.0 64.0 63.0 67.0 67.0 08:41:59 INFO - PID 16262 | -------- Summary: end -------- 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | 08:41:59 INFO - PID 16262 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:41:59 INFO - PID 16262 | 08:42:00 INFO - PID 16262 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:42:00 INFO - TEST-INFO | 16262: exit 0 08:42:00 INFO - TEST-OK | kraken | took 62660ms 08:42:00 INFO - SUITE-END | took 1175s 08:42:00 INFO - Completed test suite (00:19:35) 08:42:00 INFO - javascript benchmark 08:42:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8420.808153715649, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.3533293341306, 3255.365203785263, 3262.5921759780026, 3308.6360500344967, 3316.8507417166225, 6174.351693072224, 6301.684915754206, 6304.71628776705, 6307.968460157698, 6323.20959880015, 6097.207363042809, 6208.286047104573, 6242.0948962400425, 6252.781152659646, 6302.4012718791755, 5726.914096288559, 5738.512226460756, 5740.7703691852275, 5750.856228594277, 5755.136729490568, 5739.540836733051, 5756.769729210827, 5762.51018663412, 5781.248437703092, 5830.766769329243, 5780.335261444946, 5785.739641716112, 5788.160716696077, 5807.535397168238, 5829.0, 5722.113072473752, 5744.396838331957, 5760.193572899798, 5806.535477161817, 5833.999999999979, 5499.560035197214, 5519.668819870781, 5592.384837667853, 5601.971990140064, 5614.185943038277, 6097.390260973912, 6159.692015399257, 6175.536834737368, 6220.68896555175, 6223.43989040984, 6578.736850525973, 6596.472282217459, 6672.332766723337, 6679.031540426659, 6699.062131301622, 6606.207255129367, 6669.633170175638, 6706.530542862001, 6707.463402927754, 6715.093462382565, 6211.2857021442205, 6216.129741836146, 6224.408681175281, 6229.626222426669, 6233.0338797486465, 6824.0, 6888.070110535114, 6903.482238832108, 6906.965465172642, 6913.446924246048, 6586.538942274091, 6600.438962688129, 6667.499937504706, 6694.799156025327, 6697.9665101675155, 6681.5656982296, 6685.565438246498, 6710.83222919431, 6792.286809884891, 6825.180978282638, 6502.154719886385, 6564.4420224281475, 6573.1783527059115, 6609.07489725739, 6682.0, 6710.496712746563, 6712.530122891449, 6720.126383570105, 6720.764773232913, 6738.35985581369, 5295.099833028395, 5337.306150200527, 5347.0909945309395, 5348.491893270211, 5356.276902618175, 4686.437627484724, 4689.906201876011, 4702.294655801588, 4702.858914232578, 4748.145333839873, 5655.717214139277, 5778.711064446761, 5784.59507834456, 5785.30576330843, 5786.594938354275, 6662.56693314933, 6675.632840193739, 6679.833004174838, 6682.599044057275, 6759.459243260528, 5756.107803290497, 5830.47525722687, 5834.883302333929, 5835.649861008268, 5837.7664893404635, 5777.6822274775295, 5838.941610583925, 5843.3864444233595, 5847.473727364558, 5849.970750146222, 6346.079818426395, 6361.554691171574, 6414.9679251604375, 6454.354564543508, 6458.806235812933, 6523.478121750343, 6664.900026499703, 6669.199696036507, 6673.733050677918, 6784.08414863987, 6354.142190804368, 6367.044943258363, 6377.457916077, 6377.649229292433, 6378.266499352449, 6556.409923106943, 6582.80251592453, 6586.407223349922, 6586.5389422739945, 6641.501887358564, 6688.899666505104, 6699.631520266432, 6769.526133170631, 6794.694238759366, 6798.558093723892, 6294.181756371642, 6378.74485020594, 6383.9361606383345, 6435.678216089271, 6549.541532092708, 6393.936060639334, 6393.968030159819, 6409.551331406757, 6411.7755878545895, 6413.454856337264, 6260.718267677874, 6299.464545513682, 6315.431611155018, 6337.90493142594, 6340.71466784005, 6526.412622863775, 6545.770898018546, 6566.9014964776525, 6593.934060659524, 6605.339466053356, 6333.90499142504, 6341.556091073765, 6382.93617063842, 6396.872062558629, 6402.327755585597], "value": 6093.111745188775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.5974732128578, 866.8526350520409, 1098.0227597438277, 1114.7714718482707, 1175.1773758369143, 34707.82646086769, 36985.0, 37223.441648375265, 37272.81363593185, 37291.0, 35795.284094318165, 36043.0, 36099.0, 36101.2779744405, 36217.27565448696, 6979.685914133864, 7074.151101867783, 7102.112235970504, 7173.461990350718, 7312.744053958112, 7616.6572504237165, 7691.653875575613, 7713.652885620132, 7761.185075567068, 7761.301482866541, 7740.845183096335, 7788.4937479063965, 7797.103333116679, 7798.0, 7814.218578142197, 7734.613269336511, 7750.496217745828, 7752.108507521651, 7775.1447340792465, 7781.494202876852, 7649.9617501912135, 7665.923340766577, 7704.537727736298, 7706.537607743498, 7707.768766936945, 35333.29333413317, 35481.46777798335, 35508.28983420343, 35509.28981420357, 35534.822325888206, 3518.2963407318384, 3540.522029526007, 3549.9112522186892, 3555.2711694102645, 3556.9644303556893, 28965.275868103254, 29031.0, 29062.854685726437, 29150.416991660048, 29224.123276301743, 4968.925466118011, 5179.948200517984, 5208.583313334924, 5211.791528338862, 5216.947830521684, 188367.0, 189063.0, 189156.0, 190018.0, 190278.0, 39303.80348098241, 40211.0, 46138.538614614095, 46160.5383946163, 46517.53482465132, 48231.0, 48902.26646600233, 49087.50912490829, 49287.75356123196, 49307.75346123247, 14231.573052808433, 14284.357203925849, 14319.14085154894, 14322.57032289033, 14343.426262949573, 11663.475143618558, 11663.591774288028, 11668.066554675606, 11691.064714822794, 11700.473478693479, 13151.53969611059, 13240.271785051722, 13309.40107695156, 13405.932970335087, 13449.932750336186, 5413.133898576209, 5449.618526703092, 5453.509184173444, 5521.475459831309, 5560.388357280696, 984.1437948984286, 1000.8748906386702, 1004.477671610773, 1014.8325526288228, 1022.1822541966397, 22387.32838014862, 22454.0, 22598.661020084714, 22684.65973010406, 22745.886270568542, 1098.373926861697, 1104.364990130662, 1104.7514309280348, 1108.7837871615118, 1115.3029356652091, 11971.52113915451, 11974.922256996912, 12009.579664711693, 12032.939835300767, 12073.456694448596, 223311.0, 223852.0, 224342.0, 224571.0, 225616.0, 47747.0, 47926.520734792204, 47988.520114798404, 48043.0, 48244.27633585499, 1379.2207402817576, 1428.9428422862968, 1436.920969346696, 1437.094630382852, 1443.6246575890343, 21880.0, 22025.889870550545, 22079.66880496826, 22199.77800221977, 22561.661575076057, 46164.7691761539, 47296.0, 47589.52410475851, 47666.52333476621, 47677.28484072672, 208680.0, 209144.0, 209235.0, 209813.0, 210793.0, 30112.84943575268, 30618.540721888745, 30627.693723062483, 32840.0, 33472.66527334695, 40307.1938561233, 40372.0, 40587.59412405838, 40638.0, 40870.79564602158, 30262.69737302599, 30398.240043999078, 30417.0, 30466.0, 30843.074707758802, 30182.54726179153, 30259.546106807975, 30794.38411231718, 30797.38405231838, 30945.8452707735, 34000.65999339975, 34006.65993340134, 34008.48987265144, 34062.65937340694, 34308.31383372368, 29284.56073158947, 29618.259543511584, 29824.701752982193, 30068.24829379283, 30212.84893575518, 21983.670244946657, 22649.2072777452, 24216.51566968686, 24329.0, 25160.119395821057], "value": 16649.63015247811, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2324257660564, 552.5938435250092, 556.4241010554077, 556.8719194585243, 573.6357413042718, 20747.585048299024, 21302.147914083456, 21332.8933355333, 21401.14395424183, 21491.892540537294, 24216.0, 24671.62992555113, 24818.0, 24821.875890620566, 24831.62752558713, 6294.150289710888, 6487.578307410027, 6491.935080649204, 6496.545241833073, 6504.804855854332, 5840.328362238333, 6406.295307516193, 6426.2931077581425, 6456.22525296965, 6511.706973186194, 6381.074744162093, 6407.871842563146, 6411.48708103353, 6413.326600706929, 6413.615183089007, 6356.523260755415, 6403.391677790602, 6403.871922561546, 6409.67951602418, 6412.294647588761, 5967.492763115097, 5977.7608895644125, 5985.431384018511, 5987.1019347097845, 5999.910001349983, 27535.586966195522, 27591.448171036667, 28037.0, 28126.43747125046, 28130.859345703346, 2062.2060506704875, 2106.3786183075877, 2106.947326316839, 2107.683847422899, 2108.325335892515, 18771.718424223647, 19240.80759192404, 19304.420867374, 19312.0, 19358.322458713876, 2141.839362047837, 2155.7628660847295, 2181.1166477576608, 2197.110170380998, 2214.4795972946345, 132842.0, 136077.3196134013, 140994.2950285242, 143135.0, 143415.0, 13875.669839238712, 14243.85756142446, 14338.283085845875, 14445.566633001026, 14599.708005839824, 22206.222782202545, 22220.888895555418, 22279.331620051424, 22294.331170064925, 22301.0, 9190.90809091914, 9342.205912497513, 9510.1440870322, 9541.99236320747, 9622.29541626479, 8596.914030859736, 8646.351523635753, 8659.826803464022, 8701.47791132534, 8714.825703486022, 7391.895403930363, 8282.875756863652, 8906.777330566658, 9068.138526839939, 9144.954275228714, 2558.2453176313034, 2559.833610815291, 2582.3156863431204, 2597.8567681662703, 2672.9599056014176, 931.4411353188168, 948.5826236455937, 949.5157469690507, 964.0311486955565, 968.8740463739668, 19057.523561911064, 19168.62463397231, 19190.13644386006, 19372.0, 19795.406137815888, 1004.2869562610629, 1008.9798204035878, 1018.994905025485, 1022.99488502557, 1029.3103620574234, 10647.627333043461, 10665.146788256921, 10714.410707411167, 10753.89246107529, 10797.62208322705, 434916.0, 444452.0, 447234.0, 449651.0, 451680.0, 106537.46731266294, 110083.44958275158, 110228.0, 111622.0, 111833.44083279694, 1147.5639257082255, 1147.8679951805482, 1176.1531697177847, 1177.2818580665787, 1177.617274385811, 16970.490885272968, 17127.400540981005, 17530.12349382551, 17588.472345829647, 17738.5565360867, 52502.47497524976, 53141.4685853152, 53354.0, 54214.0, 55548.72225638846, 65627.34372656212, 65745.0, 66102.66948665226, 66689.0, 68078.0, 11642.94178529102, 12267.018638509076, 13505.594832155051, 13667.0, 14124.011319207557, 21645.891770541046, 21849.563008740053, 22088.66866996964, 22202.777972220072, 22303.219387321366, 17679.469615911545, 17754.11229438497, 17964.281428742703, 17965.0, 18141.365052223107, 15928.362865485251, 16637.168141593113, 16676.916615416845, 17119.48641540756, 17718.46844594664, 19577.412677619694, 19702.21191152338, 19711.70432443543, 19918.50203744918, 20074.698879516527, 14301.141931484144, 14411.0, 14484.0, 14492.710145797237, 14566.271686415848, 18268.634627307645, 18290.176942037375, 18327.450176494727, 18366.949867047406, 18461.81538184601], "value": 11564.528710462966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.561549073315, 1366.2007725480594, 1374.0999645232364, 1378.6829029323255, 1380.0960370957027, 14372.784408233872, 14507.92746036271, 14993.17537535435, 15007.549773506813, 15023.0, 14811.925940370284, 14961.925190374033, 14990.325435355408, 15016.924915375408, 15027.474038408658, 2708.6614173228295, 2761.6962134165224, 2763.9170824875287, 2766.8201566898188, 2773.500769861424, 2615.986920065397, 2681.691605465367, 2701.3651791828906, 2770.9030183943564, 2775.3339198592294, 2685.355514676483, 2700.216937088252, 2700.486907487581, 2700.8649567521643, 2700.9459810803774, 2591.572390555556, 2622.0429543216683, 2622.344413896526, 2638.340414896276, 2695.865206739655, 2607.9869600651873, 2635.486080214359, 2652.5092857821173, 2668.6397336359537, 2683.73162683732, 14320.42718291267, 14451.0, 14452.638684032878, 14458.27708614565, 14458.421663133462, 7699.538027718355, 7964.1637628049375, 7964.8407031859615, 7970.681172753083, 7976.800579985489, 4955.157623204064, 5097.974510127463, 5216.895662086775, 5218.8695282617855, 5226.1638137898135, 1804.864635152369, 1831.8442932350765, 1854.3139038555685, 1897.3359324236544, 1902.838258748008, 24460.266192014267, 24516.877415612988, 24704.876475617686, 24705.0, 25828.483430331475, 6628.734850605922, 6659.4006539411685, 6690.498212634072, 6790.966045169743, 6857.108575885103, 16523.173841307886, 16637.667246655, 16642.3343066276, 16654.333826647042, 16665.0, 7545.471816972869, 7769.72805951789, 7772.106207786177, 7774.455788094779, 7785.598592253449, 6934.826629334307, 7050.541714788523, 7062.3996960258955, 7135.0, 7191.89212161818, 5068.417132029864, 5185.066687996122, 5196.45437229093, 5201.973990130101, 5227.686338819683, 1505.781661659075, 1508.4644951042442, 1510.7884896114554, 1526.8778497720377, 1527.2592792495632, 897.0760117079419, 914.0448231597996, 916.7387294621001, 925.319889880937, 927.420362273579, 7607.087149542091, 7615.809604759815, 7753.224677532202, 8526.87209691855, 8744.912550874536, 694.1323345817727, 721.6031182849412, 728.7230852276207, 736.4145504324075, 737.2885165814907, 5406.8918621627345, 5595.300587426572, 5631.1271752878365, 5859.44335288147, 6023.126646636213, 20054.097565609292, 20906.37280881576, 21008.26471073505, 21013.054412551166, 21035.263765768126, 19274.903625481784, 20175.798242017685, 20285.49286267855, 20302.49243768888, 20413.0, 9456.101670341306, 9844.0, 10347.844782328271, 10501.737456563495, 10815.0, 8569.528675922884, 8628.870566941376, 8760.211580957744, 8883.466991980502, 8988.146126118008, 17577.560560985567, 17717.29130834752, 18240.17919193666, 18542.629147416705, 18554.350597729015, 18125.274989000292, 18388.908055459637, 18391.448256552325, 18690.813091868906, 18695.158717857455, 13338.799918001432, 13651.453941842215, 13679.521216757366, 13709.588712338646, 13709.588712338646, 13335.733285334432, 13608.115472494255, 13713.108647937852, 13783.173009619053, 13790.862091378958, 10534.26260161812, 10548.734151901821, 10694.14446844235, 10853.294535855144, 10987.066099381322, 10396.324238924748, 10683.89316106829, 10752.623658171926, 10829.837552436562, 10896.78206435851, 9881.407115573089, 9882.752931176778, 9917.057879501435, 10028.147607453157, 10034.899651003689, 7391.704331826667, 7476.925230747841, 7492.175860655215, 7524.548527088392, 7594.088709354913, 7323.780286591411, 7424.814379640552, 7438.776836694908, 7451.0, 7506.849863002819], "value": 6553.823078390651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.59201750573305, 501.410842260344, 523.2047288122054, 529.4546616984508, 530.1332321654095, 6466.515011374154, 6466.935330646692, 6472.482201423886, 6498.577592456493, 6510.739570417183, 6114.847128821782, 6231.1276421300945, 6240.282367527736, 6294.7482100715915, 6330.272018717849, 4962.478939711333, 4985.0, 4985.800567977277, 5030.195168772979, 5104.2088476286235, 4897.363342765453, 4983.800647974077, 5008.799648014094, 5029.547340739333, 5038.370203724535, 4965.428975667808, 4971.825986090487, 5034.773435195425, 5080.542751152396, 5080.872978175556, 4939.777710003059, 4983.302337672729, 4992.326035985132, 5023.874403139914, 5061.721605311706, 4471.731696098244, 4491.146682130385, 4508.323751437278, 4536.523665015159, 4541.137183935075, 6236.538721009838, 6273.654948977804, 6319.936800631981, 6324.620522768649, 6344.524160687921, 5751.223584816038, 5793.507551858097, 5818.4763371296785, 5825.15535247391, 5838.241028666289, 6634.668266586651, 6636.871731805604, 6637.137172167636, 6638.535302528825, 6698.5980841149685, 4857.562819346241, 4911.975440122812, 4937.8271760488215, 4954.355933728628, 4957.776900039471, 6958.686859091353, 6987.82530436738, 7003.789886303368, 7022.192447868459, 7087.610181440019, 4977.282837421084, 5032.672876263031, 5039.4708555601865, 5068.543831055223, 5070.873228169252, 5080.517350851663, 5097.490250974947, 5106.821261255838, 5119.180931051088, 5124.359455068116, 5734.0, 5765.740541675635, 5798.246227990418, 5808.593398462067, 5808.82573522795, 6611.702473388709, 6632.4745308579295, 6713.878046708206, 6734.635769198061, 6779.322067793181, 1640.6636639488877, 1642.7782249396178, 1699.2438364927737, 1742.520806778121, 1754.298280687735, 1189.9107566932514, 1202.5310129049678, 1203.8022167942952, 1207.4445754952644, 1225.3873063468266, 5726.740117174215, 5728.656280623176, 5769.221155144086, 5780.421957804186, 5878.177055212273, 6644.435223006002, 6717.16035495563, 6772.255051944282, 6804.353586409283, 6814.693338799766, 5874.0, 5891.499222566044, 5907.822765317047, 5937.139114828412, 5971.19388882504, 3552.928941421209, 3599.9640003600152, 3652.6164752701116, 3661.176235347079, 3667.064898450931, 6501.837454063591, 6540.378664027005, 6552.868942621216, 6553.672316384162, 6581.670916454158, 7146.2496437874315, 7157.284271572905, 7166.247544007804, 7166.677499512534, 7173.89239161413, 6473.0, 6527.477801775942, 6573.868522629521, 6614.503912206604, 6616.4376028037195, 6902.378785909293, 6909.516333856582, 6911.550749201286, 6934.7226110955, 6946.2011868635755, 6768.763093291711, 6787.62668053242, 6860.6912688930115, 6893.448524117958, 6908.44732421395, 6421.8715625688155, 6545.247296560766, 6556.377144171296, 6605.570637908713, 6607.339266073546, 4974.303597496426, 4983.227599722049, 4983.426905905867, 5024.773885175249, 5033.728076750142, 6475.546711730133, 6804.21751498584, 6864.553804002724, 6892.724845903524, 6900.413464855343, 6459.289478157305, 6467.0, 6497.642629655415, 6566.146400967844, 6588.8352791180605, 6441.710123044568, 6515.348465153446, 6515.54391192612, 6532.0, 6576.007916397932, 6424.550281480251, 6430.035494675836, 6432.388923052303, 6536.725338558936, 6554.246261679968, 6610.867782644416, 6614.0, 6635.966820165868, 6665.200175978914, 6706.362895524917, 6332.145160403286, 6418.935810641834, 6427.614343139427, 6438.484921206198, 6471.417572418505], "value": 5111.953994967433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.0527377795088, 881.0836729801006, 887.3034667785789, 897.1342654338564, 897.2866571075994, 18385.264589416423, 19220.13509392079, 19268.807311926877, 19284.228630854766, 20822.271220507286, 17439.476815695518, 18583.53541161468, 21812.672809907865, 21913.452163695874, 22001.779982200173, 926.7729406295467, 939.1829108675462, 943.4103685196752, 943.5329511891589, 943.8489841625342, 865.4980111535326, 945.7304668169573, 951.281782254397, 971.771633666088, 972.2319367699508, 1008.9798204035915, 1011.8785745710525, 1011.9342242754234, 1012.367270455965, 1016.7254841192873, 1006.5219020965056, 1006.9345492542961, 1008.5814387029374, 1008.9394636321845, 1009.1573536097368, 742.8625704244678, 742.9628518574103, 743.1379599664417, 743.7843025522592, 744.0104660801121, 17659.0, 17701.557461063447, 17860.55348616295, 18058.819411805845, 19953.70069448945, 20031.799682003286, 20221.191152353887, 20478.18087276507, 20561.177552898014, 20650.27724029667, 16729.749053764204, 16784.916075419544, 16923.0, 16943.830561694347, 17052.48842534726, 3631.8728844490315, 3655.853765849363, 3665.9633403666157, 3669.6697297243377, 3670.779753214789, 118469.40765296205, 124739.0, 124972.9999999991, 125514.37242813727, 127364.36317818351, 15989.920050399905, 16292.266847991868, 16330.428435004718, 16378.918105409635, 16406.1796910154, 29781.85109074484, 29988.700112999028, 30539.2365190872, 30592.69407305943, 30627.846860765552, 8740.78148046304, 8747.0, 8839.646414143363, 8856.8671469928, 8894.688685895962, 4453.933191002137, 4566.06395688883, 4576.336431217522, 4576.931346029813, 4577.931331030038, 5073.949260507421, 5159.484051594811, 5174.353205849269, 5180.611454140879, 5211.192265198824, 882.1311008656468, 894.9239314658197, 913.0595486648763, 914.29599208609, 917.6467060181878, 621.4313902778906, 692.1244625548685, 703.7572037647003, 704.5702121705756, 711.6228398948566, 11242.606508772154, 11956.52173913051, 12453.564125255754, 12492.25046497213, 14079.929600351932, 679.4474625480752, 681.0737397139886, 693.542262107017, 701.7017767448814, 719.1873183302835, 5710.828675139753, 5789.247397838254, 6039.607425517327, 6167.599106058092, 6185.536084793658, 106276.46861765796, 106857.0, 106865.93134068715, 106899.46550267354, 113099.0, 94298.63801074597, 94736.0, 96733.51633241789, 98054.5097274509, 99764.50117749364, 84777.57611212028, 86209.0, 86568.56715716381, 87563.12436875678, 87566.12433875707, 12223.69440763988, 12300.261984280973, 12380.938095309466, 12688.302143382203, 13012.869871301165, 39139.6086039136, 39664.80167599144, 40360.39459408053, 40737.38893916653, 42452.787736061124, 69689.0, 70000.6499967497, 70479.0, 72189.0, 72397.0, 18339.083045847387, 18549.2580296792, 18637.347692830685, 18643.72034419512, 18706.719399208752, 20935.0, 21705.34883953484, 21736.565268694852, 21809.0, 22080.116795328006, 18439.354622588144, 18557.793743406637, 18606.44180674582, 19516.31692890742, 19557.11992960292, 16181.271842767339, 16202.108884011492, 16341.182940853148, 16544.75182872234, 17569.385071522436, 18458.261669533604, 18601.0, 18788.436346909613, 18840.717389239446, 18919.0, 11632.88367116352, 12023.0, 12099.395030248628, 13094.345282736016, 13501.122427042212, 13950.302484875918, 13985.44058237659, 14104.0, 14128.293585320487, 14151.292435377984], "value": 9070.782445067034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 103.0, 112.0, 106.0, 109.0, 110.0, 100.0, 108.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 151.0, 172.0, 119.0, 149.0, 140.0, 121.0, 182.0, 129.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 168.0, 160.0, 162.0, 164.0, 162.0, 164.0, 175.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 74.0, 182.0, 78.0, 74.0, 75.0, 90.0, 98.0, 78.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 135.0, 80.0, 79.0, 80.0, 126.0, 80.0, 79.0, 128.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 151.0, 150.0, 148.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0, 97.0, 98.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 55.0, 56.0, 57.0, 53.0, 57.0, 62.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 60.0, 56.0, 56.0, 57.0, 63.0, 57.0, 61.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 75.0, 73.0, 78.0, 75.0, 74.0, 76.0, 77.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 123.0, 120.0, 120.0, 116.0, 123.0, 133.0, 120.0, 159.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 186.0, 165.0, 171.0, 170.0, 166.0, 173.0, 172.0, 168.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 68.0, 68.0, 64.0, 63.0, 67.0, 67.0], "value": 66.5, "unit": "score"}]}]} 08:42:00 INFO - Return code: 0 08:42:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:00 INFO - # TBPL SUCCESS # 08:42:00 INFO - Running post-action listener: _package_coverage_data 08:42:00 INFO - Running post-action listener: _resource_record_post_action 08:42:00 INFO - [mozharness: 2017-08-23 15:42:00.915303Z] Finished run-tests step (success) 08:42:00 INFO - Running post-run listener: _resource_record_post_run 08:42:01 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 428167168; Read time: 16; Write time: 350944 08:42:01 INFO - TinderboxPrint: CPU usage
13.1% 08:42:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:42:01 INFO - TinderboxPrint: I/O write bytes / time
428,167,168 / 350,944 08:42:01 INFO - TinderboxPrint: CPU idle
8,268.9 (86.9%) 08:42:01 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 08:42:01 INFO - TinderboxPrint: Swap in / out
0 / 0 08:42:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106295296; Read time: 0; Write time: 99380 08:42:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:42:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 321871872; Read time: 0; Write time: 251564 08:42:01 INFO - Running post-run listener: _upload_blobber_files 08:42:01 INFO - Blob upload gear active. 08:42:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:01 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 08:42:01 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:01 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:03 INFO - (blobuploader) - INFO - Done attempting. 08:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:09 INFO - (blobuploader) - INFO - Done attempting. 08:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:11 INFO - (blobuploader) - INFO - Done attempting. 08:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:12 INFO - (blobuploader) - INFO - Done attempting. 08:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:12 INFO - Return code: 0 08:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c2fd734a3d59a2b5eae80fb7702fc4708882b0960068c0a13d3994c1e5440b00cd68a1d8fcb3142366637468893b1a3fc1e5a4406d5e591da83ab5c45e899d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fcb85b97d918332ebaeb5117b5d1b64ee5bab88deae2f76b7f4d197943f368d0fb8f2a5c654a66e0138f7b877ce00d0999f52802d566769d4a156d35f80f8a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dcf32611d968a4694bc622b3203d6daa8cda98a08e1c556e5c809226fcc543d9f180e985163485d3a9bde5c1f27854ef5238966316b9f82fc540aa7b9d4dd16", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/261a1166fb3e861ae918210a040f23e3a66d0aa160168799a744b3b0b4271a52826d73c6727d7fc005ec2ed129fcc7b1724917d25f85b0e6636db515f31906cb"} 08:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:12 INFO - Contents: 08:42:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c2fd734a3d59a2b5eae80fb7702fc4708882b0960068c0a13d3994c1e5440b00cd68a1d8fcb3142366637468893b1a3fc1e5a4406d5e591da83ab5c45e899d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fcb85b97d918332ebaeb5117b5d1b64ee5bab88deae2f76b7f4d197943f368d0fb8f2a5c654a66e0138f7b877ce00d0999f52802d566769d4a156d35f80f8a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dcf32611d968a4694bc622b3203d6daa8cda98a08e1c556e5c809226fcc543d9f180e985163485d3a9bde5c1f27854ef5238966316b9f82fc540aa7b9d4dd16", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/261a1166fb3e861ae918210a040f23e3a66d0aa160168799a744b3b0b4271a52826d73c6727d7fc005ec2ed129fcc7b1724917d25f85b0e6636db515f31906cb"} 08:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:12 INFO - Copying logs to upload dir... 08:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.780124 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-23 08:42:12.152202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:42:12.161165) ========= 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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c2fd734a3d59a2b5eae80fb7702fc4708882b0960068c0a13d3994c1e5440b00cd68a1d8fcb3142366637468893b1a3fc1e5a4406d5e591da83ab5c45e899d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fcb85b97d918332ebaeb5117b5d1b64ee5bab88deae2f76b7f4d197943f368d0fb8f2a5c654a66e0138f7b877ce00d0999f52802d566769d4a156d35f80f8a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dcf32611d968a4694bc622b3203d6daa8cda98a08e1c556e5c809226fcc543d9f180e985163485d3a9bde5c1f27854ef5238966316b9f82fc540aa7b9d4dd16", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/261a1166fb3e861ae918210a040f23e3a66d0aa160168799a744b3b0b4271a52826d73c6727d7fc005ec2ed129fcc7b1724917d25f85b0e6636db515f31906cb"} build_url:https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c2fd734a3d59a2b5eae80fb7702fc4708882b0960068c0a13d3994c1e5440b00cd68a1d8fcb3142366637468893b1a3fc1e5a4406d5e591da83ab5c45e899d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fcb85b97d918332ebaeb5117b5d1b64ee5bab88deae2f76b7f4d197943f368d0fb8f2a5c654a66e0138f7b877ce00d0999f52802d566769d4a156d35f80f8a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dcf32611d968a4694bc622b3203d6daa8cda98a08e1c556e5c809226fcc543d9f180e985163485d3a9bde5c1f27854ef5238966316b9f82fc540aa7b9d4dd16", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/261a1166fb3e861ae918210a040f23e3a66d0aa160168799a744b3b0b4271a52826d73c6727d7fc005ec2ed129fcc7b1724917d25f85b0e6636db515f31906cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:42:12.195433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:42:12.195752) ========= 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=db0483c52d987ecb441a263b000001ad-1503501609.383578-1814507905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:42:12.277498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:42:12.279653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:42:12.279935) ========= ========= Total master_lag: 0.07 =========