builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1503502024.65 results: success (0) revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.648899) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.649416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.649689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.680967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.681319) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 08:27:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2017-08-23 08:27:04 (46.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183129 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.888203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.888545) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016553 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:04.940836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:27:04.941218) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 08:27:04,970 truncating revision to first 12 chars 2017-08-23 08:27:04,970 Setting DEBUG logging. 2017-08-23 08:27:04,970 attempt 1/10 2017-08-23 08:27:04,970 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:27:05,990 unpacking tar archive at: mozilla-central-446cd9f4b0f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.423841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:27:06.382153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:06.382497) ========= script_repo_revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:06.382914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:06.383177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:27:06.395930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-23 08:27:06.396324) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:27:06 INFO - MultiFileLogger online at 20170823 08:27:06 in /builds/slave/test 08:27:06 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:27:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:06 INFO - {'append_to_log': False, 08:27:06 INFO - 'base_work_dir': '/builds/slave/test', 08:27:06 INFO - 'blob_upload_branch': 'Firefox', 08:27:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:06 INFO - 'branch': 'Firefox', 08:27:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:06 INFO - 'code_coverage': False, 08:27:06 INFO - 'config_files': ('talos/linux_config.py',), 08:27:06 INFO - 'default_actions': ('clobber', 08:27:06 INFO - 'read-buildbot-config', 08:27:06 INFO - 'download-and-extract', 08:27:06 INFO - 'populate-webroot', 08:27:06 INFO - 'create-virtualenv', 08:27:06 INFO - 'install', 08:27:06 INFO - 'setup-mitmproxy', 08:27:06 INFO - 'run-tests'), 08:27:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:06 INFO - 'disable_ccov_upload': False, 08:27:06 INFO - 'download_minidump_stackwalk': True, 08:27:06 INFO - 'download_symbols': 'ondemand', 08:27:06 INFO - 'enable_stylo': False, 08:27:06 INFO - 'enable_webrender': False, 08:27:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:06 INFO - 'gecko_profile': False, 08:27:06 INFO - 'gecko_profile_interval': 0, 08:27:06 INFO - 'installer_path': 'installer.exe', 08:27:06 INFO - 'log_level': 'info', 08:27:06 INFO - 'log_name': 'talos', 08:27:06 INFO - 'log_to_console': True, 08:27:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:27:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:27:06 INFO - 'opt_config_files': (), 08:27:06 INFO - 'pip_index': False, 08:27:06 INFO - 'suite': 'dromaeojs-e10s', 08:27:06 INFO - 'system_bits': '32', 08:27:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:06 INFO - 'title': 'talos-linux64-ix-019', 08:27:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:06 INFO - 'use_talos_json': True, 08:27:06 INFO - 'verify': 'False', 08:27:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:06 INFO - 'work_dir': 'build'} 08:27:06 INFO - [mozharness: 2017-08-23 15:27:06.618793Z] Running clobber step. 08:27:06 INFO - Running pre-action listener: _resource_record_pre_action 08:27:06 INFO - Running main action method: clobber 08:27:06 INFO - rmtree: /builds/slave/test/build 08:27:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:07 INFO - Running post-action listener: _resource_record_post_action 08:27:07 INFO - [mozharness: 2017-08-23 15:27:07.599270Z] Finished clobber step (success) 08:27:07 INFO - [mozharness: 2017-08-23 15:27:07.599429Z] Running read-buildbot-config step. 08:27:07 INFO - Running pre-action listener: _resource_record_pre_action 08:27:07 INFO - Running main action method: read_buildbot_config 08:27:07 INFO - Using buildbot properties: 08:27:07 INFO - { 08:27:07 INFO - "project": "", 08:27:07 INFO - "product": "firefox", 08:27:07 INFO - "who": "archaeopteryx@coole-files.de", 08:27:07 INFO - "installer_path": "public/build/target.tar.bz2", 08:27:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:27:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:27:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:27:07 INFO - "stage_platform": "linux64-stylosequential", 08:27:07 INFO - "basedir": "/builds/slave/test", 08:27:07 INFO - "buildnumber": 44, 08:27:07 INFO - "platform": "ubuntu64_hw_styloseq", 08:27:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:27:07 INFO - "slavebuilddir": "test", 08:27:07 INFO - "taskId": "T1ik4_GsRY2fJe1O5OJV4Q", 08:27:07 INFO - "branch": "mozilla-central", 08:27:07 INFO - "script_repo_revision": "production", 08:27:07 INFO - "revision": "446cd9f4b0f5684adaf275a999e0361988a95cfe", 08:27:07 INFO - "slavename": "talos-linux64-ix-019", 08:27:07 INFO - "repo_path": "mozilla-central" 08:27:07 INFO - } 08:27:07 INFO - Finding installer, test and symbols from parent task. 08:27:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1ik4_GsRY2fJe1O5OJV4Q'}, attempt #1 08:27:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1ik4_GsRY2fJe1O5OJV4Q'}, attempt #1 08:27:08 INFO - Task dependencies: b8HvYVIUQ8S4HNJ3UL126w 08:27:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w'}, attempt #1 08:27:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:27:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json 08:27:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.crashreporter-symbols.zip 08:27:09 INFO - Running post-action listener: _resource_record_post_action 08:27:09 INFO - [mozharness: 2017-08-23 15:27:09.158422Z] Finished read-buildbot-config step (success) 08:27:09 INFO - [mozharness: 2017-08-23 15:27:09.158639Z] Running download-and-extract step. 08:27:09 INFO - Running pre-action listener: _resource_record_pre_action 08:27:09 INFO - Running main action method: download_and_extract 08:27:09 INFO - mkdir: /builds/slave/test/build/tests 08:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:09 INFO - trying https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.test_packages.json 08:27:09 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:27:09 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:27:09 INFO - Downloaded 989 bytes. 08:27:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:27:09 INFO - Using the following test package requirements: 08:27:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:27:09 INFO - u'common': [u'target.common.tests.zip'], 08:27:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:27:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:27:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:27:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:27:09 INFO - u'mozbase': [u'target.common.tests.zip'], 08:27:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:27:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:27:09 INFO - u'web-platform': [u'target.common.tests.zip', 08:27:09 INFO - u'target.web-platform.tests.tar.gz'], 08:27:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:27:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:27:09 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:27:09 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:27:09 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip into memory 08:27:11 INFO - Content-Length response header: 54949361 08:27:11 INFO - Bytes received: 54949361 08:27:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:27:21 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:27:21 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:27:21 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.common.tests.zip into memory 08:27:23 INFO - Content-Length response header: 54949361 08:27:23 INFO - Bytes received: 54949361 08:27:35 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:27:35 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:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.talos.tests.zip into memory 08:27:35 INFO - Content-Length response header: 14496261 08:27:35 INFO - Bytes received: 14496261 08:27:36 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:27:36 INFO - trying https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:27:36 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:27:37 INFO - Downloaded 61144598 bytes. 08:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:27:37 INFO - mkdir: /builds/slave/test/properties 08:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:27:37 INFO - Contents: 08:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 08:27:37 INFO - Running post-action listener: _resource_record_post_action 08:27:37 INFO - Running post-action listener: find_tests_for_verification 08:27:37 INFO - Running post-action listener: set_extra_try_arguments 08:27:37 INFO - [mozharness: 2017-08-23 15:27:37.394376Z] Finished download-and-extract step (success) 08:27:37 INFO - [mozharness: 2017-08-23 15:27:37.394473Z] Running populate-webroot step. 08:27:37 INFO - Running pre-action listener: _resource_record_pre_action 08:27:37 INFO - Running main action method: populate_webroot 08:27:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:27:37 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:27:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:27:37 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:27:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:27:37 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:27:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'tests': ['damp', 'tps']}, 08:27:37 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['damp', 'tps']}, 08:27:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:27:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:27:37 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:27:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:27:37 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:27:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:27:37 INFO - 'ts_paint', 08:27:37 INFO - 'tpaint', 08:27:37 INFO - 'sessionrestore', 08:27:37 INFO - 'sessionrestore_many_windows', 08:27:37 INFO - 'sessionrestore_no_auto_restore', 08:27:37 INFO - 'tabpaint']}, 08:27:37 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['a11yr', 08:27:37 INFO - 'ts_paint', 08:27:37 INFO - 'tpaint', 08:27:37 INFO - 'sessionrestore', 08:27:37 INFO - 'sessionrestore_many_windows', 08:27:37 INFO - 'sessionrestore_no_auto_restore', 08:27:37 INFO - 'tabpaint']}, 08:27:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:27:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:27:37 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['bloom_basic_singleton']}, 08:27:37 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['bloom_basic']}, 08:27:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:27:37 INFO - 'tsvgr_opacity', 08:27:37 INFO - 'tart', 08:27:37 INFO - 'tscrollx', 08:27:37 INFO - 'tsvg_static']}, 08:27:37 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['tsvgx', 08:27:37 INFO - 'tsvgr_opacity', 08:27:37 INFO - 'tart', 08:27:37 INFO - 'tscrollx', 08:27:37 INFO - 'tsvg_static']}, 08:27:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:27:37 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--stylo'], 08:27:37 INFO - 'tests': ['tp5o']}, 08:27:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:27:37 INFO - 'talos_options': ['--mitmproxy', 08:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:27:37 INFO - '--firstNonBlankPaint'], 08:27:37 INFO - 'tests': ['tp6_google', 08:27:37 INFO - 'tp6_youtube', 08:27:37 INFO - 'tp6_amazon', 08:27:37 INFO - 'tp6_facebook']}, 08:27:37 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:27:37 INFO - 'talos_options': ['--stylo', 08:27:37 INFO - '--mitmproxy', 08:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:27:37 INFO - '--firstNonBlankPaint'], 08:27:37 INFO - 'tests': ['tp6_google', 08:27:37 INFO - 'tp6_youtube', 08:27:37 INFO - 'tp6_amazon', 08:27:37 INFO - 'tp6_facebook']}, 08:27:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:27:37 INFO - 'talos_options': ['--stylo', 08:27:37 INFO - '--stylo-threads=1', 08:27:37 INFO - '--mitmproxy', 08:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:27:37 INFO - '--firstNonBlankPaint'], 08:27:37 INFO - 'tests': ['tp6_google', 08:27:37 INFO - 'tp6_youtube', 08:27:37 INFO - 'tp6_amazon', 08:27:37 INFO - 'tp6_facebook']}, 08:27:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--xperf_path', 08:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:27:37 INFO - 'tests': ['tp5n']}, 08:27:37 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:27:37 INFO - 'talos_options': ['--stylo', 08:27:37 INFO - '--xperf_path', 08:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:27:37 INFO - 'tests': ['tp5n']}}} 08:27:37 INFO - Running post-action listener: _resource_record_post_action 08:27:37 INFO - [mozharness: 2017-08-23 15:27:37.408769Z] Finished populate-webroot step (success) 08:27:37 INFO - [mozharness: 2017-08-23 15:27:37.408858Z] Running create-virtualenv step. 08:27:37 INFO - Running pre-action listener: _resource_record_pre_action 08:27:37 INFO - Running main action method: create_virtualenv 08:27:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:27:37 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:27:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:27:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:27:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:27:37 INFO - Using real prefix '/usr' 08:27:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:27:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:27:40 INFO - Installing pip.................done. 08:27:40 INFO - Return code: 0 08:27:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:27:41 INFO - Reading from file tmpfile_stdout 08:27:41 INFO - Output received: 08:27:41 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:27:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:27:41 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:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:41 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:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:41 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:41 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:27:41 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:27:41 INFO - Using env: {'DISPLAY': ':0', 08:27:41 INFO - 'HOME': '/home/cltbld', 08:27:41 INFO - 'LANG': 'en_US.UTF-8', 08:27:41 INFO - 'LANGUAGE': 'en_US:en', 08:27:41 INFO - 'LOGNAME': 'cltbld', 08:27:41 INFO - 'MAIL': '/var/mail/cltbld', 08:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:41 INFO - 'MOZ_NO_REMOTE': '1', 08:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:41 INFO - 'NO_EM_RESTART': '1', 08:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:41 INFO - 'PWD': '/builds/slave/test', 08:27:41 INFO - 'SHELL': '/bin/bash', 08:27:41 INFO - 'SHLVL': '1', 08:27:41 INFO - 'TERM': 'linux', 08:27:41 INFO - 'TMOUT': '86400', 08:27:41 INFO - 'USER': 'cltbld', 08:27:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:41 INFO - '_': '/tools/buildbot/bin/python'} 08:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:41 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:27:41 INFO - Cleaning up... 08:27:41 INFO - Return code: 0 08:27:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:27:41 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:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:41 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:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:41 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:41 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:27:41 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:27:41 INFO - Using env: {'DISPLAY': ':0', 08:27:41 INFO - 'HOME': '/home/cltbld', 08:27:41 INFO - 'LANG': 'en_US.UTF-8', 08:27:41 INFO - 'LANGUAGE': 'en_US:en', 08:27:41 INFO - 'LOGNAME': 'cltbld', 08:27:41 INFO - 'MAIL': '/var/mail/cltbld', 08:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:41 INFO - 'MOZ_NO_REMOTE': '1', 08:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:41 INFO - 'NO_EM_RESTART': '1', 08:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:41 INFO - 'PWD': '/builds/slave/test', 08:27:41 INFO - 'SHELL': '/bin/bash', 08:27:41 INFO - 'SHLVL': '1', 08:27:41 INFO - 'TERM': 'linux', 08:27:41 INFO - 'TMOUT': '86400', 08:27:41 INFO - 'USER': 'cltbld', 08:27:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:41 INFO - '_': '/tools/buildbot/bin/python'} 08:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:41 INFO - Downloading/unpacking psutil>=3.1.1 08:27:41 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:27:41 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:27:41 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:27:41 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:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:27:42 INFO - Installing collected packages: psutil 08:27:42 INFO - Running setup.py install for psutil 08:27:42 INFO - building 'psutil._psutil_linux' extension 08:27:42 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:27:43 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:27:43 INFO - building 'psutil._psutil_posix' extension 08:27:43 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:27:44 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:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:27:44 INFO - Successfully installed psutil 08:27:44 INFO - Cleaning up... 08:27:44 INFO - Return code: 0 08:27:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:44 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:44 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:27:44 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:27:44 INFO - Using env: {'DISPLAY': ':0', 08:27:44 INFO - 'HOME': '/home/cltbld', 08:27:44 INFO - 'LANG': 'en_US.UTF-8', 08:27:44 INFO - 'LANGUAGE': 'en_US:en', 08:27:44 INFO - 'LOGNAME': 'cltbld', 08:27:44 INFO - 'MAIL': '/var/mail/cltbld', 08:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:44 INFO - 'MOZ_NO_REMOTE': '1', 08:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:44 INFO - 'NO_EM_RESTART': '1', 08:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:44 INFO - 'PWD': '/builds/slave/test', 08:27:44 INFO - 'SHELL': '/bin/bash', 08:27:44 INFO - 'SHLVL': '1', 08:27:44 INFO - 'TERM': 'linux', 08:27:44 INFO - 'TMOUT': '86400', 08:27:44 INFO - 'USER': 'cltbld', 08:27:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:44 INFO - '_': '/tools/buildbot/bin/python'} 08:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:27:44 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:27:44 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:27:44 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:27:44 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:27:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:27:45 INFO - Installing collected packages: mozsystemmonitor 08:27:45 INFO - Running setup.py install for mozsystemmonitor 08:27:45 INFO - Successfully installed mozsystemmonitor 08:27:45 INFO - Cleaning up... 08:27:45 INFO - Return code: 0 08:27:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:27: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:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27: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:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:45 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:45 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:27:45 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:27:45 INFO - Using env: {'DISPLAY': ':0', 08:27:45 INFO - 'HOME': '/home/cltbld', 08:27:45 INFO - 'LANG': 'en_US.UTF-8', 08:27:45 INFO - 'LANGUAGE': 'en_US:en', 08:27:45 INFO - 'LOGNAME': 'cltbld', 08:27:45 INFO - 'MAIL': '/var/mail/cltbld', 08:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:45 INFO - 'MOZ_NO_REMOTE': '1', 08:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:45 INFO - 'NO_EM_RESTART': '1', 08:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:45 INFO - 'PWD': '/builds/slave/test', 08:27:45 INFO - 'SHELL': '/bin/bash', 08:27:45 INFO - 'SHLVL': '1', 08:27:45 INFO - 'TERM': 'linux', 08:27:45 INFO - 'TMOUT': '86400', 08:27:45 INFO - 'USER': 'cltbld', 08:27:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:45 INFO - '_': '/tools/buildbot/bin/python'} 08:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:27:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:27:47 INFO - warning: no files found matching '*.txt' 08:27:47 INFO - no previously-included directories found matching 'build' 08:27:47 INFO - no previously-included directories found matching 'dist' 08:27:47 INFO - no previously-included directories found matching '.git*' 08:27:47 INFO - Installing collected packages: jsonschema, functools32 08:27:47 INFO - Running setup.py install for functools32 08:27:47 INFO - warning: no files found matching '*.txt' 08:27:47 INFO - no previously-included directories found matching 'build' 08:27:47 INFO - no previously-included directories found matching 'dist' 08:27:47 INFO - no previously-included directories found matching '.git*' 08:27:47 INFO - Successfully installed jsonschema functools32 08:27:47 INFO - Cleaning up... 08:27:47 INFO - Return code: 0 08:27:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:47 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:47 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:27:47 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:27:47 INFO - Using env: {'DISPLAY': ':0', 08:27:47 INFO - 'HOME': '/home/cltbld', 08:27:47 INFO - 'LANG': 'en_US.UTF-8', 08:27:47 INFO - 'LANGUAGE': 'en_US:en', 08:27:47 INFO - 'LOGNAME': 'cltbld', 08:27:47 INFO - 'MAIL': '/var/mail/cltbld', 08:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:47 INFO - 'MOZ_NO_REMOTE': '1', 08:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:47 INFO - 'NO_EM_RESTART': '1', 08:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:47 INFO - 'PWD': '/builds/slave/test', 08:27:47 INFO - 'SHELL': '/bin/bash', 08:27:47 INFO - 'SHLVL': '1', 08:27:47 INFO - 'TERM': 'linux', 08:27:47 INFO - 'TMOUT': '86400', 08:27:47 INFO - 'USER': 'cltbld', 08:27:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:47 INFO - '_': '/tools/buildbot/bin/python'} 08:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:27:47 INFO - Cleaning up... 08:27:47 INFO - Return code: 0 08:27:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:47 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:47 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:27:47 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:27:47 INFO - Using env: {'DISPLAY': ':0', 08:27:47 INFO - 'HOME': '/home/cltbld', 08:27:47 INFO - 'LANG': 'en_US.UTF-8', 08:27:47 INFO - 'LANGUAGE': 'en_US:en', 08:27:47 INFO - 'LOGNAME': 'cltbld', 08:27:47 INFO - 'MAIL': '/var/mail/cltbld', 08:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:47 INFO - 'MOZ_NO_REMOTE': '1', 08:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:47 INFO - 'NO_EM_RESTART': '1', 08:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:47 INFO - 'PWD': '/builds/slave/test', 08:27:47 INFO - 'SHELL': '/bin/bash', 08:27:47 INFO - 'SHLVL': '1', 08:27:47 INFO - 'TERM': 'linux', 08:27:47 INFO - 'TMOUT': '86400', 08:27:47 INFO - 'USER': 'cltbld', 08:27:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:47 INFO - '_': '/tools/buildbot/bin/python'} 08:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:27:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:27:49 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:27:49 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:27:49 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:27:49 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:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:27:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:27:49 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:27:49 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:27:49 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:27:49 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:27:49 INFO - Downloading docopt-0.6.1.tar.gz 08:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:27:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:27:49 INFO - Running setup.py install for blobuploader 08:27:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:27:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:27:49 INFO - Running setup.py install for requests 08:27:49 INFO - Running setup.py install for docopt 08:27:50 INFO - Successfully installed blobuploader requests docopt 08:27:50 INFO - Cleaning up... 08:27:50 INFO - Return code: 0 08:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27: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:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27: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:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:50 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:50 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:27:50 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:27:50 INFO - Using env: {'DISPLAY': ':0', 08:27:50 INFO - 'HOME': '/home/cltbld', 08:27:50 INFO - 'LANG': 'en_US.UTF-8', 08:27:50 INFO - 'LANGUAGE': 'en_US:en', 08:27:50 INFO - 'LOGNAME': 'cltbld', 08:27:50 INFO - 'MAIL': '/var/mail/cltbld', 08:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:50 INFO - 'MOZ_NO_REMOTE': '1', 08:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:50 INFO - 'NO_EM_RESTART': '1', 08:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:50 INFO - 'PWD': '/builds/slave/test', 08:27:50 INFO - 'SHELL': '/bin/bash', 08:27:50 INFO - 'SHLVL': '1', 08:27:50 INFO - 'TERM': 'linux', 08:27:50 INFO - 'TMOUT': '86400', 08:27:50 INFO - 'USER': 'cltbld', 08:27:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:50 INFO - '_': '/tools/buildbot/bin/python'} 08:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:50 INFO - Running setup.py (path:/tmp/pip-9NttBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:50 INFO - Running setup.py (path:/tmp/pip-6QD9jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:50 INFO - Running setup.py (path:/tmp/pip-nBKa27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:50 INFO - Running setup.py (path:/tmp/pip-edwXFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:50 INFO - Running setup.py (path:/tmp/pip-wWlcxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:50 INFO - Running setup.py (path:/tmp/pip-_rHTLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:50 INFO - Running setup.py (path:/tmp/pip-eByWlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:50 INFO - Running setup.py (path:/tmp/pip-34cnFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:50 INFO - Running setup.py (path:/tmp/pip-2adjDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:50 INFO - Running setup.py (path:/tmp/pip-_ONxuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:51 INFO - Running setup.py (path:/tmp/pip-jD5Ga5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:51 INFO - Running setup.py (path:/tmp/pip-cQYXqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:51 INFO - Running setup.py (path:/tmp/pip-rrPx6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:51 INFO - Running setup.py (path:/tmp/pip-b694Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:51 INFO - Running setup.py (path:/tmp/pip-EZSgL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:51 INFO - Running setup.py (path:/tmp/pip-lT1g_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:51 INFO - Running setup.py (path:/tmp/pip-FLgxy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:27:51 INFO - Running setup.py install for manifestparser 08:27:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:27:51 INFO - Running setup.py install for mozcrash 08:27:51 INFO - Running setup.py install for mozdebug 08:27:51 INFO - Running setup.py install for mozdevice 08:27:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:27:51 INFO - Running setup.py install for mozfile 08:27:52 INFO - Running setup.py install for mozhttpd 08:27:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for mozinfo 08:27:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for mozInstall 08:27:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for mozleak 08:27:52 INFO - Running setup.py install for mozlog 08:27:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for moznetwork 08:27:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for mozprocess 08:27:52 INFO - Running setup.py install for mozprofile 08:27:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:27:52 INFO - Running setup.py install for mozrunner 08:27:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:53 INFO - Running setup.py install for mozscreenshot 08:27:53 INFO - Running setup.py install for moztest 08:27:53 INFO - Running setup.py install for mozversion 08:27:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:53 INFO - Cleaning up... 08:27:53 INFO - Return code: 0 08:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27: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:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27: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:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:53 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:53 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:27:53 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:27:53 INFO - Using env: {'DISPLAY': ':0', 08:27:53 INFO - 'HOME': '/home/cltbld', 08:27:53 INFO - 'LANG': 'en_US.UTF-8', 08:27:53 INFO - 'LANGUAGE': 'en_US:en', 08:27:53 INFO - 'LOGNAME': 'cltbld', 08:27:53 INFO - 'MAIL': '/var/mail/cltbld', 08:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:53 INFO - 'MOZ_NO_REMOTE': '1', 08:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:53 INFO - 'NO_EM_RESTART': '1', 08:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:53 INFO - 'PWD': '/builds/slave/test', 08:27:53 INFO - 'SHELL': '/bin/bash', 08:27:53 INFO - 'SHLVL': '1', 08:27:53 INFO - 'TERM': 'linux', 08:27:53 INFO - 'TMOUT': '86400', 08:27:53 INFO - 'USER': 'cltbld', 08:27:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:53 INFO - '_': '/tools/buildbot/bin/python'} 08:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:53 INFO - Running setup.py (path:/tmp/pip-5q9Y2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:53 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:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:53 INFO - Running setup.py (path:/tmp/pip-LSC1rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:53 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:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:53 INFO - Running setup.py (path:/tmp/pip-5d4pvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:53 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:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:53 INFO - Running setup.py (path:/tmp/pip-WtpMEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:53 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:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:53 INFO - Running setup.py (path:/tmp/pip-lDjHfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:53 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:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:53 INFO - Running setup.py (path:/tmp/pip-VcprjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:54 INFO - Running setup.py (path:/tmp/pip-QhARPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:54 INFO - Running setup.py (path:/tmp/pip-JXvDod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:54 INFO - Running setup.py (path:/tmp/pip-_q4gEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:54 INFO - Running setup.py (path:/tmp/pip-P2uebn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:54 INFO - Running setup.py (path:/tmp/pip-b2XVHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:54 INFO - Running setup.py (path:/tmp/pip-n5MZhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:54 INFO - Running setup.py (path:/tmp/pip-_3r2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:54 INFO - Running setup.py (path:/tmp/pip-euIyeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:54 INFO - Running setup.py (path:/tmp/pip-1j5CHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:54 INFO - Running setup.py (path:/tmp/pip-87lVQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:54 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:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:54 INFO - Running setup.py (path:/tmp/pip-TUMLxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27: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:27: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:27: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:27: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:27:55 INFO - Downloading blessings-1.6.tar.gz 08:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:56 INFO - Installing collected packages: blessings 08:27:56 INFO - Running setup.py install for blessings 08:27:56 INFO - Successfully installed blessings 08:27:56 INFO - Cleaning up... 08:27:56 INFO - Return code: 0 08:27:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:56 INFO - Reading from file tmpfile_stdout 08:27:56 INFO - Current package versions: 08:27:56 INFO - argparse == 1.2.1 08:27:56 INFO - blessings == 1.6 08:27:56 INFO - blobuploader == 1.2.4 08:27:56 INFO - docopt == 0.6.1 08:27:56 INFO - functools32 == 3.2.3-2 08:27:56 INFO - jsonschema == 2.5.1 08:27:56 INFO - manifestparser == 1.1 08:27:56 INFO - mozInstall == 1.13 08:27:56 INFO - mozcrash == 1.0 08:27:56 INFO - mozdebug == 0.1 08:27:56 INFO - mozdevice == 0.51 08:27:56 INFO - mozfile == 1.2 08:27:56 INFO - mozhttpd == 0.7 08:27:56 INFO - mozinfo == 0.10 08:27:56 INFO - mozleak == 0.1 08:27:56 INFO - mozlog == 3.5 08:27:56 INFO - moznetwork == 0.27 08:27:56 INFO - mozprocess == 0.25 08:27:56 INFO - mozprofile == 0.28 08:27:56 INFO - mozrunner == 6.13 08:27:56 INFO - mozscreenshot == 0.1 08:27:56 INFO - mozsystemmonitor == 0.3 08:27:56 INFO - moztest == 0.8 08:27:56 INFO - mozversion == 1.4 08:27:56 INFO - psutil == 3.1.1 08:27:56 INFO - requests == 1.2.3 08:27:56 INFO - wsgiref == 0.1.2 08:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:56 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:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:56 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:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:56 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:56 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:27:56 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:27:56 INFO - Using env: {'DISPLAY': ':0', 08:27:56 INFO - 'HOME': '/home/cltbld', 08:27:56 INFO - 'LANG': 'en_US.UTF-8', 08:27:56 INFO - 'LANGUAGE': 'en_US:en', 08:27:56 INFO - 'LOGNAME': 'cltbld', 08:27:56 INFO - 'MAIL': '/var/mail/cltbld', 08:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:56 INFO - 'MOZ_NO_REMOTE': '1', 08:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:56 INFO - 'NO_EM_RESTART': '1', 08:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:56 INFO - 'PWD': '/builds/slave/test', 08:27:56 INFO - 'SHELL': '/bin/bash', 08:27:56 INFO - 'SHLVL': '1', 08:27:56 INFO - 'TERM': 'linux', 08:27:56 INFO - 'TMOUT': '86400', 08:27:56 INFO - 'USER': 'cltbld', 08:27:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:56 INFO - '_': '/tools/buildbot/bin/python'} 08:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:56 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:27:56 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:27:56 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:27:56 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:27:56 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:27:56 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:27:56 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:27:56 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:27:56 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:27:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:27: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:27: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:27: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:27: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:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:27:57 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:27:57 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:27:57 INFO - Installing collected packages: simplejson 08:27:57 INFO - Running setup.py install for simplejson 08:27:57 INFO - building 'simplejson._speedups' extension 08:27:57 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:27:58 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:27:58 INFO - Successfully installed simplejson 08:27:58 INFO - Cleaning up... 08:27:58 INFO - Return code: 0 08:27:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27:58 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:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:58 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:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:58 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 0x12d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1647f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', '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:27:58 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:27:58 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:27:58 INFO - Using env: {'DISPLAY': ':0', 08:27:58 INFO - 'HOME': '/home/cltbld', 08:27:58 INFO - 'LANG': 'en_US.UTF-8', 08:27:58 INFO - 'LANGUAGE': 'en_US:en', 08:27:58 INFO - 'LOGNAME': 'cltbld', 08:27:58 INFO - 'MAIL': '/var/mail/cltbld', 08:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:58 INFO - 'MOZ_NO_REMOTE': '1', 08:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:58 INFO - 'NO_EM_RESTART': '1', 08:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:58 INFO - 'PWD': '/builds/slave/test', 08:27:58 INFO - 'SHELL': '/bin/bash', 08:27:58 INFO - 'SHLVL': '1', 08:27:58 INFO - 'TERM': 'linux', 08:27:58 INFO - 'TMOUT': '86400', 08:27:58 INFO - 'USER': 'cltbld', 08:27:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:58 INFO - '_': '/tools/buildbot/bin/python'} 08:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:59 INFO - Cleaning up... 08:27:59 INFO - Return code: 0 08:27:59 INFO - Running post-action listener: _resource_record_post_action 08:27:59 INFO - Running post-action listener: _start_resource_monitoring 08:27:59 INFO - Starting resource monitoring. 08:27:59 INFO - [mozharness: 2017-08-23 15:27:59.122746Z] Finished create-virtualenv step (success) 08:27:59 INFO - [mozharness: 2017-08-23 15:27:59.123772Z] Running install step. 08:27:59 INFO - Running pre-action listener: _resource_record_pre_action 08:27:59 INFO - Running main action method: install 08:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:59 INFO - Reading from file tmpfile_stdout 08:27:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:59 INFO - Reading from file tmpfile_stdout 08:27:59 INFO - Output received: 08:27:59 INFO - Usage: mozinstall [options] installer 08:27:59 INFO - Options: 08:27:59 INFO - -h, --help show this help message and exit 08:27:59 INFO - -d DEST, --destination=DEST 08:27:59 INFO - Directory to install application into. [default: 08:27:59 INFO - "/builds/slave/test"] 08:27:59 INFO - --app=APP Application being installed. [default: firefox] 08:27:59 INFO - mkdir: /builds/slave/test/build/application 08:27:59 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:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:28:17 INFO - Reading from file tmpfile_stdout 08:28:17 INFO - Output received: 08:28:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:28:17 INFO - Running post-action listener: _resource_record_post_action 08:28:17 INFO - [mozharness: 2017-08-23 15:28:17.153247Z] Finished install step (success) 08:28:17 INFO - [mozharness: 2017-08-23 15:28:17.153588Z] Running setup-mitmproxy step. 08:28:17 INFO - Running pre-action listener: _resource_record_pre_action 08:28:17 INFO - Running main action method: setup_mitmproxy 08:28:17 INFO - Skipping: mitmproxy is not required 08:28:17 INFO - Running post-action listener: _resource_record_post_action 08:28:17 INFO - [mozharness: 2017-08-23 15:28:17.155195Z] Finished setup-mitmproxy step (success) 08:28:17 INFO - [mozharness: 2017-08-23 15:28:17.155507Z] Running run-tests step. 08:28:17 INFO - Running pre-action listener: _resource_record_pre_action 08:28:17 INFO - Running pre-action listener: _set_gcov_prefix 08:28:17 INFO - Running main action method: run_tests 08:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:28:17 INFO - Python 2.7.3 08:28:17 INFO - Return code: 0 08:28:17 INFO - grabbing minidump binary from tooltool 08:28:17 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:28:17 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 0x1645130>, '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 0x1646030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16464c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:28:17 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:28:17 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:28:17 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:28:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:28:17 INFO - Return code: 0 08:28:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:28:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:28:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:28:17 INFO - ENV: RUST_BACKTRACE is now full 08:28:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:28:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:28:17 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-019', '--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:28:17 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-019 --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:28:17 INFO - Using env: {'DISPLAY': ':0', 08:28:17 INFO - 'HOME': '/home/cltbld', 08:28:17 INFO - 'LANG': 'en_US.UTF-8', 08:28:17 INFO - 'LANGUAGE': 'en_US:en', 08:28:17 INFO - 'LOGNAME': 'cltbld', 08:28:17 INFO - 'MAIL': '/var/mail/cltbld', 08:28:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:28:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:17 INFO - 'MOZ_NO_REMOTE': '1', 08:28:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:17 INFO - 'NO_EM_RESTART': '1', 08:28:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:17 INFO - 'PWD': '/builds/slave/test', 08:28:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:28:17 INFO - 'RUST_BACKTRACE': 'full', 08:28:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:28:17 INFO - 'SHELL': '/bin/bash', 08:28:17 INFO - 'SHLVL': '1', 08:28:17 INFO - 'STYLO_FORCE_ENABLED': '1', 08:28:17 INFO - 'TERM': 'linux', 08:28:17 INFO - 'TMOUT': '86400', 08:28:17 INFO - 'USER': 'cltbld', 08:28:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325', 08:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:17 INFO - '_': '/tools/buildbot/bin/python'} 08:28:17 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-019', '--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:28:17 INFO - mozversion application_buildid: 20170823143012 08:28:17 INFO - mozversion application_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:28:17 INFO - mozversion application_display_name: Nightly 08:28:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:28:17 INFO - mozversion application_name: Firefox 08:28:17 INFO - mozversion application_remotingname: firefox 08:28:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:28:17 INFO - mozversion application_vendor: Mozilla 08:28:17 INFO - mozversion application_version: 57.0a1 08:28:17 INFO - mozversion platform_buildid: 20170823143012 08:28:17 INFO - mozversion platform_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:28:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:28:17 INFO - mozversion platform_version: 57.0a1 08:28:17 INFO - using testdate: 1503502097 08:28:17 INFO - actual date: 1503502097 08:28:17 INFO - starting webserver on 'localhost:33865' 08:28:17 INFO - SUITE-START | Running 2 tests 08:28:17 INFO - TEST-START | dromaeo_css 08:28:17 INFO - Initialising browser for dromaeo_css test... 08:28:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33865/getInfo.html -profile /tmp/tmpuSXUp5/profile 08:28:17 INFO - TEST-INFO | started process 3362 (/builds/slave/test/build/application/firefox/firefox http://localhost:33865/getInfo.html) 08:28:25 INFO - TEST-INFO | 3362: exit 0 08:28:25 INFO - Browser initialized. 08:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:28:25 INFO - TEST-INFO | started process 3597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuSXUp5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:26 INFO - PID 3597 | 08:28:26 INFO - PID 3597 | (/builds/slave/test/build/application/firefox/firefox:3647): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:28:26 INFO - PID 3597 | 08:28:27 INFO - PID 3597 | 08:28:27 INFO - PID 3597 | (/builds/slave/test/build/application/firefox/firefox:3707): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:28:27 INFO - PID 3597 | 08:28:27 INFO - PID 3597 | __metrics Screen width/height:1600/1200 08:28:27 INFO - PID 3597 | colorDepth:24 08:28:27 INFO - PID 3597 | Browser inner width/height: 1024/768 08:28:27 INFO - PID 3597 | __metrics 08:28:36 INFO - PID 3597 | RSS: Main: 177848320 08:28:36 INFO - PID 3597 | 08:31:34 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33865/tests/dromaeo/cssquery-ext.html) 08:31:36 INFO - PID 3597 | RSS: Main: 178757632 08:31:36 INFO - PID 3597 | 08:34:38 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-ext.html (next: http://localhost:33865/tests/dromaeo/cssquery-jquery.html) 08:34:39 INFO - PID 3597 | RSS: Main: 175767552 08:34:39 INFO - PID 3597 | 08:37:40 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33865/tests/dromaeo/cssquery-mootools.html) 08:37:41 INFO - PID 3597 | RSS: Main: 178008064 08:37:41 INFO - PID 3597 | 08:40:43 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33865/tests/dromaeo/cssquery-prototype.html) 08:40:43 INFO - PID 3597 | RSS: Main: 176603136 08:40:43 INFO - PID 3597 | 08:43:47 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33865/tests/dromaeo/cssquery-yui.html) 08:43:48 INFO - PID 3597 | RSS: Main: 176775168 08:43:48 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | Cycle 1(1): loaded http://localhost:33865/tests/dromaeo/cssquery-yui.html (next: http://localhost:33865/tests/dromaeo/cssquery-dojo.html) 08:46:50 INFO - PID 3597 | RSS: Main: 179744768 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | __start_tp_report 08:46:50 INFO - PID 3597 | _x_x_mozilla_page_load 08:46:50 INFO - PID 3597 | _x_x_mozilla_page_load_details 08:46:50 INFO - PID 3597 | |i|pagename|runs| 08:46:50 INFO - PID 3597 | |0;dojo.html;3253.1216571525674;3268.7221586165174;3273.5744353234077;3286.408446479634;3299.1092405050636;6094;6161.229846269216;6227.377262273771;6285.748570057203;6313.400226978441;6164.815055548341;6188.907166392508;6266.5300102492265;6292.748290068404;6354.0786585945125;5770.336411312711;5808.796692115766;5832.620879642831;5842.123681447774;5940;46.17871161394598;5679.119736440858;5733.082706766918;5798.188253644493;5837.270341207349;5726.971365143168;5731;5785.132230165466;5789.623674461168;5814.5057670098095;5710.486056254916;5713.6000479966415;5794.246747922785;5819.214406055171;5837.64974101551;5689.203511508392;5726;5775.220345253379;5791.218185544982;5804.796832110856;6123.234595675541;6214.098955651405;6219.626822390625;6323.778667746653;6325.936740632581;6550.70521826519;6596.967015164942;6627.966860165669;6628.138342015555;6650.201975762891;6676.232233293184;6689.8662026759675;6698.564593301468;6700.095487109226;6700.095487109226;6125.846853828601;6130.049842274455;6192.907106393408;6193.3496982816605;6211.3167551569295;6878.65606719662;6895.172579290417;6909.861802763917;6932.168139823253;6943.72225111;6558.409743123142;6572.441342485847;6621.404073633396;6647.969564717477;6669.599824010478;6691.966540167268;6704.497162712719;6757.594544327356;6772.55978361405;6785.525013249124;6557.2131344239;6614.305497922745;6621.768238111739;6631.038499417557;6643.368879956396;6200;6701.463882889358;6737.326267373322;6745.561538499982;6782.525223234326;5289.735513224324;5316.521513063765;5367.570594352443;5374.301340825746;5387.164989426645;4614.815407383734;4680.695754775928;4716.575508204278;4720.244760838318;4733.9053218936115;5749.080147176432;5791.507721843606;5814.069748840166;5863.413658634187;5867.882642347129;6733.595984240961;6746.156730408699;6755;6765.323467653196;6791.830204244933;5763.279590051244;5787.392323806024;5799.362070172362;5867.031939729982;5869.471747542656;5758.193852860602;5774.88450230993;5821.505172060338;5826.41735826414;5830.271216097988;6207.317195108534;6306.054091886162;6312.24253089623;6418.133551970518;6426.132472116298;6723.899141512979;6747;6789.355011273921;6793.354631310018;6798.8640227196165;6336;6343.5876668016435;6343.9365606343345;6421.839454013687;6445.484361251182;6441.71012304438;6530.8367290818105;6563.310852360433;6652.035454859115;6668.499862510234;6617.338266173537;6656.667166641745;6670.132882725215;6677.432418244503;6698.899516507354;6377.170967774346;6471.385218404244;6477.255115661759;6481.611103333815;6486;6452.193475815523;6459.224893012869;6476.6114033158165;6479.838004049937;6487;6481.513886458629;6494.512911531559;6505.51208659343;6516.804495865132;6521.9673901630185;6573.408393244631;6624.403803657694;6633.767818126343;6651.7006734698025;6652.467802575686;6320.4311611955145;6358.046293056079;6431.163948686641;6447.580907241015;6469.029645553204 08:46:50 INFO - PID 3597 | |1;ext.html;760.4790718357925;835.2065537739147;866.1079088538805;871.9433236839604;1096.950637221325;29123.854380728095;29719.108426747178;29723.851380743094;38460.423093653546;39183.80408097963;39372;39676.60323396765;39731.20537589247;39793.20413591734;39825.40261896074;7063.258357872426;7260.528065675714;7492.58790766509;7643.23567643234;7660.808479788022;7590.8481830363635;7714.074311082678;7723.53658780475;7731.304182623563;7744.380449564022;7649.158592554814;7717.614119294041;7723.420743444236;7725.266099720518;7768.262015108584;7667.961660191719;7701.9614901925415;7702.0757509098985;7710.190430004881;7720.729774457867;7611.695532178706;7637.274458926393;7638.1979892111085;7648.73229436967;7649.426293027989;35372.469412958824;35491;35623.10942226465;35654.10864728376;35694.10764730877;3484.337975784593;3513.1744040150543;3516.1385460562324;3527.805970671612;3532.6290739472242;28932.421351573063;29026.70973290261;29058.709412906024;29129.41741165186;29305.413891722044;5116.76974536143;5134.255532947702;5201.635885488017;5208.687478751249;5216.713080780555;186922;187528;188255;188850;189321.05339473352;43747.781261094126;43821.34267985983;43825.56174438215;43932.78033609811;43951.560484395384;45741.771291143334;45857;45961.540384595726;46004;46012.53987460083;14807.111573305636;14811.889108316704;14813.407463701331;14821.333040013225;15105.773413398807;11259.831102533304;11470.254433461798;11820;12337.69155771095;12354.814677779841;13234.470621175238;13288.534901278408;13331.40008699611;13358.666033349049;13568.118072325267;5648.85877853057;5656.575756818255;5689.573282003867;5719.971400143056;5816.709164541756;971.6162115964296;990.762217067913;1001.5993602558889;1008.863803386548;1017.9949100254452;22338.66492002621;22365.888170559043;22458.55082898333;22586.322410327717;22800.201992930168;1084.430673896195;1099.741560733227;1102.9724256893642;1103.2222283290262;1107.3909349857547;11781.882181178249;11805.468753906094;11861.406929653655;11877.703057423634;12019.819702704466;212702;213881;214953;215831;216237;49149.26276105861;49345;49459.50540494621;49489.75255123701;49623;1392.2133994293192;1412.8092707484564;1417.6030711400824;1421.2112277685983;1434.397553027731;21695;21854;22057.889710551346;22585.322440326818;22650.093996239964;45030.324545131196;46292.768536157106;47565;47673.52326476691;48025.27962080502;213575;213778;213794;214714;214901;28252.15243542615;28806.263404976493;31463.68536314699;32082.358352832347;32274;41022.38466423066;41215.79392103021;41371.58628413677;41386.172276554906;41431;29880.70119298866;30104.849475752482;30315.545266821457;30535.389292214477;31130;30212.546811798282;30224.94212702545;30378;30433.847830760704;31181.53227701632;33782.324353513286;33823.323533529685;33863.83068084644;34005.149871253416;34017.65982340244;29254;29472.263193420335;29766.851165744032;29990.25024374408;30034.84982575073;23614.527709446058;23860.164894229314;24190.75809241885;24461.742133919837;24613.87693061523 08:46:50 INFO - PID 3597 | |2;jquery.html;540.864783804049;556.919246709227;560.3471955172224;560.9635373700709;571.5484767034043;21211.257605983792;22003.779962200373;22014.11943522259;22093.668594971048;22742;24599.63100553493;25209.621855672132;25353.87323063382;25414.87292563539;25558.105466308683;6443.83890402739;6580.341965803405;6587.967060164692;6589.538732288742;6619.30497297784;5985.700714964256;6454.870902581945;6518.804435866931;6521.08704781331;6528.445082168021;6405.19935008124;6440.388163124519;6468.74125034998;6471.385218404244;6485.2217733872;6469.5794773339585;6476.9313063344725;6477.708503117371;6509.056186852904;6517.51118666102;5897.203877476529;5957.761689532414;5961.672108034099;6019.939800601982;6032.758689652409;28264.858675706695;29079.709202908125;30259.697403025908;31361.372772544422;31507.84246078778;1984.196400457817;2024.6355655981918;2025.8075482829108;2026.311054241565;2033.278186243877;19789.10949007298;20381;20640.793592064187;20650.690239646417;20713.27503537369;2508.498300339921;2559.6160575913764;2579.1488808693084;2582.3544113971507;2599.7920166386643;133580;139862;140088;140176.29911850375;140201.29899350437;20890.1643934244;21197.364079077342;21282.467938301666;21676.674849877265;21993.560128797333;42905.78547107307;42948.3557746634;42990.78504607457;43056.78471607684;43062.569374306484;11312.660620181408;11342;11570.247933884271;11595.18833681651;11700.2979821211;8642.30861531076;9062.456252624863;9435.688256377094;9563.61745530185;9576.281778866474;10455.33388985819;11155.27490713101;11188;11305.438786782137;11771.529138834521;3564.322778672044;3582.8387722552025;3607.206414588786;3834.6416953573353;4308.202982448257;903.6024149374255;933.5472295936465;952.3761935931975;959.1799011844772;967.7725734452398;19853.801461985484;19948.90025549863;20132.39602811918;20226.595468090556;20483.487912802;1024.3904876598413;1026.1380440430075;1035.8394448860438;1047.0471870597719;1051.6109039655375;11105.777884442266;11147.108231341474;11160.386178760084;11296.887031129749;11331.093512518979;493704;508052;513165;573745;580050;120223;124505;124657.37671311585;130208;130219;1172.4841069929205;1224.3327386574338;1230.6615680687883;1235.3823088455772;1238.9442475088642;20925.79074209299;21476.78523214748;22556.548869022856;22771.772282276965;22812.087516499156;55905;56113.71943140421;56583.43416565782;57455;58137.70931145486;64542;65292.67353663201;66281.66859165674;67702.32297677157;68031.65984170047;12201.267923924594;14512.201828899511;14514.419423222953;14592.927035364755;14631.487897923522;23339.883300584068;23345.41636459102;23654.52690946206;24040;24047;18488.16803243884;19163.233470661016;19480.415587532396;19482.4155275342;19638.90180549088;16773.161341933097;17125.314987400863;17161.31354745796;17580;17661.116944152483;18751.812481875008;19012.904935475235;19070.33253836109;19104.8089519103;19160.712589310893;14245.074070185405;14628.634284142981;14646.048006879519;14662.046966947115;14737.705245895237;18662.973536455625;18806.6238675223;19001.80998190056;19071.52321191981;19198.904005479882 08:46:50 INFO - PID 3597 | |3;mootools.html;1287.1183239480956;1342.0940864916179;1343.5633419138776;1356.1591813075895;1362.7547041532525;13839.446422143103;13942.093763905339;14516.637084072903;14733.263336833143;14742.705145897102;14900.105993640389;15003;15065.472708455207;15082.622934426645;15109.622259443491;2571.1643715792347;2627.238100950722;2629.5529759940855;2643.973560264392;2644.907428240012;2615.620734993425;2616.82990605611;2621.1612284069106;2703.864806759664;2716.1036857836866;2622.8819703113404;2624.7900167986513;2657.787377009844;2660.1088635307196;2661.0154242930143;2635.235781623327;2640.3927096767757;2648.1128821844704;2658.1626787561854;2660.401409682825;2521.2688320387065;2528.329992551975;2542.745725427461;2550.1202085280547;2560.526302634;14278.571642850731;14434.133951962916;14449.422023119168;14452.49416270436;14453.927730361385;7616.543007419517;7914.683412663487;7940.967674202375;7942.761717148494;7969.123396426388;5111.2333150027425;5266.815661451831;5338.27933229013;5419.972900135514;5427.538659213932;1819.7270409438559;1852.2961274715656;1853.2123847364817;1892.5741708115702;1902.73361729358;23970.400739981465;24203.273901782974;24220.273391798273;24232.63651045218;24234.757652423603;6542.509311801538;6554.115194448784;6558.1802274715665;6667.999800030035;6688.163979502562;16058.197090145446;16154.596135096717;16160;16191;16206.675866482605;7413;7460.3658689012045;7497.587632680255;7497.625118744041;7548.773536793905;6878.3465570770695;6956.965215173993;7074.540154889915;7089.361957423856;7096.822579435556;4746.430428348551;4930.901381972412;5184.7407629618365;5187.377514698261;5211.400688920747;1356.504875720355;1507.0806807847205;1534.6086747879442;1551.6431220819275;1561.4222737587165;860.7331727164474;861.6854847980442;872.1801506583791;872.8690696395591;876.3996662286354;8021.2379823916635;8437.282830959437;8461.619227134794;8467.872981905277;8473.533955632376;963.816874793787;979.6669132494986;980.6420656460341;984.8424252119627;994.8706668133241;4596.5863072323655;4662.347271382009;4954.5540901319055;5355.4376790436445;5524.66851988882;19900.70148947767;20335.389938301876;20625.793742062688;20654;20659.58680826405;19648.21407143698;20108.195672172948;20155.798442015686;20190.293339733038;20845.1661933524;10967.670969870916;11330.94334528322;11337.866213378597;11338.716532086599;11361.091112710963;8439.95780021096;8618.138186181332;8686.956565217133;8695.521746304014;8850.424722393023;17365;17668.38160664422;17695.734563981292;17785.110744462465;17811.821881781016;17643;17661.911690441466;17929.641407172043;17948.37180698669;17999.10004499796;11693.298402095561;11826.290422574673;12149.514019439124;12191.146619736533;12200.51197952072;12146.878531214576;13615.931920340336;13690.794638080237;13743.656408589864;13776.655583610089;10943.671689849318;11127.666170014912;11136.38749868765;11308.151888608223;11470.942645287054;10717.35695858251;10869.130469562258;10915.78168436611;10967.451627418757;11202.047825934887;9161.86257206129;9227.031161727922;9259.35184537076;9271.165595096474;9282.257419406566;7532.531156424664;7579.090509138939;7587.658555364911;7591.544507329578;7691.38468922496;7399.482036257626;7473;7504.287092726182;7521;7597.278258565428 08:46:50 INFO - PID 3597 | |4;prototype.html;490.52524300049055;491.4320745948404;516.7080599461304;518.8313798015646;525.955293800027;6225.225810643968;6235.728525959709;6291;6368.140301059356;6368.395002474764;6224.23021755319;6227.346128656493;6277.2153480814895;6309.242890853093;6320.620762754238;5069.645124841262;5070.3915530136255;5100.719460429675;5154.433012368637;5157.355330583677;5054.747262636872;5079.619028572872;5083.957788653317;5109.41241757199;5119.846404607849;4840.322354870321;5040.722760248185;5043.344365232515;5076.36545431821;5078.111330517163;4946.431160416562;5020.246962955549;5037.546620804145;5095.006473737622;5100.183970564711;4480.955190448087;4484.327350897359;4516.4806047304655;4541.84103556374;4549.385832912548;6228.128062071313;6248.812535623939;6255.218097737783;6268.780592679234;6286.622802631811;5698.202251684767;5732.656040637534;5792.2912740741585;5802.941970580282;5814.982378083819;6518.674066296714;6621.271660117383;6621.86756264872;6690.130283063219;6691.364320389555;4871.780769865364;4884.5603895649565;4900.240462728283;4910.975445122787;4914.950850491485;6940.6529673516125;7019.719211231544;7022.754203602901;7076.363127318515;7097.325754053357;5034.672746271481;5040.873978150502;5047.141985862412;5103.795848166106;5104.3619547556555;5070;5122.1804511278015;5130.666506677054;5140.897182056338;5168.147255702842;5714.5999780015;5770.653760774367;5801.01382764931;5803.6807975560905;5813.476787089182;6614.980367865316;6716.597004179765;6739.427148692318;6746.4265537429865;6754.155730533684;1679.6220850308582;1722.457425910834;1758.156085079169;1770.876038677306;1902.4673091534391;1423;1450.2313773699957;1458;1470.3750905864965;1474.609228554434;5815.505682017076;5857.589968702235;5864.3378514081405;5886.411358864079;5910.8817823643285;6574.80275591733;6777.559458635173;6859.5541289816;6889.276625954303;6889.896651550231;5889.94110058894;5895.498882594941;5901.439363260483;5902.291724993029;5918.3489816121055;3586.1931065510053;3608.566971963329;3643.198496330803;3646.5259516262718;3661.1945372018113;6509.218893732783;6511.316311787289;6517.4134327910715;6529.934700653028;6566.113574667359;7012.685813681473;7024.894626580605;7038.859222815515;7041.155061392666;7053.858922821618;6478.708458119396;6484.902726459012;6501.122348482989;6501.934980650133;6517.4134327910715;6686.431653309523;6813.761518346834;6848.828779280558;6866.828329291608;6905.93094069073;6733.966330168514;6776.424003959719;6777.559458635173;6814.795556133324;6815.87538056235;6342.778002769881;6348.5238607105575;6364.268109167319;6459.709313080829;6488.12410324619;4991.301217829579;5022.271770593316;5026.874328141826;5038.647294689336;5046.444891062054;6788.2193547742645;6867.622280774605;6874.415674667709;6894.310568943066;6947.444204463732;6338.778142764981;6511.609303441809;6530.444912182327;6648.202215734143;6670.433013193933;6614.272430032596;6639.634820084942;6644.57473022353;6660.367265109807;6689.297623749436;6597.703103360456;6599.8020059398295;6612.537122401386;6618.172728408949;6637.933620663732;6535.705893234721;6655.467562594884;6684.398404143651;6688.598684078971;6696.330366963265;6434.163558737334;6497.837554061186;6517.608943463408;6530.67346632676;6536.346365363425 08:46:50 INFO - PID 3597 | |5;yui.html;862.068965517241;892.4600616626941;899.6986009686755;901.69342423576;901.8782464367308;17583.64832703345;18634.34779782708;18666.533336666573;18670.626587468243;18689;19976.700349494768;20580.691289630668;20625.896870515662;20657.27699530517;20696.793032069676;924.3899026642417;930.2650905784456;936.5738588942049;937.7374335186158;937.7468083617454;898.5282726568538;920.5535315372073;933.0809152984305;934.7336009237368;937.0722984245616;993.4238141877694;1002.8395456726926;1002.9949850250739;1003.3628645809927;1008.9949550252238;980.7940332530177;985.9852102218473;988.9604415823359;989.2827699917539;994.383482241008;721.1634503975416;727.134709695466;730.7771129805408;732.9596872172028;734.3501001613557;18744.437666870017;19178.90410547938;19339.903300483547;19358;19404.902975485173;19622.607547849108;19673.704894426595;20080.69878951817;20081.09635066411;20096.196152153898;15955.282012309473;15983.280752366172;16045.598860028476;16163.676726465523;16199.595010124724;3681.815909204529;3723;3725.1990821973136;3725.497057897176;3727.310447567209;118697.40651296689;121946;123811;124177;124767;16088.356465741239;16184.919075404783;16421.096839673934;16430;16539.751903721455;28589.857050714614;29193;29373.85313073421;29406.852965735463;29428;7933.642986065641;8124.715634952749;8255.669773209125;8266.462679925786;8294.129116442808;3943.585923478051;4119.237940980928;4239.51245606753;4267.5732426757695;4417.491988421309;4647.883802904887;4751.097291514601;4758.620000199972;4759.904801903943;4776.761161941889;956.0773853231665;981.5435822342645;992.0179022767409;993.6571882700457;993.6621548673486;676.7394553097093;688.404530081476;688.8071340024801;700.2647220418642;702.2766550453042;11678.76642467146;11911.523539058513;11977.940110299392;11992.820107698391;14016.649583760487;704.3766266853871;712.8075419636773;714.5069901767764;716.4197000429668;726.5459088069956;5365.222042803772;5578;5591.10542313228;5975.492083172979;6072.392760723892;107285.46357268319;107552;107606.46196769123;107698.46150769196;110961.44519277514;95676.9999999986;97407.51296243473;98607.50696246473;101996.49001754944;105286.4735676332;85416;87633.56183219043;90592.54703726439;92046.53976730208;93618;11634.476448559666;11682.415879206175;11783.469743861719;11923.10576706733;12096.334701591497;39407;39501.40747888727;39714.60285397109;39741.205175896896;40579.391309129795;47587.28619070647;50752.746236268584;51314.48685513246;68634;71359.64320178366;15367;15428;15594.610134746268;15663.921680391524;15709.293081811118;18904;18905.149268282687;18944.52638684044;18982.905085474486;19022.7146592804;17963.910180449013;18407.81592184061;18537;18636.16137273853;18741.15664795115;18049.819501804814;18122.003289819186;18359.265629374677;18474.63050738951;18531.536711582317;17469.82530174682;17477.825221748128;17524.299028038735;17603.647927041133;17770.111494424968;12493.18794278369;12630.179038362478;12680.6829829255;12681.93659031699;12784.61646150617;12992.545260915822;13573.04988650785;13578.981576381613;13590.851890354186;14125.788113178516 08:46:50 INFO - PID 3597 | __end_tp_report 08:46:50 INFO - PID 3597 | __start_cc_report 08:46:50 INFO - PID 3597 | _x_x_mozilla_cycle_collect,371 08:46:50 INFO - PID 3597 | __end_cc_report 08:46:50 INFO - PID 3597 | __startTimestamp1503503210396__endTimestamp 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | ------- Summary: start ------- 08:46:50 INFO - PID 3597 | Number of tests: 6 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#0] dojo.html Cycles:165 Average:6125.94 Median:6354.08 stddev:848.22 (13.3%) stddev-sans-first:820.33 08:46:50 INFO - PID 3597 | Values: 3253.1 3268.7 3273.6 3286.4 3299.1 6094.0 6161.2 6227.4 6285.7 6313.4 6164.8 6188.9 6266.5 6292.7 6354.1 5770.3 5808.8 5832.6 5842.1 5940.0 46.2 5679.1 5733.1 5798.2 5837.3 5727.0 5731.0 5785.1 5789.6 5814.5 5710.5 5713.6 5794.2 5819.2 5837.6 5689.2 5726.0 5775.2 5791.2 5804.8 6123.2 6214.1 6219.6 6323.8 6325.9 6550.7 6597.0 6628.0 6628.1 6650.2 6676.2 6689.9 6698.6 6700.1 6700.1 6125.8 6130.0 6192.9 6193.3 6211.3 6878.7 6895.2 6909.9 6932.2 6943.7 6558.4 6572.4 6621.4 6648.0 6669.6 6692.0 6704.5 6757.6 6772.6 6785.5 6557.2 6614.3 6621.8 6631.0 6643.4 6200.0 6701.5 6737.3 6745.6 6782.5 5289.7 5316.5 5367.6 5374.3 5387.2 4614.8 4680.7 4716.6 4720.2 4733.9 5749.1 5791.5 5814.1 5863.4 5867.9 6733.6 6746.2 6755.0 6765.3 6791.8 5763.3 5787.4 5799.4 5867.0 5869.5 5758.2 5774.9 5821.5 5826.4 5830.3 6207.3 6306.1 6312.2 6418.1 6426.1 6723.9 6747.0 6789.4 6793.4 6798.9 6336.0 6343.6 6343.9 6421.8 6445.5 6441.7 6530.8 6563.3 6652.0 6668.5 6617.3 6656.7 6670.1 6677.4 6698.9 6377.2 6471.4 6477.3 6481.6 6486.0 6452.2 6459.2 6476.6 6479.8 6487.0 6481.5 6494.5 6505.5 6516.8 6522.0 6573.4 6624.4 6633.8 6651.7 6652.5 6320.4 6358.0 6431.2 6447.6 6469.0 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#1] ext.html Cycles:180 Average:36522.79 Median:32178.18 stddev:53378.51 (165.9%) stddev-sans-first:53460.71 08:46:50 INFO - PID 3597 | Values: 760.5 835.2 866.1 871.9 1097.0 29123.9 29719.1 29723.9 38460.4 39183.8 39372.0 39676.6 39731.2 39793.2 39825.4 7063.3 7260.5 7492.6 7643.2 7660.8 7590.8 7714.1 7723.5 7731.3 7744.4 7649.2 7717.6 7723.4 7725.3 7768.3 7668.0 7702.0 7702.1 7710.2 7720.7 7611.7 7637.3 7638.2 7648.7 7649.4 35372.5 35491.0 35623.1 35654.1 35694.1 3484.3 3513.2 3516.1 3527.8 3532.6 28932.4 29026.7 29058.7 29129.4 29305.4 5116.8 5134.3 5201.6 5208.7 5216.7 186922.0 187528.0 188255.0 188850.0 189321.1 43747.8 43821.3 43825.6 43932.8 43951.6 45741.8 45857.0 45961.5 46004.0 46012.5 14807.1 14811.9 14813.4 14821.3 15105.8 11259.8 11470.3 11820.0 12337.7 12354.8 13234.5 13288.5 13331.4 13358.7 13568.1 5648.9 5656.6 5689.6 5720.0 5816.7 971.6 990.8 1001.6 1008.9 1018.0 22338.7 22365.9 22458.6 22586.3 22800.2 1084.4 1099.7 1103.0 1103.2 1107.4 11781.9 11805.5 11861.4 11877.7 12019.8 212702.0 213881.0 214953.0 215831.0 216237.0 49149.3 49345.0 49459.5 49489.8 49623.0 1392.2 1412.8 1417.6 1421.2 1434.4 21695.0 21854.0 22057.9 22585.3 22650.1 45030.3 46292.8 47565.0 47673.5 48025.3 213575.0 213778.0 213794.0 214714.0 214901.0 28252.2 28806.3 31463.7 32082.4 32274.0 41022.4 41215.8 41371.6 41386.2 41431.0 29880.7 30104.8 30315.5 30535.4 31130.0 30212.5 30224.9 30378.0 30433.8 31181.5 33782.3 33823.3 33863.8 34005.1 34017.7 29254.0 29472.3 29766.9 29990.3 30034.8 23614.5 23860.2 24190.8 24461.7 24613.9 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#2] jquery.html Cycles:180 Average:37224.84 Median:22325.11 stddev:89658.18 (401.6%) stddev-sans-first:89867.39 08:46:50 INFO - PID 3597 | Values: 540.9 556.9 560.3 561.0 571.5 21211.3 22003.8 22014.1 22093.7 22742.0 24599.6 25209.6 25353.9 25414.9 25558.1 6443.8 6580.3 6588.0 6589.5 6619.3 5985.7 6454.9 6518.8 6521.1 6528.4 6405.2 6440.4 6468.7 6471.4 6485.2 6469.6 6476.9 6477.7 6509.1 6517.5 5897.2 5957.8 5961.7 6019.9 6032.8 28264.9 29079.7 30259.7 31361.4 31507.8 1984.2 2024.6 2025.8 2026.3 2033.3 19789.1 20381.0 20640.8 20650.7 20713.3 2508.5 2559.6 2579.1 2582.4 2599.8 133580.0 139862.0 140088.0 140176.3 140201.3 20890.2 21197.4 21282.5 21676.7 21993.6 42905.8 42948.4 42990.8 43056.8 43062.6 11312.7 11342.0 11570.2 11595.2 11700.3 8642.3 9062.5 9435.7 9563.6 9576.3 10455.3 11155.3 11188.0 11305.4 11771.5 3564.3 3582.8 3607.2 3834.6 4308.2 903.6 933.5 952.4 959.2 967.8 19853.8 19948.9 20132.4 20226.6 20483.5 1024.4 1026.1 1035.8 1047.0 1051.6 11105.8 11147.1 11160.4 11296.9 11331.1 493704.0 508052.0 513165.0 573745.0 580050.0 120223.0 124505.0 124657.4 130208.0 130219.0 1172.5 1224.3 1230.7 1235.4 1238.9 20925.8 21476.8 22556.5 22771.8 22812.1 55905.0 56113.7 56583.4 57455.0 58137.7 64542.0 65292.7 66281.7 67702.3 68031.7 12201.3 14512.2 14514.4 14592.9 14631.5 23339.9 23345.4 23654.5 24040.0 24047.0 18488.2 19163.2 19480.4 19482.4 19638.9 16773.2 17125.3 17161.3 17580.0 17661.1 18751.8 19012.9 19070.3 19104.8 19160.7 14245.1 14628.6 14646.0 14662.0 14737.7 18663.0 18806.6 19001.8 19071.5 19198.9 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#3] mootools.html Cycles:180 Average:9012.71 Median:2593.39 stddev:6233.18 (240.3%) stddev-sans-first:6223.64 08:46:50 INFO - PID 3597 | Values: 1287.1 1342.1 1343.6 1356.2 1362.8 13839.4 13942.1 14516.6 14733.3 14742.7 14900.1 15003.0 15065.5 15082.6 15109.6 2571.2 2627.2 2629.6 2644.0 2644.9 2615.6 2616.8 2621.2 2703.9 2716.1 2622.9 2624.8 2657.8 2660.1 2661.0 2635.2 2640.4 2648.1 2658.2 2660.4 2521.3 2528.3 2542.7 2550.1 2560.5 14278.6 14434.1 14449.4 14452.5 14453.9 7616.5 7914.7 7941.0 7942.8 7969.1 5111.2 5266.8 5338.3 5420.0 5427.5 1819.7 1852.3 1853.2 1892.6 1902.7 23970.4 24203.3 24220.3 24232.6 24234.8 6542.5 6554.1 6558.2 6668.0 6688.2 16058.2 16154.6 16160.0 16191.0 16206.7 7413.0 7460.4 7497.6 7497.6 7548.8 6878.3 6957.0 7074.5 7089.4 7096.8 4746.4 4930.9 5184.7 5187.4 5211.4 1356.5 1507.1 1534.6 1551.6 1561.4 860.7 861.7 872.2 872.9 876.4 8021.2 8437.3 8461.6 8467.9 8473.5 963.8 979.7 980.6 984.8 994.9 4596.6 4662.3 4954.6 5355.4 5524.7 19900.7 20335.4 20625.8 20654.0 20659.6 19648.2 20108.2 20155.8 20190.3 20845.2 10967.7 11330.9 11337.9 11338.7 11361.1 8440.0 8618.1 8687.0 8695.5 8850.4 17365.0 17668.4 17695.7 17785.1 17811.8 17643.0 17661.9 17929.6 17948.4 17999.1 11693.3 11826.3 12149.5 12191.1 12200.5 12146.9 13615.9 13690.8 13743.7 13776.7 10943.7 11127.7 11136.4 11308.2 11470.9 10717.4 10869.1 10915.8 10967.5 11202.0 9161.9 9227.0 9259.4 9271.2 9282.3 7532.5 7579.1 7587.7 7591.5 7691.4 7399.5 7473.0 7504.3 7521.0 7597.3 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#4] prototype.html Cycles:180 Average:5596.12 Median:6252.02 stddev:1555.63 (24.9%) stddev-sans-first:1512.06 08:46:50 INFO - PID 3597 | Values: 490.5 491.4 516.7 518.8 526.0 6225.2 6235.7 6291.0 6368.1 6368.4 6224.2 6227.3 6277.2 6309.2 6320.6 5069.6 5070.4 5100.7 5154.4 5157.4 5054.7 5079.6 5084.0 5109.4 5119.8 4840.3 5040.7 5043.3 5076.4 5078.1 4946.4 5020.2 5037.5 5095.0 5100.2 4481.0 4484.3 4516.5 4541.8 4549.4 6228.1 6248.8 6255.2 6268.8 6286.6 5698.2 5732.7 5792.3 5802.9 5815.0 6518.7 6621.3 6621.9 6690.1 6691.4 4871.8 4884.6 4900.2 4911.0 4915.0 6940.7 7019.7 7022.8 7076.4 7097.3 5034.7 5040.9 5047.1 5103.8 5104.4 5070.0 5122.2 5130.7 5140.9 5168.1 5714.6 5770.7 5801.0 5803.7 5813.5 6615.0 6716.6 6739.4 6746.4 6754.2 1679.6 1722.5 1758.2 1770.9 1902.5 1423.0 1450.2 1458.0 1470.4 1474.6 5815.5 5857.6 5864.3 5886.4 5910.9 6574.8 6777.6 6859.6 6889.3 6889.9 5889.9 5895.5 5901.4 5902.3 5918.3 3586.2 3608.6 3643.2 3646.5 3661.2 6509.2 6511.3 6517.4 6529.9 6566.1 7012.7 7024.9 7038.9 7041.2 7053.9 6478.7 6484.9 6501.1 6501.9 6517.4 6686.4 6813.8 6848.8 6866.8 6905.9 6734.0 6776.4 6777.6 6814.8 6815.9 6342.8 6348.5 6364.3 6459.7 6488.1 4991.3 5022.3 5026.9 5038.6 5046.4 6788.2 6867.6 6874.4 6894.3 6947.4 6338.8 6511.6 6530.4 6648.2 6670.4 6614.3 6639.6 6644.6 6660.4 6689.3 6597.7 6599.8 6612.5 6618.2 6637.9 6535.7 6655.5 6684.4 6688.6 6696.3 6434.2 6497.8 6517.6 6530.7 6536.3 08:46:50 INFO - PID 3597 | 08:46:50 INFO - PID 3597 | [#5] yui.html Cycles:180 Average:23098.76 Median:24643.33 stddev:31685.16 (128.6%) stddev-sans-first:31730.05 08:46:50 INFO - PID 3597 | Values: 862.1 892.5 899.7 901.7 901.9 17583.6 18634.3 18666.5 18670.6 18689.0 19976.7 20580.7 20625.9 20657.3 20696.8 924.4 930.3 936.6 937.7 937.7 898.5 920.6 933.1 934.7 937.1 993.4 1002.8 1003.0 1003.4 1009.0 980.8 986.0 989.0 989.3 994.4 721.2 727.1 730.8 733.0 734.4 18744.4 19178.9 19339.9 19358.0 19404.9 19622.6 19673.7 20080.7 20081.1 20096.2 15955.3 15983.3 16045.6 16163.7 16199.6 3681.8 3723.0 3725.2 3725.5 3727.3 118697.4 121946.0 123811.0 124177.0 124767.0 16088.4 16184.9 16421.1 16430.0 16539.8 28589.9 29193.0 29373.9 29406.9 29428.0 7933.6 8124.7 8255.7 8266.5 8294.1 3943.6 4119.2 4239.5 4267.6 4417.5 4647.9 4751.1 4758.6 4759.9 4776.8 956.1 981.5 992.0 993.7 993.7 676.7 688.4 688.8 700.3 702.3 11678.8 11911.5 11977.9 11992.8 14016.6 704.4 712.8 714.5 716.4 726.5 5365.2 5578.0 5591.1 5975.5 6072.4 107285.5 107552.0 107606.5 107698.5 110961.4 95677.0 97407.5 98607.5 101996.5 105286.5 85416.0 87633.6 90592.5 92046.5 93618.0 11634.5 11682.4 11783.5 11923.1 12096.3 39407.0 39501.4 39714.6 39741.2 40579.4 47587.3 50752.7 51314.5 68634.0 71359.6 15367.0 15428.0 15594.6 15663.9 15709.3 18904.0 18905.1 18944.5 18982.9 19022.7 17963.9 18407.8 18537.0 18636.2 18741.2 18049.8 18122.0 18359.3 18474.6 18531.5 17469.8 17477.8 17524.3 17603.6 17770.1 12493.2 12630.2 12680.7 12681.9 12784.6 12992.5 13573.0 13579.0 13590.9 14125.8 08:46:50 INFO - PID 3597 | -------- Summary: end -------- 08:46:50 INFO - PID 3597 | 08:46:51 INFO - TEST-INFO | 3597: exit 0 08:46:51 INFO - TEST-OK | dromaeo_css | took 1113542ms 08:46:51 INFO - TEST-START | kraken 08:46:51 INFO - Initialising browser for kraken test... 08:46:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33865/getInfo.html -profile /tmp/tmpQ6XceF/profile 08:46:51 INFO - TEST-INFO | started process 4017 (/builds/slave/test/build/application/firefox/firefox http://localhost:33865/getInfo.html) 08:46:56 INFO - TEST-INFO | 4017: exit 0 08:46:57 INFO - Browser initialized. 08:46:57 INFO - Running cycle 1/1 for kraken test... 08:46:57 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6XceF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:58 INFO - PID 4203 | 08:46:58 INFO - PID 4203 | (/builds/slave/test/build/application/firefox/firefox:4252): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:46:58 INFO - PID 4203 | 08:46:58 INFO - PID 4203 | 08:46:58 INFO - PID 4203 | (/builds/slave/test/build/application/firefox/firefox:4311): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:46:58 INFO - PID 4203 | 08:46:58 INFO - PID 4203 | __metrics Screen width/height:1600/1200 08:46:58 INFO - PID 4203 | colorDepth:24 08:46:58 INFO - PID 4203 | Browser inner width/height: 1024/768 08:46:58 INFO - PID 4203 | __metrics 08:47:08 INFO - PID 4203 | RSS: Main: 174698496 08:47:08 INFO - PID 4203 | 08:47:11 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33865/tests/kraken/driver.html?testName=audio-beat-detection) 08:47:11 INFO - PID 4203 | RSS: Main: 178794496 08:47:11 INFO - PID 4203 | 08:47:14 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33865/tests/kraken/driver.html?testName=audio-dft) 08:47:15 INFO - PID 4203 | RSS: Main: 180797440 08:47:15 INFO - PID 4203 | 08:47:18 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33865/tests/kraken/driver.html?testName=audio-fft) 08:47:18 INFO - PID 4203 | RSS: Main: 173510656 08:47:18 INFO - PID 4203 | 08:47:21 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33865/tests/kraken/driver.html?testName=audio-oscillator) 08:47:21 INFO - PID 4203 | RSS: Main: 174505984 08:47:21 INFO - PID 4203 | 08:47:24 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:47:24 INFO - PID 4203 | RSS: Main: 175087616 08:47:24 INFO - PID 4203 | 08:47:27 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33865/tests/kraken/driver.html?testName=imaging-darkroom) 08:47:28 INFO - PID 4203 | RSS: Main: 176271360 08:47:28 INFO - PID 4203 | 08:47:32 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33865/tests/kraken/driver.html?testName=imaging-desaturate) 08:47:32 INFO - PID 4203 | RSS: Main: 176541696 08:47:32 INFO - PID 4203 | 08:47:35 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33865/tests/kraken/driver.html?testName=json-parse-financial) 08:47:36 INFO - PID 4203 | RSS: Main: 176513024 08:47:36 INFO - PID 4203 | 08:47:37 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:47:38 INFO - PID 4203 | RSS: Main: 176553984 08:47:38 INFO - PID 4203 | 08:47:40 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:47:40 INFO - PID 4203 | RSS: Main: 176840704 08:47:40 INFO - PID 4203 | 08:47:43 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:43 INFO - PID 4203 | RSS: Main: 176795648 08:47:43 INFO - PID 4203 | 08:47:46 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:47 INFO - PID 4203 | RSS: Main: 176922624 08:47:47 INFO - PID 4203 | 08:47:50 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:50 INFO - PID 4203 | RSS: Main: 176820224 08:47:50 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:33865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33865/tests/kraken/driver.html?testName=ai-astar) 08:47:52 INFO - PID 4203 | RSS: Main: 178290688 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | __start_tp_report 08:47:52 INFO - PID 4203 | _x_x_mozilla_page_load 08:47:52 INFO - PID 4203 | _x_x_mozilla_page_load_details 08:47:52 INFO - PID 4203 | |i|pagename|runs| 08:47:52 INFO - PID 4203 | |0;ai-astar;97;107;100;120;108;115;109;106;109;107 08:47:52 INFO - PID 4203 | |1;audio-beat-detection;147;117;139;192;118;141;149;122;173;122 08:47:52 INFO - PID 4203 | |2;audio-dft;177;166;165;164;162;163;163;164;170;162 08:47:52 INFO - PID 4203 | |3;audio-fft;75;74;74;166;74;74;79;76;158;78 08:47:52 INFO - PID 4203 | |4;audio-oscillator;79;82;140;83;79;85;124;87;79;141 08:47:52 INFO - PID 4203 | |5;imaging-gaussian-blur;117;117;123;114;114;117;118;117;115;115 08:47:52 INFO - PID 4203 | |6;imaging-darkroom;151;150;150;151;151;149;148;148;150;150 08:47:52 INFO - PID 4203 | |7;imaging-desaturate;93;97;96;93;94;95;93;98;94;93 08:47:52 INFO - PID 4203 | |8;json-parse-financial;53;53;53;53;52;53;54;52;55;53 08:47:52 INFO - PID 4203 | |9;json-stringify-tinderbox;56;64;56;56;56;56;57;56;57;57 08:47:52 INFO - PID 4203 | |10;stanford-crypto-aes;76;76;77;76;74;81;75;82;73;74 08:47:52 INFO - PID 4203 | |11;stanford-crypto-ccm;121;125;120;124;126;118;117;128;121;159 08:47:52 INFO - PID 4203 | |12;stanford-crypto-pbkdf2;171;182;169;170;183;173;167;173;173;174 08:47:52 INFO - PID 4203 | |13;stanford-crypto-sha256-iterative;70;69;66;65;65;70;69;66;66;66 08:47:52 INFO - PID 4203 | __end_tp_report 08:47:52 INFO - PID 4203 | __start_cc_report 08:47:52 INFO - PID 4203 | _x_x_mozilla_cycle_collect,913 08:47:52 INFO - PID 4203 | __end_cc_report 08:47:52 INFO - PID 4203 | __startTimestamp1503503272921__endTimestamp 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | ------- Summary: start ------- 08:47:52 INFO - PID 4203 | Number of tests: 14 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:6.55 (6.0%) stddev-sans-first:5.66 08:47:52 INFO - PID 4203 | Values: 97.0 107.0 100.0 120.0 108.0 115.0 109.0 106.0 109.0 107.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:144.00 stddev:24.82 (17.2%) stddev-sans-first:26.26 08:47:52 INFO - PID 4203 | Values: 147.0 117.0 139.0 192.0 118.0 141.0 149.0 122.0 173.0 122.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:4.65 (2.8%) stddev-sans-first:2.50 08:47:52 INFO - PID 4203 | Values: 177.0 166.0 165.0 164.0 162.0 163.0 163.0 164.0 170.0 162.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:36.56 (49.1%) stddev-sans-first:38.21 08:47:52 INFO - PID 4203 | Values: 75.0 74.0 74.0 166.0 74.0 74.0 79.0 76.0 158.0 78.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:80.50 stddev:26.13 (32.5%) stddev-sans-first:26.80 08:47:52 INFO - PID 4203 | Values: 79.0 82.0 140.0 83.0 79.0 85.0 124.0 87.0 79.0 141.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:2.63 (2.2%) stddev-sans-first:2.78 08:47:52 INFO - PID 4203 | Values: 117.0 117.0 123.0 114.0 114.0 117.0 118.0 117.0 115.0 115.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 08:47:52 INFO - PID 4203 | Values: 151.0 150.0 150.0 151.0 151.0 149.0 148.0 148.0 150.0 150.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:1.84 (1.9%) stddev-sans-first:1.86 08:47:52 INFO - PID 4203 | Values: 93.0 97.0 96.0 93.0 94.0 95.0 93.0 98.0 94.0 93.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 08:47:52 INFO - PID 4203 | Values: 53.0 53.0 53.0 53.0 52.0 53.0 54.0 52.0 55.0 53.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:56.50 stddev:2.47 (4.4%) stddev-sans-first:2.59 08:47:52 INFO - PID 4203 | Values: 56.0 64.0 56.0 56.0 56.0 56.0 57.0 56.0 57.0 57.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.95 (3.9%) stddev-sans-first:3.13 08:47:52 INFO - PID 4203 | Values: 76.0 76.0 77.0 76.0 74.0 81.0 75.0 82.0 73.0 74.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.50 stddev:12.15 (9.8%) stddev-sans-first:12.76 08:47:52 INFO - PID 4203 | Values: 121.0 125.0 120.0 124.0 126.0 118.0 117.0 128.0 121.0 159.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:173.00 stddev:5.21 (3.0%) stddev-sans-first:5.45 08:47:52 INFO - PID 4203 | Values: 171.0 182.0 169.0 170.0 183.0 173.0 167.0 173.0 173.0 174.0 08:47:52 INFO - PID 4203 | 08:47:52 INFO - PID 4203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.04 (3.0%) stddev-sans-first:1.90 08:47:52 INFO - PID 4203 | Values: 70.0 69.0 66.0 65.0 65.0 70.0 69.0 66.0 66.0 66.0 08:47:52 INFO - PID 4203 | -------- Summary: end -------- 08:47:52 INFO - PID 4203 | 08:47:53 INFO - PID 4203 | 08:47:53 INFO - PID 4203 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:47:53 INFO - PID 4203 | 08:47:53 INFO - PID 4203 | 08:47:53 INFO - PID 4203 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:47:53 INFO - PID 4203 | 08:47:53 INFO - PID 4203 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:47:53 INFO - TEST-INFO | 4203: exit 0 08:47:53 INFO - TEST-OK | kraken | took 62542ms 08:47:53 INFO - SUITE-END | took 1176s 08:47:54 INFO - Completed test suite (00:19:36) 08:47:54 INFO - javascript benchmark 08:47:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8507.132841268223, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.1216571525674, 3268.7221586165174, 3273.5744353234077, 3286.408446479634, 3299.1092405050636, 6094.0, 6161.229846269216, 6227.377262273771, 6285.748570057203, 6313.400226978441, 6164.815055548341, 6188.907166392508, 6266.5300102492265, 6292.748290068404, 6354.0786585945125, 5770.336411312711, 5808.796692115766, 5832.620879642831, 5842.123681447774, 5940.0, 46.17871161394598, 5679.119736440858, 5733.082706766918, 5798.188253644493, 5837.270341207349, 5726.971365143168, 5731.0, 5785.132230165466, 5789.623674461168, 5814.5057670098095, 5710.486056254916, 5713.6000479966415, 5794.246747922785, 5819.214406055171, 5837.64974101551, 5689.203511508392, 5726.0, 5775.220345253379, 5791.218185544982, 5804.796832110856, 6123.234595675541, 6214.098955651405, 6219.626822390625, 6323.778667746653, 6325.936740632581, 6550.70521826519, 6596.967015164942, 6627.966860165669, 6628.138342015555, 6650.201975762891, 6676.232233293184, 6689.8662026759675, 6698.564593301468, 6700.095487109226, 6700.095487109226, 6125.846853828601, 6130.049842274455, 6192.907106393408, 6193.3496982816605, 6211.3167551569295, 6878.65606719662, 6895.172579290417, 6909.861802763917, 6932.168139823253, 6943.72225111, 6558.409743123142, 6572.441342485847, 6621.404073633396, 6647.969564717477, 6669.599824010478, 6691.966540167268, 6704.497162712719, 6757.594544327356, 6772.55978361405, 6785.525013249124, 6557.2131344239, 6614.305497922745, 6621.768238111739, 6631.038499417557, 6643.368879956396, 6200.0, 6701.463882889358, 6737.326267373322, 6745.561538499982, 6782.525223234326, 5289.735513224324, 5316.521513063765, 5367.570594352443, 5374.301340825746, 5387.164989426645, 4614.815407383734, 4680.695754775928, 4716.575508204278, 4720.244760838318, 4733.9053218936115, 5749.080147176432, 5791.507721843606, 5814.069748840166, 5863.413658634187, 5867.882642347129, 6733.595984240961, 6746.156730408699, 6755.0, 6765.323467653196, 6791.830204244933, 5763.279590051244, 5787.392323806024, 5799.362070172362, 5867.031939729982, 5869.471747542656, 5758.193852860602, 5774.88450230993, 5821.505172060338, 5826.41735826414, 5830.271216097988, 6207.317195108534, 6306.054091886162, 6312.24253089623, 6418.133551970518, 6426.132472116298, 6723.899141512979, 6747.0, 6789.355011273921, 6793.354631310018, 6798.8640227196165, 6336.0, 6343.5876668016435, 6343.9365606343345, 6421.839454013687, 6445.484361251182, 6441.71012304438, 6530.8367290818105, 6563.310852360433, 6652.035454859115, 6668.499862510234, 6617.338266173537, 6656.667166641745, 6670.132882725215, 6677.432418244503, 6698.899516507354, 6377.170967774346, 6471.385218404244, 6477.255115661759, 6481.611103333815, 6486.0, 6452.193475815523, 6459.224893012869, 6476.6114033158165, 6479.838004049937, 6487.0, 6481.513886458629, 6494.512911531559, 6505.51208659343, 6516.804495865132, 6521.9673901630185, 6573.408393244631, 6624.403803657694, 6633.767818126343, 6651.7006734698025, 6652.467802575686, 6320.4311611955145, 6358.046293056079, 6431.163948686641, 6447.580907241015, 6469.029645553204], "value": 6069.625477479504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.4790718357925, 835.2065537739147, 866.1079088538805, 871.9433236839604, 1096.950637221325, 29123.854380728095, 29719.108426747178, 29723.851380743094, 38460.423093653546, 39183.80408097963, 39372.0, 39676.60323396765, 39731.20537589247, 39793.20413591734, 39825.40261896074, 7063.258357872426, 7260.528065675714, 7492.58790766509, 7643.23567643234, 7660.808479788022, 7590.8481830363635, 7714.074311082678, 7723.53658780475, 7731.304182623563, 7744.380449564022, 7649.158592554814, 7717.614119294041, 7723.420743444236, 7725.266099720518, 7768.262015108584, 7667.961660191719, 7701.9614901925415, 7702.0757509098985, 7710.190430004881, 7720.729774457867, 7611.695532178706, 7637.274458926393, 7638.1979892111085, 7648.73229436967, 7649.426293027989, 35372.469412958824, 35491.0, 35623.10942226465, 35654.10864728376, 35694.10764730877, 3484.337975784593, 3513.1744040150543, 3516.1385460562324, 3527.805970671612, 3532.6290739472242, 28932.421351573063, 29026.70973290261, 29058.709412906024, 29129.41741165186, 29305.413891722044, 5116.76974536143, 5134.255532947702, 5201.635885488017, 5208.687478751249, 5216.713080780555, 186922.0, 187528.0, 188255.0, 188850.0, 189321.05339473352, 43747.781261094126, 43821.34267985983, 43825.56174438215, 43932.78033609811, 43951.560484395384, 45741.771291143334, 45857.0, 45961.540384595726, 46004.0, 46012.53987460083, 14807.111573305636, 14811.889108316704, 14813.407463701331, 14821.333040013225, 15105.773413398807, 11259.831102533304, 11470.254433461798, 11820.0, 12337.69155771095, 12354.814677779841, 13234.470621175238, 13288.534901278408, 13331.40008699611, 13358.666033349049, 13568.118072325267, 5648.85877853057, 5656.575756818255, 5689.573282003867, 5719.971400143056, 5816.709164541756, 971.6162115964296, 990.762217067913, 1001.5993602558889, 1008.863803386548, 1017.9949100254452, 22338.66492002621, 22365.888170559043, 22458.55082898333, 22586.322410327717, 22800.201992930168, 1084.430673896195, 1099.741560733227, 1102.9724256893642, 1103.2222283290262, 1107.3909349857547, 11781.882181178249, 11805.468753906094, 11861.406929653655, 11877.703057423634, 12019.819702704466, 212702.0, 213881.0, 214953.0, 215831.0, 216237.0, 49149.26276105861, 49345.0, 49459.50540494621, 49489.75255123701, 49623.0, 1392.2133994293192, 1412.8092707484564, 1417.6030711400824, 1421.2112277685983, 1434.397553027731, 21695.0, 21854.0, 22057.889710551346, 22585.322440326818, 22650.093996239964, 45030.324545131196, 46292.768536157106, 47565.0, 47673.52326476691, 48025.27962080502, 213575.0, 213778.0, 213794.0, 214714.0, 214901.0, 28252.15243542615, 28806.263404976493, 31463.68536314699, 32082.358352832347, 32274.0, 41022.38466423066, 41215.79392103021, 41371.58628413677, 41386.172276554906, 41431.0, 29880.70119298866, 30104.849475752482, 30315.545266821457, 30535.389292214477, 31130.0, 30212.546811798282, 30224.94212702545, 30378.0, 30433.847830760704, 31181.53227701632, 33782.324353513286, 33823.323533529685, 33863.83068084644, 34005.149871253416, 34017.65982340244, 29254.0, 29472.263193420335, 29766.851165744032, 29990.25024374408, 30034.84982575073, 23614.527709446058, 23860.164894229314, 24190.75809241885, 24461.742133919837, 24613.87693061523], "value": 16585.613182253368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.864783804049, 556.919246709227, 560.3471955172224, 560.9635373700709, 571.5484767034043, 21211.257605983792, 22003.779962200373, 22014.11943522259, 22093.668594971048, 22742.0, 24599.63100553493, 25209.621855672132, 25353.87323063382, 25414.87292563539, 25558.105466308683, 6443.83890402739, 6580.341965803405, 6587.967060164692, 6589.538732288742, 6619.30497297784, 5985.700714964256, 6454.870902581945, 6518.804435866931, 6521.08704781331, 6528.445082168021, 6405.19935008124, 6440.388163124519, 6468.74125034998, 6471.385218404244, 6485.2217733872, 6469.5794773339585, 6476.9313063344725, 6477.708503117371, 6509.056186852904, 6517.51118666102, 5897.203877476529, 5957.761689532414, 5961.672108034099, 6019.939800601982, 6032.758689652409, 28264.858675706695, 29079.709202908125, 30259.697403025908, 31361.372772544422, 31507.84246078778, 1984.196400457817, 2024.6355655981918, 2025.8075482829108, 2026.311054241565, 2033.278186243877, 19789.10949007298, 20381.0, 20640.793592064187, 20650.690239646417, 20713.27503537369, 2508.498300339921, 2559.6160575913764, 2579.1488808693084, 2582.3544113971507, 2599.7920166386643, 133580.0, 139862.0, 140088.0, 140176.29911850375, 140201.29899350437, 20890.1643934244, 21197.364079077342, 21282.467938301666, 21676.674849877265, 21993.560128797333, 42905.78547107307, 42948.3557746634, 42990.78504607457, 43056.78471607684, 43062.569374306484, 11312.660620181408, 11342.0, 11570.247933884271, 11595.18833681651, 11700.2979821211, 8642.30861531076, 9062.456252624863, 9435.688256377094, 9563.61745530185, 9576.281778866474, 10455.33388985819, 11155.27490713101, 11188.0, 11305.438786782137, 11771.529138834521, 3564.322778672044, 3582.8387722552025, 3607.206414588786, 3834.6416953573353, 4308.202982448257, 903.6024149374255, 933.5472295936465, 952.3761935931975, 959.1799011844772, 967.7725734452398, 19853.801461985484, 19948.90025549863, 20132.39602811918, 20226.595468090556, 20483.487912802, 1024.3904876598413, 1026.1380440430075, 1035.8394448860438, 1047.0471870597719, 1051.6109039655375, 11105.777884442266, 11147.108231341474, 11160.386178760084, 11296.887031129749, 11331.093512518979, 493704.0, 508052.0, 513165.0, 573745.0, 580050.0, 120223.0, 124505.0, 124657.37671311585, 130208.0, 130219.0, 1172.4841069929205, 1224.3327386574338, 1230.6615680687883, 1235.3823088455772, 1238.9442475088642, 20925.79074209299, 21476.78523214748, 22556.548869022856, 22771.772282276965, 22812.087516499156, 55905.0, 56113.71943140421, 56583.43416565782, 57455.0, 58137.70931145486, 64542.0, 65292.67353663201, 66281.66859165674, 67702.32297677157, 68031.65984170047, 12201.267923924594, 14512.201828899511, 14514.419423222953, 14592.927035364755, 14631.487897923522, 23339.883300584068, 23345.41636459102, 23654.52690946206, 24040.0, 24047.0, 18488.16803243884, 19163.233470661016, 19480.415587532396, 19482.4155275342, 19638.90180549088, 16773.161341933097, 17125.314987400863, 17161.31354745796, 17580.0, 17661.116944152483, 18751.812481875008, 19012.904935475235, 19070.33253836109, 19104.8089519103, 19160.712589310893, 14245.074070185405, 14628.634284142981, 14646.048006879519, 14662.046966947115, 14737.705245895237, 18662.973536455625, 18806.6238675223, 19001.80998190056, 19071.52321191981, 19198.904005479882], "value": 12688.11010001177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.1183239480956, 1342.0940864916179, 1343.5633419138776, 1356.1591813075895, 1362.7547041532525, 13839.446422143103, 13942.093763905339, 14516.637084072903, 14733.263336833143, 14742.705145897102, 14900.105993640389, 15003.0, 15065.472708455207, 15082.622934426645, 15109.622259443491, 2571.1643715792347, 2627.238100950722, 2629.5529759940855, 2643.973560264392, 2644.907428240012, 2615.620734993425, 2616.82990605611, 2621.1612284069106, 2703.864806759664, 2716.1036857836866, 2622.8819703113404, 2624.7900167986513, 2657.787377009844, 2660.1088635307196, 2661.0154242930143, 2635.235781623327, 2640.3927096767757, 2648.1128821844704, 2658.1626787561854, 2660.401409682825, 2521.2688320387065, 2528.329992551975, 2542.745725427461, 2550.1202085280547, 2560.526302634, 14278.571642850731, 14434.133951962916, 14449.422023119168, 14452.49416270436, 14453.927730361385, 7616.543007419517, 7914.683412663487, 7940.967674202375, 7942.761717148494, 7969.123396426388, 5111.2333150027425, 5266.815661451831, 5338.27933229013, 5419.972900135514, 5427.538659213932, 1819.7270409438559, 1852.2961274715656, 1853.2123847364817, 1892.5741708115702, 1902.73361729358, 23970.400739981465, 24203.273901782974, 24220.273391798273, 24232.63651045218, 24234.757652423603, 6542.509311801538, 6554.115194448784, 6558.1802274715665, 6667.999800030035, 6688.163979502562, 16058.197090145446, 16154.596135096717, 16160.0, 16191.0, 16206.675866482605, 7413.0, 7460.3658689012045, 7497.587632680255, 7497.625118744041, 7548.773536793905, 6878.3465570770695, 6956.965215173993, 7074.540154889915, 7089.361957423856, 7096.822579435556, 4746.430428348551, 4930.901381972412, 5184.7407629618365, 5187.377514698261, 5211.400688920747, 1356.504875720355, 1507.0806807847205, 1534.6086747879442, 1551.6431220819275, 1561.4222737587165, 860.7331727164474, 861.6854847980442, 872.1801506583791, 872.8690696395591, 876.3996662286354, 8021.2379823916635, 8437.282830959437, 8461.619227134794, 8467.872981905277, 8473.533955632376, 963.816874793787, 979.6669132494986, 980.6420656460341, 984.8424252119627, 994.8706668133241, 4596.5863072323655, 4662.347271382009, 4954.5540901319055, 5355.4376790436445, 5524.66851988882, 19900.70148947767, 20335.389938301876, 20625.793742062688, 20654.0, 20659.58680826405, 19648.21407143698, 20108.195672172948, 20155.798442015686, 20190.293339733038, 20845.1661933524, 10967.670969870916, 11330.94334528322, 11337.866213378597, 11338.716532086599, 11361.091112710963, 8439.95780021096, 8618.138186181332, 8686.956565217133, 8695.521746304014, 8850.424722393023, 17365.0, 17668.38160664422, 17695.734563981292, 17785.110744462465, 17811.821881781016, 17643.0, 17661.911690441466, 17929.641407172043, 17948.37180698669, 17999.10004499796, 11693.298402095561, 11826.290422574673, 12149.514019439124, 12191.146619736533, 12200.51197952072, 12146.878531214576, 13615.931920340336, 13690.794638080237, 13743.656408589864, 13776.655583610089, 10943.671689849318, 11127.666170014912, 11136.38749868765, 11308.151888608223, 11470.942645287054, 10717.35695858251, 10869.130469562258, 10915.78168436611, 10967.451627418757, 11202.047825934887, 9161.86257206129, 9227.031161727922, 9259.35184537076, 9271.165595096474, 9282.257419406566, 7532.531156424664, 7579.090509138939, 7587.658555364911, 7591.544507329578, 7691.38468922496, 7399.482036257626, 7473.0, 7504.287092726182, 7521.0, 7597.278258565428], "value": 6510.837757190447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.52524300049055, 491.4320745948404, 516.7080599461304, 518.8313798015646, 525.955293800027, 6225.225810643968, 6235.728525959709, 6291.0, 6368.140301059356, 6368.395002474764, 6224.23021755319, 6227.346128656493, 6277.2153480814895, 6309.242890853093, 6320.620762754238, 5069.645124841262, 5070.3915530136255, 5100.719460429675, 5154.433012368637, 5157.355330583677, 5054.747262636872, 5079.619028572872, 5083.957788653317, 5109.41241757199, 5119.846404607849, 4840.322354870321, 5040.722760248185, 5043.344365232515, 5076.36545431821, 5078.111330517163, 4946.431160416562, 5020.246962955549, 5037.546620804145, 5095.006473737622, 5100.183970564711, 4480.955190448087, 4484.327350897359, 4516.4806047304655, 4541.84103556374, 4549.385832912548, 6228.128062071313, 6248.812535623939, 6255.218097737783, 6268.780592679234, 6286.622802631811, 5698.202251684767, 5732.656040637534, 5792.2912740741585, 5802.941970580282, 5814.982378083819, 6518.674066296714, 6621.271660117383, 6621.86756264872, 6690.130283063219, 6691.364320389555, 4871.780769865364, 4884.5603895649565, 4900.240462728283, 4910.975445122787, 4914.950850491485, 6940.6529673516125, 7019.719211231544, 7022.754203602901, 7076.363127318515, 7097.325754053357, 5034.672746271481, 5040.873978150502, 5047.141985862412, 5103.795848166106, 5104.3619547556555, 5070.0, 5122.1804511278015, 5130.666506677054, 5140.897182056338, 5168.147255702842, 5714.5999780015, 5770.653760774367, 5801.01382764931, 5803.6807975560905, 5813.476787089182, 6614.980367865316, 6716.597004179765, 6739.427148692318, 6746.4265537429865, 6754.155730533684, 1679.6220850308582, 1722.457425910834, 1758.156085079169, 1770.876038677306, 1902.4673091534391, 1423.0, 1450.2313773699957, 1458.0, 1470.3750905864965, 1474.609228554434, 5815.505682017076, 5857.589968702235, 5864.3378514081405, 5886.411358864079, 5910.8817823643285, 6574.80275591733, 6777.559458635173, 6859.5541289816, 6889.276625954303, 6889.896651550231, 5889.94110058894, 5895.498882594941, 5901.439363260483, 5902.291724993029, 5918.3489816121055, 3586.1931065510053, 3608.566971963329, 3643.198496330803, 3646.5259516262718, 3661.1945372018113, 6509.218893732783, 6511.316311787289, 6517.4134327910715, 6529.934700653028, 6566.113574667359, 7012.685813681473, 7024.894626580605, 7038.859222815515, 7041.155061392666, 7053.858922821618, 6478.708458119396, 6484.902726459012, 6501.122348482989, 6501.934980650133, 6517.4134327910715, 6686.431653309523, 6813.761518346834, 6848.828779280558, 6866.828329291608, 6905.93094069073, 6733.966330168514, 6776.424003959719, 6777.559458635173, 6814.795556133324, 6815.87538056235, 6342.778002769881, 6348.5238607105575, 6364.268109167319, 6459.709313080829, 6488.12410324619, 4991.301217829579, 5022.271770593316, 5026.874328141826, 5038.647294689336, 5046.444891062054, 6788.2193547742645, 6867.622280774605, 6874.415674667709, 6894.310568943066, 6947.444204463732, 6338.778142764981, 6511.609303441809, 6530.444912182327, 6648.202215734143, 6670.433013193933, 6614.272430032596, 6639.634820084942, 6644.57473022353, 6660.367265109807, 6689.297623749436, 6597.703103360456, 6599.8020059398295, 6612.537122401386, 6618.172728408949, 6637.933620663732, 6535.705893234721, 6655.467562594884, 6684.398404143651, 6688.598684078971, 6696.330366963265, 6434.163558737334, 6497.837554061186, 6517.608943463408, 6530.67346632676, 6536.346365363425], "value": 5147.320848997361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.068965517241, 892.4600616626941, 899.6986009686755, 901.69342423576, 901.8782464367308, 17583.64832703345, 18634.34779782708, 18666.533336666573, 18670.626587468243, 18689.0, 19976.700349494768, 20580.691289630668, 20625.896870515662, 20657.27699530517, 20696.793032069676, 924.3899026642417, 930.2650905784456, 936.5738588942049, 937.7374335186158, 937.7468083617454, 898.5282726568538, 920.5535315372073, 933.0809152984305, 934.7336009237368, 937.0722984245616, 993.4238141877694, 1002.8395456726926, 1002.9949850250739, 1003.3628645809927, 1008.9949550252238, 980.7940332530177, 985.9852102218473, 988.9604415823359, 989.2827699917539, 994.383482241008, 721.1634503975416, 727.134709695466, 730.7771129805408, 732.9596872172028, 734.3501001613557, 18744.437666870017, 19178.90410547938, 19339.903300483547, 19358.0, 19404.902975485173, 19622.607547849108, 19673.704894426595, 20080.69878951817, 20081.09635066411, 20096.196152153898, 15955.282012309473, 15983.280752366172, 16045.598860028476, 16163.676726465523, 16199.595010124724, 3681.815909204529, 3723.0, 3725.1990821973136, 3725.497057897176, 3727.310447567209, 118697.40651296689, 121946.0, 123811.0, 124177.0, 124767.0, 16088.356465741239, 16184.919075404783, 16421.096839673934, 16430.0, 16539.751903721455, 28589.857050714614, 29193.0, 29373.85313073421, 29406.852965735463, 29428.0, 7933.642986065641, 8124.715634952749, 8255.669773209125, 8266.462679925786, 8294.129116442808, 3943.585923478051, 4119.237940980928, 4239.51245606753, 4267.5732426757695, 4417.491988421309, 4647.883802904887, 4751.097291514601, 4758.620000199972, 4759.904801903943, 4776.761161941889, 956.0773853231665, 981.5435822342645, 992.0179022767409, 993.6571882700457, 993.6621548673486, 676.7394553097093, 688.404530081476, 688.8071340024801, 700.2647220418642, 702.2766550453042, 11678.76642467146, 11911.523539058513, 11977.940110299392, 11992.820107698391, 14016.649583760487, 704.3766266853871, 712.8075419636773, 714.5069901767764, 716.4197000429668, 726.5459088069956, 5365.222042803772, 5578.0, 5591.10542313228, 5975.492083172979, 6072.392760723892, 107285.46357268319, 107552.0, 107606.46196769123, 107698.46150769196, 110961.44519277514, 95676.9999999986, 97407.51296243473, 98607.50696246473, 101996.49001754944, 105286.4735676332, 85416.0, 87633.56183219043, 90592.54703726439, 92046.53976730208, 93618.0, 11634.476448559666, 11682.415879206175, 11783.469743861719, 11923.10576706733, 12096.334701591497, 39407.0, 39501.40747888727, 39714.60285397109, 39741.205175896896, 40579.391309129795, 47587.28619070647, 50752.746236268584, 51314.48685513246, 68634.0, 71359.64320178366, 15367.0, 15428.0, 15594.610134746268, 15663.921680391524, 15709.293081811118, 18904.0, 18905.149268282687, 18944.52638684044, 18982.905085474486, 19022.7146592804, 17963.910180449013, 18407.81592184061, 18537.0, 18636.16137273853, 18741.15664795115, 18049.819501804814, 18122.003289819186, 18359.265629374677, 18474.63050738951, 18531.536711582317, 17469.82530174682, 17477.825221748128, 17524.299028038735, 17603.647927041133, 17770.111494424968, 12493.18794278369, 12630.179038362478, 12680.6829829255, 12681.93659031699, 12784.61646150617, 12992.545260915822, 13573.04988650785, 13578.981576381613, 13590.851890354186, 14125.788113178516], "value": 8854.520115857515, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 120.0, 108.0, 115.0, 109.0, 106.0, 109.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 139.0, 192.0, 118.0, 141.0, 149.0, 122.0, 173.0, 122.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 166.0, 165.0, 164.0, 162.0, 163.0, 163.0, 164.0, 170.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 166.0, 74.0, 74.0, 79.0, 76.0, 158.0, 78.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 140.0, 83.0, 79.0, 85.0, 124.0, 87.0, 79.0, 141.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 123.0, 114.0, 114.0, 117.0, 118.0, 117.0, 115.0, 115.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 151.0, 149.0, 148.0, 148.0, 150.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 96.0, 93.0, 94.0, 95.0, 93.0, 98.0, 94.0, 93.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 54.0, 52.0, 55.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 74.0, 81.0, 75.0, 82.0, 73.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 125.0, 120.0, 124.0, 126.0, 118.0, 117.0, 128.0, 121.0, 159.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 182.0, 169.0, 170.0, 183.0, 173.0, 167.0, 173.0, 173.0, 174.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 66.0, 65.0, 65.0, 70.0, 69.0, 66.0, 66.0, 66.0], "value": 67.2, "unit": "score"}]}]} 08:47:54 INFO - Return code: 0 08:47:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:54 INFO - # TBPL SUCCESS # 08:47:54 INFO - Running post-action listener: _package_coverage_data 08:47:54 INFO - Running post-action listener: _resource_record_post_action 08:47:54 INFO - [mozharness: 2017-08-23 15:47:54.189701Z] Finished run-tests step (success) 08:47:54 INFO - Running post-run listener: _resource_record_post_run 08:47:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5349376; Write bytes: 439721984; Read time: 2620; Write time: 342076 08:47:54 INFO - TinderboxPrint: CPU usage
13.1% 08:47:54 INFO - TinderboxPrint: I/O read bytes / time
5,349,376 / 2,620 08:47:54 INFO - TinderboxPrint: I/O write bytes / time
439,721,984 / 342,076 08:47:54 INFO - TinderboxPrint: CPU idle
8,272.9 (86.8%) 08:47:54 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 08:47:54 INFO - TinderboxPrint: Swap in / out
0 / 0 08:47:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115884032; Read time: 0; Write time: 104500 08:47:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:47:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2854912; Write bytes: 272154624; Read time: 1508; Write time: 210068 08:47:54 INFO - Running post-run listener: _upload_blobber_files 08:47:54 INFO - Blob upload gear active. 08:47:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:54 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:47:54 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:47:54 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:47:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:56 INFO - (blobuploader) - INFO - Done attempting. 08:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:59 INFO - (blobuploader) - INFO - Done attempting. 08:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:00 INFO - (blobuploader) - INFO - Done attempting. 08:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:07 INFO - (blobuploader) - INFO - Done attempting. 08:48:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:48:07 INFO - Return code: 0 08:48:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:48:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:48:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c70ef6ae3b427df48a71bd07d46b9853c813283250de140db89aa04a892f9db4743d23cfc08d60a8da699aaf322a31a238dfe116e0e4d2f15dad529aca19180", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08aba45b4f675c9082a1dab179a27061c2207cbdf5e4f5f02189d23fbf5d7c175f3ebca0140fec7249ca7a82d651ea08fe231198851fa292c4cfed661ca17559", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1bd56f495f86ece1bce089909db4dff02595de748d43d6a73cc1025b3c41d160e38594d6fccc14ddbc5e5579763e948e7d60b1cb7de0b9b1aaf19c29da72ef9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b15f3d7646807130d33f4f139752c06234b701203fc4bf4aac603f89931515171500efda3723441b8b227daaa841992ffda65beda16a2d53b0187596f8c2215"} 08:48:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:07 INFO - Contents: 08:48:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c70ef6ae3b427df48a71bd07d46b9853c813283250de140db89aa04a892f9db4743d23cfc08d60a8da699aaf322a31a238dfe116e0e4d2f15dad529aca19180", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08aba45b4f675c9082a1dab179a27061c2207cbdf5e4f5f02189d23fbf5d7c175f3ebca0140fec7249ca7a82d651ea08fe231198851fa292c4cfed661ca17559", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1bd56f495f86ece1bce089909db4dff02595de748d43d6a73cc1025b3c41d160e38594d6fccc14ddbc5e5579763e948e7d60b1cb7de0b9b1aaf19c29da72ef9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b15f3d7646807130d33f4f139752c06234b701203fc4bf4aac603f89931515171500efda3723441b8b227daaa841992ffda65beda16a2d53b0187596f8c2215"} 08:48:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:07 INFO - Copying logs to upload dir... 08:48:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.715723 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-23 08:48:07.475510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:48:07.483099) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c70ef6ae3b427df48a71bd07d46b9853c813283250de140db89aa04a892f9db4743d23cfc08d60a8da699aaf322a31a238dfe116e0e4d2f15dad529aca19180", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08aba45b4f675c9082a1dab179a27061c2207cbdf5e4f5f02189d23fbf5d7c175f3ebca0140fec7249ca7a82d651ea08fe231198851fa292c4cfed661ca17559", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1bd56f495f86ece1bce089909db4dff02595de748d43d6a73cc1025b3c41d160e38594d6fccc14ddbc5e5579763e948e7d60b1cb7de0b9b1aaf19c29da72ef9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b15f3d7646807130d33f4f139752c06234b701203fc4bf4aac603f89931515171500efda3723441b8b227daaa841992ffda65beda16a2d53b0187596f8c2215"} build_url:https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/b8HvYVIUQ8S4HNJ3UL126w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c70ef6ae3b427df48a71bd07d46b9853c813283250de140db89aa04a892f9db4743d23cfc08d60a8da699aaf322a31a238dfe116e0e4d2f15dad529aca19180", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08aba45b4f675c9082a1dab179a27061c2207cbdf5e4f5f02189d23fbf5d7c175f3ebca0140fec7249ca7a82d651ea08fe231198851fa292c4cfed661ca17559", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1bd56f495f86ece1bce089909db4dff02595de748d43d6a73cc1025b3c41d160e38594d6fccc14ddbc5e5579763e948e7d60b1cb7de0b9b1aaf19c29da72ef9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b15f3d7646807130d33f4f139752c06234b701203fc4bf4aac603f89931515171500efda3723441b8b227daaa841992ffda65beda16a2d53b0187596f8c2215"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:48:07.512496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:48:07.512837) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1503502023.362927-319087325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:48:07.562695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:48:07.566067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:48:07.566434) ========= ========= Total master_lag: 0.50 =========