builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1503532603.72 results: success (0) revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.722220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.722689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.722999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.739044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.739362) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 16:56:44-- 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.0M=0s 2017-08-23 16:56:44 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.841267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.841599) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.895193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:43.895551) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0abd25e1f4acced652d180c34b7c9eda638deb1 --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 f0abd25e1f4acced652d180c34b7c9eda638deb1 --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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 16:56:44,230 truncating revision to first 12 chars 2017-08-23 16:56:44,230 Setting DEBUG logging. 2017-08-23 16:56:44,230 attempt 1/10 2017-08-23 16:56:44,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0abd25e1f4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 16:56:44,673 unpacking tar archive at: mozilla-central-f0abd25e1f4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:44.672695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:44.676086) ========= script_repo_revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:44.676509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:44.676796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 16:56:44.688787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 16:56:44.689169) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:45 INFO - MultiFileLogger online at 20170823 16:56:45 in /builds/slave/test 16:56:45 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 16:56:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:45 INFO - {'append_to_log': False, 16:56:45 INFO - 'base_work_dir': '/builds/slave/test', 16:56:45 INFO - 'blob_upload_branch': 'Firefox', 16:56:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:45 INFO - 'branch': 'Firefox', 16:56:45 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:45 INFO - 'code_coverage': False, 16:56:45 INFO - 'config_files': ('talos/linux_config.py',), 16:56:45 INFO - 'default_actions': ('clobber', 16:56:45 INFO - 'read-buildbot-config', 16:56:45 INFO - 'download-and-extract', 16:56:45 INFO - 'populate-webroot', 16:56:45 INFO - 'create-virtualenv', 16:56:45 INFO - 'install', 16:56:45 INFO - 'setup-mitmproxy', 16:56:45 INFO - 'run-tests'), 16:56:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:45 INFO - 'disable_ccov_upload': False, 16:56:45 INFO - 'download_minidump_stackwalk': True, 16:56:45 INFO - 'download_symbols': 'ondemand', 16:56:45 INFO - 'enable_stylo': False, 16:56:45 INFO - 'enable_webrender': False, 16:56:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:56:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:45 INFO - 'gecko_profile': False, 16:56:45 INFO - 'gecko_profile_interval': 0, 16:56:45 INFO - 'installer_path': 'installer.exe', 16:56:45 INFO - 'log_level': 'info', 16:56:45 INFO - 'log_name': 'talos', 16:56:45 INFO - 'log_to_console': True, 16:56:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:45 INFO - 'opt_config_files': (), 16:56:45 INFO - 'pip_index': False, 16:56:45 INFO - 'suite': 'dromaeojs-e10s', 16:56:45 INFO - 'system_bits': '32', 16:56:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:45 INFO - 'title': 'talos-linux64-ix-037', 16:56:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:45 INFO - 'use_talos_json': True, 16:56:45 INFO - 'verify': 'False', 16:56:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:45 INFO - 'work_dir': 'build'} 16:56:45 INFO - [mozharness: 2017-08-23 23:56:45.161839Z] Running clobber step. 16:56:45 INFO - Running pre-action listener: _resource_record_pre_action 16:56:45 INFO - Running main action method: clobber 16:56:45 INFO - rmtree: /builds/slave/test/build 16:56:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:46 INFO - Running post-action listener: _resource_record_post_action 16:56:46 INFO - [mozharness: 2017-08-23 23:56:46.302405Z] Finished clobber step (success) 16:56:46 INFO - [mozharness: 2017-08-23 23:56:46.302504Z] Running read-buildbot-config step. 16:56:46 INFO - Running pre-action listener: _resource_record_pre_action 16:56:46 INFO - Running main action method: read_buildbot_config 16:56:46 INFO - Using buildbot properties: 16:56:46 INFO - { 16:56:46 INFO - "project": "", 16:56:46 INFO - "product": "firefox", 16:56:46 INFO - "who": "kwierso@gmail.com", 16:56:46 INFO - "installer_path": "public/build/target.tar.bz2", 16:56:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:56:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:56:46 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:56:46 INFO - "stage_platform": "linux64-qr", 16:56:46 INFO - "basedir": "/builds/slave/test", 16:56:46 INFO - "buildnumber": 16, 16:56:46 INFO - "platform": "ubuntu64_hw_qr", 16:56:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:56:46 INFO - "slavebuilddir": "test", 16:56:46 INFO - "taskId": "X8KiH0XHRKq_bmPUepqGMw", 16:56:46 INFO - "branch": "mozilla-central", 16:56:46 INFO - "script_repo_revision": "production", 16:56:46 INFO - "revision": "f0abd25e1f4acced652d180c34b7c9eda638deb1", 16:56:46 INFO - "slavename": "talos-linux64-ix-037", 16:56:46 INFO - "repo_path": "mozilla-central" 16:56:46 INFO - } 16:56:46 INFO - Finding installer, test and symbols from parent task. 16:56:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8KiH0XHRKq_bmPUepqGMw'}, attempt #1 16:56:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8KiH0XHRKq_bmPUepqGMw'}, attempt #1 16:56:47 INFO - Task dependencies: OO07YykgQ7SfVQl5pfp5jg 16:56:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg'}, attempt #1 16:56:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:56:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 16:56:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip 16:56:47 INFO - Running post-action listener: _resource_record_post_action 16:56:47 INFO - [mozharness: 2017-08-23 23:56:47.668200Z] Finished read-buildbot-config step (success) 16:56:47 INFO - [mozharness: 2017-08-23 23:56:47.668413Z] Running download-and-extract step. 16:56:47 INFO - Running pre-action listener: _resource_record_pre_action 16:56:47 INFO - Running main action method: download_and_extract 16:56:47 INFO - mkdir: /builds/slave/test/build/tests 16:56: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')]} 16:56:47 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 16:56:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:56:48 INFO - Downloaded 989 bytes. 16:56:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:56:48 INFO - Using the following test package requirements: 16:56:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:56:48 INFO - u'common': [u'target.common.tests.zip'], 16:56:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:56:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:56:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:56:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:56:48 INFO - u'mozbase': [u'target.common.tests.zip'], 16:56:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:56:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:56:48 INFO - u'web-platform': [u'target.common.tests.zip', 16:56:48 INFO - u'target.web-platform.tests.tar.gz'], 16:56:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:56:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:56:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 16:56:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:56:48 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 16:56:49 INFO - Content-Length response header: 54950441 16:56:49 INFO - Bytes received: 54950441 16:57:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:57:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 16:57:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:57:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 16:57:01 INFO - Content-Length response header: 54950441 16:57:01 INFO - Bytes received: 54950441 16:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip 16:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip into memory 16:57:13 INFO - Content-Length response header: 14496384 16:57:13 INFO - Bytes received: 14496384 16:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:14 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:57:14 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:57:15 INFO - Downloaded 61087534 bytes. 16:57:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:57:15 INFO - mkdir: /builds/slave/test/properties 16:57:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:15 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:15 INFO - Contents: 16:57:15 INFO - build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:57:15 INFO - Running post-action listener: _resource_record_post_action 16:57:15 INFO - Running post-action listener: find_tests_for_verification 16:57:15 INFO - Running post-action listener: set_extra_try_arguments 16:57:15 INFO - [mozharness: 2017-08-23 23:57:15.339191Z] Finished download-and-extract step (success) 16:57:15 INFO - [mozharness: 2017-08-23 23:57:15.339289Z] Running populate-webroot step. 16:57:15 INFO - Running pre-action listener: _resource_record_pre_action 16:57:15 INFO - Running main action method: populate_webroot 16:57:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:15 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:15 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:15 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'tests': ['damp', 'tps']}, 16:57:15 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['damp', 'tps']}, 16:57:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:57:15 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:57:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:57:15 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:57:15 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:15 INFO - 'ts_paint', 16:57:15 INFO - 'tpaint', 16:57:15 INFO - 'sessionrestore', 16:57:15 INFO - 'sessionrestore_many_windows', 16:57:15 INFO - 'sessionrestore_no_auto_restore', 16:57:15 INFO - 'tabpaint']}, 16:57:15 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['a11yr', 16:57:15 INFO - 'ts_paint', 16:57:15 INFO - 'tpaint', 16:57:15 INFO - 'sessionrestore', 16:57:15 INFO - 'sessionrestore_many_windows', 16:57:15 INFO - 'sessionrestore_no_auto_restore', 16:57:15 INFO - 'tabpaint']}, 16:57:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:57:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:57:15 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['bloom_basic_singleton']}, 16:57:15 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['bloom_basic']}, 16:57:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:15 INFO - 'tsvgr_opacity', 16:57:15 INFO - 'tart', 16:57:15 INFO - 'tscrollx', 16:57:15 INFO - 'tsvg_static']}, 16:57:15 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['tsvgx', 16:57:15 INFO - 'tsvgr_opacity', 16:57:15 INFO - 'tart', 16:57:15 INFO - 'tscrollx', 16:57:15 INFO - 'tsvg_static']}, 16:57:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:57:15 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--stylo'], 16:57:15 INFO - 'tests': ['tp5o']}, 16:57:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:57:15 INFO - 'talos_options': ['--mitmproxy', 16:57:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:57:15 INFO - '--firstNonBlankPaint'], 16:57:15 INFO - 'tests': ['tp6_google', 16:57:15 INFO - 'tp6_youtube', 16:57:15 INFO - 'tp6_amazon', 16:57:15 INFO - 'tp6_facebook']}, 16:57:15 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:57:15 INFO - 'talos_options': ['--stylo', 16:57:15 INFO - '--mitmproxy', 16:57:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:57:15 INFO - '--firstNonBlankPaint'], 16:57:15 INFO - 'tests': ['tp6_google', 16:57:15 INFO - 'tp6_youtube', 16:57:15 INFO - 'tp6_amazon', 16:57:15 INFO - 'tp6_facebook']}, 16:57:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:57:15 INFO - 'talos_options': ['--stylo', 16:57:15 INFO - '--stylo-threads=1', 16:57:15 INFO - '--mitmproxy', 16:57:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:57:15 INFO - '--firstNonBlankPaint'], 16:57:15 INFO - 'tests': ['tp6_google', 16:57:15 INFO - 'tp6_youtube', 16:57:15 INFO - 'tp6_amazon', 16:57:15 INFO - 'tp6_facebook']}, 16:57:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--xperf_path', 16:57:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:15 INFO - 'tests': ['tp5n']}, 16:57:15 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:57:15 INFO - 'talos_options': ['--stylo', 16:57:15 INFO - '--xperf_path', 16:57:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:15 INFO - 'tests': ['tp5n']}}} 16:57:15 INFO - Running post-action listener: _resource_record_post_action 16:57:15 INFO - [mozharness: 2017-08-23 23:57:15.353534Z] Finished populate-webroot step (success) 16:57:15 INFO - [mozharness: 2017-08-23 23:57:15.353634Z] Running create-virtualenv step. 16:57:15 INFO - Running pre-action listener: _resource_record_pre_action 16:57:15 INFO - Running main action method: create_virtualenv 16:57:15 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:15 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:57:15 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:57:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:57:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:16 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:16 INFO - Installing pip...............done. 16:57:16 INFO - Return code: 0 16:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:57:16 INFO - Reading from file tmpfile_stdout 16:57:16 INFO - Output received: 16:57:16 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:57:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:57:16 INFO - Using env: {'DISPLAY': ':0', 16:57:16 INFO - 'HOME': '/home/cltbld', 16:57:16 INFO - 'LANG': 'en_US.UTF-8', 16:57:16 INFO - 'LANGUAGE': 'en_US:en', 16:57:16 INFO - 'LOGNAME': 'cltbld', 16:57:16 INFO - 'MAIL': '/var/mail/cltbld', 16:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:16 INFO - 'MOZ_NO_REMOTE': '1', 16:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:16 INFO - 'NO_EM_RESTART': '1', 16:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:16 INFO - 'PWD': '/builds/slave/test', 16:57:16 INFO - 'SHELL': '/bin/bash', 16:57:16 INFO - 'SHLVL': '1', 16:57:16 INFO - 'TERM': 'linux', 16:57:16 INFO - 'TMOUT': '86400', 16:57:16 INFO - 'USER': 'cltbld', 16:57:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:16 INFO - '_': '/tools/buildbot/bin/python'} 16:57:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:57:17 INFO - Downloading/unpacking pip>=1.5 16:57:17 INFO - Running setup.py egg_info for package pip 16:57:17 INFO - warning: no files found matching 'pip/cacert.pem' 16:57:17 INFO - warning: no files found matching '*.html' under directory 'docs' 16:57:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:57:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:57:17 INFO - Installing collected packages: pip 16:57:17 INFO - Found existing installation: pip 1.1 16:57:17 INFO - Uninstalling pip: 16:57:17 INFO - Successfully uninstalled pip 16:57:17 INFO - Running setup.py install for pip 16:57:17 INFO - warning: no files found matching 'pip/cacert.pem' 16:57:17 INFO - warning: no files found matching '*.html' under directory 'docs' 16:57:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:57:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:57:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:57:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:57:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:57:17 INFO - Successfully installed pip 16:57:17 INFO - Cleaning up... 16:57:17 INFO - Return code: 0 16:57:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57: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')]} 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:17 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:17 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 16:57:17 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 16:57:17 INFO - Using env: {'DISPLAY': ':0', 16:57:17 INFO - 'HOME': '/home/cltbld', 16:57:17 INFO - 'LANG': 'en_US.UTF-8', 16:57:17 INFO - 'LANGUAGE': 'en_US:en', 16:57:17 INFO - 'LOGNAME': 'cltbld', 16:57:17 INFO - 'MAIL': '/var/mail/cltbld', 16:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:17 INFO - 'MOZ_NO_REMOTE': '1', 16:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:17 INFO - 'NO_EM_RESTART': '1', 16:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:17 INFO - 'PWD': '/builds/slave/test', 16:57:17 INFO - 'SHELL': '/bin/bash', 16:57:17 INFO - 'SHLVL': '1', 16:57:17 INFO - 'TERM': 'linux', 16:57:17 INFO - 'TMOUT': '86400', 16:57:17 INFO - 'USER': 'cltbld', 16:57:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:17 INFO - '_': '/tools/buildbot/bin/python'} 16:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:17 INFO - Downloading/unpacking psutil>=3.1.1 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:19 INFO - Installing collected packages: psutil 16:57:19 INFO - Running setup.py install for psutil 16:57:19 INFO - building 'psutil._psutil_linux' extension 16:57:19 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 16:57:19 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 16:57:19 INFO - building 'psutil._psutil_posix' extension 16:57:19 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 16:57:19 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 16:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:19 INFO - Successfully installed psutil 16:57:19 INFO - Cleaning up... 16:57:19 INFO - Return code: 0 16:57:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:57:19 INFO - Using env: {'DISPLAY': ':0', 16:57:19 INFO - 'HOME': '/home/cltbld', 16:57:19 INFO - 'LANG': 'en_US.UTF-8', 16:57:19 INFO - 'LANGUAGE': 'en_US:en', 16:57:19 INFO - 'LOGNAME': 'cltbld', 16:57:19 INFO - 'MAIL': '/var/mail/cltbld', 16:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:19 INFO - 'MOZ_NO_REMOTE': '1', 16:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:19 INFO - 'NO_EM_RESTART': '1', 16:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:19 INFO - 'PWD': '/builds/slave/test', 16:57:19 INFO - 'SHELL': '/bin/bash', 16:57:19 INFO - 'SHLVL': '1', 16:57:19 INFO - 'TERM': 'linux', 16:57:19 INFO - 'TMOUT': '86400', 16:57:19 INFO - 'USER': 'cltbld', 16:57:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:19 INFO - '_': '/tools/buildbot/bin/python'} 16:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:21 INFO - Installing collected packages: mozsystemmonitor 16:57:21 INFO - Running setup.py install for mozsystemmonitor 16:57:21 INFO - Successfully installed mozsystemmonitor 16:57:21 INFO - Cleaning up... 16:57:21 INFO - Return code: 0 16:57:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57:21 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')]} 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:21 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')]} 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:21 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:21 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 16:57:21 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 16:57:21 INFO - Using env: {'DISPLAY': ':0', 16:57:21 INFO - 'HOME': '/home/cltbld', 16:57:21 INFO - 'LANG': 'en_US.UTF-8', 16:57:21 INFO - 'LANGUAGE': 'en_US:en', 16:57:21 INFO - 'LOGNAME': 'cltbld', 16:57:21 INFO - 'MAIL': '/var/mail/cltbld', 16:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:21 INFO - 'MOZ_NO_REMOTE': '1', 16:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:21 INFO - 'NO_EM_RESTART': '1', 16:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:21 INFO - 'PWD': '/builds/slave/test', 16:57:21 INFO - 'SHELL': '/bin/bash', 16:57:21 INFO - 'SHLVL': '1', 16:57:21 INFO - 'TERM': 'linux', 16:57:21 INFO - 'TMOUT': '86400', 16:57:21 INFO - 'USER': 'cltbld', 16:57:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:21 INFO - '_': '/tools/buildbot/bin/python'} 16:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:22 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 16:57:22 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 16:57:22 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 16:57:22 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 16:57:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:22 INFO - warning: no files found matching '*.txt' 16:57:22 INFO - no previously-included directories found matching 'build' 16:57:22 INFO - no previously-included directories found matching 'dist' 16:57:22 INFO - no previously-included directories found matching '.git*' 16:57:22 INFO - Installing collected packages: jsonschema, functools32 16:57:22 INFO - Running setup.py install for functools32 16:57:22 INFO - warning: no files found matching '*.txt' 16:57:22 INFO - no previously-included directories found matching 'build' 16:57:22 INFO - no previously-included directories found matching 'dist' 16:57:22 INFO - no previously-included directories found matching '.git*' 16:57:22 INFO - Successfully installed jsonschema functools32 16:57:22 INFO - Cleaning up... 16:57:22 INFO - Return code: 0 16:57:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:22 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:22 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 16:57:22 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 16:57:22 INFO - Using env: {'DISPLAY': ':0', 16:57:22 INFO - 'HOME': '/home/cltbld', 16:57:22 INFO - 'LANG': 'en_US.UTF-8', 16:57:22 INFO - 'LANGUAGE': 'en_US:en', 16:57:22 INFO - 'LOGNAME': 'cltbld', 16:57:22 INFO - 'MAIL': '/var/mail/cltbld', 16:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:22 INFO - 'MOZ_NO_REMOTE': '1', 16:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:22 INFO - 'NO_EM_RESTART': '1', 16:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:22 INFO - 'PWD': '/builds/slave/test', 16:57:22 INFO - 'SHELL': '/bin/bash', 16:57:22 INFO - 'SHLVL': '1', 16:57:22 INFO - 'TERM': 'linux', 16:57:22 INFO - 'TMOUT': '86400', 16:57:22 INFO - 'USER': 'cltbld', 16:57:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:22 INFO - '_': '/tools/buildbot/bin/python'} 16:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:23 INFO - Cleaning up... 16:57:23 INFO - Return code: 0 16:57:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:23 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:23 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 16:57:23 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 16:57:23 INFO - Using env: {'DISPLAY': ':0', 16:57:23 INFO - 'HOME': '/home/cltbld', 16:57:23 INFO - 'LANG': 'en_US.UTF-8', 16:57:23 INFO - 'LANGUAGE': 'en_US:en', 16:57:23 INFO - 'LOGNAME': 'cltbld', 16:57:23 INFO - 'MAIL': '/var/mail/cltbld', 16:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:23 INFO - 'MOZ_NO_REMOTE': '1', 16:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:23 INFO - 'NO_EM_RESTART': '1', 16:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:23 INFO - 'PWD': '/builds/slave/test', 16:57:23 INFO - 'SHELL': '/bin/bash', 16:57:23 INFO - 'SHLVL': '1', 16:57:23 INFO - 'TERM': 'linux', 16:57:23 INFO - 'TMOUT': '86400', 16:57:23 INFO - 'USER': 'cltbld', 16:57:23 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:23 INFO - '_': '/tools/buildbot/bin/python'} 16:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:24 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 16:57:24 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 16:57:24 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 16:57:24 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 16:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:24 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 16:57:24 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 16:57:24 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 16:57:24 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 16:57:24 INFO - Downloading docopt-0.6.1.tar.gz 16:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:24 INFO - Running setup.py install for blobuploader 16:57:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:25 INFO - Running setup.py install for requests 16:57:25 INFO - Running setup.py install for docopt 16:57:25 INFO - Successfully installed blobuploader requests docopt 16:57:25 INFO - Cleaning up... 16:57:25 INFO - Return code: 0 16:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:25 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:25 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 16:57:25 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 16:57:25 INFO - Using env: {'DISPLAY': ':0', 16:57:25 INFO - 'HOME': '/home/cltbld', 16:57:25 INFO - 'LANG': 'en_US.UTF-8', 16:57:25 INFO - 'LANGUAGE': 'en_US:en', 16:57:25 INFO - 'LOGNAME': 'cltbld', 16:57:25 INFO - 'MAIL': '/var/mail/cltbld', 16:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:25 INFO - 'MOZ_NO_REMOTE': '1', 16:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:25 INFO - 'NO_EM_RESTART': '1', 16:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:25 INFO - 'PWD': '/builds/slave/test', 16:57:25 INFO - 'SHELL': '/bin/bash', 16:57:25 INFO - 'SHLVL': '1', 16:57:25 INFO - 'TERM': 'linux', 16:57:25 INFO - 'TMOUT': '86400', 16:57:25 INFO - 'USER': 'cltbld', 16:57:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:25 INFO - '_': '/tools/buildbot/bin/python'} 16:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:25 INFO - Running setup.py (path:/tmp/pip-zt1T61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:25 INFO - Running setup.py (path:/tmp/pip-TH93Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:25 INFO - Running setup.py (path:/tmp/pip-OrIPfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:26 INFO - Running setup.py (path:/tmp/pip-0VwbxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:26 INFO - Running setup.py (path:/tmp/pip-HuSQu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:26 INFO - Running setup.py (path:/tmp/pip-fRSBhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:26 INFO - Running setup.py (path:/tmp/pip-WaQ_xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:26 INFO - Running setup.py (path:/tmp/pip-bAuGbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:26 INFO - Running setup.py (path:/tmp/pip-_pEiCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:26 INFO - Running setup.py (path:/tmp/pip-g67d1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:26 INFO - Running setup.py (path:/tmp/pip-1iv3pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:26 INFO - Running setup.py (path:/tmp/pip-Uy3TlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:26 INFO - Running setup.py (path:/tmp/pip-tJGGbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:26 INFO - Running setup.py (path:/tmp/pip-Hn2S9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:26 INFO - Running setup.py (path:/tmp/pip-eIYKiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:26 INFO - Running setup.py (path:/tmp/pip-iPxMPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:26 INFO - Running setup.py (path:/tmp/pip-IVy1WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:26 INFO - Running setup.py install for manifestparser 16:57:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Running setup.py install for mozcrash 16:57:27 INFO - Running setup.py install for mozdebug 16:57:27 INFO - Running setup.py install for mozdevice 16:57:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Running setup.py install for mozfile 16:57:27 INFO - Running setup.py install for mozhttpd 16:57:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Running setup.py install for mozinfo 16:57:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Running setup.py install for mozInstall 16:57:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:27 INFO - Running setup.py install for mozleak 16:57:27 INFO - Running setup.py install for mozlog 16:57:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Running setup.py install for moznetwork 16:57:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Running setup.py install for mozprocess 16:57:28 INFO - Running setup.py install for mozprofile 16:57:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Running setup.py install for mozrunner 16:57:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Running setup.py install for mozscreenshot 16:57:28 INFO - Running setup.py install for moztest 16:57:28 INFO - Running setup.py install for mozversion 16:57:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:28 INFO - Cleaning up... 16:57:28 INFO - Return code: 0 16:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:28 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:28 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 16:57:28 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 16:57:28 INFO - Using env: {'DISPLAY': ':0', 16:57:28 INFO - 'HOME': '/home/cltbld', 16:57:28 INFO - 'LANG': 'en_US.UTF-8', 16:57:28 INFO - 'LANGUAGE': 'en_US:en', 16:57:28 INFO - 'LOGNAME': 'cltbld', 16:57:28 INFO - 'MAIL': '/var/mail/cltbld', 16:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:28 INFO - 'MOZ_NO_REMOTE': '1', 16:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:28 INFO - 'NO_EM_RESTART': '1', 16:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:28 INFO - 'PWD': '/builds/slave/test', 16:57:28 INFO - 'SHELL': '/bin/bash', 16:57:28 INFO - 'SHLVL': '1', 16:57:28 INFO - 'TERM': 'linux', 16:57:28 INFO - 'TMOUT': '86400', 16:57:28 INFO - 'USER': 'cltbld', 16:57:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:28 INFO - '_': '/tools/buildbot/bin/python'} 16:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:28 INFO - Running setup.py (path:/tmp/pip-vjdIGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:29 INFO - Running setup.py (path:/tmp/pip-hzSA_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:29 INFO - Running setup.py (path:/tmp/pip-kIsKYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:29 INFO - Running setup.py (path:/tmp/pip-iD_2O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:29 INFO - Running setup.py (path:/tmp/pip-hgPi2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:29 INFO - Running setup.py (path:/tmp/pip-O_m0Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:29 INFO - Running setup.py (path:/tmp/pip-ENo4Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:29 INFO - Running setup.py (path:/tmp/pip-HmREHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:29 INFO - Running setup.py (path:/tmp/pip-rve3ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:29 INFO - Running setup.py (path:/tmp/pip-25RWDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:29 INFO - Running setup.py (path:/tmp/pip-c14kcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:29 INFO - Running setup.py (path:/tmp/pip-bdUbka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:29 INFO - Running setup.py (path:/tmp/pip-HQ8D0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:29 INFO - Running setup.py (path:/tmp/pip-g4Ks0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:29 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)) 16:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:29 INFO - Running setup.py (path:/tmp/pip-11a1Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:30 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)) 16:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:30 INFO - Running setup.py (path:/tmp/pip-o9A9MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:30 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)) 16:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:30 INFO - Running setup.py (path:/tmp/pip-BYMN0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:30 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)) 16:57:30 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)) 16:57:30 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)) 16:57:30 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)) 16:57:30 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)) 16:57:30 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)) 16:57:30 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)) 16:57:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:31 INFO - Downloading blessings-1.6.tar.gz 16:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:31 INFO - Installing collected packages: blessings 16:57:31 INFO - Running setup.py install for blessings 16:57:31 INFO - Successfully installed blessings 16:57:31 INFO - Cleaning up... 16:57:31 INFO - Return code: 0 16:57:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:31 INFO - Reading from file tmpfile_stdout 16:57:31 INFO - Current package versions: 16:57:31 INFO - argparse == 1.2.1 16:57:31 INFO - blessings == 1.6 16:57:31 INFO - blobuploader == 1.2.4 16:57:31 INFO - docopt == 0.6.1 16:57:31 INFO - functools32 == 3.2.3-2 16:57:31 INFO - jsonschema == 2.5.1 16:57:31 INFO - manifestparser == 1.1 16:57:31 INFO - mozInstall == 1.13 16:57:31 INFO - mozcrash == 1.0 16:57:31 INFO - mozdebug == 0.1 16:57:31 INFO - mozdevice == 0.51 16:57:31 INFO - mozfile == 1.2 16:57:31 INFO - mozhttpd == 0.7 16:57:31 INFO - mozinfo == 0.10 16:57:31 INFO - mozleak == 0.1 16:57:31 INFO - mozlog == 3.5 16:57:31 INFO - moznetwork == 0.27 16:57:31 INFO - mozprocess == 0.25 16:57:31 INFO - mozprofile == 0.28 16:57:31 INFO - mozrunner == 6.13 16:57:31 INFO - mozscreenshot == 0.1 16:57:31 INFO - mozsystemmonitor == 0.3 16:57:31 INFO - moztest == 0.8 16:57:31 INFO - mozversion == 1.4 16:57:31 INFO - psutil == 3.1.1 16:57:31 INFO - requests == 1.2.3 16:57:31 INFO - wsgiref == 0.1.2 16:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:31 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:31 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 16:57:31 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 16:57:31 INFO - Using env: {'DISPLAY': ':0', 16:57:31 INFO - 'HOME': '/home/cltbld', 16:57:31 INFO - 'LANG': 'en_US.UTF-8', 16:57:31 INFO - 'LANGUAGE': 'en_US:en', 16:57:31 INFO - 'LOGNAME': 'cltbld', 16:57:31 INFO - 'MAIL': '/var/mail/cltbld', 16:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:31 INFO - 'MOZ_NO_REMOTE': '1', 16:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:31 INFO - 'NO_EM_RESTART': '1', 16:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:31 INFO - 'PWD': '/builds/slave/test', 16:57:31 INFO - 'SHELL': '/bin/bash', 16:57:31 INFO - 'SHLVL': '1', 16:57:31 INFO - 'TERM': 'linux', 16:57:31 INFO - 'TMOUT': '86400', 16:57:31 INFO - 'USER': 'cltbld', 16:57:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:31 INFO - '_': '/tools/buildbot/bin/python'} 16:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 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)) 16:57:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:57:31 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 16:57:31 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 16:57:31 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 16:57:31 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 16:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:57:33 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)) 16:57:33 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)) 16:57:33 INFO - Installing collected packages: simplejson 16:57:33 INFO - Running setup.py install for simplejson 16:57:33 INFO - building 'simplejson._speedups' extension 16:57:33 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 16:57:34 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 16:57:34 INFO - Successfully installed simplejson 16:57:34 INFO - Cleaning up... 16:57:34 INFO - Return code: 0 16:57:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:34 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 0x1fad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2178a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', '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 16:57:34 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 16:57:34 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 16:57:34 INFO - Using env: {'DISPLAY': ':0', 16:57:34 INFO - 'HOME': '/home/cltbld', 16:57:34 INFO - 'LANG': 'en_US.UTF-8', 16:57:34 INFO - 'LANGUAGE': 'en_US:en', 16:57:34 INFO - 'LOGNAME': 'cltbld', 16:57:34 INFO - 'MAIL': '/var/mail/cltbld', 16:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:34 INFO - 'MOZ_NO_REMOTE': '1', 16:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:34 INFO - 'NO_EM_RESTART': '1', 16:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:34 INFO - 'PWD': '/builds/slave/test', 16:57:34 INFO - 'SHELL': '/bin/bash', 16:57:34 INFO - 'SHLVL': '1', 16:57:34 INFO - 'TERM': 'linux', 16:57:34 INFO - 'TMOUT': '86400', 16:57:34 INFO - 'USER': 'cltbld', 16:57:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:34 INFO - '_': '/tools/buildbot/bin/python'} 16:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:57:34 INFO - Cleaning up... 16:57:34 INFO - Return code: 0 16:57:34 INFO - Running post-action listener: _resource_record_post_action 16:57:34 INFO - Running post-action listener: _start_resource_monitoring 16:57:34 INFO - Starting resource monitoring. 16:57:34 INFO - [mozharness: 2017-08-23 23:57:34.479393Z] Finished create-virtualenv step (success) 16:57:34 INFO - [mozharness: 2017-08-23 23:57:34.479915Z] Running install step. 16:57:34 INFO - Running pre-action listener: _resource_record_pre_action 16:57:34 INFO - Running main action method: install 16:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:34 INFO - Reading from file tmpfile_stdout 16:57:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:34 INFO - Reading from file tmpfile_stdout 16:57:34 INFO - Output received: 16:57:34 INFO - Usage: mozinstall [options] installer 16:57:34 INFO - Options: 16:57:34 INFO - -h, --help show this help message and exit 16:57:34 INFO - -d DEST, --destination=DEST 16:57:34 INFO - Directory to install application into. [default: 16:57:34 INFO - "/builds/slave/test"] 16:57:34 INFO - --app=APP Application being installed. [default: firefox] 16:57:34 INFO - mkdir: /builds/slave/test/build/application 16:57:34 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'] 16:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:57:52 INFO - Reading from file tmpfile_stdout 16:57:52 INFO - Output received: 16:57:52 INFO - /builds/slave/test/build/application/firefox/firefox 16:57:52 INFO - Running post-action listener: _resource_record_post_action 16:57:52 INFO - [mozharness: 2017-08-23 23:57:52.519160Z] Finished install step (success) 16:57:52 INFO - [mozharness: 2017-08-23 23:57:52.519445Z] Running setup-mitmproxy step. 16:57:52 INFO - Running pre-action listener: _resource_record_pre_action 16:57:52 INFO - Running main action method: setup_mitmproxy 16:57:52 INFO - Skipping: mitmproxy is not required 16:57:52 INFO - Running post-action listener: _resource_record_post_action 16:57:52 INFO - [mozharness: 2017-08-23 23:57:52.520586Z] Finished setup-mitmproxy step (success) 16:57:52 INFO - [mozharness: 2017-08-23 23:57:52.520807Z] Running run-tests step. 16:57:52 INFO - Running pre-action listener: _resource_record_pre_action 16:57:52 INFO - Running pre-action listener: _set_gcov_prefix 16:57:52 INFO - Running main action method: run_tests 16:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:57:52 INFO - Python 2.7.3 16:57:52 INFO - Return code: 0 16:57:52 INFO - grabbing minidump binary from tooltool 16:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2319130>, '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 0x231a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231a4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:57:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:57:52 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:57:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:57:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:57:52 INFO - Return code: 0 16:57:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:57:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:57:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:57:52 INFO - ENV: RUST_BACKTRACE is now full 16:57:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:57:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:57:52 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:57:52 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 16:57:52 INFO - Using env: {'DISPLAY': ':0', 16:57:52 INFO - 'HOME': '/home/cltbld', 16:57:52 INFO - 'LANG': 'en_US.UTF-8', 16:57:52 INFO - 'LANGUAGE': 'en_US:en', 16:57:52 INFO - 'LOGNAME': 'cltbld', 16:57:52 INFO - 'MAIL': '/var/mail/cltbld', 16:57:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:57:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:57:52 INFO - 'MOZ_ACCELERATED': '1', 16:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:52 INFO - 'MOZ_NO_REMOTE': '1', 16:57:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:57:52 INFO - 'MOZ_WEBRENDER': '1', 16:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:52 INFO - 'NO_EM_RESTART': '1', 16:57:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:52 INFO - 'PWD': '/builds/slave/test', 16:57:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:57:52 INFO - 'RUST_BACKTRACE': 'full', 16:57:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:57:52 INFO - 'SHELL': '/bin/bash', 16:57:52 INFO - 'SHLVL': '1', 16:57:52 INFO - 'TERM': 'linux', 16:57:52 INFO - 'TMOUT': '86400', 16:57:52 INFO - 'USER': 'cltbld', 16:57:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412', 16:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:52 INFO - '_': '/tools/buildbot/bin/python'} 16:57:52 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:57:52 INFO - mozversion application_buildid: 20170823230708 16:57:52 INFO - mozversion application_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 16:57:52 INFO - mozversion application_display_name: Nightly 16:57:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:52 INFO - mozversion application_name: Firefox 16:57:52 INFO - mozversion application_remotingname: firefox 16:57:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:57:52 INFO - mozversion application_vendor: Mozilla 16:57:52 INFO - mozversion application_version: 57.0a1 16:57:52 INFO - mozversion platform_buildid: 20170823230708 16:57:52 INFO - mozversion platform_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 16:57:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:57:52 INFO - mozversion platform_version: 57.0a1 16:57:52 INFO - using testdate: 1503532672 16:57:52 INFO - actual date: 1503532672 16:57:52 INFO - starting webserver on 'localhost:52728' 16:57:52 INFO - SUITE-START | Running 2 tests 16:57:52 INFO - TEST-START | dromaeo_css 16:57:52 INFO - Initialising browser for dromaeo_css test... 16:57:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52728/getInfo.html -profile /tmp/tmpZS00yO/profile 16:57:52 INFO - TEST-INFO | started process 17690 (/builds/slave/test/build/application/firefox/firefox http://localhost:52728/getInfo.html) 16:57:58 INFO - TEST-INFO | 17690: exit 0 16:57:58 INFO - Browser initialized. 16:57:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:58 INFO - TEST-INFO | started process 17873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZS00yO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:59 INFO - PID 17873 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:57:59 INFO - PID 17873 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:58:00 INFO - PID 17873 | 16:58:00 INFO - PID 17873 | (/builds/slave/test/build/application/firefox/firefox:17932): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:58:00 INFO - PID 17873 | 16:58:00 INFO - PID 17873 | 16:58:00 INFO - PID 17873 | (/builds/slave/test/build/application/firefox/firefox:17990): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:58:00 INFO - PID 17873 | 16:58:00 INFO - PID 17873 | __metrics Screen width/height:1600/1200 16:58:00 INFO - PID 17873 | colorDepth:24 16:58:00 INFO - PID 17873 | Browser inner width/height: 1024/768 16:58:00 INFO - PID 17873 | __metrics 16:58:10 INFO - PID 17873 | RSS: Main: 202190848 16:58:10 INFO - PID 17873 | 16:58:13 INFO - PID 17873 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:01:09 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52728/tests/dromaeo/cssquery-ext.html) 17:01:10 INFO - PID 17873 | RSS: Main: 212516864 17:01:10 INFO - PID 17873 | 17:04:12 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-ext.html (next: http://localhost:52728/tests/dromaeo/cssquery-jquery.html) 17:04:13 INFO - PID 17873 | RSS: Main: 210653184 17:04:13 INFO - PID 17873 | 17:07:15 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52728/tests/dromaeo/cssquery-mootools.html) 17:07:16 INFO - PID 17873 | RSS: Main: 212418560 17:07:16 INFO - PID 17873 | 17:10:18 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52728/tests/dromaeo/cssquery-prototype.html) 17:10:18 INFO - PID 17873 | RSS: Main: 210767872 17:10:18 INFO - PID 17873 | 17:13:23 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52728/tests/dromaeo/cssquery-yui.html) 17:13:23 INFO - PID 17873 | RSS: Main: 212226048 17:13:23 INFO - PID 17873 | 17:16:25 INFO - PID 17873 | Cycle 1(1): loaded http://localhost:52728/tests/dromaeo/cssquery-yui.html (next: http://localhost:52728/tests/dromaeo/cssquery-dojo.html) 17:16:26 INFO - PID 17873 | RSS: Main: 217276416 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | __start_tp_report 17:16:26 INFO - PID 17873 | _x_x_mozilla_page_load 17:16:26 INFO - PID 17873 | _x_x_mozilla_page_load_details 17:16:26 INFO - PID 17873 | |i|pagename|runs| 17:16:26 INFO - PID 17873 | |0;dojo.html;3233.967660323396;3239.271163988103;3245.1887028242936;3260.1034715453234;3272.509123631455;6144.5391595630335;6161.661108639023;6184.381561843813;6211.161493198417;6231.875362492753;6061.363556826536;6166.568340216187;6169.629822210659;6184.072389141631;6207.937920620792;5649.689267090308;5672.744726487297;5681.11942648888;5685.658860468365;5694.288213973254;5709.486146246837;5713.257276554042;5717.599768016241;5721.9427805721825;5723.54211663066;5697.6866272355;5727;5730.971345143268;5735.770569177228;5737.770489180449;5649.209110724522;5678.432156784289;5687.687177205252;5689.260396148516;5711.314642242936;5548.306461692288;5630.577706671975;5685.687287199203;5715.885682286373;5775.5668324875805;5941.049432090845;6128.17269668598;6135.294441139237;6191.597546159485;6196.039613859859;6527.836804079936;6540.247871494791;6567;6574.868502629921;6669.733210671568;6729.427998620124;6755.763548275836;6767.289434609344;6787.151606049244;6794.184697836291;6193.566450348432;6201.379862013808;6280.685965701742;6299.0551417287315;6304.747810087637;6838.452923766186;6869.656517174121;6916.792496225121;6936.861262774716;6951;6358.395952384516;6522.706478208492;6577.309382514863;6594.142761440982;6687.732490700318;6281.623102613858;6613.4709223262025;6637.668116594247;6641.966790166115;6663.4669226461765;6275.3724627537795;6633.933660663428;6641.933580664228;6655.600663960178;6725.495587830835;6560.245571759213;6595.604263744095;6656.73373065072;6709.932900671029;6713.1272934519175;5078.035173317058;5273.604479664041;5339.492748188916;5351.464853514695;5399.487048730364;4543.045960348298;4570.954290457119;4575.565321294472;4579.931301030487;4648.511906249795;5851.414858514115;5862.237909071793;5864.912026319608;5867.3839246879315;5867.823965281048;6648.933510664831;6670.199576050808;6681.5656982296;6706.966465167643;6722.798316050526;5792.218050563204;5842.269716285465;5875.441833025856;5879.735411906475;5886.3230728465915;5686.914696279559;5752.13717942312;5781.768729250783;5786.826395208151;5849.473547380756;6240.31356550779;6283.37166283368;6288.937110628926;6295.685215739195;6307.463865571478;6543.443807276435;6583.670816459254;6597.538172327891;6613.173353330833;6620.735170593219;6225;6264.49884009269;6283.183186185766;6286.119943208046;6312.400321969406;5757.769689212552;6478.5141114415665;6487.870242595027;6562.278149403466;6645.60126392418;6645.435138013323;6660.034295027291;6663.333666633492;6740.359665831738;6740.561863478858;6268.059791031199;6300.275468321019;6390.648514331757;6442.226932768098;6448.5163612730175;6427.550071495138;6537.640429776408;6548.672566371758;6560.671966401565;6562.442192413699;6250.0937364082865;6251.031090181029;6271.843203919939;6277.089821975696;6303.46420554258;6306.432421082125;6387.680615969276;6388.329225431263;6408.87844627179;6444.871102578016;6150;6157.138000679819;6226.128342032029;6268.686565671789;6287.811365659038 17:16:26 INFO - PID 17873 | |1;ext.html;802.193795235788;829.2785276809175;858.296197118363;859.8581234096371;1129.6441620889414;29390.265243368925;31010.84494577527;40060.39909401358;40539;40694.38958415626;40721.38917916234;41252.79373603128;41402.37896431556;41439;41584.79207603965;7746.225377462265;7781;7819;7824.72613458529;7834;7790;7836.72571459999;7839.255270749298;7848.175941526143;7853.5680537570415;7838.490498117604;7912.367010639135;7925.722599709012;7929.088154862207;7941.523508589475;7826.804329891741;7861.764147075597;7865.2134786521465;7887.171846956045;7921.881171782428;7758.185390534026;7761.689532418696;7769.689212431496;7770.961145194238;7774.689012439496;36354.27291454156;36355.45466818;36557.45163822545;36616.45075323872;36676.81661591675;3526.365254254233;3546.397112490857;3552.3250582389524;3568.1614820517157;3578.0697018775045;30443.543346849816;30588.8470557648;30591.235219119477;30606.846965765253;30651.693483065108;4967.081089998362;5139.537441630234;5149;5210.4268530461995;5223.112070947948;168303;168375;168451;169075;169298;44467.77766111149;44799.55200448019;44877.32684009743;44918.32622510665;45036.54963450324;46955;51063.74468127636;52443.47556524386;52524.474755252726;52629.473705262455;14535.345909433889;14564.49024284166;14588.854111458963;14608.269586520631;14608.34262458192;11437.656870293904;11637.359945203096;11648.94175529117;11667.241629294069;11956.163068585289;14206.715865682629;14310.713785724436;14409.85590144106;14419.35112919921;14632.122072675673;5482.205080263339;5578.30271216098;5642.802501912413;5700.9429905701245;5734.225879506297;961.9134277915022;968.4092703450889;995.8008398320364;995.9053889880449;1003.3227571389428;22577.548449030928;22597.322080337617;22619.88690056572;22710.772892271198;22924.9683764231;1099.6810924831868;1104.1829046505527;1106.3583121789343;1111.9054880335261;1112.8497652816927;11988.52045918171;12034.338111403957;12037;12091;12114.454849531792;211296;220482;221292;221696;223814;43974.340384894254;50479.747601261755;50890.236646450336;50959.235611465854;51235.487645123816;1432.4771458417601;1437.4609521429463;1446.8914831387688;1448.73922693914;1448.9637759056109;25763;26401.207963761117;26578;26861.52051797126;27264.591031134947;36260.27479450449;36392.45411318779;36473.452898206015;36500.26999460049;36522;190429;192513;192671;193477;193578;33764.83117584397;33772;33796.81711140098;33833.66166338305;34185.145371365914;40570.59429405668;41136.38295425631;41726.16547668969;41766;42278.365824513276;30758.077257682304;30934.535981959838;30994.380112397175;31200.21999449941;31818.84090579532;30024.24939376533;30268.394632107676;30686;30701.692983069883;30730.84634576813;34584.82707586446;34590.82704586461;34628.82685586556;34834.47748283727;35054.824725876206;29522;29878.402431950806;30048.3990320188;31171;31202.21994450157;22512.212072577382;22874.77125228793;23086.538269234858;23182.536349273258;23621 17:16:26 INFO - PID 17873 | |2;jquery.html;546.1589152704832;552.544151075363;556.3157316500702;562.6652141975526;563.3802816901408;21421.250256241034;22329.330120096383;22369.55260894781;22390.88804555979;22394.88802555985;23419.41451463714;24331.39171520713;24436;24539.75460245397;24568.38579035525;6712.530122891388;6863.588184708909;6868.416184624313;6881.105456290676;6882.965585172092;6724.697388617524;6760.560563563377;6765.695543700521;6766.188057433115;6774.593524388528;5877.588568800185;6457.096006559085;6458.612483250997;6478.93521064788;6489.4483968862705;6397.968010159942;6426.518011149183;6439.291677915426;6485.3514648534765;6493.577917435352;6001.729922153513;6027.216461859974;6028.969855150696;6032.245969253843;6039.969800151015;27192.504412257316;27668.86165569159;27945.161645150678;28155.85922070397;28399.71600284012;2032.562998955217;2097.224027109964;2101.4746313421647;2105.663093904968;2108.104055776289;19215.231390744353;19744.901275493532;19862.70205946912;19898.104585293695;19900;2349.5418393413293;2353.599888019041;2374.798142157919;2391.198948352304;2415.8188135889877;131303;135734;135892.32053839767;136081.3195934014;136764;14191.361388737532;14317.140971541741;14337.928310358382;14657.413703451955;15222.619434514225;21877.12491500354;21903.67144492834;21967.450813729785;22218.888905555694;22221.11115555392;9893.406395616286;10125.291229613857;10246.48767561619;10286.588536458608;10311.278210525341;9333.579988900516;9526.809463810823;9548.522573871278;9571.234301255883;9641.903580964101;8512.787180320418;8540.487570745776;8739.475631462006;8871.201591856763;9185.678501252423;2604.9869750651123;2627.618995245717;2677.718839521861;2680.370113023438;2781.0544414898627;912.8904531456268;931.1228304539007;933.2300851797295;936.3071327217809;945.9006804285589;18724.625507489774;18771.421038755798;18995.715064274045;19268.518287042934;19362.225510979686;993.4089216915924;994.4580203788952;1002.5137808163036;1003.372891942536;1018.9439580823126;9987.900120998696;10024;10051.296409251428;10172.643957461454;10279.588816447407;444240;455890;457533;464696;465279;111628;112507.4374628138;112961.43519282516;113397;115143.42428287973;1119.9776004479866;1158.9130815188894;1163.650904728595;1164.7903377392151;1174.1194104421684;16436.75344869804;16467.917660411622;16566.254518546935;16640.83359166393;16901.323947042474;50132.49867501424;53115.20327195172;53961;54089.72955135199;54969;63000.36999629945;64630;64773.67613161904;65249.67375163094;65400.34599653943;14255.215963121713;14286.142831430148;14333.784993224901;14472.204028778096;14520.273986300854;22062.676239425688;22144.889275554164;22460.663090053335;22544.098236070375;22643.88678056599;17800.287988480835;17965.461036168414;18304.816951830842;18378.264869405608;18752.249910003447;16595.336186552402;17084.231209595848;17139.228734707216;17626.20682069284;17684.204210810803;19749.308774192836;19869.801301986794;20001.199952001756;20013.299534516224;20022.59954800925;13961.860381396056;14429.567112986628;14511;14631.780523291945;14642.560723178321;18556.257749689863;18622.72065918985;18732.812671873107;18846.52883677864;18908 17:16:26 INFO - PID 17873 | |3;mootools.html;1281.5706738242689;1338.2171429713617;1338.370965646146;1344.227069435075;1345.9798103028454;14261.215633140173;14942.327595258212;14969.10185388876;14979.176145312003;14985.700285994273;12410.503579856795;12833.743325133491;14498.565043048698;14869.405223791035;14962.32669529871;2572.511222867654;2605.101240072172;2606.1660268714018;2609.9086531971384;2631.3816253180585;2381.9285421437385;2486.2416962826333;2491.4394261291245;2500.112460076674;2508.736582658822;2519.244226731982;2617.3587471069613;2618.3323252570567;2618.463215040912;2625.698044724862;2516.962245566318;2569.5888657814753;2588.404666926608;2589.1844069118356;2590.7150213476502;2625.4355313607666;2633.499635069331;2639.802014848875;2643.603459481074;2645.08744483153;14437.566872993826;14817.333220005126;14818.03682760617;14833.70332593342;14843.257837108102;7812.453128281023;8077.071136819282;8127.878081828777;8131.430799844014;8156.265936065783;5223.425423203445;5385.811496597639;5564.221009058735;5571.526420254283;5582.665040097607;1867.094459187293;1904.2478221102588;1905.1331644102038;1951.9707204391946;1957.2855907593769;25297.747022529722;25345.36636584082;25425;25480.980760769547;25491.362715932064;6559.47524198063;6603.702833372414;6661.633610151488;6765.154355705537;6875.3124687531845;16436.260368283456;16463.34146634121;16477.505674829776;16543;16564.75152872708;7586.203448637924;7620.123685776096;7648.65581048843;7725.459217854696;7730.729424470116;6995.4753393494675;7113.857722845514;7149.60677162761;7178.138623365126;7198.352148306678;5170.1469257572835;5199.974000130051;5254.395744489356;5300.602454815904;5451.48210919962;1515.1060874084344;1517.9392824286904;1528.8929774915648;1533.2027345780132;1558.7661850722482;754.2269174096594;861.0743450790426;894.1326912894482;901.8511945529045;907.111031189438;8219.630116644765;8370.916290837136;8501.19238672325;8526.31789456842;8703.738887833375;980.2501086668705;1009;1009.6970908727352;1010.7416266747946;1015.3197357770312;5192.948070519322;5359.1157459019605;5369.4362091980565;5395.352557693023;5431.293931788842;20113.899430502755;20627.79372206289;20671.379858604265;20722.896385517975;20981.265655701976;20162;20231.4942126448;20463.8976805115;20569.794302056787;20765.688514672293;10949.890501094887;11222.428859959613;11298.774024519464;11321.150913681508;11363.431828408711;7728.504348780659;7872.1340652529325;8064.677412903418;8166.918330816616;8261;17727.645447091243;18048.729269060714;18143.183556739714;18341.633167336313;18773.249070037047;18261.634767304844;18550.814491854908;18665.72001420007;18914;19422.611547769247;10501.31741436804;10824.484572160061;10855.45722713877;11420.143489238506;11593.768124637629;13477.258750768802;13543.255120968048;13568.38942247621;13596.93201533986;13616.319184040956;10479.10927571165;10505.842412363667;10677.89322106769;10761.515731792244;10813;10654.307470014424;10713.089387402159;11090.833637495283;11177.888221117684;11234;9803.803923921625;9832.410055396698;9920.702378928643;9965;9967.700968970943;7100.218975912542;7224.819379515554;7234.6020968847215;7300.96349518249;7371.336579707638;7093.609851458013;7139.964300178466;7248.202697703143;7284.344409003215;7341.375983041501 17:16:26 INFO - PID 17873 | |4;prototype.html;496.1567386484615;502.7151595996198;515.3377909386439;517.2396577031764;523.9214117882317;6135.938640613593;6278.1838361013115;6350.872982540346;6371.745130194792;6417.262014868292;5927.644341339523;6060.575759696823;6071.908921366183;6092.939070609293;6141.416565426277;4959.776810043557;4973.602111831063;5005.699658020512;5047.84856454306;5091.338126043609;4884.877878053042;4988.87527811804;5009.499050094998;5026.371703537058;5056.533605254472;4923.729194894279;4926.531979461945;4953.083679519283;4987.451380348159;4994.950050499503;4883.731394773286;4924.532169443897;4942.3327850740225;4948.1093403187415;4954.925676114861;4421.678618725195;4456.77716114193;4468.977655111737;4476.082403107355;4496.168208881368;6086.817395478142;6120.480723583957;6140.171076904606;6150.477209437203;6171.783987560459;5575.163725441175;5659.688717120557;5693.345265294462;5709.286339207599;5720.742566584514;6545.639989800607;6587.802365928982;6600.669966501704;6643.80068597938;6687.465002799764;4833.081714474239;4838.056578967103;4857.465678775332;4862.197737373329;4876.7808047988;6805.311901798811;6869.587824730532;6895.379415852547;6905.205901321362;6967.82580435483;5019.52314530119;5028.79884804611;5062.772175252123;5067.619928505377;5068.189089745623;4990.80036798524;5051.949480505222;5092.694438333638;5113.897722045613;5134.2298655201275;5605.355384130796;5643.887122257532;5668.546516278688;5697.658140511582;5714.371419143891;6458.644774537445;6524.608523488606;6583.967080164664;6584.275729669733;6593.109930159463;1628.552148159242;1674.2967953459577;1696.8812183147309;1700.7278835386278;1715.845573898355;1176.6999415149253;1185.6739396665814;1190.4464424042687;1220.7802595532712;1235.8887700106854;5683.204351390808;5707.914381284284;5752.597318187687;5755.395683453261;5824.184614154022;6542.182227221598;6564.179477565304;6564.901526477107;6656.201255849329;6678.565893216925;5642.589352661835;5738.196652468658;5791.247137872134;5819.418058194146;5850.414958504116;3563.6792688658147;3567.714582833367;3596.8849656606535;3625.2930678517964;3641.399169137063;6371.980483122678;6442.162518872517;6462.450691691165;6474.741010359533;6531.211897099671;6696.397324240842;6817.386435220854;6852.760153394607;6885.9671049342;6919.827004324932;6360.332165122595;6392.242133413256;6491.4806815455595;6492.220933488012;6549.869002619826;6726.831829204309;6804.183497980076;6821.010953411628;6832.838417468943;6841;6644.966775166094;6681.465482761465;6704.262531121475;6785.93214067853;6813;6447.161868957006;6455.903161452676;6458;6468.967655161694;6580.76967306142;4949.653524253267;4951.455339912679;4955.925661115159;4964.801407943642;4986.775595098156;6738.528303018742;6783.913319439742;6795.93204067953;6805.319468053155;6880.862382752417;6454.806355809334;6455.419012288917;6563.409293163638;6611.107500487565;6683.465322774069;6382.904256436064;6453.838654033687;6478.445173158314;6492.740290388331;6591.373819487141;5988.323269484551;6103.3591472894705;6266.216722909637;6390.48876089921;6405.967970160119;6442.581232219891;6537.986612075136;6553.475721942138;6592.373724496165;6593.307702691149;6219.440250377488;6230.283517395557;6262.248530176408;6324.588901721373;6365.649889256136 17:16:26 INFO - PID 17873 | |5;yui.html;872.9476231426115;881.40064755966;895.892492900852;900.9684661036865;902.6524787956635;18021;19135.42593722187;19165.71251431228;19222;19260.518487037833;17679.82320176798;19675.114619842105;19765.802341976578;19804;19886.602267954633;920.7283851263876;935.8876934767837;940.5861420974784;944.4239014201366;948.7153853843854;868.053821334745;953.6185525789671;957.5212393803098;961.9903800962006;964.2960638733729;1000.9149222316112;1003.9698809035704;1004.1364426593124;1009.3893194617261;1010.1211945607332;986.1272773595348;993.096282383028;998.3810037776552;998.6904059741468;999.0908273471143;732.8827387618009;734.5592644413363;735.1619154164257;735.2867718313228;737.6311844077961;17693.823061769348;17782.644347112986;17895.73156402655;17916.372926947493;19242.71135932962;20361.796382036136;20619.175232990663;20737.688934665992;21390.358289251348;21405.250816221356;15837.208139593089;15852;15972.440964566184;16074.75887861683;16129.596760080974;3517.243792584581;3538.5930617979006;3552.7335449841366;3556.5198698175673;3559.2347645256395;122944;126801;129462.3526882369;130090;130899.34550327282;15316.310766015557;16242.431514896922;16276.837231627533;16324.836751632569;16408.589785255463;29362.853185733933;29617.111486655434;30412.391752165277;30446.391072178434;30515.542266866014;8654.6538138475;8681.479111253346;8872.955635221782;9011.27909767217;9060.501672408082;4215.325547912381;4241.703080784378;4262.062346283813;4291.978540107342;4296.6347860432215;4840.685355451885;4966.15575352191;4987.900241995212;4990.975045124751;4995.650304478724;964.5032808103832;987.782687808681;988.2044953812107;993.0317940008579;1002.1832206751474;618.604093380237;624.7469774741237;626.6428135962458;637.3976592120495;641.2593454559991;11997.941039775033;12014.879851201551;12076.470000998163;12310.938445307716;12315.630531084082;647.3397134922353;653.0628548033492;660.7654282729562;660.9669516524251;666.6566718140161;5485.076117792774;5571.164325351148;5630.85922851932;5669.546436285087;5723.255976723082;112320.87679123267;115557;116388.41805790916;117214;121339;96891;98676;99758.5012074935;104650;105960;85323.57338213269;91746;94420;94497;99539.50230248802;12621.432035558239;12788.872111278768;12833.550825721428;12972.740545189232;13054.673633159247;39392.80303598464;39580.80209598933;40148.1970360597;41375.172496550505;41992.370114447695;51292.23061654004;54528.18207726808;55145;55468.16797747956;55490.44509554853;17665.38171164003;17770.289188432318;17775;17791.377301794375;17877.106144692974;20476.283330083377;20625.278115265894;20700.275490357766;20810.687839682116;20811.8959405202;18772.624547509247;18878.52803679919;18899;19004.619907602046;19295;16536.66926661484;16551.83448165503;16613.418530351864;16701.665966680357;16830.495085147464;17645.20596573183;17953.64092718112;18017.909910450362;18054;18075.457736267934;12104.394780261127;12128.757424851277;12239.69400764988;12298.385080746106;12300.81548776787;12070;12140.453679584616;12240.707329472492;12365.567205148136;12479.376031198586 17:16:26 INFO - PID 17873 | __end_tp_report 17:16:26 INFO - PID 17873 | __start_cc_report 17:16:26 INFO - PID 17873 | _x_x_mozilla_cycle_collect,380 17:16:26 INFO - PID 17873 | __end_cc_report 17:16:26 INFO - PID 17873 | __startTimestamp1503533786130__endTimestamp 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | ------- Summary: start ------- 17:16:26 INFO - PID 17873 | Number of tests: 6 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#0] dojo.html Cycles:165 Average:6093.45 Median:6268.69 stddev:701.01 (11.2%) stddev-sans-first:666.30 17:16:26 INFO - PID 17873 | Values: 3234.0 3239.3 3245.2 3260.1 3272.5 6144.5 6161.7 6184.4 6211.2 6231.9 6061.4 6166.6 6169.6 6184.1 6207.9 5649.7 5672.7 5681.1 5685.7 5694.3 5709.5 5713.3 5717.6 5721.9 5723.5 5697.7 5727.0 5731.0 5735.8 5737.8 5649.2 5678.4 5687.7 5689.3 5711.3 5548.3 5630.6 5685.7 5715.9 5775.6 5941.0 6128.2 6135.3 6191.6 6196.0 6527.8 6540.2 6567.0 6574.9 6669.7 6729.4 6755.8 6767.3 6787.2 6794.2 6193.6 6201.4 6280.7 6299.1 6304.7 6838.5 6869.7 6916.8 6936.9 6951.0 6358.4 6522.7 6577.3 6594.1 6687.7 6281.6 6613.5 6637.7 6642.0 6663.5 6275.4 6633.9 6641.9 6655.6 6725.5 6560.2 6595.6 6656.7 6709.9 6713.1 5078.0 5273.6 5339.5 5351.5 5399.5 4543.0 4571.0 4575.6 4579.9 4648.5 5851.4 5862.2 5864.9 5867.4 5867.8 6648.9 6670.2 6681.6 6707.0 6722.8 5792.2 5842.3 5875.4 5879.7 5886.3 5686.9 5752.1 5781.8 5786.8 5849.5 6240.3 6283.4 6288.9 6295.7 6307.5 6543.4 6583.7 6597.5 6613.2 6620.7 6225.0 6264.5 6283.2 6286.1 6312.4 5757.8 6478.5 6487.9 6562.3 6645.6 6645.4 6660.0 6663.3 6740.4 6740.6 6268.1 6300.3 6390.6 6442.2 6448.5 6427.6 6537.6 6548.7 6560.7 6562.4 6250.1 6251.0 6271.8 6277.1 6303.5 6306.4 6387.7 6388.3 6408.9 6444.9 6150.0 6157.1 6226.1 6268.7 6287.8 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#1] ext.html Cycles:180 Average:35904.99 Median:34609.83 stddev:50384.15 (145.6%) stddev-sans-first:50456.54 17:16:26 INFO - PID 17873 | Values: 802.2 829.3 858.3 859.9 1129.6 29390.3 31010.8 40060.4 40539.0 40694.4 40721.4 41252.8 41402.4 41439.0 41584.8 7746.2 7781.0 7819.0 7824.7 7834.0 7790.0 7836.7 7839.3 7848.2 7853.6 7838.5 7912.4 7925.7 7929.1 7941.5 7826.8 7861.8 7865.2 7887.2 7921.9 7758.2 7761.7 7769.7 7771.0 7774.7 36354.3 36355.5 36557.5 36616.5 36676.8 3526.4 3546.4 3552.3 3568.2 3578.1 30443.5 30588.8 30591.2 30606.8 30651.7 4967.1 5139.5 5149.0 5210.4 5223.1 168303.0 168375.0 168451.0 169075.0 169298.0 44467.8 44799.6 44877.3 44918.3 45036.5 46955.0 51063.7 52443.5 52524.5 52629.5 14535.3 14564.5 14588.9 14608.3 14608.3 11437.7 11637.4 11648.9 11667.2 11956.2 14206.7 14310.7 14409.9 14419.4 14632.1 5482.2 5578.3 5642.8 5700.9 5734.2 961.9 968.4 995.8 995.9 1003.3 22577.5 22597.3 22619.9 22710.8 22925.0 1099.7 1104.2 1106.4 1111.9 1112.8 11988.5 12034.3 12037.0 12091.0 12114.5 211296.0 220482.0 221292.0 221696.0 223814.0 43974.3 50479.7 50890.2 50959.2 51235.5 1432.5 1437.5 1446.9 1448.7 1449.0 25763.0 26401.2 26578.0 26861.5 27264.6 36260.3 36392.5 36473.5 36500.3 36522.0 190429.0 192513.0 192671.0 193477.0 193578.0 33764.8 33772.0 33796.8 33833.7 34185.1 40570.6 41136.4 41726.2 41766.0 42278.4 30758.1 30934.5 30994.4 31200.2 31818.8 30024.2 30268.4 30686.0 30701.7 30730.8 34584.8 34590.8 34628.8 34834.5 35054.8 29522.0 29878.4 30048.4 31171.0 31202.2 22512.2 22874.8 23086.5 23182.5 23621.0 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#2] jquery.html Cycles:180 Average:33250.45 Median:22380.22 stddev:77342.83 (345.6%) stddev-sans-first:77520.82 17:16:26 INFO - PID 17873 | Values: 546.2 552.5 556.3 562.7 563.4 21421.3 22329.3 22369.6 22390.9 22394.9 23419.4 24331.4 24436.0 24539.8 24568.4 6712.5 6863.6 6868.4 6881.1 6883.0 6724.7 6760.6 6765.7 6766.2 6774.6 5877.6 6457.1 6458.6 6478.9 6489.4 6398.0 6426.5 6439.3 6485.4 6493.6 6001.7 6027.2 6029.0 6032.2 6040.0 27192.5 27668.9 27945.2 28155.9 28399.7 2032.6 2097.2 2101.5 2105.7 2108.1 19215.2 19744.9 19862.7 19898.1 19900.0 2349.5 2353.6 2374.8 2391.2 2415.8 131303.0 135734.0 135892.3 136081.3 136764.0 14191.4 14317.1 14337.9 14657.4 15222.6 21877.1 21903.7 21967.5 22218.9 22221.1 9893.4 10125.3 10246.5 10286.6 10311.3 9333.6 9526.8 9548.5 9571.2 9641.9 8512.8 8540.5 8739.5 8871.2 9185.7 2605.0 2627.6 2677.7 2680.4 2781.1 912.9 931.1 933.2 936.3 945.9 18724.6 18771.4 18995.7 19268.5 19362.2 993.4 994.5 1002.5 1003.4 1018.9 9987.9 10024.0 10051.3 10172.6 10279.6 444240.0 455890.0 457533.0 464696.0 465279.0 111628.0 112507.4 112961.4 113397.0 115143.4 1120.0 1158.9 1163.7 1164.8 1174.1 16436.8 16467.9 16566.3 16640.8 16901.3 50132.5 53115.2 53961.0 54089.7 54969.0 63000.4 64630.0 64773.7 65249.7 65400.3 14255.2 14286.1 14333.8 14472.2 14520.3 22062.7 22144.9 22460.7 22544.1 22643.9 17800.3 17965.5 18304.8 18378.3 18752.2 16595.3 17084.2 17139.2 17626.2 17684.2 19749.3 19869.8 20001.2 20013.3 20022.6 13961.9 14429.6 14511.0 14631.8 14642.6 18556.3 18622.7 18732.8 18846.5 18908.0 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#3] mootools.html Cycles:180 Average:9080.48 Median:13908.50 stddev:6389.83 (45.9%) stddev-sans-first:6380.89 17:16:26 INFO - PID 17873 | Values: 1281.6 1338.2 1338.4 1344.2 1346.0 14261.2 14942.3 14969.1 14979.2 14985.7 12410.5 12833.7 14498.6 14869.4 14962.3 2572.5 2605.1 2606.2 2609.9 2631.4 2381.9 2486.2 2491.4 2500.1 2508.7 2519.2 2617.4 2618.3 2618.5 2625.7 2517.0 2569.6 2588.4 2589.2 2590.7 2625.4 2633.5 2639.8 2643.6 2645.1 14437.6 14817.3 14818.0 14833.7 14843.3 7812.5 8077.1 8127.9 8131.4 8156.3 5223.4 5385.8 5564.2 5571.5 5582.7 1867.1 1904.2 1905.1 1952.0 1957.3 25297.7 25345.4 25425.0 25481.0 25491.4 6559.5 6603.7 6661.6 6765.2 6875.3 16436.3 16463.3 16477.5 16543.0 16564.8 7586.2 7620.1 7648.7 7725.5 7730.7 6995.5 7113.9 7149.6 7178.1 7198.4 5170.1 5200.0 5254.4 5300.6 5451.5 1515.1 1517.9 1528.9 1533.2 1558.8 754.2 861.1 894.1 901.9 907.1 8219.6 8370.9 8501.2 8526.3 8703.7 980.3 1009.0 1009.7 1010.7 1015.3 5192.9 5359.1 5369.4 5395.4 5431.3 20113.9 20627.8 20671.4 20722.9 20981.3 20162.0 20231.5 20463.9 20569.8 20765.7 10949.9 11222.4 11298.8 11321.2 11363.4 7728.5 7872.1 8064.7 8166.9 8261.0 17727.6 18048.7 18143.2 18341.6 18773.2 18261.6 18550.8 18665.7 18914.0 19422.6 10501.3 10824.5 10855.5 11420.1 11593.8 13477.3 13543.3 13568.4 13596.9 13616.3 10479.1 10505.8 10677.9 10761.5 10813.0 10654.3 10713.1 11090.8 11177.9 11234.0 9803.8 9832.4 9920.7 9965.0 9967.7 7100.2 7224.8 7234.6 7301.0 7371.3 7093.6 7140.0 7248.2 7284.3 7341.4 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#4] prototype.html Cycles:180 Average:5498.74 Median:6098.15 stddev:1547.74 (25.4%) stddev-sans-first:1505.84 17:16:26 INFO - PID 17873 | Values: 496.2 502.7 515.3 517.2 523.9 6135.9 6278.2 6350.9 6371.7 6417.3 5927.6 6060.6 6071.9 6092.9 6141.4 4959.8 4973.6 5005.7 5047.8 5091.3 4884.9 4988.9 5009.5 5026.4 5056.5 4923.7 4926.5 4953.1 4987.5 4995.0 4883.7 4924.5 4942.3 4948.1 4954.9 4421.7 4456.8 4469.0 4476.1 4496.2 6086.8 6120.5 6140.2 6150.5 6171.8 5575.2 5659.7 5693.3 5709.3 5720.7 6545.6 6587.8 6600.7 6643.8 6687.5 4833.1 4838.1 4857.5 4862.2 4876.8 6805.3 6869.6 6895.4 6905.2 6967.8 5019.5 5028.8 5062.8 5067.6 5068.2 4990.8 5051.9 5092.7 5113.9 5134.2 5605.4 5643.9 5668.5 5697.7 5714.4 6458.6 6524.6 6584.0 6584.3 6593.1 1628.6 1674.3 1696.9 1700.7 1715.8 1176.7 1185.7 1190.4 1220.8 1235.9 5683.2 5707.9 5752.6 5755.4 5824.2 6542.2 6564.2 6564.9 6656.2 6678.6 5642.6 5738.2 5791.2 5819.4 5850.4 3563.7 3567.7 3596.9 3625.3 3641.4 6372.0 6442.2 6462.5 6474.7 6531.2 6696.4 6817.4 6852.8 6886.0 6919.8 6360.3 6392.2 6491.5 6492.2 6549.9 6726.8 6804.2 6821.0 6832.8 6841.0 6645.0 6681.5 6704.3 6785.9 6813.0 6447.2 6455.9 6458.0 6469.0 6580.8 4949.7 4951.5 4955.9 4964.8 4986.8 6738.5 6783.9 6795.9 6805.3 6880.9 6454.8 6455.4 6563.4 6611.1 6683.5 6382.9 6453.8 6478.4 6492.7 6591.4 5988.3 6103.4 6266.2 6390.5 6406.0 6442.6 6538.0 6553.5 6592.4 6593.3 6219.4 6230.3 6262.2 6324.6 6365.6 17:16:26 INFO - PID 17873 | 17:16:26 INFO - PID 17873 | [#5] yui.html Cycles:180 Average:23605.04 Median:21101.13 stddev:32958.87 (156.2%) stddev-sans-first:33007.13 17:16:26 INFO - PID 17873 | Values: 872.9 881.4 895.9 901.0 902.7 18021.0 19135.4 19165.7 19222.0 19260.5 17679.8 19675.1 19765.8 19804.0 19886.6 920.7 935.9 940.6 944.4 948.7 868.1 953.6 957.5 962.0 964.3 1000.9 1004.0 1004.1 1009.4 1010.1 986.1 993.1 998.4 998.7 999.1 732.9 734.6 735.2 735.3 737.6 17693.8 17782.6 17895.7 17916.4 19242.7 20361.8 20619.2 20737.7 21390.4 21405.3 15837.2 15852.0 15972.4 16074.8 16129.6 3517.2 3538.6 3552.7 3556.5 3559.2 122944.0 126801.0 129462.4 130090.0 130899.3 15316.3 16242.4 16276.8 16324.8 16408.6 29362.9 29617.1 30412.4 30446.4 30515.5 8654.7 8681.5 8873.0 9011.3 9060.5 4215.3 4241.7 4262.1 4292.0 4296.6 4840.7 4966.2 4987.9 4991.0 4995.7 964.5 987.8 988.2 993.0 1002.2 618.6 624.7 626.6 637.4 641.3 11997.9 12014.9 12076.5 12310.9 12315.6 647.3 653.1 660.8 661.0 666.7 5485.1 5571.2 5630.9 5669.5 5723.3 112320.9 115557.0 116388.4 117214.0 121339.0 96891.0 98676.0 99758.5 104650.0 105960.0 85323.6 91746.0 94420.0 94497.0 99539.5 12621.4 12788.9 12833.6 12972.7 13054.7 39392.8 39580.8 40148.2 41375.2 41992.4 51292.2 54528.2 55145.0 55468.2 55490.4 17665.4 17770.3 17775.0 17791.4 17877.1 20476.3 20625.3 20700.3 20810.7 20811.9 18772.6 18878.5 18899.0 19004.6 19295.0 16536.7 16551.8 16613.4 16701.7 16830.5 17645.2 17953.6 18017.9 18054.0 18075.5 12104.4 12128.8 12239.7 12298.4 12300.8 12070.0 12140.5 12240.7 12365.6 12479.4 17:16:26 INFO - PID 17873 | -------- Summary: end -------- 17:16:26 INFO - PID 17873 | 17:16:27 INFO - TEST-INFO | 17873: exit 0 17:16:27 INFO - TEST-OK | dromaeo_css | took 1114151ms 17:16:27 INFO - TEST-START | kraken 17:16:27 INFO - Initialising browser for kraken test... 17:16:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52728/getInfo.html -profile /tmp/tmpE3EFdz/profile 17:16:27 INFO - TEST-INFO | started process 18298 (/builds/slave/test/build/application/firefox/firefox http://localhost:52728/getInfo.html) 17:16:32 INFO - TEST-INFO | 18298: exit 0 17:16:32 INFO - Browser initialized. 17:16:32 INFO - Running cycle 1/1 for kraken test... 17:16:32 INFO - TEST-INFO | started process 18523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE3EFdz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:33 INFO - PID 18523 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:16:34 INFO - PID 18523 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:16:34 INFO - PID 18523 | 17:16:34 INFO - PID 18523 | (/builds/slave/test/build/application/firefox/firefox:18584): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:16:34 INFO - PID 18523 | 17:16:34 INFO - PID 18523 | 17:16:34 INFO - PID 18523 | (/builds/slave/test/build/application/firefox/firefox:18638): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:16:34 INFO - PID 18523 | 17:16:35 INFO - PID 18523 | __metrics Screen width/height:1600/1200 17:16:35 INFO - PID 18523 | colorDepth:24 17:16:35 INFO - PID 18523 | Browser inner width/height: 1024/768 17:16:35 INFO - PID 18523 | __metrics 17:16:44 INFO - PID 18523 | RSS: Main: 202432512 17:16:44 INFO - PID 18523 | 17:16:47 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52728/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:48 INFO - PID 18523 | RSS: Main: 211111936 17:16:48 INFO - PID 18523 | 17:16:50 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52728/tests/kraken/driver.html?testName=audio-dft) 17:16:51 INFO - PID 18523 | RSS: Main: 210960384 17:16:51 INFO - PID 18523 | 17:16:54 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52728/tests/kraken/driver.html?testName=audio-fft) 17:16:55 INFO - PID 18523 | RSS: Main: 206135296 17:16:55 INFO - PID 18523 | 17:16:57 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52728/tests/kraken/driver.html?testName=audio-oscillator) 17:16:58 INFO - PID 18523 | RSS: Main: 207261696 17:16:58 INFO - PID 18523 | 17:17:00 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:00 INFO - PID 18523 | RSS: Main: 207224832 17:17:00 INFO - PID 18523 | 17:17:04 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52728/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:04 INFO - PID 18523 | RSS: Main: 207609856 17:17:04 INFO - PID 18523 | 17:17:08 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52728/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:08 INFO - PID 18523 | RSS: Main: 205979648 17:17:08 INFO - PID 18523 | 17:17:11 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52728/tests/kraken/driver.html?testName=json-parse-financial) 17:17:12 INFO - PID 18523 | RSS: Main: 206557184 17:17:12 INFO - PID 18523 | 17:17:14 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:14 INFO - PID 18523 | RSS: Main: 206643200 17:17:14 INFO - PID 18523 | 17:17:16 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:17 INFO - PID 18523 | RSS: Main: 207216640 17:17:17 INFO - PID 18523 | 17:17:19 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:20 INFO - PID 18523 | RSS: Main: 208351232 17:17:20 INFO - PID 18523 | 17:17:22 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:23 INFO - PID 18523 | RSS: Main: 206827520 17:17:23 INFO - PID 18523 | 17:17:26 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:27 INFO - PID 18523 | RSS: Main: 208048128 17:17:27 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | Cycle 1(1): loaded http://localhost:52728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52728/tests/kraken/driver.html?testName=ai-astar) 17:17:29 INFO - PID 18523 | RSS: Main: 210313216 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | __start_tp_report 17:17:29 INFO - PID 18523 | _x_x_mozilla_page_load 17:17:29 INFO - PID 18523 | _x_x_mozilla_page_load_details 17:17:29 INFO - PID 18523 | |i|pagename|runs| 17:17:29 INFO - PID 18523 | |0;ai-astar;102;110;101;107;117;108;113;100;109;110 17:17:29 INFO - PID 18523 | |1;audio-beat-detection;142;120;152;179;122;142;142;125;170;126 17:17:29 INFO - PID 18523 | |2;audio-dft;165;176;171;164;163;171;168;173;164;166 17:17:29 INFO - PID 18523 | |3;audio-fft;75;74;76;168;87;75;74;80;162;80 17:17:29 INFO - PID 18523 | |4;audio-oscillator;81;78;141;84;79;79;133;85;80;122 17:17:29 INFO - PID 18523 | |5;imaging-gaussian-blur;122;115;114;114;114;120;118;120;113;119 17:17:29 INFO - PID 18523 | |6;imaging-darkroom;156;150;154;147;150;150;149;157;150;151 17:17:29 INFO - PID 18523 | |7;imaging-desaturate;94;101;99;96;100;103;94;94;95;94 17:17:29 INFO - PID 18523 | |8;json-parse-financial;64;53;52;54;55;59;53;53;53;54 17:17:29 INFO - PID 18523 | |9;json-stringify-tinderbox;63;56;56;63;64;58;60;56;60;66 17:17:29 INFO - PID 18523 | |10;stanford-crypto-aes;82;77;78;75;80;78;74;81;79;79 17:17:29 INFO - PID 18523 | |11;stanford-crypto-ccm;122;133;135;119;131;123;124;135;117;172 17:17:29 INFO - PID 18523 | |12;stanford-crypto-pbkdf2;176;172;180;168;176;176;174;169;163;169 17:17:29 INFO - PID 18523 | |13;stanford-crypto-sha256-iterative;68;66;68;65;64;65;68;67;66;63 17:17:29 INFO - PID 18523 | __end_tp_report 17:17:29 INFO - PID 18523 | __start_cc_report 17:17:29 INFO - PID 18523 | _x_x_mozilla_cycle_collect,922 17:17:29 INFO - PID 18523 | __end_cc_report 17:17:29 INFO - PID 18523 | __startTimestamp1503533849257__endTimestamp 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | ------- Summary: start ------- 17:17:29 INFO - PID 18523 | Number of tests: 14 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:5.42 (4.9%) stddev-sans-first:5.34 17:17:29 INFO - PID 18523 | Values: 102.0 110.0 101.0 107.0 117.0 108.0 113.0 100.0 109.0 110.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.00 stddev:20.23 (14.2%) stddev-sans-first:21.45 17:17:29 INFO - PID 18523 | Values: 142.0 120.0 152.0 179.0 122.0 142.0 142.0 125.0 170.0 126.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#2] audio-dft Cycles:10 Average:168.10 Median:169.50 stddev:4.43 (2.6%) stddev-sans-first:4.56 17:17:29 INFO - PID 18523 | Values: 165.0 176.0 171.0 164.0 163.0 171.0 168.0 173.0 164.0 166.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.50 stddev:37.08 (49.1%) stddev-sans-first:38.61 17:17:29 INFO - PID 18523 | Values: 75.0 74.0 76.0 168.0 87.0 75.0 74.0 80.0 162.0 80.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.50 stddev:25.20 (31.7%) stddev-sans-first:26.13 17:17:29 INFO - PID 18523 | Values: 81.0 78.0 141.0 84.0 79.0 79.0 133.0 85.0 80.0 122.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:118.50 stddev:3.25 (2.7%) stddev-sans-first:2.87 17:17:29 INFO - PID 18523 | Values: 122.0 115.0 114.0 114.0 114.0 120.0 118.0 120.0 113.0 119.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:150.50 stddev:3.20 (2.1%) stddev-sans-first:2.93 17:17:29 INFO - PID 18523 | Values: 156.0 150.0 154.0 147.0 150.0 150.0 149.0 157.0 150.0 151.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:94.00 stddev:3.43 (3.7%) stddev-sans-first:3.46 17:17:29 INFO - PID 18523 | Values: 94.0 101.0 99.0 96.0 100.0 103.0 94.0 94.0 95.0 94.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.71 (6.9%) stddev-sans-first:2.06 17:17:29 INFO - PID 18523 | Values: 64.0 53.0 52.0 54.0 55.0 59.0 53.0 53.0 53.0 54.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:61.50 stddev:3.68 (6.0%) stddev-sans-first:3.76 17:17:29 INFO - PID 18523 | Values: 63.0 56.0 56.0 63.0 64.0 58.0 60.0 56.0 60.0 66.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:2.50 (3.2%) stddev-sans-first:2.26 17:17:29 INFO - PID 18523 | Values: 82.0 77.0 78.0 75.0 80.0 78.0 74.0 81.0 79.0 79.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:132.00 stddev:15.81 (12.0%) stddev-sans-first:16.43 17:17:29 INFO - PID 18523 | Values: 122.0 133.0 135.0 119.0 131.0 123.0 124.0 135.0 117.0 172.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:175.00 stddev:5.06 (2.9%) stddev-sans-first:5.18 17:17:29 INFO - PID 18523 | Values: 176.0 172.0 180.0 168.0 176.0 176.0 174.0 169.0 163.0 169.0 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.76 (2.7%) stddev-sans-first:1.72 17:17:29 INFO - PID 18523 | Values: 68.0 66.0 68.0 65.0 64.0 65.0 68.0 67.0 66.0 63.0 17:17:29 INFO - PID 18523 | -------- Summary: end -------- 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:17:29 INFO - PID 18523 | 17:17:29 INFO - PID 18523 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:17:30 INFO - TEST-INFO | 18523: exit 0 17:17:30 INFO - TEST-OK | kraken | took 63162ms 17:17:30 INFO - SUITE-END | took 1177s 17:17:30 INFO - Completed test suite (00:19:37) 17:17:30 INFO - javascript benchmark 17:17:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8386.869794227574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.967660323396, 3239.271163988103, 3245.1887028242936, 3260.1034715453234, 3272.509123631455, 6144.5391595630335, 6161.661108639023, 6184.381561843813, 6211.161493198417, 6231.875362492753, 6061.363556826536, 6166.568340216187, 6169.629822210659, 6184.072389141631, 6207.937920620792, 5649.689267090308, 5672.744726487297, 5681.11942648888, 5685.658860468365, 5694.288213973254, 5709.486146246837, 5713.257276554042, 5717.599768016241, 5721.9427805721825, 5723.54211663066, 5697.6866272355, 5727.0, 5730.971345143268, 5735.770569177228, 5737.770489180449, 5649.209110724522, 5678.432156784289, 5687.687177205252, 5689.260396148516, 5711.314642242936, 5548.306461692288, 5630.577706671975, 5685.687287199203, 5715.885682286373, 5775.5668324875805, 5941.049432090845, 6128.17269668598, 6135.294441139237, 6191.597546159485, 6196.039613859859, 6527.836804079936, 6540.247871494791, 6567.0, 6574.868502629921, 6669.733210671568, 6729.427998620124, 6755.763548275836, 6767.289434609344, 6787.151606049244, 6794.184697836291, 6193.566450348432, 6201.379862013808, 6280.685965701742, 6299.0551417287315, 6304.747810087637, 6838.452923766186, 6869.656517174121, 6916.792496225121, 6936.861262774716, 6951.0, 6358.395952384516, 6522.706478208492, 6577.309382514863, 6594.142761440982, 6687.732490700318, 6281.623102613858, 6613.4709223262025, 6637.668116594247, 6641.966790166115, 6663.4669226461765, 6275.3724627537795, 6633.933660663428, 6641.933580664228, 6655.600663960178, 6725.495587830835, 6560.245571759213, 6595.604263744095, 6656.73373065072, 6709.932900671029, 6713.1272934519175, 5078.035173317058, 5273.604479664041, 5339.492748188916, 5351.464853514695, 5399.487048730364, 4543.045960348298, 4570.954290457119, 4575.565321294472, 4579.931301030487, 4648.511906249795, 5851.414858514115, 5862.237909071793, 5864.912026319608, 5867.3839246879315, 5867.823965281048, 6648.933510664831, 6670.199576050808, 6681.5656982296, 6706.966465167643, 6722.798316050526, 5792.218050563204, 5842.269716285465, 5875.441833025856, 5879.735411906475, 5886.3230728465915, 5686.914696279559, 5752.13717942312, 5781.768729250783, 5786.826395208151, 5849.473547380756, 6240.31356550779, 6283.37166283368, 6288.937110628926, 6295.685215739195, 6307.463865571478, 6543.443807276435, 6583.670816459254, 6597.538172327891, 6613.173353330833, 6620.735170593219, 6225.0, 6264.49884009269, 6283.183186185766, 6286.119943208046, 6312.400321969406, 5757.769689212552, 6478.5141114415665, 6487.870242595027, 6562.278149403466, 6645.60126392418, 6645.435138013323, 6660.034295027291, 6663.333666633492, 6740.359665831738, 6740.561863478858, 6268.059791031199, 6300.275468321019, 6390.648514331757, 6442.226932768098, 6448.5163612730175, 6427.550071495138, 6537.640429776408, 6548.672566371758, 6560.671966401565, 6562.442192413699, 6250.0937364082865, 6251.031090181029, 6271.843203919939, 6277.089821975696, 6303.46420554258, 6306.432421082125, 6387.680615969276, 6388.329225431263, 6408.87844627179, 6444.871102578016, 6150.0, 6157.138000679819, 6226.128342032029, 6268.686565671789, 6287.811365659038], "value": 6043.490855575546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.193795235788, 829.2785276809175, 858.296197118363, 859.8581234096371, 1129.6441620889414, 29390.265243368925, 31010.84494577527, 40060.39909401358, 40539.0, 40694.38958415626, 40721.38917916234, 41252.79373603128, 41402.37896431556, 41439.0, 41584.79207603965, 7746.225377462265, 7781.0, 7819.0, 7824.72613458529, 7834.0, 7790.0, 7836.72571459999, 7839.255270749298, 7848.175941526143, 7853.5680537570415, 7838.490498117604, 7912.367010639135, 7925.722599709012, 7929.088154862207, 7941.523508589475, 7826.804329891741, 7861.764147075597, 7865.2134786521465, 7887.171846956045, 7921.881171782428, 7758.185390534026, 7761.689532418696, 7769.689212431496, 7770.961145194238, 7774.689012439496, 36354.27291454156, 36355.45466818, 36557.45163822545, 36616.45075323872, 36676.81661591675, 3526.365254254233, 3546.397112490857, 3552.3250582389524, 3568.1614820517157, 3578.0697018775045, 30443.543346849816, 30588.8470557648, 30591.235219119477, 30606.846965765253, 30651.693483065108, 4967.081089998362, 5139.537441630234, 5149.0, 5210.4268530461995, 5223.112070947948, 168303.0, 168375.0, 168451.0, 169075.0, 169298.0, 44467.77766111149, 44799.55200448019, 44877.32684009743, 44918.32622510665, 45036.54963450324, 46955.0, 51063.74468127636, 52443.47556524386, 52524.474755252726, 52629.473705262455, 14535.345909433889, 14564.49024284166, 14588.854111458963, 14608.269586520631, 14608.34262458192, 11437.656870293904, 11637.359945203096, 11648.94175529117, 11667.241629294069, 11956.163068585289, 14206.715865682629, 14310.713785724436, 14409.85590144106, 14419.35112919921, 14632.122072675673, 5482.205080263339, 5578.30271216098, 5642.802501912413, 5700.9429905701245, 5734.225879506297, 961.9134277915022, 968.4092703450889, 995.8008398320364, 995.9053889880449, 1003.3227571389428, 22577.548449030928, 22597.322080337617, 22619.88690056572, 22710.772892271198, 22924.9683764231, 1099.6810924831868, 1104.1829046505527, 1106.3583121789343, 1111.9054880335261, 1112.8497652816927, 11988.52045918171, 12034.338111403957, 12037.0, 12091.0, 12114.454849531792, 211296.0, 220482.0, 221292.0, 221696.0, 223814.0, 43974.340384894254, 50479.747601261755, 50890.236646450336, 50959.235611465854, 51235.487645123816, 1432.4771458417601, 1437.4609521429463, 1446.8914831387688, 1448.73922693914, 1448.9637759056109, 25763.0, 26401.207963761117, 26578.0, 26861.52051797126, 27264.591031134947, 36260.27479450449, 36392.45411318779, 36473.452898206015, 36500.26999460049, 36522.0, 190429.0, 192513.0, 192671.0, 193477.0, 193578.0, 33764.83117584397, 33772.0, 33796.81711140098, 33833.66166338305, 34185.145371365914, 40570.59429405668, 41136.38295425631, 41726.16547668969, 41766.0, 42278.365824513276, 30758.077257682304, 30934.535981959838, 30994.380112397175, 31200.21999449941, 31818.84090579532, 30024.24939376533, 30268.394632107676, 30686.0, 30701.692983069883, 30730.84634576813, 34584.82707586446, 34590.82704586461, 34628.82685586556, 34834.47748283727, 35054.824725876206, 29522.0, 29878.402431950806, 30048.3990320188, 31171.0, 31202.21994450157, 22512.212072577382, 22874.77125228793, 23086.538269234858, 23182.536349273258, 23621.0], "value": 16775.547534173213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.1589152704832, 552.544151075363, 556.3157316500702, 562.6652141975526, 563.3802816901408, 21421.250256241034, 22329.330120096383, 22369.55260894781, 22390.88804555979, 22394.88802555985, 23419.41451463714, 24331.39171520713, 24436.0, 24539.75460245397, 24568.38579035525, 6712.530122891388, 6863.588184708909, 6868.416184624313, 6881.105456290676, 6882.965585172092, 6724.697388617524, 6760.560563563377, 6765.695543700521, 6766.188057433115, 6774.593524388528, 5877.588568800185, 6457.096006559085, 6458.612483250997, 6478.93521064788, 6489.4483968862705, 6397.968010159942, 6426.518011149183, 6439.291677915426, 6485.3514648534765, 6493.577917435352, 6001.729922153513, 6027.216461859974, 6028.969855150696, 6032.245969253843, 6039.969800151015, 27192.504412257316, 27668.86165569159, 27945.161645150678, 28155.85922070397, 28399.71600284012, 2032.562998955217, 2097.224027109964, 2101.4746313421647, 2105.663093904968, 2108.104055776289, 19215.231390744353, 19744.901275493532, 19862.70205946912, 19898.104585293695, 19900.0, 2349.5418393413293, 2353.599888019041, 2374.798142157919, 2391.198948352304, 2415.8188135889877, 131303.0, 135734.0, 135892.32053839767, 136081.3195934014, 136764.0, 14191.361388737532, 14317.140971541741, 14337.928310358382, 14657.413703451955, 15222.619434514225, 21877.12491500354, 21903.67144492834, 21967.450813729785, 22218.888905555694, 22221.11115555392, 9893.406395616286, 10125.291229613857, 10246.48767561619, 10286.588536458608, 10311.278210525341, 9333.579988900516, 9526.809463810823, 9548.522573871278, 9571.234301255883, 9641.903580964101, 8512.787180320418, 8540.487570745776, 8739.475631462006, 8871.201591856763, 9185.678501252423, 2604.9869750651123, 2627.618995245717, 2677.718839521861, 2680.370113023438, 2781.0544414898627, 912.8904531456268, 931.1228304539007, 933.2300851797295, 936.3071327217809, 945.9006804285589, 18724.625507489774, 18771.421038755798, 18995.715064274045, 19268.518287042934, 19362.225510979686, 993.4089216915924, 994.4580203788952, 1002.5137808163036, 1003.372891942536, 1018.9439580823126, 9987.900120998696, 10024.0, 10051.296409251428, 10172.643957461454, 10279.588816447407, 444240.0, 455890.0, 457533.0, 464696.0, 465279.0, 111628.0, 112507.4374628138, 112961.43519282516, 113397.0, 115143.42428287973, 1119.9776004479866, 1158.9130815188894, 1163.650904728595, 1164.7903377392151, 1174.1194104421684, 16436.75344869804, 16467.917660411622, 16566.254518546935, 16640.83359166393, 16901.323947042474, 50132.49867501424, 53115.20327195172, 53961.0, 54089.72955135199, 54969.0, 63000.36999629945, 64630.0, 64773.67613161904, 65249.67375163094, 65400.34599653943, 14255.215963121713, 14286.142831430148, 14333.784993224901, 14472.204028778096, 14520.273986300854, 22062.676239425688, 22144.889275554164, 22460.663090053335, 22544.098236070375, 22643.88678056599, 17800.287988480835, 17965.461036168414, 18304.816951830842, 18378.264869405608, 18752.249910003447, 16595.336186552402, 17084.231209595848, 17139.228734707216, 17626.20682069284, 17684.204210810803, 19749.308774192836, 19869.801301986794, 20001.199952001756, 20013.299534516224, 20022.59954800925, 13961.860381396056, 14429.567112986628, 14511.0, 14631.780523291945, 14642.560723178321, 18556.257749689863, 18622.72065918985, 18732.812671873107, 18846.52883677864, 18908.0], "value": 11725.845943429806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.5706738242689, 1338.2171429713617, 1338.370965646146, 1344.227069435075, 1345.9798103028454, 14261.215633140173, 14942.327595258212, 14969.10185388876, 14979.176145312003, 14985.700285994273, 12410.503579856795, 12833.743325133491, 14498.565043048698, 14869.405223791035, 14962.32669529871, 2572.511222867654, 2605.101240072172, 2606.1660268714018, 2609.9086531971384, 2631.3816253180585, 2381.9285421437385, 2486.2416962826333, 2491.4394261291245, 2500.112460076674, 2508.736582658822, 2519.244226731982, 2617.3587471069613, 2618.3323252570567, 2618.463215040912, 2625.698044724862, 2516.962245566318, 2569.5888657814753, 2588.404666926608, 2589.1844069118356, 2590.7150213476502, 2625.4355313607666, 2633.499635069331, 2639.802014848875, 2643.603459481074, 2645.08744483153, 14437.566872993826, 14817.333220005126, 14818.03682760617, 14833.70332593342, 14843.257837108102, 7812.453128281023, 8077.071136819282, 8127.878081828777, 8131.430799844014, 8156.265936065783, 5223.425423203445, 5385.811496597639, 5564.221009058735, 5571.526420254283, 5582.665040097607, 1867.094459187293, 1904.2478221102588, 1905.1331644102038, 1951.9707204391946, 1957.2855907593769, 25297.747022529722, 25345.36636584082, 25425.0, 25480.980760769547, 25491.362715932064, 6559.47524198063, 6603.702833372414, 6661.633610151488, 6765.154355705537, 6875.3124687531845, 16436.260368283456, 16463.34146634121, 16477.505674829776, 16543.0, 16564.75152872708, 7586.203448637924, 7620.123685776096, 7648.65581048843, 7725.459217854696, 7730.729424470116, 6995.4753393494675, 7113.857722845514, 7149.60677162761, 7178.138623365126, 7198.352148306678, 5170.1469257572835, 5199.974000130051, 5254.395744489356, 5300.602454815904, 5451.48210919962, 1515.1060874084344, 1517.9392824286904, 1528.8929774915648, 1533.2027345780132, 1558.7661850722482, 754.2269174096594, 861.0743450790426, 894.1326912894482, 901.8511945529045, 907.111031189438, 8219.630116644765, 8370.916290837136, 8501.19238672325, 8526.31789456842, 8703.738887833375, 980.2501086668705, 1009.0, 1009.6970908727352, 1010.7416266747946, 1015.3197357770312, 5192.948070519322, 5359.1157459019605, 5369.4362091980565, 5395.352557693023, 5431.293931788842, 20113.899430502755, 20627.79372206289, 20671.379858604265, 20722.896385517975, 20981.265655701976, 20162.0, 20231.4942126448, 20463.8976805115, 20569.794302056787, 20765.688514672293, 10949.890501094887, 11222.428859959613, 11298.774024519464, 11321.150913681508, 11363.431828408711, 7728.504348780659, 7872.1340652529325, 8064.677412903418, 8166.918330816616, 8261.0, 17727.645447091243, 18048.729269060714, 18143.183556739714, 18341.633167336313, 18773.249070037047, 18261.634767304844, 18550.814491854908, 18665.72001420007, 18914.0, 19422.611547769247, 10501.31741436804, 10824.484572160061, 10855.45722713877, 11420.143489238506, 11593.768124637629, 13477.258750768802, 13543.255120968048, 13568.38942247621, 13596.93201533986, 13616.319184040956, 10479.10927571165, 10505.842412363667, 10677.89322106769, 10761.515731792244, 10813.0, 10654.307470014424, 10713.089387402159, 11090.833637495283, 11177.888221117684, 11234.0, 9803.803923921625, 9832.410055396698, 9920.702378928643, 9965.0, 9967.700968970943, 7100.218975912542, 7224.819379515554, 7234.6020968847215, 7300.96349518249, 7371.336579707638, 7093.609851458013, 7139.964300178466, 7248.202697703143, 7284.344409003215, 7341.375983041501], "value": 6534.390168920198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.1567386484615, 502.7151595996198, 515.3377909386439, 517.2396577031764, 523.9214117882317, 6135.938640613593, 6278.1838361013115, 6350.872982540346, 6371.745130194792, 6417.262014868292, 5927.644341339523, 6060.575759696823, 6071.908921366183, 6092.939070609293, 6141.416565426277, 4959.776810043557, 4973.602111831063, 5005.699658020512, 5047.84856454306, 5091.338126043609, 4884.877878053042, 4988.87527811804, 5009.499050094998, 5026.371703537058, 5056.533605254472, 4923.729194894279, 4926.531979461945, 4953.083679519283, 4987.451380348159, 4994.950050499503, 4883.731394773286, 4924.532169443897, 4942.3327850740225, 4948.1093403187415, 4954.925676114861, 4421.678618725195, 4456.77716114193, 4468.977655111737, 4476.082403107355, 4496.168208881368, 6086.817395478142, 6120.480723583957, 6140.171076904606, 6150.477209437203, 6171.783987560459, 5575.163725441175, 5659.688717120557, 5693.345265294462, 5709.286339207599, 5720.742566584514, 6545.639989800607, 6587.802365928982, 6600.669966501704, 6643.80068597938, 6687.465002799764, 4833.081714474239, 4838.056578967103, 4857.465678775332, 4862.197737373329, 4876.7808047988, 6805.311901798811, 6869.587824730532, 6895.379415852547, 6905.205901321362, 6967.82580435483, 5019.52314530119, 5028.79884804611, 5062.772175252123, 5067.619928505377, 5068.189089745623, 4990.80036798524, 5051.949480505222, 5092.694438333638, 5113.897722045613, 5134.2298655201275, 5605.355384130796, 5643.887122257532, 5668.546516278688, 5697.658140511582, 5714.371419143891, 6458.644774537445, 6524.608523488606, 6583.967080164664, 6584.275729669733, 6593.109930159463, 1628.552148159242, 1674.2967953459577, 1696.8812183147309, 1700.7278835386278, 1715.845573898355, 1176.6999415149253, 1185.6739396665814, 1190.4464424042687, 1220.7802595532712, 1235.8887700106854, 5683.204351390808, 5707.914381284284, 5752.597318187687, 5755.395683453261, 5824.184614154022, 6542.182227221598, 6564.179477565304, 6564.901526477107, 6656.201255849329, 6678.565893216925, 5642.589352661835, 5738.196652468658, 5791.247137872134, 5819.418058194146, 5850.414958504116, 3563.6792688658147, 3567.714582833367, 3596.8849656606535, 3625.2930678517964, 3641.399169137063, 6371.980483122678, 6442.162518872517, 6462.450691691165, 6474.741010359533, 6531.211897099671, 6696.397324240842, 6817.386435220854, 6852.760153394607, 6885.9671049342, 6919.827004324932, 6360.332165122595, 6392.242133413256, 6491.4806815455595, 6492.220933488012, 6549.869002619826, 6726.831829204309, 6804.183497980076, 6821.010953411628, 6832.838417468943, 6841.0, 6644.966775166094, 6681.465482761465, 6704.262531121475, 6785.93214067853, 6813.0, 6447.161868957006, 6455.903161452676, 6458.0, 6468.967655161694, 6580.76967306142, 4949.653524253267, 4951.455339912679, 4955.925661115159, 4964.801407943642, 4986.775595098156, 6738.528303018742, 6783.913319439742, 6795.93204067953, 6805.319468053155, 6880.862382752417, 6454.806355809334, 6455.419012288917, 6563.409293163638, 6611.107500487565, 6683.465322774069, 6382.904256436064, 6453.838654033687, 6478.445173158314, 6492.740290388331, 6591.373819487141, 5988.323269484551, 6103.3591472894705, 6266.216722909637, 6390.48876089921, 6405.967970160119, 6442.581232219891, 6537.986612075136, 6553.475721942138, 6592.373724496165, 6593.307702691149, 6219.440250377488, 6230.283517395557, 6262.248530176408, 6324.588901721373, 6365.649889256136], "value": 5039.6847097675745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.9476231426115, 881.40064755966, 895.892492900852, 900.9684661036865, 902.6524787956635, 18021.0, 19135.42593722187, 19165.71251431228, 19222.0, 19260.518487037833, 17679.82320176798, 19675.114619842105, 19765.802341976578, 19804.0, 19886.602267954633, 920.7283851263876, 935.8876934767837, 940.5861420974784, 944.4239014201366, 948.7153853843854, 868.053821334745, 953.6185525789671, 957.5212393803098, 961.9903800962006, 964.2960638733729, 1000.9149222316112, 1003.9698809035704, 1004.1364426593124, 1009.3893194617261, 1010.1211945607332, 986.1272773595348, 993.096282383028, 998.3810037776552, 998.6904059741468, 999.0908273471143, 732.8827387618009, 734.5592644413363, 735.1619154164257, 735.2867718313228, 737.6311844077961, 17693.823061769348, 17782.644347112986, 17895.73156402655, 17916.372926947493, 19242.71135932962, 20361.796382036136, 20619.175232990663, 20737.688934665992, 21390.358289251348, 21405.250816221356, 15837.208139593089, 15852.0, 15972.440964566184, 16074.75887861683, 16129.596760080974, 3517.243792584581, 3538.5930617979006, 3552.7335449841366, 3556.5198698175673, 3559.2347645256395, 122944.0, 126801.0, 129462.3526882369, 130090.0, 130899.34550327282, 15316.310766015557, 16242.431514896922, 16276.837231627533, 16324.836751632569, 16408.589785255463, 29362.853185733933, 29617.111486655434, 30412.391752165277, 30446.391072178434, 30515.542266866014, 8654.6538138475, 8681.479111253346, 8872.955635221782, 9011.27909767217, 9060.501672408082, 4215.325547912381, 4241.703080784378, 4262.062346283813, 4291.978540107342, 4296.6347860432215, 4840.685355451885, 4966.15575352191, 4987.900241995212, 4990.975045124751, 4995.650304478724, 964.5032808103832, 987.782687808681, 988.2044953812107, 993.0317940008579, 1002.1832206751474, 618.604093380237, 624.7469774741237, 626.6428135962458, 637.3976592120495, 641.2593454559991, 11997.941039775033, 12014.879851201551, 12076.470000998163, 12310.938445307716, 12315.630531084082, 647.3397134922353, 653.0628548033492, 660.7654282729562, 660.9669516524251, 666.6566718140161, 5485.076117792774, 5571.164325351148, 5630.85922851932, 5669.546436285087, 5723.255976723082, 112320.87679123267, 115557.0, 116388.41805790916, 117214.0, 121339.0, 96891.0, 98676.0, 99758.5012074935, 104650.0, 105960.0, 85323.57338213269, 91746.0, 94420.0, 94497.0, 99539.50230248802, 12621.432035558239, 12788.872111278768, 12833.550825721428, 12972.740545189232, 13054.673633159247, 39392.80303598464, 39580.80209598933, 40148.1970360597, 41375.172496550505, 41992.370114447695, 51292.23061654004, 54528.18207726808, 55145.0, 55468.16797747956, 55490.44509554853, 17665.38171164003, 17770.289188432318, 17775.0, 17791.377301794375, 17877.106144692974, 20476.283330083377, 20625.278115265894, 20700.275490357766, 20810.687839682116, 20811.8959405202, 18772.624547509247, 18878.52803679919, 18899.0, 19004.619907602046, 19295.0, 16536.66926661484, 16551.83448165503, 16613.418530351864, 16701.665966680357, 16830.495085147464, 17645.20596573183, 17953.64092718112, 18017.909910450362, 18054.0, 18075.457736267934, 12104.394780261127, 12128.757424851277, 12239.69400764988, 12298.385080746106, 12300.81548776787, 12070.0, 12140.453679584616, 12240.707329472492, 12365.567205148136, 12479.376031198586], "value": 8889.076354294031, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 101.0, 107.0, 117.0, 108.0, 113.0, 100.0, 109.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 120.0, 152.0, 179.0, 122.0, 142.0, 142.0, 125.0, 170.0, 126.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 176.0, 171.0, 164.0, 163.0, 171.0, 168.0, 173.0, 164.0, 166.0], "value": 168.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 168.0, 87.0, 75.0, 74.0, 80.0, 162.0, 80.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 141.0, 84.0, 79.0, 79.0, 133.0, 85.0, 80.0, 122.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 114.0, 114.0, 114.0, 120.0, 118.0, 120.0, 113.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 150.0, 154.0, 147.0, 150.0, 150.0, 149.0, 157.0, 150.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 99.0, 96.0, 100.0, 103.0, 94.0, 94.0, 95.0, 94.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 53.0, 52.0, 54.0, 55.0, 59.0, 53.0, 53.0, 53.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 56.0, 63.0, 64.0, 58.0, 60.0, 56.0, 60.0, 66.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 78.0, 75.0, 80.0, 78.0, 74.0, 81.0, 79.0, 79.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 133.0, 135.0, 119.0, 131.0, 123.0, 124.0, 135.0, 117.0, 172.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 180.0, 168.0, 176.0, 176.0, 174.0, 169.0, 163.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 65.0, 64.0, 65.0, 68.0, 67.0, 66.0, 63.0], "value": 66.0, "unit": "score"}]}]} 17:17:30 INFO - Return code: 0 17:17:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:17:30 INFO - # TBPL SUCCESS # 17:17:30 INFO - Running post-action listener: _package_coverage_data 17:17:30 INFO - Running post-action listener: _resource_record_post_action 17:17:30 INFO - [mozharness: 2017-08-24 00:17:30.547825Z] Finished run-tests step (success) 17:17:30 INFO - Running post-run listener: _resource_record_post_run 17:17:30 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 442609664; Read time: 16; Write time: 278612 17:17:30 INFO - TinderboxPrint: CPU usage
13.3% 17:17:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:17:30 INFO - TinderboxPrint: I/O write bytes / time
442,609,664 / 278,612 17:17:30 INFO - TinderboxPrint: CPU idle
8,266.4 (86.7%) 17:17:30 INFO - TinderboxPrint: CPU user
1,204.4 (12.6%) 17:17:30 INFO - TinderboxPrint: Swap in / out
0 / 0 17:17:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 121765888; Read time: 0; Write time: 89408 17:17:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:17:30 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 320843776; Read time: 0; Write time: 189204 17:17:31 INFO - Running post-run listener: _upload_blobber_files 17:17:31 INFO - Blob upload gear active. 17:17:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:31 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 17:17:31 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'] 17:17:31 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 17:17:31 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:32 INFO - (blobuploader) - INFO - Done attempting. 17:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:36 INFO - (blobuploader) - INFO - Done attempting. 17:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:37 INFO - (blobuploader) - INFO - Done attempting. 17:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:37 INFO - (blobuploader) - INFO - Done attempting. 17:17:37 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:37 INFO - Return code: 0 17:17:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddda545138318be003f700e5ca055db7fcebb01bbcdec9e42b408439e8bae3d8d6397bea84f689dd7c2117542a768f74d34cde09d4eef9d9abda7b3573ff7d13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161406aae05690038ce8ac8b648c5ce8bfe2dbcc13db69fa455d4cc4ab066150175133ce09574d8354b1bcf9b3eefd65197fbf36b63a8c100f4240bf22d25c9f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eb8cfb6b01decbc0c8e4f357efd3b378b098ab99693b755f6dc738900770959d351eb1be7e4a3d81b633884b049ac879a20c17fedb8043daba27764ebaa5092", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9122a4b244bfafc887af295c60f6b16fb0e235147d16b38bcd8df5c906e014deb99a02b956331b85c7fdddafa3518fc918f343cb747079d648566fa8eba117"} 17:17:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:37 INFO - Contents: 17:17:37 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddda545138318be003f700e5ca055db7fcebb01bbcdec9e42b408439e8bae3d8d6397bea84f689dd7c2117542a768f74d34cde09d4eef9d9abda7b3573ff7d13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161406aae05690038ce8ac8b648c5ce8bfe2dbcc13db69fa455d4cc4ab066150175133ce09574d8354b1bcf9b3eefd65197fbf36b63a8c100f4240bf22d25c9f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eb8cfb6b01decbc0c8e4f357efd3b378b098ab99693b755f6dc738900770959d351eb1be7e4a3d81b633884b049ac879a20c17fedb8043daba27764ebaa5092", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9122a4b244bfafc887af295c60f6b16fb0e235147d16b38bcd8df5c906e014deb99a02b956331b85c7fdddafa3518fc918f343cb747079d648566fa8eba117"} 17:17:38 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:38 INFO - Copying logs to upload dir... 17:17:38 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.058577 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 17:17:37.809831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:17:37.818519) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 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/ddda545138318be003f700e5ca055db7fcebb01bbcdec9e42b408439e8bae3d8d6397bea84f689dd7c2117542a768f74d34cde09d4eef9d9abda7b3573ff7d13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161406aae05690038ce8ac8b648c5ce8bfe2dbcc13db69fa455d4cc4ab066150175133ce09574d8354b1bcf9b3eefd65197fbf36b63a8c100f4240bf22d25c9f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eb8cfb6b01decbc0c8e4f357efd3b378b098ab99693b755f6dc738900770959d351eb1be7e4a3d81b633884b049ac879a20c17fedb8043daba27764ebaa5092", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9122a4b244bfafc887af295c60f6b16fb0e235147d16b38bcd8df5c906e014deb99a02b956331b85c7fdddafa3518fc918f343cb747079d648566fa8eba117"} build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddda545138318be003f700e5ca055db7fcebb01bbcdec9e42b408439e8bae3d8d6397bea84f689dd7c2117542a768f74d34cde09d4eef9d9abda7b3573ff7d13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161406aae05690038ce8ac8b648c5ce8bfe2dbcc13db69fa455d4cc4ab066150175133ce09574d8354b1bcf9b3eefd65197fbf36b63a8c100f4240bf22d25c9f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eb8cfb6b01decbc0c8e4f357efd3b378b098ab99693b755f6dc738900770959d351eb1be7e4a3d81b633884b049ac879a20c17fedb8043daba27764ebaa5092", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9122a4b244bfafc887af295c60f6b16fb0e235147d16b38bcd8df5c906e014deb99a02b956331b85c7fdddafa3518fc918f343cb747079d648566fa8eba117"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:17:37.848709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:17:37.849168) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503532603.56458-1926887412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:17:37.931040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:17:37.931376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:17:37.931711) ========= ========= Total master_lag: 0.23 =========