builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1503411210.49 results: success (0) revision: 1867d7931c0a70ab90edf4aa84876525773a7139 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.486469) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.487499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.488251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.506746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.507377) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 07:13:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-08-22 07:13:30 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.623590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.624349) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014349 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:30.677979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 07:13:30.678746) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1867d7931c0a70ab90edf4aa84876525773a7139 --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 1867d7931c0a70ab90edf4aa84876525773a7139 --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=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 07:13:31,006 truncating revision to first 12 chars 2017-08-22 07:13:31,006 Setting DEBUG logging. 2017-08-22 07:13:31,006 attempt 1/10 2017-08-22 07:13:31,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1867d7931c0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 07:13:31,535 unpacking tar archive at: mozilla-central-1867d7931c0a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 07:13:31.712574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:31.713367) ========= script_repo_revision: 1867d7931c0a70ab90edf4aa84876525773a7139 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:31.714106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:31.714850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 07:13:31.727609) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-22 07:13:31.728263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:32 INFO - MultiFileLogger online at 20170822 07:13:32 in /builds/slave/test 07:13:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:13:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:32 INFO - {'append_to_log': False, 07:13:32 INFO - 'base_work_dir': '/builds/slave/test', 07:13:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:13:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:32 INFO - 'branch': 'Firefox-Non-PGO', 07:13:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:32 INFO - 'code_coverage': False, 07:13:32 INFO - 'config_files': ('talos/linux_config.py',), 07:13:32 INFO - 'default_actions': ('clobber', 07:13:32 INFO - 'read-buildbot-config', 07:13:32 INFO - 'download-and-extract', 07:13:32 INFO - 'populate-webroot', 07:13:32 INFO - 'create-virtualenv', 07:13:32 INFO - 'install', 07:13:32 INFO - 'setup-mitmproxy', 07:13:32 INFO - 'run-tests'), 07:13:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:32 INFO - 'disable_ccov_upload': False, 07:13:32 INFO - 'download_minidump_stackwalk': True, 07:13:32 INFO - 'download_symbols': 'ondemand', 07:13:32 INFO - 'enable_stylo': False, 07:13:32 INFO - 'enable_webrender': False, 07:13:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:32 INFO - 'gecko_profile': False, 07:13:32 INFO - 'gecko_profile_interval': 0, 07:13:32 INFO - 'installer_path': 'installer.exe', 07:13:32 INFO - 'log_level': 'info', 07:13:32 INFO - 'log_name': 'talos', 07:13:32 INFO - 'log_to_console': True, 07:13:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:32 INFO - 'opt_config_files': (), 07:13:32 INFO - 'pip_index': False, 07:13:32 INFO - 'suite': 'dromaeojs-e10s', 07:13:32 INFO - 'system_bits': '32', 07:13:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:32 INFO - 'title': 'talos-linux64-ix-087', 07:13:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:32 INFO - 'use_talos_json': True, 07:13:32 INFO - 'verify': 'False', 07:13:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:32 INFO - 'work_dir': 'build'} 07:13:32 INFO - [mozharness: 2017-08-22 14:13:32.199473Z] Running clobber step. 07:13:32 INFO - Running pre-action listener: _resource_record_pre_action 07:13:32 INFO - Running main action method: clobber 07:13:32 INFO - rmtree: /builds/slave/test/build 07:13:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:33 INFO - Running post-action listener: _resource_record_post_action 07:13:33 INFO - [mozharness: 2017-08-22 14:13:33.837760Z] Finished clobber step (success) 07:13:33 INFO - [mozharness: 2017-08-22 14:13:33.837858Z] Running read-buildbot-config step. 07:13:33 INFO - Running pre-action listener: _resource_record_pre_action 07:13:33 INFO - Running main action method: read_buildbot_config 07:13:33 INFO - Using buildbot properties: 07:13:33 INFO - { 07:13:33 INFO - "project": "", 07:13:33 INFO - "product": "firefox", 07:13:33 INFO - "who": "archaeopteryx@coole-files.de", 07:13:33 INFO - "installer_path": "public/build/target.tar.bz2", 07:13:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:13:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:13:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:13:33 INFO - "stage_platform": "linux64", 07:13:33 INFO - "basedir": "/builds/slave/test", 07:13:33 INFO - "buildnumber": 1092, 07:13:33 INFO - "platform": "ubuntu64_hw", 07:13:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:13:33 INFO - "slavebuilddir": "test", 07:13:33 INFO - "taskId": "fw_MhdWuQIiRBmEOL3Uakw", 07:13:33 INFO - "branch": "mozilla-central", 07:13:33 INFO - "script_repo_revision": "production", 07:13:33 INFO - "revision": "1867d7931c0a70ab90edf4aa84876525773a7139", 07:13:33 INFO - "slavename": "talos-linux64-ix-087", 07:13:33 INFO - "repo_path": "mozilla-central" 07:13:33 INFO - } 07:13:33 INFO - Finding installer, test and symbols from parent task. 07:13:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw_MhdWuQIiRBmEOL3Uakw'}, attempt #1 07:13:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw_MhdWuQIiRBmEOL3Uakw'}, attempt #1 07:13:34 INFO - Task dependencies: H_QFZYnlS7C0GUfsoawK7w 07:13:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w'}, attempt #1 07:13:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 07:13:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.test_packages.json 07:13:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.crashreporter-symbols.zip 07:13:35 INFO - Running post-action listener: _resource_record_post_action 07:13:35 INFO - [mozharness: 2017-08-22 14:13:35.345979Z] Finished read-buildbot-config step (success) 07:13:35 INFO - [mozharness: 2017-08-22 14:13:35.346197Z] Running download-and-extract step. 07:13:35 INFO - Running pre-action listener: _resource_record_pre_action 07:13:35 INFO - Running main action method: download_and_extract 07:13:35 INFO - mkdir: /builds/slave/test/build/tests 07:13:35 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')]} 07:13:35 INFO - trying https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.test_packages.json 07:13:35 INFO - Downloading https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:13:35 INFO - Downloaded 989 bytes. 07:13:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:13:35 INFO - Using the following test package requirements: 07:13:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:13:35 INFO - u'common': [u'target.common.tests.zip'], 07:13:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:13:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:13:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:13:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:13:35 INFO - u'mozbase': [u'target.common.tests.zip'], 07:13:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:13:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:13:35 INFO - u'web-platform': [u'target.common.tests.zip', 07:13:35 INFO - u'target.web-platform.tests.tar.gz'], 07:13:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:13:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:13:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip 07:13:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:13:35 INFO - Fetch https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip into memory 07:13:36 INFO - Content-Length response header: 54949426 07:13:36 INFO - Bytes received: 54949426 07:13:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:13:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip 07:13:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:13:48 INFO - Fetch https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.common.tests.zip into memory 07:13:49 INFO - Content-Length response header: 54949426 07:13:49 INFO - Bytes received: 54949426 07:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.talos.tests.zip 07:14:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:14:01 INFO - Fetch https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.talos.tests.zip into memory 07:14:01 INFO - Content-Length response header: 14496256 07:14:01 INFO - Bytes received: 14496256 07:14:02 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')]} 07:14:02 INFO - trying https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 07:14:02 INFO - Downloading https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:14:03 INFO - Downloaded 61262102 bytes. 07:14:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 07:14:03 INFO - mkdir: /builds/slave/test/properties 07:14:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:03 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:03 INFO - Contents: 07:14:03 INFO - build_url:https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 07:14:03 INFO - Running post-action listener: _resource_record_post_action 07:14:03 INFO - Running post-action listener: find_tests_for_verification 07:14:03 INFO - Running post-action listener: set_extra_try_arguments 07:14:03 INFO - [mozharness: 2017-08-22 14:14:03.380768Z] Finished download-and-extract step (success) 07:14:03 INFO - [mozharness: 2017-08-22 14:14:03.380867Z] Running populate-webroot step. 07:14:03 INFO - Running pre-action listener: _resource_record_pre_action 07:14:03 INFO - Running main action method: populate_webroot 07:14:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:03 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:03 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:03 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'tests': ['damp', 'tps']}, 07:14:03 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['damp', 'tps']}, 07:14:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:14:03 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:14:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:14:03 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:14:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:03 INFO - 'ts_paint', 07:14:03 INFO - 'tpaint', 07:14:03 INFO - 'sessionrestore', 07:14:03 INFO - 'sessionrestore_many_windows', 07:14:03 INFO - 'sessionrestore_no_auto_restore', 07:14:03 INFO - 'tabpaint']}, 07:14:03 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['a11yr', 07:14:03 INFO - 'ts_paint', 07:14:03 INFO - 'tpaint', 07:14:03 INFO - 'sessionrestore', 07:14:03 INFO - 'sessionrestore_many_windows', 07:14:03 INFO - 'sessionrestore_no_auto_restore', 07:14:03 INFO - 'tabpaint']}, 07:14:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:14:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:14:03 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['bloom_basic_singleton']}, 07:14:03 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['bloom_basic']}, 07:14:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:03 INFO - 'tsvgr_opacity', 07:14:03 INFO - 'tart', 07:14:03 INFO - 'tscrollx', 07:14:03 INFO - 'tsvg_static']}, 07:14:03 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['tsvgx', 07:14:03 INFO - 'tsvgr_opacity', 07:14:03 INFO - 'tart', 07:14:03 INFO - 'tscrollx', 07:14:03 INFO - 'tsvg_static']}, 07:14:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:14:03 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--stylo'], 07:14:03 INFO - 'tests': ['tp5o']}, 07:14:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:14:03 INFO - 'talos_options': ['--mitmproxy', 07:14:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:14:03 INFO - '--firstNonBlankPaint'], 07:14:03 INFO - 'tests': ['tp6_google', 07:14:03 INFO - 'tp6_youtube', 07:14:03 INFO - 'tp6_amazon', 07:14:03 INFO - 'tp6_facebook']}, 07:14:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:14:03 INFO - 'talos_options': ['--stylo', 07:14:03 INFO - '--mitmproxy', 07:14:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:14:03 INFO - '--firstNonBlankPaint'], 07:14:03 INFO - 'tests': ['tp6_google', 07:14:03 INFO - 'tp6_youtube', 07:14:03 INFO - 'tp6_amazon', 07:14:03 INFO - 'tp6_facebook']}, 07:14:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:14:03 INFO - 'talos_options': ['--stylo', 07:14:03 INFO - '--stylo-threads=1', 07:14:03 INFO - '--mitmproxy', 07:14:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:14:03 INFO - '--firstNonBlankPaint'], 07:14:03 INFO - 'tests': ['tp6_google', 07:14:03 INFO - 'tp6_youtube', 07:14:03 INFO - 'tp6_amazon', 07:14:03 INFO - 'tp6_facebook']}, 07:14:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--xperf_path', 07:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:03 INFO - 'tests': ['tp5n']}, 07:14:03 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:14:03 INFO - 'talos_options': ['--stylo', 07:14:03 INFO - '--xperf_path', 07:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:03 INFO - 'tests': ['tp5n']}}} 07:14:03 INFO - Running post-action listener: _resource_record_post_action 07:14:03 INFO - [mozharness: 2017-08-22 14:14:03.395478Z] Finished populate-webroot step (success) 07:14:03 INFO - [mozharness: 2017-08-22 14:14:03.395568Z] Running create-virtualenv step. 07:14:03 INFO - Running pre-action listener: _resource_record_pre_action 07:14:03 INFO - Running main action method: create_virtualenv 07:14:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:14:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:14:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:03 INFO - Using real prefix '/usr' 07:14:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:05 INFO - Installing pip.................done. 07:14:05 INFO - Return code: 0 07:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:14:06 INFO - Reading from file tmpfile_stdout 07:14:06 INFO - Output received: 07:14:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:14:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:14:06 INFO - Using env: {'DISPLAY': ':0', 07:14:06 INFO - 'HOME': '/home/cltbld', 07:14:06 INFO - 'LANG': 'en_US.UTF-8', 07:14:06 INFO - 'LANGUAGE': 'en_US:en', 07:14:06 INFO - 'LOGNAME': 'cltbld', 07:14:06 INFO - 'MAIL': '/var/mail/cltbld', 07:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:06 INFO - 'MOZ_NO_REMOTE': '1', 07:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:06 INFO - 'NO_EM_RESTART': '1', 07:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:06 INFO - 'PWD': '/builds/slave/test', 07:14:06 INFO - 'SHELL': '/bin/bash', 07:14:06 INFO - 'SHLVL': '1', 07:14:06 INFO - 'TERM': 'linux', 07:14:06 INFO - 'TMOUT': '86400', 07:14:06 INFO - 'USER': 'cltbld', 07:14:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:06 INFO - '_': '/tools/buildbot/bin/python'} 07:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:14:06 INFO - Cleaning up... 07:14:06 INFO - Return code: 0 07:14:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:14:06 INFO - Using env: {'DISPLAY': ':0', 07:14:06 INFO - 'HOME': '/home/cltbld', 07:14:06 INFO - 'LANG': 'en_US.UTF-8', 07:14:06 INFO - 'LANGUAGE': 'en_US:en', 07:14:06 INFO - 'LOGNAME': 'cltbld', 07:14:06 INFO - 'MAIL': '/var/mail/cltbld', 07:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:06 INFO - 'MOZ_NO_REMOTE': '1', 07:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:06 INFO - 'NO_EM_RESTART': '1', 07:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:06 INFO - 'PWD': '/builds/slave/test', 07:14:06 INFO - 'SHELL': '/bin/bash', 07:14:06 INFO - 'SHLVL': '1', 07:14:06 INFO - 'TERM': 'linux', 07:14:06 INFO - 'TMOUT': '86400', 07:14:06 INFO - 'USER': 'cltbld', 07:14:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:06 INFO - '_': '/tools/buildbot/bin/python'} 07:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:06 INFO - Downloading/unpacking psutil>=3.1.1 07:14:06 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 07:14:06 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 07:14:06 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 07:14:06 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 07:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:07 INFO - Installing collected packages: psutil 07:14:07 INFO - Running setup.py install for psutil 07:14:07 INFO - building 'psutil._psutil_linux' extension 07:14:07 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 07:14:08 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 07:14:08 INFO - building 'psutil._psutil_posix' extension 07:14:08 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 07:14:08 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 07:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:08 INFO - Successfully installed psutil 07:14:08 INFO - Cleaning up... 07:14:08 INFO - Return code: 0 07:14:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:08 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:08 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 07:14:08 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 07:14:08 INFO - Using env: {'DISPLAY': ':0', 07:14:08 INFO - 'HOME': '/home/cltbld', 07:14:08 INFO - 'LANG': 'en_US.UTF-8', 07:14:08 INFO - 'LANGUAGE': 'en_US:en', 07:14:08 INFO - 'LOGNAME': 'cltbld', 07:14:08 INFO - 'MAIL': '/var/mail/cltbld', 07:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:08 INFO - 'MOZ_NO_REMOTE': '1', 07:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:08 INFO - 'NO_EM_RESTART': '1', 07:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:08 INFO - 'PWD': '/builds/slave/test', 07:14:08 INFO - 'SHELL': '/bin/bash', 07:14:08 INFO - 'SHLVL': '1', 07:14:08 INFO - 'TERM': 'linux', 07:14:08 INFO - 'TMOUT': '86400', 07:14:08 INFO - 'USER': 'cltbld', 07:14:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:08 INFO - '_': '/tools/buildbot/bin/python'} 07:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:14:09 INFO - Installing collected packages: mozsystemmonitor 07:14:09 INFO - Running setup.py install for mozsystemmonitor 07:14:09 INFO - Successfully installed mozsystemmonitor 07:14:09 INFO - Cleaning up... 07:14:09 INFO - Return code: 0 07:14:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:09 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:09 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 07:14:09 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 07:14:09 INFO - Using env: {'DISPLAY': ':0', 07:14:09 INFO - 'HOME': '/home/cltbld', 07:14:09 INFO - 'LANG': 'en_US.UTF-8', 07:14:09 INFO - 'LANGUAGE': 'en_US:en', 07:14:09 INFO - 'LOGNAME': 'cltbld', 07:14:09 INFO - 'MAIL': '/var/mail/cltbld', 07:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:09 INFO - 'MOZ_NO_REMOTE': '1', 07:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:09 INFO - 'NO_EM_RESTART': '1', 07:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:09 INFO - 'PWD': '/builds/slave/test', 07:14:09 INFO - 'SHELL': '/bin/bash', 07:14:09 INFO - 'SHLVL': '1', 07:14:09 INFO - 'TERM': 'linux', 07:14:09 INFO - 'TMOUT': '86400', 07:14:09 INFO - 'USER': 'cltbld', 07:14:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:09 INFO - '_': '/tools/buildbot/bin/python'} 07:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:10 INFO - Downloading/unpacking jsonschema==2.5.1 07:14:10 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 07:14:10 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 07:14:10 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 07:14:10 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 07:14:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:11 INFO - warning: no files found matching '*.txt' 07:14:11 INFO - no previously-included directories found matching 'build' 07:14:11 INFO - no previously-included directories found matching 'dist' 07:14:11 INFO - no previously-included directories found matching '.git*' 07:14:11 INFO - Installing collected packages: jsonschema, functools32 07:14:11 INFO - Running setup.py install for functools32 07:14:11 INFO - warning: no files found matching '*.txt' 07:14:11 INFO - no previously-included directories found matching 'build' 07:14:11 INFO - no previously-included directories found matching 'dist' 07:14:11 INFO - no previously-included directories found matching '.git*' 07:14:11 INFO - Successfully installed jsonschema functools32 07:14:11 INFO - Cleaning up... 07:14:11 INFO - Return code: 0 07:14:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:14:11 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')]} 07:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:11 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')]} 07:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:11 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:11 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 07:14:11 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 07:14:11 INFO - Using env: {'DISPLAY': ':0', 07:14:11 INFO - 'HOME': '/home/cltbld', 07:14:11 INFO - 'LANG': 'en_US.UTF-8', 07:14:11 INFO - 'LANGUAGE': 'en_US:en', 07:14:11 INFO - 'LOGNAME': 'cltbld', 07:14:11 INFO - 'MAIL': '/var/mail/cltbld', 07:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:11 INFO - 'MOZ_NO_REMOTE': '1', 07:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:11 INFO - 'NO_EM_RESTART': '1', 07:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:11 INFO - 'PWD': '/builds/slave/test', 07:14:11 INFO - 'SHELL': '/bin/bash', 07:14:11 INFO - 'SHLVL': '1', 07:14:11 INFO - 'TERM': 'linux', 07:14:11 INFO - 'TMOUT': '86400', 07:14:11 INFO - 'USER': 'cltbld', 07:14:11 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:11 INFO - '_': '/tools/buildbot/bin/python'} 07:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:14:11 INFO - Cleaning up... 07:14:11 INFO - Return code: 0 07:14:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14:11 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')]} 07:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:11 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')]} 07:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:11 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:11 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 07:14:11 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 07:14:11 INFO - Using env: {'DISPLAY': ':0', 07:14:11 INFO - 'HOME': '/home/cltbld', 07:14:11 INFO - 'LANG': 'en_US.UTF-8', 07:14:11 INFO - 'LANGUAGE': 'en_US:en', 07:14:11 INFO - 'LOGNAME': 'cltbld', 07:14:11 INFO - 'MAIL': '/var/mail/cltbld', 07:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:11 INFO - 'MOZ_NO_REMOTE': '1', 07:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:11 INFO - 'NO_EM_RESTART': '1', 07:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:11 INFO - 'PWD': '/builds/slave/test', 07:14:11 INFO - 'SHELL': '/bin/bash', 07:14:11 INFO - 'SHLVL': '1', 07:14:11 INFO - 'TERM': 'linux', 07:14:11 INFO - 'TMOUT': '86400', 07:14:11 INFO - 'USER': 'cltbld', 07:14:11 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:11 INFO - '_': '/tools/buildbot/bin/python'} 07:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:11 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 07:14:11 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 07:14:11 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 07:14:11 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 07:14:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - Downloading docopt-0.6.1.tar.gz 07:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:13 INFO - Running setup.py install for blobuploader 07:14:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:13 INFO - Running setup.py install for requests 07:14:14 INFO - Running setup.py install for docopt 07:14:14 INFO - Successfully installed blobuploader requests docopt 07:14:14 INFO - Cleaning up... 07:14:14 INFO - Return code: 0 07:14:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:14 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:14 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 07:14:14 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 07:14:14 INFO - Using env: {'DISPLAY': ':0', 07:14:14 INFO - 'HOME': '/home/cltbld', 07:14:14 INFO - 'LANG': 'en_US.UTF-8', 07:14:14 INFO - 'LANGUAGE': 'en_US:en', 07:14:14 INFO - 'LOGNAME': 'cltbld', 07:14:14 INFO - 'MAIL': '/var/mail/cltbld', 07:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:14 INFO - 'MOZ_NO_REMOTE': '1', 07:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:14 INFO - 'NO_EM_RESTART': '1', 07:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:14 INFO - 'PWD': '/builds/slave/test', 07:14:14 INFO - 'SHELL': '/bin/bash', 07:14:14 INFO - 'SHLVL': '1', 07:14:14 INFO - 'TERM': 'linux', 07:14:14 INFO - 'TMOUT': '86400', 07:14:14 INFO - 'USER': 'cltbld', 07:14:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:14 INFO - '_': '/tools/buildbot/bin/python'} 07:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:14 INFO - Running setup.py (path:/tmp/pip-sCZmHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:14 INFO - Running setup.py (path:/tmp/pip-_rU7Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:14 INFO - Running setup.py (path:/tmp/pip-KdPPu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:14 INFO - Running setup.py (path:/tmp/pip-MD2EJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:14 INFO - Running setup.py (path:/tmp/pip-3waTbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:14 INFO - Running setup.py (path:/tmp/pip-WcumO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:15 INFO - Running setup.py (path:/tmp/pip-nzw2fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:15 INFO - Running setup.py (path:/tmp/pip-K5bnSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:15 INFO - Running setup.py (path:/tmp/pip-HdTSOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:15 INFO - Running setup.py (path:/tmp/pip-OrGM01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:15 INFO - Running setup.py (path:/tmp/pip-_TI6r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:15 INFO - Running setup.py (path:/tmp/pip-oxgi1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:15 INFO - Running setup.py (path:/tmp/pip-EdtQbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:15 INFO - Running setup.py (path:/tmp/pip-amOn3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:15 INFO - Running setup.py (path:/tmp/pip-HZdn_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:15 INFO - Running setup.py (path:/tmp/pip-aWcW0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:15 INFO - Running setup.py (path:/tmp/pip-E8id64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:15 INFO - Running setup.py install for manifestparser 07:14:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:15 INFO - Running setup.py install for mozcrash 07:14:16 INFO - Running setup.py install for mozdebug 07:14:16 INFO - Running setup.py install for mozdevice 07:14:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for mozfile 07:14:16 INFO - Running setup.py install for mozhttpd 07:14:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for mozinfo 07:14:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for mozInstall 07:14:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for mozleak 07:14:16 INFO - Running setup.py install for mozlog 07:14:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for moznetwork 07:14:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:16 INFO - Running setup.py install for mozprocess 07:14:17 INFO - Running setup.py install for mozprofile 07:14:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:17 INFO - Running setup.py install for mozrunner 07:14:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:17 INFO - Running setup.py install for mozscreenshot 07:14:17 INFO - Running setup.py install for moztest 07:14:17 INFO - Running setup.py install for mozversion 07:14:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:17 INFO - Cleaning up... 07:14:17 INFO - Return code: 0 07:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:17 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:17 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 07:14:17 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 07:14:17 INFO - Using env: {'DISPLAY': ':0', 07:14:17 INFO - 'HOME': '/home/cltbld', 07:14:17 INFO - 'LANG': 'en_US.UTF-8', 07:14:17 INFO - 'LANGUAGE': 'en_US:en', 07:14:17 INFO - 'LOGNAME': 'cltbld', 07:14:17 INFO - 'MAIL': '/var/mail/cltbld', 07:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:17 INFO - 'MOZ_NO_REMOTE': '1', 07:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:17 INFO - 'NO_EM_RESTART': '1', 07:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:17 INFO - 'PWD': '/builds/slave/test', 07:14:17 INFO - 'SHELL': '/bin/bash', 07:14:17 INFO - 'SHLVL': '1', 07:14:17 INFO - 'TERM': 'linux', 07:14:17 INFO - 'TMOUT': '86400', 07:14:17 INFO - 'USER': 'cltbld', 07:14:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:17 INFO - '_': '/tools/buildbot/bin/python'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:17 INFO - Running setup.py (path:/tmp/pip-_7vBO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:17 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)) 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:17 INFO - Running setup.py (path:/tmp/pip-NNXWXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:18 INFO - Running setup.py (path:/tmp/pip-K3Jb6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:18 INFO - Running setup.py (path:/tmp/pip-J9s0OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:18 INFO - Running setup.py (path:/tmp/pip-XbG4Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:18 INFO - Running setup.py (path:/tmp/pip-rbxdzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:18 INFO - Running setup.py (path:/tmp/pip-luzMZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:18 INFO - Running setup.py (path:/tmp/pip-wxHJ33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:18 INFO - Running setup.py (path:/tmp/pip-FrVujd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:18 INFO - Running setup.py (path:/tmp/pip-xiHF0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:18 INFO - Running setup.py (path:/tmp/pip-HgxkXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:18 INFO - Running setup.py (path:/tmp/pip-Loz9U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:18 INFO - Running setup.py (path:/tmp/pip-FxcND0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:18 INFO - Running setup.py (path:/tmp/pip-oXBPkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:18 INFO - Running setup.py (path:/tmp/pip-6LPTzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:18 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)) 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:18 INFO - Running setup.py (path:/tmp/pip-UKqYdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:19 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)) 07:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:19 INFO - Running setup.py (path:/tmp/pip-S25NpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:19 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)) 07:14:19 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)) 07:14:19 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)) 07:14:19 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)) 07:14:19 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)) 07:14:19 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)) 07:14:19 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)) 07:14:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:20 INFO - Downloading blessings-1.6.tar.gz 07:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:20 INFO - Installing collected packages: blessings 07:14:20 INFO - Running setup.py install for blessings 07:14:20 INFO - Successfully installed blessings 07:14:20 INFO - Cleaning up... 07:14:20 INFO - Return code: 0 07:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:20 INFO - Reading from file tmpfile_stdout 07:14:20 INFO - Current package versions: 07:14:20 INFO - argparse == 1.2.1 07:14:20 INFO - blessings == 1.6 07:14:20 INFO - blobuploader == 1.2.4 07:14:20 INFO - docopt == 0.6.1 07:14:20 INFO - functools32 == 3.2.3-2 07:14:20 INFO - jsonschema == 2.5.1 07:14:20 INFO - manifestparser == 1.1 07:14:20 INFO - mozInstall == 1.13 07:14:20 INFO - mozcrash == 1.0 07:14:20 INFO - mozdebug == 0.1 07:14:20 INFO - mozdevice == 0.51 07:14:20 INFO - mozfile == 1.2 07:14:20 INFO - mozhttpd == 0.7 07:14:20 INFO - mozinfo == 0.10 07:14:20 INFO - mozleak == 0.1 07:14:20 INFO - mozlog == 3.5 07:14:20 INFO - moznetwork == 0.27 07:14:20 INFO - mozprocess == 0.25 07:14:20 INFO - mozprofile == 0.28 07:14:20 INFO - mozrunner == 6.13 07:14:20 INFO - mozscreenshot == 0.1 07:14:20 INFO - mozsystemmonitor == 0.3 07:14:20 INFO - moztest == 0.8 07:14:20 INFO - mozversion == 1.4 07:14:20 INFO - psutil == 3.1.1 07:14:20 INFO - requests == 1.2.3 07:14:20 INFO - wsgiref == 0.1.2 07:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:20 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 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14:20 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 07:14:20 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 07:14:20 INFO - Using env: {'DISPLAY': ':0', 07:14:20 INFO - 'HOME': '/home/cltbld', 07:14:20 INFO - 'LANG': 'en_US.UTF-8', 07:14:20 INFO - 'LANGUAGE': 'en_US:en', 07:14:20 INFO - 'LOGNAME': 'cltbld', 07:14:20 INFO - 'MAIL': '/var/mail/cltbld', 07:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:20 INFO - 'MOZ_NO_REMOTE': '1', 07:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:20 INFO - 'NO_EM_RESTART': '1', 07:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:20 INFO - 'PWD': '/builds/slave/test', 07:14:20 INFO - 'SHELL': '/bin/bash', 07:14:20 INFO - 'SHLVL': '1', 07:14:20 INFO - 'TERM': 'linux', 07:14:20 INFO - 'TMOUT': '86400', 07:14:20 INFO - 'USER': 'cltbld', 07:14:20 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:20 INFO - '_': '/tools/buildbot/bin/python'} 07:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 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)) 07:14:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:14:20 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 07:14:20 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 07:14:20 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 07:14:20 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 07:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:14:22 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)) 07:14:22 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)) 07:14:22 INFO - Installing collected packages: simplejson 07:14:22 INFO - Running setup.py install for simplejson 07:14:22 INFO - building 'simplejson._speedups' extension 07:14:22 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 07:14:22 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 07:14:23 INFO - Successfully installed simplejson 07:14:23 INFO - Cleaning up... 07:14:23 INFO - Return code: 0 07:14:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', '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 07:14: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', 'jsonschema'] in /builds/slave/test/build 07:14: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 jsonschema 07:14:23 INFO - Using env: {'DISPLAY': ':0', 07:14:23 INFO - 'HOME': '/home/cltbld', 07:14:23 INFO - 'LANG': 'en_US.UTF-8', 07:14:23 INFO - 'LANGUAGE': 'en_US:en', 07:14:23 INFO - 'LOGNAME': 'cltbld', 07:14:23 INFO - 'MAIL': '/var/mail/cltbld', 07:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:23 INFO - 'MOZ_NO_REMOTE': '1', 07:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:23 INFO - 'NO_EM_RESTART': '1', 07:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:23 INFO - 'PWD': '/builds/slave/test', 07:14:23 INFO - 'SHELL': '/bin/bash', 07:14:23 INFO - 'SHLVL': '1', 07:14:23 INFO - 'TERM': 'linux', 07:14:23 INFO - 'TMOUT': '86400', 07:14:23 INFO - 'USER': 'cltbld', 07:14:23 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:23 INFO - '_': '/tools/buildbot/bin/python'} 07:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:14:23 INFO - Cleaning up... 07:14:23 INFO - Return code: 0 07:14:23 INFO - Running post-action listener: _resource_record_post_action 07:14:23 INFO - Running post-action listener: _start_resource_monitoring 07:14:23 INFO - Starting resource monitoring. 07:14:23 INFO - [mozharness: 2017-08-22 14:14:23.374994Z] Finished create-virtualenv step (success) 07:14:23 INFO - [mozharness: 2017-08-22 14:14:23.375462Z] Running install step. 07:14:23 INFO - Running pre-action listener: _resource_record_pre_action 07:14:23 INFO - Running main action method: install 07:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:23 INFO - Reading from file tmpfile_stdout 07:14:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:23 INFO - Reading from file tmpfile_stdout 07:14:23 INFO - Output received: 07:14:23 INFO - Usage: mozinstall [options] installer 07:14:23 INFO - Options: 07:14:23 INFO - -h, --help show this help message and exit 07:14:23 INFO - -d DEST, --destination=DEST 07:14:23 INFO - Directory to install application into. [default: 07:14:23 INFO - "/builds/slave/test"] 07:14:23 INFO - --app=APP Application being installed. [default: firefox] 07:14:23 INFO - mkdir: /builds/slave/test/build/application 07:14:23 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'] 07:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:14:41 INFO - Reading from file tmpfile_stdout 07:14:41 INFO - Output received: 07:14:41 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:41 INFO - Running post-action listener: _resource_record_post_action 07:14:41 INFO - [mozharness: 2017-08-22 14:14:41.411905Z] Finished install step (success) 07:14:41 INFO - [mozharness: 2017-08-22 14:14:41.412250Z] Running setup-mitmproxy step. 07:14:41 INFO - Running pre-action listener: _resource_record_pre_action 07:14:41 INFO - Running main action method: setup_mitmproxy 07:14:41 INFO - Skipping: mitmproxy is not required 07:14:41 INFO - Running post-action listener: _resource_record_post_action 07:14:41 INFO - [mozharness: 2017-08-22 14:14:41.414012Z] Finished setup-mitmproxy step (success) 07:14:41 INFO - [mozharness: 2017-08-22 14:14:41.414324Z] Running run-tests step. 07:14:41 INFO - Running pre-action listener: _resource_record_pre_action 07:14:41 INFO - Running pre-action listener: _set_gcov_prefix 07:14:41 INFO - Running main action method: run_tests 07:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:41 INFO - Python 2.7.3 07:14:41 INFO - Return code: 0 07:14:41 INFO - grabbing minidump binary from tooltool 07:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1909130>, '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 0x190a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190a4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:14:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:14:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:14:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:41 INFO - Return code: 0 07:14:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:41 INFO - ENV: RUST_BACKTRACE is now full 07:14:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 07:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 07:14:41 INFO - Using env: {'DISPLAY': ':0', 07:14:41 INFO - 'HOME': '/home/cltbld', 07:14:41 INFO - 'LANG': 'en_US.UTF-8', 07:14:41 INFO - 'LANGUAGE': 'en_US:en', 07:14:41 INFO - 'LOGNAME': 'cltbld', 07:14:41 INFO - 'MAIL': '/var/mail/cltbld', 07:14:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:41 INFO - 'MOZ_NO_REMOTE': '1', 07:14:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:41 INFO - 'NO_EM_RESTART': '1', 07:14:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:41 INFO - 'PWD': '/builds/slave/test', 07:14:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:41 INFO - 'RUST_BACKTRACE': 'full', 07:14:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:41 INFO - 'SHELL': '/bin/bash', 07:14:41 INFO - 'SHLVL': '1', 07:14:41 INFO - 'TERM': 'linux', 07:14:41 INFO - 'TMOUT': '86400', 07:14:41 INFO - 'USER': 'cltbld', 07:14:41 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483', 07:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:41 INFO - '_': '/tools/buildbot/bin/python'} 07:14:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 07:14:41 INFO - mozversion application_buildid: 20170822131001 07:14:41 INFO - mozversion application_changeset: 1867d7931c0a70ab90edf4aa84876525773a7139 07:14:41 INFO - mozversion application_display_name: Nightly 07:14:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:41 INFO - mozversion application_name: Firefox 07:14:41 INFO - mozversion application_remotingname: firefox 07:14:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:14:41 INFO - mozversion application_vendor: Mozilla 07:14:41 INFO - mozversion application_version: 57.0a1 07:14:41 INFO - mozversion platform_buildid: 20170822131001 07:14:41 INFO - mozversion platform_changeset: 1867d7931c0a70ab90edf4aa84876525773a7139 07:14:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:14:41 INFO - mozversion platform_version: 57.0a1 07:14:41 INFO - using testdate: 1503411281 07:14:41 INFO - actual date: 1503411281 07:14:41 INFO - starting webserver on 'localhost:55273' 07:14:41 INFO - SUITE-START | Running 2 tests 07:14:41 INFO - TEST-START | dromaeo_css 07:14:41 INFO - Initialising browser for dromaeo_css test... 07:14:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55273/getInfo.html -profile /tmp/tmpT2dO2T/profile 07:14:41 INFO - TEST-INFO | started process 5695 (/builds/slave/test/build/application/firefox/firefox http://localhost:55273/getInfo.html) 07:14:47 INFO - TEST-INFO | 5695: exit 0 07:14:47 INFO - Browser initialized. 07:14:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:47 INFO - TEST-INFO | started process 5869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT2dO2T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:48 INFO - PID 5869 | 07:14:48 INFO - PID 5869 | (/builds/slave/test/build/application/firefox/firefox:5919): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:14:48 INFO - PID 5869 | 07:14:49 INFO - PID 5869 | 07:14:49 INFO - PID 5869 | (/builds/slave/test/build/application/firefox/firefox:5974): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:14:49 INFO - PID 5869 | 07:14:49 INFO - PID 5869 | __metrics Screen width/height:1600/1200 07:14:49 INFO - PID 5869 | colorDepth:24 07:14:49 INFO - PID 5869 | Browser inner width/height: 1024/768 07:14:49 INFO - PID 5869 | __metrics 07:14:58 INFO - PID 5869 | RSS: Main: 170967040 07:14:58 INFO - PID 5869 | 07:17:57 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55273/tests/dromaeo/cssquery-ext.html) 07:17:58 INFO - PID 5869 | RSS: Main: 175284224 07:17:58 INFO - PID 5869 | 07:21:00 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-ext.html (next: http://localhost:55273/tests/dromaeo/cssquery-jquery.html) 07:21:01 INFO - PID 5869 | RSS: Main: 172060672 07:21:01 INFO - PID 5869 | 07:24:02 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55273/tests/dromaeo/cssquery-mootools.html) 07:24:03 INFO - PID 5869 | RSS: Main: 172101632 07:24:03 INFO - PID 5869 | 07:27:05 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55273/tests/dromaeo/cssquery-prototype.html) 07:27:05 INFO - PID 5869 | RSS: Main: 172789760 07:27:05 INFO - PID 5869 | 07:30:09 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55273/tests/dromaeo/cssquery-yui.html) 07:30:10 INFO - PID 5869 | RSS: Main: 175808512 07:30:10 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | Cycle 1(1): loaded http://localhost:55273/tests/dromaeo/cssquery-yui.html (next: http://localhost:55273/tests/dromaeo/cssquery-dojo.html) 07:33:11 INFO - PID 5869 | RSS: Main: 175820800 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | __start_tp_report 07:33:11 INFO - PID 5869 | _x_x_mozilla_page_load 07:33:11 INFO - PID 5869 | _x_x_mozilla_page_load_details 07:33:11 INFO - PID 5869 | |i|pagename|runs| 07:33:11 INFO - PID 5869 | |0;dojo.html;3215.067630387188;3247.447933851245;3281.0320955318184;3294.5717056782614;3312.536244925711;6168.876622467548;6194.597351172176;6232.034034724614;6239.594426362289;6265.3734626537325;6049.092636104587;6150.661713605761;6155.599886007418;6156.384361563842;6183.505319574435;5664.830055098354;5701.857453563653;5767.5962682612235;5799.652020878761;5867.589268751189;5732.2261494698305;5790.7683692652245;5823.2138661280605;5825.242718446596;5833.183354330376;5492.121260598305;5673.773049078052;5680.6591604503865;5721.056025755745;5769.826905192851;5680.034394153004;5709.115087161496;5750.108733146369;5754.280714910637;5766.884662306772;5564.749586268627;5610.046292130348;5640.153976903456;5715.771369145229;5737.942620573783;6104.298005729309;6113.388661133896;6168.228971378578;6202.472789812871;6231.9065214021375;6630.303818099078;6680.565763225375;6741.460683145386;6749.156355455568;6775.898361524581;6567.770128045543;6670.599764014175;6744.190697116328;6745.325467453215;6845.657717114124;6186.505079593577;6189.195404597419;6224.128621992924;6229.4704950079295;6279.591826531261;6718.462522998246;6821.386075253251;6953.582785032914;6978.511504194657;6988.196357418962;6442.871142577123;6553.541252112402;6554.573952693155;6554.836129096715;6562.212534495891;6596;6643.5017373697165;6666.433353164938;6667.49993750461;6684.431823294977;6681.265060843303;6701.832454188684;6740.359665831738;6743.393094621508;6744.730210791611;6643.5017373697165;6648.634325112069;6669.666516674147;6745.662716864137;6764.188297404343;5197.792088316501;5284.339457567804;5330.440303768126;5384.165454354581;5400.486953739389;4622.168009758276;4681.531846815291;4688.601468875184;4703.341532185496;4724.763761811896;5778.508826749689;5825.621334613236;5830.941690583125;5840.59115861894;5866.882662346815;6678.699458524378;6707.396334329934;6748.223954245226;6768.120144381199;6781.62701051437;5591.664500130005;5687.829365119053;5690.032694441955;5812.88374232513;5814.941850581525;5658.490735833712;5672.716364181774;5681.744321505542;5717;5723.513501352349;6342.4926005919415;6379.521535884827;6430.7749228776765;6451.096846441502;6468.126802881551;6495.545311828221;6524.510661700297;6532.183477065367;6617.371349721769;6623.039659249285;6436.0989461476365;6459.838504037437;6525.3800888915475;6530.7387704493185;6535;6545;6637.966810165918;6648;6671.099401580918;6692.765753198614;6684.799456016327;6690.431313338421;6694.263631000488;6780.660966951534;6784.253732089367;6316.589421687576;6427.485801135805;6443.516736244706;6451.709673064817;6556.573822701509;6536.901946470712;6571.474282057328;6585.242697089704;6587.80236592903;6593.571417857824;6291;6411.4229719325485;6418.229812422539;6436.67816609177;6527.216733991761;6388.648624325707;6436.324185960407;6449.097126402401;6465.870682586416;6469.547131700736;6260.937390626035;6264.2796078451565;6268.529860260407;6272.40412160844;6272.8118156455375 07:33:11 INFO - PID 5869 | |1;ext.html;773.6402572803645;832.8667413213886;853.9487630742154;863.477596054387;1041.6302212714481;26550.86724566377;28003.85998070012;38572.61427385725;39135.21729565414;39346.40980385296;39726.801365993204;39991.40012899809;40004.59995400045;40078.39882401766;40112.39831402524;7417.592032438214;7464.328210461071;7595.81010474737;7597.164311925684;7605.2014538473495;7457.850842983137;7537.359324457428;7557.433192510556;7564.773056808277;7568.091828980502;7523.097228332607;7579.052618422697;7581.772546823577;7585.317321441069;7586.3172314491685;7512.474126811126;7531.924680753177;7544.283293087148;7546.283103105251;7547.283008114247;7420.666070026862;7466.328030477283;7490.288422599899;7495.650782859083;7516.624168791539;36366.27267454663;36474.635253647655;36506;36528.26943461142;36564.451533227024;3443.2080621456953;3473.8263086845554;3474.808885511296;3478.113081164312;3483.6690514401093;30751.846240768653;30754;30757.84621076903;30780.53829192564;30794;4899.216125419915;5068.949310506885;5127.230915362688;5148.742562871841;5162.586993040548;189251;189418;190534;191143;191244;45231;45266.77366613212;45370.77314613406;45390.773046134556;45404.772976135566;48195.75902120467;48207;48336;48384;48413.5158648416;12211.389430528616;12535.24788512692;14900.850991490162;15214.315355809014;15257.465988690343;11959.641210763692;12142.696432589257;12168.08739344535;12178.208416452902;12190.963768079813;13882.722345553033;13905.513307034205;13911.165330080228;13924.164550126823;14031.438742450187;5706.743196556165;5752.539796816244;5773.566982476331;5829.387914269026;5901.557383196192;992.3599278465349;1023.7850051489122;1025.8922813104666;1027.5427434791445;1034.6792494326783;22135.557288854132;22234.77652234796;22440.775592244194;22497.100115995505;22499.212527561456;1102.8786833448314;1105.309181761399;1113.7215696075982;1126.189143816451;1130.6438471881331;11754.35351055683;11827.704307392383;11956.641300760992;11966.581169659194;11986.820197697041;229600;230934;231169;231357;231681;48537.757311213216;48731;49100.263496047584;49232;49604;1405.866442687943;1434.956951291463;1438.928053597316;1461.174436443406;1468.1851572377434;21732;22028;22369.44076398103;22438.1941956286;22457.32628021162;31596.052118436484;31669.524957125202;36036.81981590075;36058.45912311265;36143;188559;189060;189112;189294;189671;29140.417191655622;29528.409431811673;29536.704632953395;32795.34409311848;33646.15884602807;41334.37998430086;41580.376294355;41584.792076039426;41672;41766;31036;31221.687783122787;31340.843295783376;31637;31701.365972679956;30670.77316907299;30860.38279234358;30940.845295773375;31461;31521.52717709282;32965.50551741774;34649.133771655914;34731;34741;34957.47563786495;29849.5522567166;30553;30631.846840765655;30661.92683256075;31182.532262015633;22977.88511057434;23131.421714457272;23947.52104957856;23953.880230598734;24763.50472990566 07:33:11 INFO - PID 5869 | |2;jquery.html;543.3208489388262;552.5413906457641;558.4666643355596;561.9213310136581;573.2948473377745;21658.566828663435;22471.651700897935;22552;22561.097556097757;23938.28185154448;25738.871305643446;26557.60163597543;26587.867060664717;26609;26629;6789.932100679004;7014.5440546364325;7179.030830837823;7179.748708795193;7186.065811444531;7012;7026.191987921404;7044.753433629824;7067.505274630778;7069.363757261845;7025.82435439113;7042.330978557055;7057.929420705778;7062.717491300367;7073.964630176842;7064.682089305994;7065.682044307992;7067.85864282714;7068.752593659248;7073.717051317941;6865.176178858569;6873.278305777922;6886.965565172142;6891.345322194384;6904.344087311697;29464.852675736485;31012.224694382596;31087.844560777277;31137.377252454826;31476.527852082007;2014.8891810950392;2050.0569737920573;2055.9280425185198;2058.3824852544176;2058.60886431579;19158.52103697405;19644.901775491173;19662;19677.409677709693;19683.11425985834;2408.205292253552;2565.204786516186;2574.382148284398;2581.4191806843496;2582.3673200066105;137913;141472;141590;141670;141794.58205417916;20685.379438616867;22017.779822201894;22073.117075316808;22804.4298892529;22882.427939301317;42171;42177.36733948993;42179.789101054295;42186.36720449196;42344;11335.943320283346;11469.598564050219;11703.531858725555;11720;11764.058875289957;7791.4935529190425;8156.714514991947;8425.4944703318;9552.761180970532;9691.224702023963;11394.715132121597;11722;11848.763024739457;11924.344161071225;11928.582499612472;3704.499892514476;3713.164537978933;3963.137325457031;4136.338185890243;4322.481302243751;882.2060145868642;903.13299232736;910.8815853938945;916.3768637326549;918.2516249256968;19287.035648217534;19679.803201968083;19828;19987.20051197965;20007.399778006682;948.8719022931816;962.6726912849665;962.7833737409167;967.9225661947028;980.4215512847312;10803.729906752236;10904.34573925567;11065.668029959113;11105.666829995112;11197.832032519518;441341;447083;462585;463398;464652;106318;109155.45422272838;111080.4445977765;111614.44192778984;112855.4357228225;1140.7832511822728;1153.4924633161381;1165.7901577716093;1167.9824802627968;1184.9881501184877;17541.912290438977;17662.646747065242;17805.19876605582;17892.10539472995;18065.729014065062;53581.46418535765;54037.189442159186;54417;54962;55579.444205557425;64051;64118.35881641124;65141.34858651353;65154;65254.67372663107;14281.500147494788;14970.101793892401;15011.624709382353;19697.507562310482;20077.49806254855;23633.29100126999;24059.157929473084;24067.638985414884;24117.638235426835;24175.758242417352;18744.906275468536;18808.52978675544;18982.335618253295;19176.945268010393;19189.232430702614;17056.658866822345;17130.800843940804;17378.47864564065;17391.739123913405;17680.292788288323;16701.582460438585;16895.493135205965;16949.32202711878;16971.745423818407;17025;14651.780223296872;14781.556553303419;14785.186814725294;14789.926050369679;14810.185439800915;18530.907345463187;18625.44123676292;18774.6245075095;18790;18799.624007520048 07:33:11 INFO - PID 5869 | |3;mootools.html;1265.2155663488638;1299.6880748620329;1323.8411390633125;1329.8071779591955;1331.9067665263435;14432.639184020405;15060.924695376509;15078.849211507895;15091.39634414622;15091.849081509195;14820.481283155092;15148.091114533136;15182.84817151828;15188.164650944194;15216.619584510392;2685.382362056728;2710.7695845853127;2761.282066662662;2769.127724766692;2779.221817890994;2671.4122892963615;2686.6507354043947;2689.273896048066;2695.8382497050143;2707.7698395636394;2617.4895895300424;2650.390410205654;2653.24382550973;2656.0836511403536;2683.798715096366;2590.533703933301;2637.1165659503995;2641.8507949042228;2641.9867900660565;2645.4841305945347;2607.361196506868;2610.830296030752;2640.234332043705;2641.9471610567875;2676.1703871799805;14628.634284142876;14776.778348324784;14782.482613108597;14803.259837008107;14807.407703691839;7527.736529221451;7752.418568607377;7782.766517004442;7801.258880406409;7803.609819509059;5216.66091704038;5350.785968561253;5562.972185139089;5571;5602.411746766572;1918.1847714721187;1932.8743631663897;1977.2387630762116;2002.1991203518564;2012.30575451469;24438.389040273956;25093.12174073917;25741.22776316695;26059.21822345333;26124.216273511825;7149.714011439484;7216.170140433917;7221.616866434169;7234.276572342724;7302.868055451414;19596.706049408986;19668.90165549163;19677.606447871247;19689.212431502867;19692.212311507665;7783.494072885244;7830.099538553025;7863.13505514393;7868;7876.684932602631;6930.44556435484;7040;7075.327843854826;7087.929120708727;7096;5488.862778430571;5593.524550413261;5597.888042239132;5636.239107720406;5638.295213098363;1693.8729595280404;1766.9558261043576;1769.4160926894094;1770.371518111052;1770.504258807536;888.4358432395346;916.1891725822695;926.9212116969999;932.0912110692021;941.4680705401427;7611.847763044819;7729.884051739228;7745.419093568005;7755.3407960324;7795.649195786204;690.2821066091209;706.1561434086218;708.989365159523;726.2882375272263;731.1518638379455;5067.6199285053035;5229.032628963654;5315.787368505216;5395.433479484676;5405.297311349578;19716.211351546066;20679.689804652942;20740.06669699867;20931.37205883826;20939.162433502795;20088.899555502423;20219.191232350542;20382.796172038386;20454.897725511277;21615.459613509473;9719.076687714656;10097.495125243708;10526.73683157912;10947.781044379228;11214.775704486028;8422.536760478233;8463.449875758057;8494.277986371228;8527.403081784463;8654.35567242222;17627.471175864746;17776.466705998842;18234.817651823843;18258.543536411697;18530.44408667742;18346.357877474224;18401.079946002916;18438.63122737511;18537.98041107752;18798.718019229447;11329.603463878724;11583.710407239887;11683.941580292045;11747.118966077749;11780.352080635646;13507.662308441975;13519.594412167651;13655.590332290047;13679.316034198051;13681.247531385869;10934.726631834268;10962.945185274022;11154.16343774204;11369.488373023069;11527.077833773446;10190.694279171637;10199.694009179737;10200.540975655966;10208.2343824212;10281.383117013003;9652.372595781251;9749.07383798538;9798.069183427562;9799.314048016855;9816.80366392654;6969.7909062728195;6996.545224560387;7017.193022802443;7019.613921234381;7053.858922821412;7106.964465177641;7136.429085673238;7164.534305270141;7193.676284567103;7216.314450127229 07:33:11 INFO - PID 5869 | |4;prototype.html;491.95837275307485;498.87043580105944;508.81428278678294;513.3788116379181;524.6589716684155;6123;6127.142200091991;6140.109684095809;6144.723487443064;6170.228721409824;5934.792282270121;6044.4613262429775;6085.330613632508;6106.725197366118;6141.72362243699;4958.87602809929;4962.816360801245;4972.6379969514555;4999.150144475448;5026.949730502684;4821.638377121712;4965.826196083138;4976.552110310071;4977.3529441172595;4982.750862456881;4894.4371397289415;4899.608031357483;4912.828051018215;4933.629977751665;4964.230544265644;4911.582515486188;4952.628552858532;4960.553550180501;4963.404391473046;4978.153713868651;4449.822007119711;4480.059187570581;4482.125985432842;4485.529019452975;4490.57339552742;6067.423594758491;6067.998780201261;6073.483753880925;6100.938990610081;6108.358622344635;5685.061964775807;5694.1458781183155;5701.828945131652;5725.255716756837;5727.942720572824;6495.123158373606;6509.576877502947;6530.902036469457;6576.441002514792;6602.438792702626;4802.207635740098;4828.637852161067;4831.613470922318;4835.395575553056;4837.540433658797;6782.9321706783285;6831.351021652935;6848.630273945231;6876.553024053421;6891.724331026753;4975.179095449283;4976.62675299354;4979.9542096159485;5005.874853128701;5030;5041.495850415003;5047.41954675217;5052.9894021195905;5074.873128171826;5090.211017292326;5568.610197286151;5642.7178641067785;5670.347909990322;5679.772809087673;5689.743961521742;6459.160309159779;6500.7572387526225;6520.315366886503;6543.574667646683;6652.567583107082;1645.1609679063524;1665.2423147467873;1682.1505139904514;1718.828117188271;1719.1232471439405;1176.4823477669797;1181.9586314478952;1204.3978010994504;1219.0978675779859;1224.993875030637;5638.590352411897;5666.4050274721385;5667.024811973747;5668.093105103246;5691.715414229272;6496.805095847132;6544;6553.606783593;6668.599884006975;6699.866002679919;5652.406497317805;5710.600257981984;5751.511121554631;5751.971240143773;5785.293338465163;3493.8602455901478;3517.876874309438;3541.8937431877084;3548.059764162499;3564.536610240652;6447.4197322241225;6493.642849643315;6494.415502604788;6530.444912182517;6593.175853018372;6761.695723692445;6876.931230687629;6878.793636190922;6901.896471552931;6904.171499420001;6450.5808722081065;6475.449586785176;6523.412892839668;6535.967320163464;6538.574992625559;6586.365453818511;6604.669766511752;6633.900491492535;6647.202335719745;6661.300563440769;6512.804615861532;6568.934310656832;6669.399754022162;6680.465562754871;6738.663066846736;6496.577722448026;6505.763904858062;6516.934830651822;6539.378759017885;6557.9344206559235;4968.975155124202;4973.204287314013;4975.5522003019905;4977.203647416541;4985.825496107619;6479.7408103675325;6771.424428923597;6775.661216939035;6780.355866192704;6803.285655006153;6333.968330158504;6402.807915762534;6416.486681065597;6429.7140571884875;6469.611823290617;6426.518011149276;6430.164078669743;6457.967710161419;6461.61230326182;6480.319566445455;6380.363192979957;6396.71214795326;6407.519436042222;6408.295087540274;6443.806685799434;6366.618002919654;6446;6454.870902582016;6458.160439142881;6507.381798729113;6241.937580624317;6258.749650014131;6262.248530176408;6277.529185311028;6334.461570766536 07:33:11 INFO - PID 5869 | |5;yui.html;866.1425189062827;886.1006078829988;895.417978314096;899.1907283444899;908.6819613135399;17838.464846054623;19119.904400477997;19198.616027679436;19230.134643941023;21032.474188145265;20883.269085582007;21104.683429748566;21595.676064859;21605.567888642217;21616.459588510294;933.9392939458913;947.114447991127;949.6438835436711;950.2967803825154;950.5009869818332;917.8485549884261;943.580106852451;946.7443790176649;966.111177716499;968.3270127261557;987.249690235419;1005.8088963096989;1016.7559785651428;1016.9644062457816;1017.8269694152012;995.3231802374382;996.5266498413268;1002.7793885345212;1012.1245122968616;1013.3565186106838;713.864365770502;724.1021133794058;733.9816504587375;734.3207533031978;738.6823665823694;19124;19435.514112147168;19609.607807843764;19667;19788.307409240606;20404;20487.795122048738;20653.17387304506;20800.5839883203;20919.790802091935;14584.70830583393;15945.521634350987;16111.194440278057;16113.43602973902;16127.274272657758;3737.4206997915367;3777.8299976501125;3778.338790711642;3782.659560639528;3786.3373909565717;116218.41890790492;118421;124398;127157;129344.35327823395;15110.093394396372;15440.691186176213;15479.458218962282;15520.223988800515;15590.142542160063;27578.44843103167;28273.858630706716;28328.8583557085;28719.85640071786;28738.85630571834;8171.264586187272;8493.915060849436;8515.659373625109;8545.48727076365;8623.913760862437;4049.8380064797666;4085.97957010219;4132.710710250314;4154.626083652486;4157.5010998679745;5057.418396884405;5080.949190508121;5138.665986710852;5168.147255702767;5182.740862956837;970.335320305593;981.5877331520778;997.9550920208608;1000.6097621927454;1002.8194924913586;663.9136912201479;670.5373292428307;700.3836623771151;704.4118161335342;713.8429545499981;11480.368579728029;11568.88431115678;11609.709757255967;11695.824562631567;12011;667.2226855713137;672.7174586673609;679.4937771360368;680.7141000779684;688.6728803818246;5504.642198257181;5552.611317207838;5622.662640241599;5667.659940403589;5780.682062486603;110330;111353;111922.44038779917;112083;118346.40826795984;92729.53635231781;92764.53617732003;93721;95868.52065739766;100684;82659;84668.57665711633;84799;85151.14848851557;86996;10281.53733082028;10306;10407.63573274962;10458.790824183321;10685.091767199876;38223.23553528969;39357.212855743295;39627.60372396239;40168.39747403733;40290.99272518211;70848.29151708623;73023;73624.63187684027;74471;74681.62659186669;17845.910770446066;18020.2791888323;18134.18396172149;18138.455846324632;18260.08699565043;19607.215711371384;20120.19519219215;20274.290399835936;20320.89839550852;21010.159593616085;17015.574610634834;17641.911790440965;17908.46274611764;18518.351857684916;18726.344577939708;17964.371247006293;18529.258829646664;18986;19150.904245478683;19554.60890782205;17597.208125634123;17655.558611034314;17852.107394630475;17967.730484042488;18202.72695909589;13303.135296205715;13568.118072325267;13882.722345553235;14178.716425671635;14386.136831790127;13528.93235533816;13786.65533361674;13823.585292441243;13896.58310250694;14138.151710897379 07:33:11 INFO - PID 5869 | __end_tp_report 07:33:11 INFO - PID 5869 | __start_cc_report 07:33:11 INFO - PID 5869 | _x_x_mozilla_cycle_collect,390 07:33:11 INFO - PID 5869 | __end_cc_report 07:33:11 INFO - PID 5869 | __startTimestamp1503412391926__endTimestamp 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | ------- Summary: start ------- 07:33:11 INFO - PID 5869 | Number of tests: 6 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#0] dojo.html Cycles:165 Average:6136.66 Median:6342.49 stddev:711.03 (11.2%) stddev-sans-first:675.26 07:33:11 INFO - PID 5869 | Values: 3215.1 3247.4 3281.0 3294.6 3312.5 6168.9 6194.6 6232.0 6239.6 6265.4 6049.1 6150.7 6155.6 6156.4 6183.5 5664.8 5701.9 5767.6 5799.7 5867.6 5732.2 5790.8 5823.2 5825.2 5833.2 5492.1 5673.8 5680.7 5721.1 5769.8 5680.0 5709.1 5750.1 5754.3 5766.9 5564.7 5610.0 5640.2 5715.8 5737.9 6104.3 6113.4 6168.2 6202.5 6231.9 6630.3 6680.6 6741.5 6749.2 6775.9 6567.8 6670.6 6744.2 6745.3 6845.7 6186.5 6189.2 6224.1 6229.5 6279.6 6718.5 6821.4 6953.6 6978.5 6988.2 6442.9 6553.5 6554.6 6554.8 6562.2 6596.0 6643.5 6666.4 6667.5 6684.4 6681.3 6701.8 6740.4 6743.4 6744.7 6643.5 6648.6 6669.7 6745.7 6764.2 5197.8 5284.3 5330.4 5384.2 5400.5 4622.2 4681.5 4688.6 4703.3 4724.8 5778.5 5825.6 5830.9 5840.6 5866.9 6678.7 6707.4 6748.2 6768.1 6781.6 5591.7 5687.8 5690.0 5812.9 5814.9 5658.5 5672.7 5681.7 5717.0 5723.5 6342.5 6379.5 6430.8 6451.1 6468.1 6495.5 6524.5 6532.2 6617.4 6623.0 6436.1 6459.8 6525.4 6530.7 6535.0 6545.0 6638.0 6648.0 6671.1 6692.8 6684.8 6690.4 6694.3 6780.7 6784.3 6316.6 6427.5 6443.5 6451.7 6556.6 6536.9 6571.5 6585.2 6587.8 6593.6 6291.0 6411.4 6418.2 6436.7 6527.2 6388.6 6436.3 6449.1 6465.9 6469.5 6260.9 6264.3 6268.5 6272.4 6272.8 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#1] ext.html Cycles:180 Average:36269.02 Median:31685.45 stddev:52957.48 (167.1%) stddev-sans-first:53038.98 07:33:11 INFO - PID 5869 | Values: 773.6 832.9 853.9 863.5 1041.6 26550.9 28003.9 38572.6 39135.2 39346.4 39726.8 39991.4 40004.6 40078.4 40112.4 7417.6 7464.3 7595.8 7597.2 7605.2 7457.9 7537.4 7557.4 7564.8 7568.1 7523.1 7579.1 7581.8 7585.3 7586.3 7512.5 7531.9 7544.3 7546.3 7547.3 7420.7 7466.3 7490.3 7495.7 7516.6 36366.3 36474.6 36506.0 36528.3 36564.5 3443.2 3473.8 3474.8 3478.1 3483.7 30751.8 30754.0 30757.8 30780.5 30794.0 4899.2 5068.9 5127.2 5148.7 5162.6 189251.0 189418.0 190534.0 191143.0 191244.0 45231.0 45266.8 45370.8 45390.8 45404.8 48195.8 48207.0 48336.0 48384.0 48413.5 12211.4 12535.2 14900.9 15214.3 15257.5 11959.6 12142.7 12168.1 12178.2 12191.0 13882.7 13905.5 13911.2 13924.2 14031.4 5706.7 5752.5 5773.6 5829.4 5901.6 992.4 1023.8 1025.9 1027.5 1034.7 22135.6 22234.8 22440.8 22497.1 22499.2 1102.9 1105.3 1113.7 1126.2 1130.6 11754.4 11827.7 11956.6 11966.6 11986.8 229600.0 230934.0 231169.0 231357.0 231681.0 48537.8 48731.0 49100.3 49232.0 49604.0 1405.9 1435.0 1438.9 1461.2 1468.2 21732.0 22028.0 22369.4 22438.2 22457.3 31596.1 31669.5 36036.8 36058.5 36143.0 188559.0 189060.0 189112.0 189294.0 189671.0 29140.4 29528.4 29536.7 32795.3 33646.2 41334.4 41580.4 41584.8 41672.0 41766.0 31036.0 31221.7 31340.8 31637.0 31701.4 30670.8 30860.4 30940.8 31461.0 31521.5 32965.5 34649.1 34731.0 34741.0 34957.5 29849.6 30553.0 30631.8 30661.9 31182.5 22977.9 23131.4 23947.5 23953.9 24763.5 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#2] jquery.html Cycles:180 Average:34593.14 Median:23998.72 stddev:77060.89 (321.1%) stddev-sans-first:77234.66 07:33:11 INFO - PID 5869 | Values: 543.3 552.5 558.5 561.9 573.3 21658.6 22471.7 22552.0 22561.1 23938.3 25738.9 26557.6 26587.9 26609.0 26629.0 6789.9 7014.5 7179.0 7179.7 7186.1 7012.0 7026.2 7044.8 7067.5 7069.4 7025.8 7042.3 7057.9 7062.7 7074.0 7064.7 7065.7 7067.9 7068.8 7073.7 6865.2 6873.3 6887.0 6891.3 6904.3 29464.9 31012.2 31087.8 31137.4 31476.5 2014.9 2050.1 2055.9 2058.4 2058.6 19158.5 19644.9 19662.0 19677.4 19683.1 2408.2 2565.2 2574.4 2581.4 2582.4 137913.0 141472.0 141590.0 141670.0 141794.6 20685.4 22017.8 22073.1 22804.4 22882.4 42171.0 42177.4 42179.8 42186.4 42344.0 11335.9 11469.6 11703.5 11720.0 11764.1 7791.5 8156.7 8425.5 9552.8 9691.2 11394.7 11722.0 11848.8 11924.3 11928.6 3704.5 3713.2 3963.1 4136.3 4322.5 882.2 903.1 910.9 916.4 918.3 19287.0 19679.8 19828.0 19987.2 20007.4 948.9 962.7 962.8 967.9 980.4 10803.7 10904.3 11065.7 11105.7 11197.8 441341.0 447083.0 462585.0 463398.0 464652.0 106318.0 109155.5 111080.4 111614.4 112855.4 1140.8 1153.5 1165.8 1168.0 1185.0 17541.9 17662.6 17805.2 17892.1 18065.7 53581.5 54037.2 54417.0 54962.0 55579.4 64051.0 64118.4 65141.3 65154.0 65254.7 14281.5 14970.1 15011.6 19697.5 20077.5 23633.3 24059.2 24067.6 24117.6 24175.8 18744.9 18808.5 18982.3 19176.9 19189.2 17056.7 17130.8 17378.5 17391.7 17680.3 16701.6 16895.5 16949.3 16971.7 17025.0 14651.8 14781.6 14785.2 14789.9 14810.2 18530.9 18625.4 18774.6 18790.0 18799.6 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#3] mootools.html Cycles:180 Average:9201.12 Median:2641.90 stddev:6521.13 (246.8%) stddev-sans-first:6512.16 07:33:11 INFO - PID 5869 | Values: 1265.2 1299.7 1323.8 1329.8 1331.9 14432.6 15060.9 15078.8 15091.4 15091.8 14820.5 15148.1 15182.8 15188.2 15216.6 2685.4 2710.8 2761.3 2769.1 2779.2 2671.4 2686.7 2689.3 2695.8 2707.8 2617.5 2650.4 2653.2 2656.1 2683.8 2590.5 2637.1 2641.9 2642.0 2645.5 2607.4 2610.8 2640.2 2641.9 2676.2 14628.6 14776.8 14782.5 14803.3 14807.4 7527.7 7752.4 7782.8 7801.3 7803.6 5216.7 5350.8 5563.0 5571.0 5602.4 1918.2 1932.9 1977.2 2002.2 2012.3 24438.4 25093.1 25741.2 26059.2 26124.2 7149.7 7216.2 7221.6 7234.3 7302.9 19596.7 19668.9 19677.6 19689.2 19692.2 7783.5 7830.1 7863.1 7868.0 7876.7 6930.4 7040.0 7075.3 7087.9 7096.0 5488.9 5593.5 5597.9 5636.2 5638.3 1693.9 1767.0 1769.4 1770.4 1770.5 888.4 916.2 926.9 932.1 941.5 7611.8 7729.9 7745.4 7755.3 7795.6 690.3 706.2 709.0 726.3 731.2 5067.6 5229.0 5315.8 5395.4 5405.3 19716.2 20679.7 20740.1 20931.4 20939.2 20088.9 20219.2 20382.8 20454.9 21615.5 9719.1 10097.5 10526.7 10947.8 11214.8 8422.5 8463.4 8494.3 8527.4 8654.4 17627.5 17776.5 18234.8 18258.5 18530.4 18346.4 18401.1 18438.6 18538.0 18798.7 11329.6 11583.7 11683.9 11747.1 11780.4 13507.7 13519.6 13655.6 13679.3 13681.2 10934.7 10962.9 11154.2 11369.5 11527.1 10190.7 10199.7 10200.5 10208.2 10281.4 9652.4 9749.1 9798.1 9799.3 9816.8 6969.8 6996.5 7017.2 7019.6 7053.9 7107.0 7136.4 7164.5 7193.7 7216.3 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#4] prototype.html Cycles:180 Average:5472.32 Median:6093.13 stddev:1538.27 (25.2%) stddev-sans-first:1496.47 07:33:11 INFO - PID 5869 | Values: 492.0 498.9 508.8 513.4 524.7 6123.0 6127.1 6140.1 6144.7 6170.2 5934.8 6044.5 6085.3 6106.7 6141.7 4958.9 4962.8 4972.6 4999.2 5026.9 4821.6 4965.8 4976.6 4977.4 4982.8 4894.4 4899.6 4912.8 4933.6 4964.2 4911.6 4952.6 4960.6 4963.4 4978.2 4449.8 4480.1 4482.1 4485.5 4490.6 6067.4 6068.0 6073.5 6100.9 6108.4 5685.1 5694.1 5701.8 5725.3 5727.9 6495.1 6509.6 6530.9 6576.4 6602.4 4802.2 4828.6 4831.6 4835.4 4837.5 6782.9 6831.4 6848.6 6876.6 6891.7 4975.2 4976.6 4980.0 5005.9 5030.0 5041.5 5047.4 5053.0 5074.9 5090.2 5568.6 5642.7 5670.3 5679.8 5689.7 6459.2 6500.8 6520.3 6543.6 6652.6 1645.2 1665.2 1682.2 1718.8 1719.1 1176.5 1182.0 1204.4 1219.1 1225.0 5638.6 5666.4 5667.0 5668.1 5691.7 6496.8 6544.0 6553.6 6668.6 6699.9 5652.4 5710.6 5751.5 5752.0 5785.3 3493.9 3517.9 3541.9 3548.1 3564.5 6447.4 6493.6 6494.4 6530.4 6593.2 6761.7 6876.9 6878.8 6901.9 6904.2 6450.6 6475.4 6523.4 6536.0 6538.6 6586.4 6604.7 6633.9 6647.2 6661.3 6512.8 6568.9 6669.4 6680.5 6738.7 6496.6 6505.8 6516.9 6539.4 6557.9 4969.0 4973.2 4975.6 4977.2 4985.8 6479.7 6771.4 6775.7 6780.4 6803.3 6334.0 6402.8 6416.5 6429.7 6469.6 6426.5 6430.2 6458.0 6461.6 6480.3 6380.4 6396.7 6407.5 6408.3 6443.8 6366.6 6446.0 6454.9 6458.2 6507.4 6241.9 6258.7 6262.2 6277.5 6334.5 07:33:11 INFO - PID 5869 | 07:33:11 INFO - PID 5869 | [#5] yui.html Cycles:180 Average:23526.07 Median:21068.58 stddev:31998.53 (151.9%) stddev-sans-first:32043.05 07:33:11 INFO - PID 5869 | Values: 866.1 886.1 895.4 899.2 908.7 17838.5 19119.9 19198.6 19230.1 21032.5 20883.3 21104.7 21595.7 21605.6 21616.5 933.9 947.1 949.6 950.3 950.5 917.8 943.6 946.7 966.1 968.3 987.2 1005.8 1016.8 1017.0 1017.8 995.3 996.5 1002.8 1012.1 1013.4 713.9 724.1 734.0 734.3 738.7 19124.0 19435.5 19609.6 19667.0 19788.3 20404.0 20487.8 20653.2 20800.6 20919.8 14584.7 15945.5 16111.2 16113.4 16127.3 3737.4 3777.8 3778.3 3782.7 3786.3 116218.4 118421.0 124398.0 127157.0 129344.4 15110.1 15440.7 15479.5 15520.2 15590.1 27578.4 28273.9 28328.9 28719.9 28738.9 8171.3 8493.9 8515.7 8545.5 8623.9 4049.8 4086.0 4132.7 4154.6 4157.5 5057.4 5080.9 5138.7 5168.1 5182.7 970.3 981.6 998.0 1000.6 1002.8 663.9 670.5 700.4 704.4 713.8 11480.4 11568.9 11609.7 11695.8 12011.0 667.2 672.7 679.5 680.7 688.7 5504.6 5552.6 5622.7 5667.7 5780.7 110330.0 111353.0 111922.4 112083.0 118346.4 92729.5 92764.5 93721.0 95868.5 100684.0 82659.0 84668.6 84799.0 85151.1 86996.0 10281.5 10306.0 10407.6 10458.8 10685.1 38223.2 39357.2 39627.6 40168.4 40291.0 70848.3 73023.0 73624.6 74471.0 74681.6 17845.9 18020.3 18134.2 18138.5 18260.1 19607.2 20120.2 20274.3 20320.9 21010.2 17015.6 17641.9 17908.5 18518.4 18726.3 17964.4 18529.3 18986.0 19150.9 19554.6 17597.2 17655.6 17852.1 17967.7 18202.7 13303.1 13568.1 13882.7 14178.7 14386.1 13528.9 13786.7 13823.6 13896.6 14138.2 07:33:11 INFO - PID 5869 | -------- Summary: end -------- 07:33:11 INFO - PID 5869 | 07:33:12 INFO - TEST-INFO | 5869: exit 0 07:33:12 INFO - TEST-OK | dromaeo_css | took 1110839ms 07:33:12 INFO - TEST-START | kraken 07:33:12 INFO - Initialising browser for kraken test... 07:33:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55273/getInfo.html -profile /tmp/tmpCEntzj/profile 07:33:12 INFO - TEST-INFO | started process 6284 (/builds/slave/test/build/application/firefox/firefox http://localhost:55273/getInfo.html) 07:33:18 INFO - TEST-INFO | 6284: exit 0 07:33:18 INFO - Browser initialized. 07:33:18 INFO - Running cycle 1/1 for kraken test... 07:33:18 INFO - TEST-INFO | started process 6459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCEntzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:19 INFO - PID 6459 | 07:33:19 INFO - PID 6459 | (/builds/slave/test/build/application/firefox/firefox:6509): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:33:19 INFO - PID 6459 | 07:33:20 INFO - PID 6459 | 07:33:20 INFO - PID 6459 | (/builds/slave/test/build/application/firefox/firefox:6566): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:33:20 INFO - PID 6459 | 07:33:20 INFO - PID 6459 | __metrics Screen width/height:1600/1200 07:33:20 INFO - PID 6459 | colorDepth:24 07:33:20 INFO - PID 6459 | Browser inner width/height: 1024/768 07:33:20 INFO - PID 6459 | __metrics 07:33:29 INFO - PID 6459 | RSS: Main: 171659264 07:33:29 INFO - PID 6459 | 07:33:32 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55273/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:33 INFO - PID 6459 | RSS: Main: 175329280 07:33:33 INFO - PID 6459 | 07:33:36 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55273/tests/kraken/driver.html?testName=audio-dft) 07:33:36 INFO - PID 6459 | RSS: Main: 175943680 07:33:36 INFO - PID 6459 | 07:33:39 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55273/tests/kraken/driver.html?testName=audio-fft) 07:33:40 INFO - PID 6459 | RSS: Main: 170078208 07:33:40 INFO - PID 6459 | 07:33:42 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55273/tests/kraken/driver.html?testName=audio-oscillator) 07:33:42 INFO - PID 6459 | RSS: Main: 170516480 07:33:42 INFO - PID 6459 | 07:33:45 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:45 INFO - PID 6459 | RSS: Main: 171360256 07:33:45 INFO - PID 6459 | 07:33:48 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55273/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:49 INFO - PID 6459 | RSS: Main: 172158976 07:33:49 INFO - PID 6459 | 07:33:53 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55273/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:53 INFO - PID 6459 | RSS: Main: 171958272 07:33:53 INFO - PID 6459 | 07:33:56 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55273/tests/kraken/driver.html?testName=json-parse-financial) 07:33:57 INFO - PID 6459 | RSS: Main: 172167168 07:33:57 INFO - PID 6459 | 07:33:58 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:59 INFO - PID 6459 | RSS: Main: 171732992 07:33:59 INFO - PID 6459 | 07:34:01 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:01 INFO - PID 6459 | RSS: Main: 172445696 07:34:01 INFO - PID 6459 | 07:34:03 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:04 INFO - PID 6459 | RSS: Main: 171966464 07:34:04 INFO - PID 6459 | 07:34:07 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:08 INFO - PID 6459 | RSS: Main: 172433408 07:34:08 INFO - PID 6459 | 07:34:10 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:11 INFO - PID 6459 | RSS: Main: 172199936 07:34:11 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | Cycle 1(1): loaded http://localhost:55273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55273/tests/kraken/driver.html?testName=ai-astar) 07:34:13 INFO - PID 6459 | RSS: Main: 174346240 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | __start_tp_report 07:34:13 INFO - PID 6459 | _x_x_mozilla_page_load 07:34:13 INFO - PID 6459 | _x_x_mozilla_page_load_details 07:34:13 INFO - PID 6459 | |i|pagename|runs| 07:34:13 INFO - PID 6459 | |0;ai-astar;98;108;102;107;106;110;109;101;107;111 07:34:13 INFO - PID 6459 | |1;audio-beat-detection;145;117;146;161;119;144;144;119;170;121 07:34:13 INFO - PID 6459 | |2;audio-dft;165;163;162;161;163;161;163;165;163;171 07:34:13 INFO - PID 6459 | |3;audio-fft;77;75;75;176;75;76;73;77;164;76 07:34:13 INFO - PID 6459 | |4;audio-oscillator;79;81;135;80;79;80;123;80;79;133 07:34:13 INFO - PID 6459 | |5;imaging-gaussian-blur;114;115;114;114;114;115;115;115;115;114 07:34:13 INFO - PID 6459 | |6;imaging-darkroom;148;148;149;148;148;149;148;148;149;149 07:34:13 INFO - PID 6459 | |7;imaging-desaturate;93;94;94;94;94;94;95;94;94;94 07:34:13 INFO - PID 6459 | |8;json-parse-financial;55;53;52;53;52;53;53;53;53;53 07:34:13 INFO - PID 6459 | |9;json-stringify-tinderbox;56;55;56;55;55;55;56;56;57;56 07:34:13 INFO - PID 6459 | |10;stanford-crypto-aes;75;75;75;75;75;75;77;76;78;78 07:34:13 INFO - PID 6459 | |11;stanford-crypto-ccm;121;119;129;125;125;119;124;127;123;174 07:34:13 INFO - PID 6459 | |12;stanford-crypto-pbkdf2;176;170;176;170;171;180;176;171;170;175 07:34:13 INFO - PID 6459 | |13;stanford-crypto-sha256-iterative;65;64;65;68;63;64;64;69;64;66 07:34:13 INFO - PID 6459 | __end_tp_report 07:34:13 INFO - PID 6459 | __start_cc_report 07:34:13 INFO - PID 6459 | _x_x_mozilla_cycle_collect,965 07:34:13 INFO - PID 6459 | __end_cc_report 07:34:13 INFO - PID 6459 | __startTimestamp1503412453607__endTimestamp 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | ------- Summary: start ------- 07:34:13 INFO - PID 6459 | Number of tests: 14 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#0] ai-astar Cycles:10 Average:105.90 Median:108.50 stddev:4.23 (3.9%) stddev-sans-first:3.38 07:34:13 INFO - PID 6459 | Values: 98.0 108.0 102.0 107.0 106.0 110.0 109.0 101.0 107.0 111.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:144.50 stddev:18.82 (13.0%) stddev-sans-first:19.81 07:34:13 INFO - PID 6459 | Values: 145.0 117.0 146.0 161.0 119.0 144.0 144.0 119.0 170.0 121.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.91 (1.8%) stddev-sans-first:3.05 07:34:13 INFO - PID 6459 | Values: 165.0 163.0 162.0 161.0 163.0 161.0 163.0 165.0 163.0 171.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.96 (52.9%) stddev-sans-first:41.89 07:34:13 INFO - PID 6459 | Values: 77.0 75.0 75.0 176.0 75.0 76.0 73.0 77.0 164.0 76.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.50 stddev:24.65 (31.0%) stddev-sans-first:25.46 07:34:13 INFO - PID 6459 | Values: 79.0 81.0 135.0 80.0 79.0 80.0 123.0 80.0 79.0 133.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:34:13 INFO - PID 6459 | Values: 114.0 115.0 114.0 114.0 114.0 115.0 115.0 115.0 115.0 114.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 07:34:13 INFO - PID 6459 | Values: 148.0 148.0 149.0 148.0 148.0 149.0 148.0 148.0 149.0 149.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 07:34:13 INFO - PID 6459 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.44 07:34:13 INFO - PID 6459 | Values: 55.0 53.0 52.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 07:34:13 INFO - PID 6459 | Values: 56.0 55.0 56.0 55.0 55.0 55.0 56.0 56.0 57.0 56.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:1.29 (1.7%) stddev-sans-first:1.32 07:34:13 INFO - PID 6459 | Values: 75.0 75.0 75.0 75.0 75.0 75.0 77.0 76.0 78.0 78.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:125.00 stddev:16.28 (13.0%) stddev-sans-first:17.03 07:34:13 INFO - PID 6459 | Values: 121.0 119.0 129.0 125.0 125.0 119.0 124.0 127.0 123.0 174.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:175.50 stddev:3.54 (2.0%) stddev-sans-first:3.63 07:34:13 INFO - PID 6459 | Values: 176.0 170.0 176.0 170.0 171.0 180.0 176.0 171.0 170.0 175.0 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.93 (3.0%) stddev-sans-first:2.05 07:34:13 INFO - PID 6459 | Values: 65.0 64.0 65.0 68.0 63.0 64.0 64.0 69.0 64.0 66.0 07:34:13 INFO - PID 6459 | -------- Summary: end -------- 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | 07:34:13 INFO - PID 6459 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 07:34:13 INFO - PID 6459 | 07:34:14 INFO - PID 6459 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:34:14 INFO - TEST-INFO | 6459: exit 0 07:34:14 INFO - TEST-OK | kraken | took 61744ms 07:34:14 INFO - SUITE-END | took 1172s 07:34:14 INFO - Completed test suite (00:19:32) 07:34:14 INFO - javascript benchmark 07:34:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8501.495554078349, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.067630387188, 3247.447933851245, 3281.0320955318184, 3294.5717056782614, 3312.536244925711, 6168.876622467548, 6194.597351172176, 6232.034034724614, 6239.594426362289, 6265.3734626537325, 6049.092636104587, 6150.661713605761, 6155.599886007418, 6156.384361563842, 6183.505319574435, 5664.830055098354, 5701.857453563653, 5767.5962682612235, 5799.652020878761, 5867.589268751189, 5732.2261494698305, 5790.7683692652245, 5823.2138661280605, 5825.242718446596, 5833.183354330376, 5492.121260598305, 5673.773049078052, 5680.6591604503865, 5721.056025755745, 5769.826905192851, 5680.034394153004, 5709.115087161496, 5750.108733146369, 5754.280714910637, 5766.884662306772, 5564.749586268627, 5610.046292130348, 5640.153976903456, 5715.771369145229, 5737.942620573783, 6104.298005729309, 6113.388661133896, 6168.228971378578, 6202.472789812871, 6231.9065214021375, 6630.303818099078, 6680.565763225375, 6741.460683145386, 6749.156355455568, 6775.898361524581, 6567.770128045543, 6670.599764014175, 6744.190697116328, 6745.325467453215, 6845.657717114124, 6186.505079593577, 6189.195404597419, 6224.128621992924, 6229.4704950079295, 6279.591826531261, 6718.462522998246, 6821.386075253251, 6953.582785032914, 6978.511504194657, 6988.196357418962, 6442.871142577123, 6553.541252112402, 6554.573952693155, 6554.836129096715, 6562.212534495891, 6596.0, 6643.5017373697165, 6666.433353164938, 6667.49993750461, 6684.431823294977, 6681.265060843303, 6701.832454188684, 6740.359665831738, 6743.393094621508, 6744.730210791611, 6643.5017373697165, 6648.634325112069, 6669.666516674147, 6745.662716864137, 6764.188297404343, 5197.792088316501, 5284.339457567804, 5330.440303768126, 5384.165454354581, 5400.486953739389, 4622.168009758276, 4681.531846815291, 4688.601468875184, 4703.341532185496, 4724.763761811896, 5778.508826749689, 5825.621334613236, 5830.941690583125, 5840.59115861894, 5866.882662346815, 6678.699458524378, 6707.396334329934, 6748.223954245226, 6768.120144381199, 6781.62701051437, 5591.664500130005, 5687.829365119053, 5690.032694441955, 5812.88374232513, 5814.941850581525, 5658.490735833712, 5672.716364181774, 5681.744321505542, 5717.0, 5723.513501352349, 6342.4926005919415, 6379.521535884827, 6430.7749228776765, 6451.096846441502, 6468.126802881551, 6495.545311828221, 6524.510661700297, 6532.183477065367, 6617.371349721769, 6623.039659249285, 6436.0989461476365, 6459.838504037437, 6525.3800888915475, 6530.7387704493185, 6535.0, 6545.0, 6637.966810165918, 6648.0, 6671.099401580918, 6692.765753198614, 6684.799456016327, 6690.431313338421, 6694.263631000488, 6780.660966951534, 6784.253732089367, 6316.589421687576, 6427.485801135805, 6443.516736244706, 6451.709673064817, 6556.573822701509, 6536.901946470712, 6571.474282057328, 6585.242697089704, 6587.80236592903, 6593.571417857824, 6291.0, 6411.4229719325485, 6418.229812422539, 6436.67816609177, 6527.216733991761, 6388.648624325707, 6436.324185960407, 6449.097126402401, 6465.870682586416, 6469.547131700736, 6260.937390626035, 6264.2796078451565, 6268.529860260407, 6272.40412160844, 6272.8118156455375], "value": 6085.521578172673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.6402572803645, 832.8667413213886, 853.9487630742154, 863.477596054387, 1041.6302212714481, 26550.86724566377, 28003.85998070012, 38572.61427385725, 39135.21729565414, 39346.40980385296, 39726.801365993204, 39991.40012899809, 40004.59995400045, 40078.39882401766, 40112.39831402524, 7417.592032438214, 7464.328210461071, 7595.81010474737, 7597.164311925684, 7605.2014538473495, 7457.850842983137, 7537.359324457428, 7557.433192510556, 7564.773056808277, 7568.091828980502, 7523.097228332607, 7579.052618422697, 7581.772546823577, 7585.317321441069, 7586.3172314491685, 7512.474126811126, 7531.924680753177, 7544.283293087148, 7546.283103105251, 7547.283008114247, 7420.666070026862, 7466.328030477283, 7490.288422599899, 7495.650782859083, 7516.624168791539, 36366.27267454663, 36474.635253647655, 36506.0, 36528.26943461142, 36564.451533227024, 3443.2080621456953, 3473.8263086845554, 3474.808885511296, 3478.113081164312, 3483.6690514401093, 30751.846240768653, 30754.0, 30757.84621076903, 30780.53829192564, 30794.0, 4899.216125419915, 5068.949310506885, 5127.230915362688, 5148.742562871841, 5162.586993040548, 189251.0, 189418.0, 190534.0, 191143.0, 191244.0, 45231.0, 45266.77366613212, 45370.77314613406, 45390.773046134556, 45404.772976135566, 48195.75902120467, 48207.0, 48336.0, 48384.0, 48413.5158648416, 12211.389430528616, 12535.24788512692, 14900.850991490162, 15214.315355809014, 15257.465988690343, 11959.641210763692, 12142.696432589257, 12168.08739344535, 12178.208416452902, 12190.963768079813, 13882.722345553033, 13905.513307034205, 13911.165330080228, 13924.164550126823, 14031.438742450187, 5706.743196556165, 5752.539796816244, 5773.566982476331, 5829.387914269026, 5901.557383196192, 992.3599278465349, 1023.7850051489122, 1025.8922813104666, 1027.5427434791445, 1034.6792494326783, 22135.557288854132, 22234.77652234796, 22440.775592244194, 22497.100115995505, 22499.212527561456, 1102.8786833448314, 1105.309181761399, 1113.7215696075982, 1126.189143816451, 1130.6438471881331, 11754.35351055683, 11827.704307392383, 11956.641300760992, 11966.581169659194, 11986.820197697041, 229600.0, 230934.0, 231169.0, 231357.0, 231681.0, 48537.757311213216, 48731.0, 49100.263496047584, 49232.0, 49604.0, 1405.866442687943, 1434.956951291463, 1438.928053597316, 1461.174436443406, 1468.1851572377434, 21732.0, 22028.0, 22369.44076398103, 22438.1941956286, 22457.32628021162, 31596.052118436484, 31669.524957125202, 36036.81981590075, 36058.45912311265, 36143.0, 188559.0, 189060.0, 189112.0, 189294.0, 189671.0, 29140.417191655622, 29528.409431811673, 29536.704632953395, 32795.34409311848, 33646.15884602807, 41334.37998430086, 41580.376294355, 41584.792076039426, 41672.0, 41766.0, 31036.0, 31221.687783122787, 31340.843295783376, 31637.0, 31701.365972679956, 30670.77316907299, 30860.38279234358, 30940.845295773375, 31461.0, 31521.52717709282, 32965.50551741774, 34649.133771655914, 34731.0, 34741.0, 34957.47563786495, 29849.5522567166, 30553.0, 30631.846840765655, 30661.92683256075, 31182.532262015633, 22977.88511057434, 23131.421714457272, 23947.52104957856, 23953.880230598734, 24763.50472990566], "value": 16540.981136362334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3208489388262, 552.5413906457641, 558.4666643355596, 561.9213310136581, 573.2948473377745, 21658.566828663435, 22471.651700897935, 22552.0, 22561.097556097757, 23938.28185154448, 25738.871305643446, 26557.60163597543, 26587.867060664717, 26609.0, 26629.0, 6789.932100679004, 7014.5440546364325, 7179.030830837823, 7179.748708795193, 7186.065811444531, 7012.0, 7026.191987921404, 7044.753433629824, 7067.505274630778, 7069.363757261845, 7025.82435439113, 7042.330978557055, 7057.929420705778, 7062.717491300367, 7073.964630176842, 7064.682089305994, 7065.682044307992, 7067.85864282714, 7068.752593659248, 7073.717051317941, 6865.176178858569, 6873.278305777922, 6886.965565172142, 6891.345322194384, 6904.344087311697, 29464.852675736485, 31012.224694382596, 31087.844560777277, 31137.377252454826, 31476.527852082007, 2014.8891810950392, 2050.0569737920573, 2055.9280425185198, 2058.3824852544176, 2058.60886431579, 19158.52103697405, 19644.901775491173, 19662.0, 19677.409677709693, 19683.11425985834, 2408.205292253552, 2565.204786516186, 2574.382148284398, 2581.4191806843496, 2582.3673200066105, 137913.0, 141472.0, 141590.0, 141670.0, 141794.58205417916, 20685.379438616867, 22017.779822201894, 22073.117075316808, 22804.4298892529, 22882.427939301317, 42171.0, 42177.36733948993, 42179.789101054295, 42186.36720449196, 42344.0, 11335.943320283346, 11469.598564050219, 11703.531858725555, 11720.0, 11764.058875289957, 7791.4935529190425, 8156.714514991947, 8425.4944703318, 9552.761180970532, 9691.224702023963, 11394.715132121597, 11722.0, 11848.763024739457, 11924.344161071225, 11928.582499612472, 3704.499892514476, 3713.164537978933, 3963.137325457031, 4136.338185890243, 4322.481302243751, 882.2060145868642, 903.13299232736, 910.8815853938945, 916.3768637326549, 918.2516249256968, 19287.035648217534, 19679.803201968083, 19828.0, 19987.20051197965, 20007.399778006682, 948.8719022931816, 962.6726912849665, 962.7833737409167, 967.9225661947028, 980.4215512847312, 10803.729906752236, 10904.34573925567, 11065.668029959113, 11105.666829995112, 11197.832032519518, 441341.0, 447083.0, 462585.0, 463398.0, 464652.0, 106318.0, 109155.45422272838, 111080.4445977765, 111614.44192778984, 112855.4357228225, 1140.7832511822728, 1153.4924633161381, 1165.7901577716093, 1167.9824802627968, 1184.9881501184877, 17541.912290438977, 17662.646747065242, 17805.19876605582, 17892.10539472995, 18065.729014065062, 53581.46418535765, 54037.189442159186, 54417.0, 54962.0, 55579.444205557425, 64051.0, 64118.35881641124, 65141.34858651353, 65154.0, 65254.67372663107, 14281.500147494788, 14970.101793892401, 15011.624709382353, 19697.507562310482, 20077.49806254855, 23633.29100126999, 24059.157929473084, 24067.638985414884, 24117.638235426835, 24175.758242417352, 18744.906275468536, 18808.52978675544, 18982.335618253295, 19176.945268010393, 19189.232430702614, 17056.658866822345, 17130.800843940804, 17378.47864564065, 17391.739123913405, 17680.292788288323, 16701.582460438585, 16895.493135205965, 16949.32202711878, 16971.745423818407, 17025.0, 14651.780223296872, 14781.556553303419, 14785.186814725294, 14789.926050369679, 14810.185439800915, 18530.907345463187, 18625.44123676292, 18774.6245075095, 18790.0, 18799.624007520048], "value": 12656.988595582086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.2155663488638, 1299.6880748620329, 1323.8411390633125, 1329.8071779591955, 1331.9067665263435, 14432.639184020405, 15060.924695376509, 15078.849211507895, 15091.39634414622, 15091.849081509195, 14820.481283155092, 15148.091114533136, 15182.84817151828, 15188.164650944194, 15216.619584510392, 2685.382362056728, 2710.7695845853127, 2761.282066662662, 2769.127724766692, 2779.221817890994, 2671.4122892963615, 2686.6507354043947, 2689.273896048066, 2695.8382497050143, 2707.7698395636394, 2617.4895895300424, 2650.390410205654, 2653.24382550973, 2656.0836511403536, 2683.798715096366, 2590.533703933301, 2637.1165659503995, 2641.8507949042228, 2641.9867900660565, 2645.4841305945347, 2607.361196506868, 2610.830296030752, 2640.234332043705, 2641.9471610567875, 2676.1703871799805, 14628.634284142876, 14776.778348324784, 14782.482613108597, 14803.259837008107, 14807.407703691839, 7527.736529221451, 7752.418568607377, 7782.766517004442, 7801.258880406409, 7803.609819509059, 5216.66091704038, 5350.785968561253, 5562.972185139089, 5571.0, 5602.411746766572, 1918.1847714721187, 1932.8743631663897, 1977.2387630762116, 2002.1991203518564, 2012.30575451469, 24438.389040273956, 25093.12174073917, 25741.22776316695, 26059.21822345333, 26124.216273511825, 7149.714011439484, 7216.170140433917, 7221.616866434169, 7234.276572342724, 7302.868055451414, 19596.706049408986, 19668.90165549163, 19677.606447871247, 19689.212431502867, 19692.212311507665, 7783.494072885244, 7830.099538553025, 7863.13505514393, 7868.0, 7876.684932602631, 6930.44556435484, 7040.0, 7075.327843854826, 7087.929120708727, 7096.0, 5488.862778430571, 5593.524550413261, 5597.888042239132, 5636.239107720406, 5638.295213098363, 1693.8729595280404, 1766.9558261043576, 1769.4160926894094, 1770.371518111052, 1770.504258807536, 888.4358432395346, 916.1891725822695, 926.9212116969999, 932.0912110692021, 941.4680705401427, 7611.847763044819, 7729.884051739228, 7745.419093568005, 7755.3407960324, 7795.649195786204, 690.2821066091209, 706.1561434086218, 708.989365159523, 726.2882375272263, 731.1518638379455, 5067.6199285053035, 5229.032628963654, 5315.787368505216, 5395.433479484676, 5405.297311349578, 19716.211351546066, 20679.689804652942, 20740.06669699867, 20931.37205883826, 20939.162433502795, 20088.899555502423, 20219.191232350542, 20382.796172038386, 20454.897725511277, 21615.459613509473, 9719.076687714656, 10097.495125243708, 10526.73683157912, 10947.781044379228, 11214.775704486028, 8422.536760478233, 8463.449875758057, 8494.277986371228, 8527.403081784463, 8654.35567242222, 17627.471175864746, 17776.466705998842, 18234.817651823843, 18258.543536411697, 18530.44408667742, 18346.357877474224, 18401.079946002916, 18438.63122737511, 18537.98041107752, 18798.718019229447, 11329.603463878724, 11583.710407239887, 11683.941580292045, 11747.118966077749, 11780.352080635646, 13507.662308441975, 13519.594412167651, 13655.590332290047, 13679.316034198051, 13681.247531385869, 10934.726631834268, 10962.945185274022, 11154.16343774204, 11369.488373023069, 11527.077833773446, 10190.694279171637, 10199.694009179737, 10200.540975655966, 10208.2343824212, 10281.383117013003, 9652.372595781251, 9749.07383798538, 9798.069183427562, 9799.314048016855, 9816.80366392654, 6969.7909062728195, 6996.545224560387, 7017.193022802443, 7019.613921234381, 7053.858922821412, 7106.964465177641, 7136.429085673238, 7164.534305270141, 7193.676284567103, 7216.314450127229], "value": 6583.9078590856325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.95837275307485, 498.87043580105944, 508.81428278678294, 513.3788116379181, 524.6589716684155, 6123.0, 6127.142200091991, 6140.109684095809, 6144.723487443064, 6170.228721409824, 5934.792282270121, 6044.4613262429775, 6085.330613632508, 6106.725197366118, 6141.72362243699, 4958.87602809929, 4962.816360801245, 4972.6379969514555, 4999.150144475448, 5026.949730502684, 4821.638377121712, 4965.826196083138, 4976.552110310071, 4977.3529441172595, 4982.750862456881, 4894.4371397289415, 4899.608031357483, 4912.828051018215, 4933.629977751665, 4964.230544265644, 4911.582515486188, 4952.628552858532, 4960.553550180501, 4963.404391473046, 4978.153713868651, 4449.822007119711, 4480.059187570581, 4482.125985432842, 4485.529019452975, 4490.57339552742, 6067.423594758491, 6067.998780201261, 6073.483753880925, 6100.938990610081, 6108.358622344635, 5685.061964775807, 5694.1458781183155, 5701.828945131652, 5725.255716756837, 5727.942720572824, 6495.123158373606, 6509.576877502947, 6530.902036469457, 6576.441002514792, 6602.438792702626, 4802.207635740098, 4828.637852161067, 4831.613470922318, 4835.395575553056, 4837.540433658797, 6782.9321706783285, 6831.351021652935, 6848.630273945231, 6876.553024053421, 6891.724331026753, 4975.179095449283, 4976.62675299354, 4979.9542096159485, 5005.874853128701, 5030.0, 5041.495850415003, 5047.41954675217, 5052.9894021195905, 5074.873128171826, 5090.211017292326, 5568.610197286151, 5642.7178641067785, 5670.347909990322, 5679.772809087673, 5689.743961521742, 6459.160309159779, 6500.7572387526225, 6520.315366886503, 6543.574667646683, 6652.567583107082, 1645.1609679063524, 1665.2423147467873, 1682.1505139904514, 1718.828117188271, 1719.1232471439405, 1176.4823477669797, 1181.9586314478952, 1204.3978010994504, 1219.0978675779859, 1224.993875030637, 5638.590352411897, 5666.4050274721385, 5667.024811973747, 5668.093105103246, 5691.715414229272, 6496.805095847132, 6544.0, 6553.606783593, 6668.599884006975, 6699.866002679919, 5652.406497317805, 5710.600257981984, 5751.511121554631, 5751.971240143773, 5785.293338465163, 3493.8602455901478, 3517.876874309438, 3541.8937431877084, 3548.059764162499, 3564.536610240652, 6447.4197322241225, 6493.642849643315, 6494.415502604788, 6530.444912182517, 6593.175853018372, 6761.695723692445, 6876.931230687629, 6878.793636190922, 6901.896471552931, 6904.171499420001, 6450.5808722081065, 6475.449586785176, 6523.412892839668, 6535.967320163464, 6538.574992625559, 6586.365453818511, 6604.669766511752, 6633.900491492535, 6647.202335719745, 6661.300563440769, 6512.804615861532, 6568.934310656832, 6669.399754022162, 6680.465562754871, 6738.663066846736, 6496.577722448026, 6505.763904858062, 6516.934830651822, 6539.378759017885, 6557.9344206559235, 4968.975155124202, 4973.204287314013, 4975.5522003019905, 4977.203647416541, 4985.825496107619, 6479.7408103675325, 6771.424428923597, 6775.661216939035, 6780.355866192704, 6803.285655006153, 6333.968330158504, 6402.807915762534, 6416.486681065597, 6429.7140571884875, 6469.611823290617, 6426.518011149276, 6430.164078669743, 6457.967710161419, 6461.61230326182, 6480.319566445455, 6380.363192979957, 6396.71214795326, 6407.519436042222, 6408.295087540274, 6443.806685799434, 6366.618002919654, 6446.0, 6454.870902582016, 6458.160439142881, 6507.381798729113, 6241.937580624317, 6258.749650014131, 6262.248530176408, 6277.529185311028, 6334.461570766536], "value": 5016.159666582968, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.1425189062827, 886.1006078829988, 895.417978314096, 899.1907283444899, 908.6819613135399, 17838.464846054623, 19119.904400477997, 19198.616027679436, 19230.134643941023, 21032.474188145265, 20883.269085582007, 21104.683429748566, 21595.676064859, 21605.567888642217, 21616.459588510294, 933.9392939458913, 947.114447991127, 949.6438835436711, 950.2967803825154, 950.5009869818332, 917.8485549884261, 943.580106852451, 946.7443790176649, 966.111177716499, 968.3270127261557, 987.249690235419, 1005.8088963096989, 1016.7559785651428, 1016.9644062457816, 1017.8269694152012, 995.3231802374382, 996.5266498413268, 1002.7793885345212, 1012.1245122968616, 1013.3565186106838, 713.864365770502, 724.1021133794058, 733.9816504587375, 734.3207533031978, 738.6823665823694, 19124.0, 19435.514112147168, 19609.607807843764, 19667.0, 19788.307409240606, 20404.0, 20487.795122048738, 20653.17387304506, 20800.5839883203, 20919.790802091935, 14584.70830583393, 15945.521634350987, 16111.194440278057, 16113.43602973902, 16127.274272657758, 3737.4206997915367, 3777.8299976501125, 3778.338790711642, 3782.659560639528, 3786.3373909565717, 116218.41890790492, 118421.0, 124398.0, 127157.0, 129344.35327823395, 15110.093394396372, 15440.691186176213, 15479.458218962282, 15520.223988800515, 15590.142542160063, 27578.44843103167, 28273.858630706716, 28328.8583557085, 28719.85640071786, 28738.85630571834, 8171.264586187272, 8493.915060849436, 8515.659373625109, 8545.48727076365, 8623.913760862437, 4049.8380064797666, 4085.97957010219, 4132.710710250314, 4154.626083652486, 4157.5010998679745, 5057.418396884405, 5080.949190508121, 5138.665986710852, 5168.147255702767, 5182.740862956837, 970.335320305593, 981.5877331520778, 997.9550920208608, 1000.6097621927454, 1002.8194924913586, 663.9136912201479, 670.5373292428307, 700.3836623771151, 704.4118161335342, 713.8429545499981, 11480.368579728029, 11568.88431115678, 11609.709757255967, 11695.824562631567, 12011.0, 667.2226855713137, 672.7174586673609, 679.4937771360368, 680.7141000779684, 688.6728803818246, 5504.642198257181, 5552.611317207838, 5622.662640241599, 5667.659940403589, 5780.682062486603, 110330.0, 111353.0, 111922.44038779917, 112083.0, 118346.40826795984, 92729.53635231781, 92764.53617732003, 93721.0, 95868.52065739766, 100684.0, 82659.0, 84668.57665711633, 84799.0, 85151.14848851557, 86996.0, 10281.53733082028, 10306.0, 10407.63573274962, 10458.790824183321, 10685.091767199876, 38223.23553528969, 39357.212855743295, 39627.60372396239, 40168.39747403733, 40290.99272518211, 70848.29151708623, 73023.0, 73624.63187684027, 74471.0, 74681.62659186669, 17845.910770446066, 18020.2791888323, 18134.18396172149, 18138.455846324632, 18260.08699565043, 19607.215711371384, 20120.19519219215, 20274.290399835936, 20320.89839550852, 21010.159593616085, 17015.574610634834, 17641.911790440965, 17908.46274611764, 18518.351857684916, 18726.344577939708, 17964.371247006293, 18529.258829646664, 18986.0, 19150.904245478683, 19554.60890782205, 17597.208125634123, 17655.558611034314, 17852.107394630475, 17967.730484042488, 18202.72695909589, 13303.135296205715, 13568.118072325267, 13882.722345553235, 14178.716425671635, 14386.136831790127, 13528.93235533816, 13786.65533361674, 13823.585292441243, 13896.58310250694, 14138.151710897379], "value": 8972.243832242175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 102.0, 107.0, 106.0, 110.0, 109.0, 101.0, 107.0, 111.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 146.0, 161.0, 119.0, 144.0, 144.0, 119.0, 170.0, 121.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 161.0, 163.0, 161.0, 163.0, 165.0, 163.0, 171.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 176.0, 75.0, 76.0, 73.0, 77.0, 164.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 135.0, 80.0, 79.0, 80.0, 123.0, 80.0, 79.0, 133.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 56.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 77.0, 76.0, 78.0, 78.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 129.0, 125.0, 125.0, 119.0, 124.0, 127.0, 123.0, 174.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 176.0, 170.0, 171.0, 180.0, 176.0, 171.0, 170.0, 175.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 68.0, 63.0, 64.0, 64.0, 69.0, 64.0, 66.0], "value": 65.2, "unit": "score"}]}]} 07:34:14 INFO - Return code: 0 07:34:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:34:14 INFO - # TBPL SUCCESS # 07:34:14 INFO - Running post-action listener: _package_coverage_data 07:34:14 INFO - Running post-action listener: _resource_record_post_action 07:34:14 INFO - [mozharness: 2017-08-22 14:34:14.898112Z] Finished run-tests step (success) 07:34:14 INFO - Running post-run listener: _resource_record_post_run 07:34:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434286592; Read time: 192; Write time: 211960 07:34:14 INFO - TinderboxPrint: CPU usage
13.1% 07:34:14 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 192 07:34:14 INFO - TinderboxPrint: I/O write bytes / time
434,286,592 / 211,960 07:34:14 INFO - TinderboxPrint: CPU idle
8,251.7 (86.9%) 07:34:14 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 07:34:14 INFO - TinderboxPrint: Swap in / out
0 / 0 07:34:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110690304; Read time: 60; Write time: 69592 07:34:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:34:15 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323579904; Read time: 132; Write time: 142368 07:34:15 INFO - Running post-run listener: _upload_blobber_files 07:34:15 INFO - Blob upload gear active. 07:34:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:15 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 07:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:34:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:16 INFO - (blobuploader) - INFO - Done attempting. 07:34:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:34:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:17 INFO - (blobuploader) - INFO - Done attempting. 07:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:20 INFO - (blobuploader) - INFO - Done attempting. 07:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:21 INFO - (blobuploader) - INFO - Done attempting. 07:34:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:21 INFO - Return code: 0 07:34:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82989c1f6661e98e251cc11091c05f213da59f31b830ce71a10df6695ad682cd175e06d4affe293031350367ebd27bc105382c219fe3c6bc1f7f44b2101d9993", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5949a1ddfce37dfd5fb42453c2919e1ddcb5dd5bd1324322123e488e49ba3cd3919daeb57856c133209133dc52d65aa2662e28f3fee7bf222e288d1ac8cb95c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e49f1fe9922d176b0b57a178e6332f3773216d959270a7d4d7154d919aa262887c5dc7dce3ab27a1474a4267e7bcaea0de18da9a30e2a9e085a68a3a202b0ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05a9bd59dc037330df029341603b1d72ba03e03a047129b97ea4f42c1151c07a5594dacb74958e8f5e743adb08b5ce79f696d5ba30e19fb108c0cceeaee486ec"} 07:34:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:21 INFO - Contents: 07:34:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82989c1f6661e98e251cc11091c05f213da59f31b830ce71a10df6695ad682cd175e06d4affe293031350367ebd27bc105382c219fe3c6bc1f7f44b2101d9993", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5949a1ddfce37dfd5fb42453c2919e1ddcb5dd5bd1324322123e488e49ba3cd3919daeb57856c133209133dc52d65aa2662e28f3fee7bf222e288d1ac8cb95c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e49f1fe9922d176b0b57a178e6332f3773216d959270a7d4d7154d919aa262887c5dc7dce3ab27a1474a4267e7bcaea0de18da9a30e2a9e085a68a3a202b0ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05a9bd59dc037330df029341603b1d72ba03e03a047129b97ea4f42c1151c07a5594dacb74958e8f5e743adb08b5ce79f696d5ba30e19fb108c0cceeaee486ec"} 07:34:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:21 INFO - Copying logs to upload dir... 07:34:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.539679 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-22 07:34:21.288347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 07:34:21.292395) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82989c1f6661e98e251cc11091c05f213da59f31b830ce71a10df6695ad682cd175e06d4affe293031350367ebd27bc105382c219fe3c6bc1f7f44b2101d9993", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5949a1ddfce37dfd5fb42453c2919e1ddcb5dd5bd1324322123e488e49ba3cd3919daeb57856c133209133dc52d65aa2662e28f3fee7bf222e288d1ac8cb95c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e49f1fe9922d176b0b57a178e6332f3773216d959270a7d4d7154d919aa262887c5dc7dce3ab27a1474a4267e7bcaea0de18da9a30e2a9e085a68a3a202b0ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05a9bd59dc037330df029341603b1d72ba03e03a047129b97ea4f42c1151c07a5594dacb74958e8f5e743adb08b5ce79f696d5ba30e19fb108c0cceeaee486ec"} build_url:https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/H_QFZYnlS7C0GUfsoawK7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82989c1f6661e98e251cc11091c05f213da59f31b830ce71a10df6695ad682cd175e06d4affe293031350367ebd27bc105382c219fe3c6bc1f7f44b2101d9993", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5949a1ddfce37dfd5fb42453c2919e1ddcb5dd5bd1324322123e488e49ba3cd3919daeb57856c133209133dc52d65aa2662e28f3fee7bf222e288d1ac8cb95c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e49f1fe9922d176b0b57a178e6332f3773216d959270a7d4d7154d919aa262887c5dc7dce3ab27a1474a4267e7bcaea0de18da9a30e2a9e085a68a3a202b0ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05a9bd59dc037330df029341603b1d72ba03e03a047129b97ea4f42c1151c07a5594dacb74958e8f5e743adb08b5ce79f696d5ba30e19fb108c0cceeaee486ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 07:34:21.319384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:34:21.319735) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503411209.526368-1029144483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:34:21.402182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 07:34:21.402492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 07:34:21.402776) ========= ========= Total master_lag: 0.20 =========