builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1503501384.56 results: success (0) revision: 76c7aa772dc494d77ae7e1183b0ec1d073152dee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.564273) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.565304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.565598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.627990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.628369) ========= 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=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 08:16:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-08-23 08:16:25 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199608 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.859034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.859377) ========= 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=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015218 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.933025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:16:24.933325) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 76c7aa772dc494d77ae7e1183b0ec1d073152dee --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 76c7aa772dc494d77ae7e1183b0ec1d073152dee --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=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 08:16:25,202 truncating revision to first 12 chars 2017-08-23 08:16:25,202 Setting DEBUG logging. 2017-08-23 08:16:25,202 attempt 1/10 2017-08-23 08:16:25,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/76c7aa772dc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 08:16:26,379 unpacking tar archive at: mozilla-central-76c7aa772dc4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.490213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:16:26.437055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:26.437360) ========= script_repo_revision: 76c7aa772dc494d77ae7e1183b0ec1d073152dee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:26.437734) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:26.438002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:26.448376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-23 08:16:26.448658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:26 INFO - MultiFileLogger online at 20170823 08:16:26 in /builds/slave/test 08:16:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:26 INFO - {'append_to_log': False, 08:16:26 INFO - 'base_work_dir': '/builds/slave/test', 08:16:26 INFO - 'blob_upload_branch': 'Firefox', 08:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:26 INFO - 'branch': 'Firefox', 08:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:26 INFO - 'code_coverage': False, 08:16:26 INFO - 'config_files': ('talos/linux_config.py',), 08:16:26 INFO - 'default_actions': ('clobber', 08:16:26 INFO - 'read-buildbot-config', 08:16:26 INFO - 'download-and-extract', 08:16:26 INFO - 'populate-webroot', 08:16:26 INFO - 'create-virtualenv', 08:16:26 INFO - 'install', 08:16:26 INFO - 'setup-mitmproxy', 08:16:26 INFO - 'run-tests'), 08:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:26 INFO - 'disable_ccov_upload': False, 08:16:26 INFO - 'download_minidump_stackwalk': True, 08:16:26 INFO - 'download_symbols': 'ondemand', 08:16:26 INFO - 'enable_stylo': False, 08:16:26 INFO - 'enable_webrender': False, 08:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:26 INFO - 'gecko_profile': False, 08:16:26 INFO - 'gecko_profile_interval': 0, 08:16:26 INFO - 'installer_path': 'installer.exe', 08:16:26 INFO - 'log_level': 'info', 08:16:26 INFO - 'log_name': 'talos', 08:16:26 INFO - 'log_to_console': True, 08:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:26 INFO - 'opt_config_files': (), 08:16:26 INFO - 'pip_index': False, 08:16:26 INFO - 'suite': 'dromaeojs-e10s', 08:16:26 INFO - 'system_bits': '32', 08:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:26 INFO - 'title': 'talos-linux64-ix-002', 08:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:26 INFO - 'use_talos_json': True, 08:16:26 INFO - 'verify': 'False', 08:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:26 INFO - 'work_dir': 'build'} 08:16:26 INFO - [mozharness: 2017-08-23 15:16:26.929671Z] Running clobber step. 08:16:26 INFO - Running pre-action listener: _resource_record_pre_action 08:16:26 INFO - Running main action method: clobber 08:16:26 INFO - rmtree: /builds/slave/test/build 08:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:27 INFO - Running post-action listener: _resource_record_post_action 08:16:27 INFO - [mozharness: 2017-08-23 15:16:27.903916Z] Finished clobber step (success) 08:16:27 INFO - [mozharness: 2017-08-23 15:16:27.904013Z] Running read-buildbot-config step. 08:16:27 INFO - Running pre-action listener: _resource_record_pre_action 08:16:27 INFO - Running main action method: read_buildbot_config 08:16:27 INFO - Using buildbot properties: 08:16:27 INFO - { 08:16:27 INFO - "project": "", 08:16:27 INFO - "product": "firefox", 08:16:27 INFO - "who": "archaeopteryx@coole-files.de", 08:16:27 INFO - "installer_path": "public/build/target.tar.bz2", 08:16:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 08:16:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:16:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 08:16:27 INFO - "stage_platform": "linux64-qr", 08:16:27 INFO - "basedir": "/builds/slave/test", 08:16:27 INFO - "buildnumber": 15, 08:16:27 INFO - "platform": "ubuntu64_hw_qr", 08:16:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:16:27 INFO - "slavebuilddir": "test", 08:16:27 INFO - "taskId": "cW6wABU1QXmfAOOwSR7DUw", 08:16:27 INFO - "branch": "mozilla-central", 08:16:27 INFO - "script_repo_revision": "production", 08:16:27 INFO - "revision": "76c7aa772dc494d77ae7e1183b0ec1d073152dee", 08:16:27 INFO - "slavename": "talos-linux64-ix-002", 08:16:27 INFO - "repo_path": "mozilla-central" 08:16:27 INFO - } 08:16:27 INFO - Finding installer, test and symbols from parent task. 08:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW6wABU1QXmfAOOwSR7DUw'}, attempt #1 08:16:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW6wABU1QXmfAOOwSR7DUw'}, attempt #1 08:16:28 INFO - Task dependencies: WODyYTpCRhaowJbHTZlbvA 08:16:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA'}, attempt #1 08:16:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json 08:16:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip 08:16:29 INFO - Running post-action listener: _resource_record_post_action 08:16:29 INFO - [mozharness: 2017-08-23 15:16:29.263861Z] Finished read-buildbot-config step (success) 08:16:29 INFO - [mozharness: 2017-08-23 15:16:29.264081Z] Running download-and-extract step. 08:16:29 INFO - Running pre-action listener: _resource_record_pre_action 08:16:29 INFO - Running main action method: download_and_extract 08:16:29 INFO - mkdir: /builds/slave/test/build/tests 08:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:29 INFO - trying https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json 08:16:29 INFO - Downloading https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:16:29 INFO - Downloaded 989 bytes. 08:16:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:16:29 INFO - Using the following test package requirements: 08:16:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:16:29 INFO - u'common': [u'target.common.tests.zip'], 08:16:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:16:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:16:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:16:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:16:29 INFO - u'mozbase': [u'target.common.tests.zip'], 08:16:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:16:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:16:29 INFO - u'web-platform': [u'target.common.tests.zip', 08:16:29 INFO - u'target.web-platform.tests.tar.gz'], 08:16:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:16:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip 08:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip into memory 08:16:31 INFO - Content-Length response header: 54949506 08:16:31 INFO - Bytes received: 54949506 08:16:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip 08:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip into memory 08:16:43 INFO - Content-Length response header: 54949506 08:16:43 INFO - Bytes received: 54949506 08:16:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip 08:16:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:16:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip into memory 08:16:56 INFO - Content-Length response header: 14496261 08:16:56 INFO - Bytes received: 14496261 08:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:56 INFO - trying https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:16:58 INFO - Downloaded 61084946 bytes. 08:16:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:58 INFO - mkdir: /builds/slave/test/properties 08:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:58 INFO - Contents: 08:16:58 INFO - build_url:https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:58 INFO - Running post-action listener: _resource_record_post_action 08:16:58 INFO - Running post-action listener: find_tests_for_verification 08:16:58 INFO - Running post-action listener: set_extra_try_arguments 08:16:58 INFO - [mozharness: 2017-08-23 15:16:58.786553Z] Finished download-and-extract step (success) 08:16:58 INFO - [mozharness: 2017-08-23 15:16:58.786781Z] Running populate-webroot step. 08:16:58 INFO - Running pre-action listener: _resource_record_pre_action 08:16:58 INFO - Running main action method: populate_webroot 08:16:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:58 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:58 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:58 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'tests': ['damp', 'tps']}, 08:16:58 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['damp', 'tps']}, 08:16:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:16:58 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:16:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:16:58 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:16:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:58 INFO - 'ts_paint', 08:16:58 INFO - 'tpaint', 08:16:58 INFO - 'sessionrestore', 08:16:58 INFO - 'sessionrestore_many_windows', 08:16:58 INFO - 'sessionrestore_no_auto_restore', 08:16:58 INFO - 'tabpaint']}, 08:16:58 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['a11yr', 08:16:58 INFO - 'ts_paint', 08:16:58 INFO - 'tpaint', 08:16:58 INFO - 'sessionrestore', 08:16:58 INFO - 'sessionrestore_many_windows', 08:16:58 INFO - 'sessionrestore_no_auto_restore', 08:16:58 INFO - 'tabpaint']}, 08:16:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:16:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:16:58 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['bloom_basic_singleton']}, 08:16:58 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['bloom_basic']}, 08:16:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:58 INFO - 'tsvgr_opacity', 08:16:58 INFO - 'tart', 08:16:58 INFO - 'tscrollx', 08:16:58 INFO - 'tsvg_static']}, 08:16:58 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['tsvgx', 08:16:58 INFO - 'tsvgr_opacity', 08:16:58 INFO - 'tart', 08:16:58 INFO - 'tscrollx', 08:16:58 INFO - 'tsvg_static']}, 08:16:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:16:58 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--stylo'], 08:16:58 INFO - 'tests': ['tp5o']}, 08:16:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:58 INFO - 'talos_options': ['--mitmproxy', 08:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:58 INFO - '--firstNonBlankPaint'], 08:16:58 INFO - 'tests': ['tp6_google', 08:16:58 INFO - 'tp6_youtube', 08:16:58 INFO - 'tp6_amazon', 08:16:58 INFO - 'tp6_facebook']}, 08:16:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:58 INFO - 'talos_options': ['--stylo', 08:16:58 INFO - '--mitmproxy', 08:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:58 INFO - '--firstNonBlankPaint'], 08:16:58 INFO - 'tests': ['tp6_google', 08:16:58 INFO - 'tp6_youtube', 08:16:58 INFO - 'tp6_amazon', 08:16:58 INFO - 'tp6_facebook']}, 08:16:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:58 INFO - 'talos_options': ['--stylo', 08:16:58 INFO - '--stylo-threads=1', 08:16:58 INFO - '--mitmproxy', 08:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:58 INFO - '--firstNonBlankPaint'], 08:16:58 INFO - 'tests': ['tp6_google', 08:16:58 INFO - 'tp6_youtube', 08:16:58 INFO - 'tp6_amazon', 08:16:58 INFO - 'tp6_facebook']}, 08:16:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--xperf_path', 08:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:58 INFO - 'tests': ['tp5n']}, 08:16:58 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:58 INFO - 'talos_options': ['--stylo', 08:16:58 INFO - '--xperf_path', 08:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:58 INFO - 'tests': ['tp5n']}}} 08:16:58 INFO - Running post-action listener: _resource_record_post_action 08:16:58 INFO - [mozharness: 2017-08-23 15:16:58.812586Z] Finished populate-webroot step (success) 08:16:58 INFO - [mozharness: 2017-08-23 15:16:58.812675Z] Running create-virtualenv step. 08:16:58 INFO - Running pre-action listener: _resource_record_pre_action 08:16:58 INFO - Running main action method: create_virtualenv 08:16:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:16:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:16:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:58 INFO - Using real prefix '/usr' 08:16:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:01 INFO - Installing pip.................done. 08:17:01 INFO - Return code: 0 08:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:01 INFO - Reading from file tmpfile_stdout 08:17:01 INFO - Output received: 08:17:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:01 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:17:01 INFO - Using env: {'DISPLAY': ':0', 08:17:01 INFO - 'HOME': '/home/cltbld', 08:17:01 INFO - 'LANG': 'en_US.UTF-8', 08:17:01 INFO - 'LANGUAGE': 'en_US:en', 08:17:01 INFO - 'LOGNAME': 'cltbld', 08:17:01 INFO - 'MAIL': '/var/mail/cltbld', 08:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:01 INFO - 'MOZ_NO_REMOTE': '1', 08:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:01 INFO - 'NO_EM_RESTART': '1', 08:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:01 INFO - 'PWD': '/builds/slave/test', 08:17:01 INFO - 'SHELL': '/bin/bash', 08:17:01 INFO - 'SHLVL': '1', 08:17:01 INFO - 'TERM': 'linux', 08:17:01 INFO - 'TMOUT': '86400', 08:17:01 INFO - 'USER': 'cltbld', 08:17:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:01 INFO - '_': '/tools/buildbot/bin/python'} 08:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:17:02 INFO - Cleaning up... 08:17:02 INFO - Return code: 0 08:17:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:02 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:17:02 INFO - Using env: {'DISPLAY': ':0', 08:17:02 INFO - 'HOME': '/home/cltbld', 08:17:02 INFO - 'LANG': 'en_US.UTF-8', 08:17:02 INFO - 'LANGUAGE': 'en_US:en', 08:17:02 INFO - 'LOGNAME': 'cltbld', 08:17:02 INFO - 'MAIL': '/var/mail/cltbld', 08:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:02 INFO - 'MOZ_NO_REMOTE': '1', 08:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:02 INFO - 'NO_EM_RESTART': '1', 08:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:02 INFO - 'PWD': '/builds/slave/test', 08:17:02 INFO - 'SHELL': '/bin/bash', 08:17:02 INFO - 'SHLVL': '1', 08:17:02 INFO - 'TERM': 'linux', 08:17:02 INFO - 'TMOUT': '86400', 08:17:02 INFO - 'USER': 'cltbld', 08:17:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:02 INFO - '_': '/tools/buildbot/bin/python'} 08:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:02 INFO - Downloading/unpacking psutil>=3.1.1 08:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:03 INFO - Installing collected packages: psutil 08:17:03 INFO - Running setup.py install for psutil 08:17:03 INFO - building 'psutil._psutil_linux' extension 08:17:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:17:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:17:04 INFO - building 'psutil._psutil_posix' extension 08:17:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:17:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:04 INFO - Successfully installed psutil 08:17:04 INFO - Cleaning up... 08:17:04 INFO - Return code: 0 08:17:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:04 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:04 INFO - Using env: {'DISPLAY': ':0', 08:17:04 INFO - 'HOME': '/home/cltbld', 08:17:04 INFO - 'LANG': 'en_US.UTF-8', 08:17:04 INFO - 'LANGUAGE': 'en_US:en', 08:17:04 INFO - 'LOGNAME': 'cltbld', 08:17:04 INFO - 'MAIL': '/var/mail/cltbld', 08:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:04 INFO - 'MOZ_NO_REMOTE': '1', 08:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:04 INFO - 'NO_EM_RESTART': '1', 08:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:04 INFO - 'PWD': '/builds/slave/test', 08:17:04 INFO - 'SHELL': '/bin/bash', 08:17:04 INFO - 'SHLVL': '1', 08:17:04 INFO - 'TERM': 'linux', 08:17:04 INFO - 'TMOUT': '86400', 08:17:04 INFO - 'USER': 'cltbld', 08:17:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:04 INFO - '_': '/tools/buildbot/bin/python'} 08:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:06 INFO - Installing collected packages: mozsystemmonitor 08:17:06 INFO - Running setup.py install for mozsystemmonitor 08:17:06 INFO - Successfully installed mozsystemmonitor 08:17:06 INFO - Cleaning up... 08:17:06 INFO - Return code: 0 08:17:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:06 INFO - Using env: {'DISPLAY': ':0', 08:17:06 INFO - 'HOME': '/home/cltbld', 08:17:06 INFO - 'LANG': 'en_US.UTF-8', 08:17:06 INFO - 'LANGUAGE': 'en_US:en', 08:17:06 INFO - 'LOGNAME': 'cltbld', 08:17:06 INFO - 'MAIL': '/var/mail/cltbld', 08:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:06 INFO - 'MOZ_NO_REMOTE': '1', 08:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:06 INFO - 'NO_EM_RESTART': '1', 08:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:06 INFO - 'PWD': '/builds/slave/test', 08:17:06 INFO - 'SHELL': '/bin/bash', 08:17:06 INFO - 'SHLVL': '1', 08:17:06 INFO - 'TERM': 'linux', 08:17:06 INFO - 'TMOUT': '86400', 08:17:06 INFO - 'USER': 'cltbld', 08:17:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:06 INFO - '_': '/tools/buildbot/bin/python'} 08:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:17: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 08:17: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 08:17: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 08:17: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 08:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:08 INFO - warning: no files found matching '*.txt' 08:17:08 INFO - no previously-included directories found matching 'build' 08:17:08 INFO - no previously-included directories found matching 'dist' 08:17:08 INFO - no previously-included directories found matching '.git*' 08:17:08 INFO - Installing collected packages: jsonschema, functools32 08:17:08 INFO - Running setup.py install for functools32 08:17:08 INFO - warning: no files found matching '*.txt' 08:17:08 INFO - no previously-included directories found matching 'build' 08:17:08 INFO - no previously-included directories found matching 'dist' 08:17:08 INFO - no previously-included directories found matching '.git*' 08:17:08 INFO - Successfully installed jsonschema functools32 08:17:08 INFO - Cleaning up... 08:17:08 INFO - Return code: 0 08:17:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17: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', '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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17: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 functools32==3.2.3-2 08:17:08 INFO - Using env: {'DISPLAY': ':0', 08:17:08 INFO - 'HOME': '/home/cltbld', 08:17:08 INFO - 'LANG': 'en_US.UTF-8', 08:17:08 INFO - 'LANGUAGE': 'en_US:en', 08:17:08 INFO - 'LOGNAME': 'cltbld', 08:17:08 INFO - 'MAIL': '/var/mail/cltbld', 08:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:08 INFO - 'MOZ_NO_REMOTE': '1', 08:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:08 INFO - 'NO_EM_RESTART': '1', 08:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:08 INFO - 'PWD': '/builds/slave/test', 08:17:08 INFO - 'SHELL': '/bin/bash', 08:17:08 INFO - 'SHLVL': '1', 08:17:08 INFO - 'TERM': 'linux', 08:17:08 INFO - 'TMOUT': '86400', 08:17:08 INFO - 'USER': 'cltbld', 08:17:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:08 INFO - '_': '/tools/buildbot/bin/python'} 08:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:08 INFO - Cleaning up... 08:17:08 INFO - Return code: 0 08:17:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17: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', '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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17: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 blobuploader==1.2.4 08:17:08 INFO - Using env: {'DISPLAY': ':0', 08:17:08 INFO - 'HOME': '/home/cltbld', 08:17:08 INFO - 'LANG': 'en_US.UTF-8', 08:17:08 INFO - 'LANGUAGE': 'en_US:en', 08:17:08 INFO - 'LOGNAME': 'cltbld', 08:17:08 INFO - 'MAIL': '/var/mail/cltbld', 08:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:08 INFO - 'MOZ_NO_REMOTE': '1', 08:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:08 INFO - 'NO_EM_RESTART': '1', 08:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:08 INFO - 'PWD': '/builds/slave/test', 08:17:08 INFO - 'SHELL': '/bin/bash', 08:17:08 INFO - 'SHLVL': '1', 08:17:08 INFO - 'TERM': 'linux', 08:17:08 INFO - 'TMOUT': '86400', 08:17:08 INFO - 'USER': 'cltbld', 08:17:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:08 INFO - '_': '/tools/buildbot/bin/python'} 08:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:17: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 08:17: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 08:17: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 08:17: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 08:17:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17:10 INFO - Downloading docopt-0.6.1.tar.gz 08:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:10 INFO - Running setup.py install for blobuploader 08:17:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:10 INFO - Running setup.py install for requests 08:17:10 INFO - Running setup.py install for docopt 08:17:10 INFO - Successfully installed blobuploader requests docopt 08:17:10 INFO - Cleaning up... 08:17:10 INFO - Return code: 0 08:17:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:10 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:10 INFO - Using env: {'DISPLAY': ':0', 08:17:10 INFO - 'HOME': '/home/cltbld', 08:17:10 INFO - 'LANG': 'en_US.UTF-8', 08:17:10 INFO - 'LANGUAGE': 'en_US:en', 08:17:10 INFO - 'LOGNAME': 'cltbld', 08:17:10 INFO - 'MAIL': '/var/mail/cltbld', 08:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:10 INFO - 'MOZ_NO_REMOTE': '1', 08:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:10 INFO - 'NO_EM_RESTART': '1', 08:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:10 INFO - 'PWD': '/builds/slave/test', 08:17:10 INFO - 'SHELL': '/bin/bash', 08:17:10 INFO - 'SHLVL': '1', 08:17:10 INFO - 'TERM': 'linux', 08:17:10 INFO - 'TMOUT': '86400', 08:17:10 INFO - 'USER': 'cltbld', 08:17:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:10 INFO - '_': '/tools/buildbot/bin/python'} 08:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:11 INFO - Running setup.py (path:/tmp/pip-KN9H5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:11 INFO - Running setup.py (path:/tmp/pip-nBymxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:11 INFO - Running setup.py (path:/tmp/pip-MsUbEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:11 INFO - Running setup.py (path:/tmp/pip-JkF_cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:11 INFO - Running setup.py (path:/tmp/pip-8lRsC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:11 INFO - Running setup.py (path:/tmp/pip-jqfsnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:11 INFO - Running setup.py (path:/tmp/pip-AFvNex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:11 INFO - Running setup.py (path:/tmp/pip-xkSofz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:11 INFO - Running setup.py (path:/tmp/pip-CanPA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:11 INFO - Running setup.py (path:/tmp/pip-SacCsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:11 INFO - Running setup.py (path:/tmp/pip-Wb53Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:11 INFO - Running setup.py (path:/tmp/pip-whoBFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:12 INFO - Running setup.py (path:/tmp/pip-_eOGnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:12 INFO - Running setup.py (path:/tmp/pip-OOydwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:12 INFO - Running setup.py (path:/tmp/pip-UxfROv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:12 INFO - Running setup.py (path:/tmp/pip-6rk74C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:12 INFO - Running setup.py (path:/tmp/pip-OoRHDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:12 INFO - Running setup.py install for manifestparser 08:17:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozcrash 08:17:12 INFO - Running setup.py install for mozdebug 08:17:12 INFO - Running setup.py install for mozdevice 08:17:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozfile 08:17:12 INFO - Running setup.py install for mozhttpd 08:17:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozinfo 08:17:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for mozInstall 08:17:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for mozleak 08:17:13 INFO - Running setup.py install for mozlog 08:17:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for moznetwork 08:17:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for mozprocess 08:17:13 INFO - Running setup.py install for mozprofile 08:17:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for mozrunner 08:17:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Running setup.py install for mozscreenshot 08:17:13 INFO - Running setup.py install for moztest 08:17:14 INFO - Running setup.py install for mozversion 08:17:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:14 INFO - Cleaning up... 08:17:14 INFO - Return code: 0 08:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:14 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:14 INFO - Using env: {'DISPLAY': ':0', 08:17:14 INFO - 'HOME': '/home/cltbld', 08:17:14 INFO - 'LANG': 'en_US.UTF-8', 08:17:14 INFO - 'LANGUAGE': 'en_US:en', 08:17:14 INFO - 'LOGNAME': 'cltbld', 08:17:14 INFO - 'MAIL': '/var/mail/cltbld', 08:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:14 INFO - 'MOZ_NO_REMOTE': '1', 08:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:14 INFO - 'NO_EM_RESTART': '1', 08:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:14 INFO - 'PWD': '/builds/slave/test', 08:17:14 INFO - 'SHELL': '/bin/bash', 08:17:14 INFO - 'SHLVL': '1', 08:17:14 INFO - 'TERM': 'linux', 08:17:14 INFO - 'TMOUT': '86400', 08:17:14 INFO - 'USER': 'cltbld', 08:17:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:14 INFO - '_': '/tools/buildbot/bin/python'} 08:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:14 INFO - Running setup.py (path:/tmp/pip-LWivjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:14 INFO - Running setup.py (path:/tmp/pip-RotFNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:14 INFO - Running setup.py (path:/tmp/pip-9SfAlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:14 INFO - Running setup.py (path:/tmp/pip-0h7CIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:14 INFO - Running setup.py (path:/tmp/pip-u6d0Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:14 INFO - Running setup.py (path:/tmp/pip-Mx53bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:14 INFO - Running setup.py (path:/tmp/pip-Kn5cGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:14 INFO - Running setup.py (path:/tmp/pip-hckpqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:14 INFO - Running setup.py (path:/tmp/pip-2QveT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:15 INFO - Running setup.py (path:/tmp/pip-rEkZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:15 INFO - Running setup.py (path:/tmp/pip-fSKlkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:15 INFO - Running setup.py (path:/tmp/pip-CizcDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:15 INFO - Running setup.py (path:/tmp/pip-hLyDn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:15 INFO - Running setup.py (path:/tmp/pip-S3BM7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:15 INFO - Running setup.py (path:/tmp/pip-Qnp7N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:15 INFO - Running setup.py (path:/tmp/pip-d8bee3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:15 INFO - Running setup.py (path:/tmp/pip-sR6Yzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:16 INFO - Downloading blessings-1.6.tar.gz 08:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:16 INFO - Installing collected packages: blessings 08:17:16 INFO - Running setup.py install for blessings 08:17:16 INFO - Successfully installed blessings 08:17:16 INFO - Cleaning up... 08:17:16 INFO - Return code: 0 08:17:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:17 INFO - Reading from file tmpfile_stdout 08:17:17 INFO - Current package versions: 08:17:17 INFO - argparse == 1.2.1 08:17:17 INFO - blessings == 1.6 08:17:17 INFO - blobuploader == 1.2.4 08:17:17 INFO - docopt == 0.6.1 08:17:17 INFO - functools32 == 3.2.3-2 08:17:17 INFO - jsonschema == 2.5.1 08:17:17 INFO - manifestparser == 1.1 08:17:17 INFO - mozInstall == 1.13 08:17:17 INFO - mozcrash == 1.0 08:17:17 INFO - mozdebug == 0.1 08:17:17 INFO - mozdevice == 0.51 08:17:17 INFO - mozfile == 1.2 08:17:17 INFO - mozhttpd == 0.7 08:17:17 INFO - mozinfo == 0.10 08:17:17 INFO - mozleak == 0.1 08:17:17 INFO - mozlog == 3.5 08:17:17 INFO - moznetwork == 0.27 08:17:17 INFO - mozprocess == 0.25 08:17:17 INFO - mozprofile == 0.28 08:17:17 INFO - mozrunner == 6.13 08:17:17 INFO - mozscreenshot == 0.1 08:17:17 INFO - mozsystemmonitor == 0.3 08:17:17 INFO - moztest == 0.8 08:17:17 INFO - mozversion == 1.4 08:17:17 INFO - psutil == 3.1.1 08:17:17 INFO - requests == 1.2.3 08:17:17 INFO - wsgiref == 0.1.2 08:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:17 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 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:17 INFO - Using env: {'DISPLAY': ':0', 08:17:17 INFO - 'HOME': '/home/cltbld', 08:17:17 INFO - 'LANG': 'en_US.UTF-8', 08:17:17 INFO - 'LANGUAGE': 'en_US:en', 08:17:17 INFO - 'LOGNAME': 'cltbld', 08:17:17 INFO - 'MAIL': '/var/mail/cltbld', 08:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:17 INFO - 'MOZ_NO_REMOTE': '1', 08:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:17 INFO - 'NO_EM_RESTART': '1', 08:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:17 INFO - 'PWD': '/builds/slave/test', 08:17:17 INFO - 'SHELL': '/bin/bash', 08:17:17 INFO - 'SHLVL': '1', 08:17:17 INFO - 'TERM': 'linux', 08:17:17 INFO - 'TMOUT': '86400', 08:17:17 INFO - 'USER': 'cltbld', 08:17:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:17 INFO - '_': '/tools/buildbot/bin/python'} 08:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:17:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:18 INFO - Installing collected packages: simplejson 08:17:18 INFO - Running setup.py install for simplejson 08:17:18 INFO - building 'simplejson._speedups' extension 08:17:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:17:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:17:19 INFO - Successfully installed simplejson 08:17:19 INFO - Cleaning up... 08:17:19 INFO - Return code: 0 08:17:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27edf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:19 INFO - Using env: {'DISPLAY': ':0', 08:17:19 INFO - 'HOME': '/home/cltbld', 08:17:19 INFO - 'LANG': 'en_US.UTF-8', 08:17:19 INFO - 'LANGUAGE': 'en_US:en', 08:17:19 INFO - 'LOGNAME': 'cltbld', 08:17:19 INFO - 'MAIL': '/var/mail/cltbld', 08:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:19 INFO - 'MOZ_NO_REMOTE': '1', 08:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:19 INFO - 'NO_EM_RESTART': '1', 08:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:19 INFO - 'PWD': '/builds/slave/test', 08:17:19 INFO - 'SHELL': '/bin/bash', 08:17:19 INFO - 'SHLVL': '1', 08:17:19 INFO - 'TERM': 'linux', 08:17:19 INFO - 'TMOUT': '86400', 08:17:19 INFO - 'USER': 'cltbld', 08:17:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:19 INFO - '_': '/tools/buildbot/bin/python'} 08:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:19 INFO - Cleaning up... 08:17:19 INFO - Return code: 0 08:17:19 INFO - Running post-action listener: _resource_record_post_action 08:17:19 INFO - Running post-action listener: _start_resource_monitoring 08:17:19 INFO - Starting resource monitoring. 08:17:19 INFO - [mozharness: 2017-08-23 15:17:19.966962Z] Finished create-virtualenv step (success) 08:17:19 INFO - [mozharness: 2017-08-23 15:17:19.967974Z] Running install step. 08:17:19 INFO - Running pre-action listener: _resource_record_pre_action 08:17:19 INFO - Running main action method: install 08:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:20 INFO - Reading from file tmpfile_stdout 08:17:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:20 INFO - Reading from file tmpfile_stdout 08:17:20 INFO - Output received: 08:17:20 INFO - Usage: mozinstall [options] installer 08:17:20 INFO - Options: 08:17:20 INFO - -h, --help show this help message and exit 08:17:20 INFO - -d DEST, --destination=DEST 08:17:20 INFO - Directory to install application into. [default: 08:17:20 INFO - "/builds/slave/test"] 08:17:20 INFO - --app=APP Application being installed. [default: firefox] 08:17:20 INFO - mkdir: /builds/slave/test/build/application 08:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:17:37 INFO - Reading from file tmpfile_stdout 08:17:37 INFO - Output received: 08:17:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.948043Z] Finished install step (success) 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.948327Z] Running setup-mitmproxy step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running main action method: setup_mitmproxy 08:17:37 INFO - Skipping: mitmproxy is not required 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.949601Z] Finished setup-mitmproxy step (success) 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.949914Z] Running run-tests step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running pre-action listener: _set_gcov_prefix 08:17:37 INFO - Running main action method: run_tests 08:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:37 INFO - Python 2.7.3 08:17:37 INFO - Return code: 0 08:17:37 INFO - grabbing minidump binary from tooltool 08:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:37 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 0x27eb130>, '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 0x27ec030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ec4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:17:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:17:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:17:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:38 INFO - Return code: 0 08:17:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - ENV: RUST_BACKTRACE is now full 08:17:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:17:38 INFO - Using env: {'DISPLAY': ':0', 08:17:38 INFO - 'HOME': '/home/cltbld', 08:17:38 INFO - 'LANG': 'en_US.UTF-8', 08:17:38 INFO - 'LANGUAGE': 'en_US:en', 08:17:38 INFO - 'LOGNAME': 'cltbld', 08:17:38 INFO - 'MAIL': '/var/mail/cltbld', 08:17:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:38 INFO - 'MOZ_ACCELERATED': '1', 08:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:38 INFO - 'MOZ_NO_REMOTE': '1', 08:17:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:38 INFO - 'MOZ_WEBRENDER': '1', 08:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:38 INFO - 'NO_EM_RESTART': '1', 08:17:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:38 INFO - 'PWD': '/builds/slave/test', 08:17:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:38 INFO - 'RUST_BACKTRACE': 'full', 08:17:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:17:38 INFO - 'SHELL': '/bin/bash', 08:17:38 INFO - 'SHLVL': '1', 08:17:38 INFO - 'TERM': 'linux', 08:17:38 INFO - 'TMOUT': '86400', 08:17:38 INFO - 'USER': 'cltbld', 08:17:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434', 08:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:38 INFO - '_': '/tools/buildbot/bin/python'} 08:17:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:17:38 INFO - mozversion application_buildid: 20170823142347 08:17:38 INFO - mozversion application_changeset: 76c7aa772dc494d77ae7e1183b0ec1d073152dee 08:17:38 INFO - mozversion application_display_name: Nightly 08:17:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:38 INFO - mozversion application_name: Firefox 08:17:38 INFO - mozversion application_remotingname: firefox 08:17:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:17:38 INFO - mozversion application_vendor: Mozilla 08:17:38 INFO - mozversion application_version: 57.0a1 08:17:38 INFO - mozversion platform_buildid: 20170823142347 08:17:38 INFO - mozversion platform_changeset: 76c7aa772dc494d77ae7e1183b0ec1d073152dee 08:17:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:17:38 INFO - mozversion platform_version: 57.0a1 08:17:38 INFO - using testdate: 1503501458 08:17:38 INFO - actual date: 1503501458 08:17:38 INFO - starting webserver on 'localhost:57952' 08:17:38 INFO - SUITE-START | Running 2 tests 08:17:38 INFO - TEST-START | dromaeo_css 08:17:38 INFO - Initialising browser for dromaeo_css test... 08:17:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57952/getInfo.html -profile /tmp/tmpwcr6Yo/profile 08:17:38 INFO - TEST-INFO | started process 3346 (/builds/slave/test/build/application/firefox/firefox http://localhost:57952/getInfo.html) 08:17:46 INFO - TEST-INFO | 3346: exit 0 08:17:46 INFO - Browser initialized. 08:17:46 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:46 INFO - TEST-INFO | started process 3570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcr6Yo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:47 INFO - PID 3570 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:17:47 INFO - PID 3570 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:17:47 INFO - PID 3570 | 08:17:47 INFO - PID 3570 | (/builds/slave/test/build/application/firefox/firefox:3632): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:17:47 INFO - PID 3570 | 08:17:48 INFO - PID 3570 | 08:17:48 INFO - PID 3570 | (/builds/slave/test/build/application/firefox/firefox:3687): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:17:48 INFO - PID 3570 | 08:17:48 INFO - PID 3570 | __metrics Screen width/height:1600/1200 08:17:48 INFO - PID 3570 | colorDepth:24 08:17:48 INFO - PID 3570 | Browser inner width/height: 1024/768 08:17:48 INFO - PID 3570 | __metrics 08:17:58 INFO - PID 3570 | RSS: Main: 199819264 08:17:58 INFO - PID 3570 | 08:18:01 INFO - PID 3570 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:20:57 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57952/tests/dromaeo/cssquery-ext.html) 08:20:58 INFO - PID 3570 | RSS: Main: 209944576 08:20:58 INFO - PID 3570 | 08:24:00 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-ext.html (next: http://localhost:57952/tests/dromaeo/cssquery-jquery.html) 08:24:01 INFO - PID 3570 | RSS: Main: 207122432 08:24:01 INFO - PID 3570 | 08:27:03 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57952/tests/dromaeo/cssquery-mootools.html) 08:27:04 INFO - PID 3570 | RSS: Main: 209121280 08:27:04 INFO - PID 3570 | 08:30:06 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57952/tests/dromaeo/cssquery-prototype.html) 08:30:07 INFO - PID 3570 | RSS: Main: 207724544 08:30:07 INFO - PID 3570 | 08:33:11 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57952/tests/dromaeo/cssquery-yui.html) 08:33:11 INFO - PID 3570 | RSS: Main: 209317888 08:33:11 INFO - PID 3570 | 08:36:13 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:57952/tests/dromaeo/cssquery-yui.html (next: http://localhost:57952/tests/dromaeo/cssquery-dojo.html) 08:36:14 INFO - PID 3570 | RSS: Main: 212410368 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | __start_tp_report 08:36:14 INFO - PID 3570 | _x_x_mozilla_page_load 08:36:14 INFO - PID 3570 | _x_x_mozilla_page_load_details 08:36:14 INFO - PID 3570 | |i|pagename|runs| 08:36:14 INFO - PID 3570 | |0;dojo.html;3184.283536204353;3202.4075546024;3233.838308084596;3238.9190270243244;3261.608606967164;5936.228290322258;5976.760929562824;6020.789272375468;6126.326104128542;6160.630362178273;6057.787977420791;6093.634381937087;6130.601510901799;6156.230471191101;6169.043798211284;5575.721213939307;5636.239107720467;5638.971805140968;5668.659880407178;5695.601307908448;5502.174673798922;5504.256925315091;5552.305961754781;5564.721763911808;5617.887642247153;5609.046462101453;5616.129499927518;5622.437756224385;5644.407337229593;5648.096304591266;5569.832905012816;5610.326760788691;5641.802536911188;5652.943470565324;5656.745446454919;5400.486953739389;5520.033994051025;5543.113101903676;5563.332400111972;5605.383407825136;5880.323762767293;5916.645001299936;5939.732712027969;6002.559385747433;6023.789167379165;6341.936580634181;6404.583702059351;6419.390157934989;6439.066335381343;6495.123158373606;6424.196975378078;6430.035494675789;6471.546991710582;6498.350164983511;6556.901646475307;5865.706714664249;5934.43622855828;6035.064564992434;6042.154098426224;6045.909311360333;6742.9662851685425;6748.865022699519;6750.561213521106;6762.019507171432;6775.966120169368;6284.528660350492;6372;6397.8720425592155;6454.225492940877;6466.256380516207;6343.524235682342;6490.286068532458;6543.1493905792895;6559.47524198063;6559.967200163968;6298.496120310364;6341.968290158612;6424.38968298011;6424.614523128627;6430.967845160838;6523.575967562093;6559;6559.376859198369;6567.9671601641685;6570.375814297634;5116.948830511647;5182.4299327073995;5245.527902488794;5253.711045892513;5261.0793111205385;4454.554544545519;4495.910081798345;4552.499225085238;4566.520515345907;4586.2661974083985;5583.720813959286;5600.103983362643;5677;5702.144678298206;5716.971415142898;6486.578372405778;6595.8021259362295;6600.900986485207;6614.86770264592;6630.270670226271;5579.832605021856;5640.746166422521;5642.04085305499;5674.517665998436;5718.170865224519;5537.695426751487;5643.5767317451355;5653.293338332708;5677.744501497443;5713.8285851424525;6206.038064100072;6225.501959843202;6238.656873871981;6242.968785156045;6254.499640028786;6420.967895160495;6469.805905822833;6474.093626892333;6475;6482;6131.294901086432;6144.508439324753;6191.690415479298;6199.690015499117;6200.7519699213335;6371.872562548816;6378.521610879296;6421.261554921057;6422.678866056585;6437.227532696106;6542.54202205841;6557.475401967927;6606.075149478981;6620.271770105381;6642.701078451578;6353.301136875032;6358.96820515913;6422.614643121427;6438.323975982455;6444.516661250331;6059.6364218147055;6204.534659900616;6252.187215662117;6261.279952805304;6408.839779005376;6173.012318029273;6202.782902598387;6226;6229.844253893508;6275.278342990615;6357.205349331333;6360.840978975562;6366.936330636634;6416.647084410402;6453.386928241809;6168.0439531872635;6172.629642221481;6246;6252.030935205051;6260.060990851409 08:36:14 INFO - PID 3570 | |1;ext.html;793.4644115222227;815.7471183932978;841.5035129273728;861.6294993152942;867.0289276010867;39106.413403798964;39947.40078898812;39975.200495990066;39987.800060999725;40058.79970600143;35953;36288;36464.81767591165;36507.26985460289;36552.26895462096;6905.654717264142;6952.5480843745;7015.228324884284;7019.789406317818;7020.613866237355;6869.622170780605;6947.687354069079;6962.373386395224;6999.055127557791;7023.82440438988;6986.161660600709;7468.365188958945;7724.6523906424345;7748.7675369739;7759.728409505668;7596.772096837104;7647.579383133925;7658.8468230635635;7660.1573826879;7662.387009039264;7508.8122796929965;7582.8483430331635;7598.962005189994;7599.050118735158;7604.885926711104;37133.44299835504;37387.439188412194;37393.25213495715;37397.25205495902;37513.06217344561;3419.675130862564;3419.726421886268;3448.793072415663;3449.0515108345153;3449.862005519776;30784.230394240098;30842.228944276347;30867.382652346827;30898.845505772326;30914.53628195579;4982.651214414992;5017.874553136201;5036.798528058874;5065.214891691757;5173.017126745906;177495.11252443783;180840;185764;185982;196385;46355.5364446358;46591;46669;46961.76519117383;47034.529654703016;48622.75688621534;48676.5132348679;48700.26949595759;48719.5128048722;48733.756331218116;15103.244837758068;15219.467318644016;15243.847561524464;15245;15385.538433847003;12442.253464792142;12493.687657808447;12598.874011259953;12609.684757881127;12655.683607909876;13370.197788132744;13432.597022089352;13467.932660336635;13543.525976590772;13629.25039122838;5354.866128346823;5438.537724293479;5473.781048758085;5483.259759932438;5519.972400138054;978.3151793744407;980.9166220871306;1000.8198524265703;1011.3729487717662;1017.6031347774374;21601.459963501038;22362.329130126123;22830.200942966916;28138.43723125526;29634.851825741163;1057.9788404231872;1065.8667666541683;1072.254782925859;1089.0470838016736;1090.936337071349;15574.377024919104;15677.608059798367;15696.372145114296;16176.595585110232;16333.509994700178;207877;209968;210330;210908;210938;54824.72587637116;55188.72405637946;55207.17189242165;55223.44776552264;55356.44643553513;1359.1233654292926;1407.9014468987277;1412.512683124341;1413.039133389305;1418.4184484361363;27629.723702762716;27662;27820.44359112766;28015;28306.575401368584;37286.25427491489;37348.81325593355;37491.2501749958;37526.62473375232;37567;190262;190421.09578904588;191664;192345;193276;33844.492332615526;35253.29493410169;36954.44568331423;36966.445503316936;37044.07389815276;43222.78388608037;44680;45140.54859451495;45416.77291613521;45502;32885.17787055343;32927.50608740823;33231.667683322856;33467.16332091717;33529.66470335363;32466.026019219462;32575.18562035968;32830.507542386404;32978;33083.00750977475;35290.82354588211;36617.81691091527;36697;36738.448923265634;36870.446943295334;31730.206744831565;31757.682423175473;31905.521417178297;32416.513752294206;32531.674683253812;23503.647445288676;23920;24198.274051778473;24278.27165185047;24901 08:36:14 INFO - PID 3570 | |2;jquery.html;551.1897510659329;555.9583031272655;555.9861003474913;560.2240896358542;573.2433188191587;21596.784032159674;22196;22283.888580557075;22409.55180896385;22423.775762242374;24231.878840605816;26685.466290674223;26688.19935401936;26774.464510709822;26853.46293074142;7003.964980175092;7175.031370764932;7184.425245980336;7205.819854503627;7220.025296584972;3954.1498577805764;4276.764777937212;7107.680154393039;7165.713371465161;7182.102237220348;6752.966235168818;7096.574205547658;7102.680379382914;7112.110986126734;7114.395276401512;7112.146542414892;7134.965430012671;7143.571385716822;7146.4282857371545;7153.177384600759;6928.896066559006;6944.479164062665;6980.336867997583;6994.860102797967;6997.195322537922;29701.405971880442;30556.847215764003;30925.536116958265;31013.37973240545;31190.22024449384;2037.6434124028235;2061.742282214723;2068.5759419319;2068.9482762931048;2076.771555128935;19962.900185499126;20300.79699203004;20375.898120509304;20445.079971401323;20451;2433.148398060682;2438.67077944477;2494.837835540702;2533.1128309409423;2537.9873100634563;130648.3467582656;133146.33426832804;134922;134976;135115;19484.861185956976;21192.576148476943;21230.681539776917;21520.89239553792;21811;41307.58692413098;41425.55010574615;41468.79265603652;41614.25471707561;41628;11144.777104457866;11170.664880053611;11295.491702873225;11325.886741132483;11396.031337336253;9368.156865882103;9435.528223588793;9438.622455101857;9444;9482.715518534455;8382.413231073888;9093.135417447558;10995.505202265917;11505.71235719097;11579.652610421532;2494.912678056259;2508.686414198225;2520.6345079963303;2584.9224523264334;2615.751503607154;918.3296193778579;940.1256831147099;948.4735971535864;964.5659453245927;975.2782940623887;19173.61652766937;19387.612247754965;19470.610587788164;19786.90106549458;20194.39416817498;1002.5137808163036;1028.711960651019;1045.4145678419957;1046.4767616191905;1062.4634559547378;10679.359238445719;10773.353598784099;10787.946060269649;10841.403722795321;10879.673609791718;484511;488423;495943;509992;517564;123316.38341808414;124625;125523;126504;127436.36281818531;1156.3928937307812;1168.7545615420686;1193.039603119497;1194.1044216837372;1207.2213422342716;16596;17139.91430042842;17219.82780172182;17264.309427622753;17369.13154342303;52883.471165287854;53213;53788.73105634447;54384.728076359366;55487.16769248384;68515;68754;68824.62350753057;69111.65444172747;69189.30810691828;12063.81904271419;14401.847852171592;14454.638634034232;14475;14631;18380;21043.684344734535;22498.325050248517;22788.088476460754;23178.884105579364;18133.546661333574;18148.546286342946;18316.084195789892;18327.35854245095;18379.90810045941;16062.196890155212;16497.257623407215;16626.085565294026;16866.915665421595;17096.0597167157;16422.75365869489;18145.274189032818;18183.363582274556;18209.908950455163;18211.089445527934;13936.442542298195;14162;14248.643783905485;14336.713265734836;14387.712245754818;17804.198811053793;18252.634947301245;18737.812621874153;18959.90520047391;19169.32907348236 08:36:14 INFO - PID 3570 | |3;mootools.html;1306.8889144422724;1353.6412850594595;1361.7821148616224;1362.3256488038423;1370.3079944627964;14077.577672669824;14557.563273101798;14744.33650485728;14800.555983320504;14840.703185936289;14776.113433193988;15209.77185342218;15241.237938103079;15250;15345.15601641912;2639.3269716222385;2707.10665480391;2710.0921191400807;2711.7830573554165;2715.0768738628863;2471.8505894758932;2569.5888657814753;2636.433166869123;2648.801339899506;2658.4417272372825;2628.9615601837263;2666.0668765931964;2681.302861256078;2692.5557283048274;2696.4741875334316;2618.8297760645687;2638.2349118755537;2641.5641419165718;2642.207337798672;2646.722094180122;2530.734272901337;2544.5674235379843;2580.658057809947;2603.8177327587077;2630.8026897982727;14272.714545709028;14606.780898286534;14651.560453186421;14665.413383464755;14701.1914344711;7799.3760499159935;8054.838903221961;8073.838523229502;8078.717244896459;8100.149484304181;4858.659893807435;4927.334809800667;5038.5465308122075;5096;5142.30578871855;1721.4405318271613;1723.276223985929;1747.8077411484726;1759.480953118833;2277.646964720471;24275.87862060696;24474;24483.143089991943;24557.754422455724;24616.5076698465;6346.4605508532295;6393.392627700361;6478.222613286436;6535.248446428626;6624.86750264992;15781.210939452982;16144.515664530083;16710.4151354702;16753.581160471087;16759;7615.5430674159725;7822.726204582812;7850.882236766453;7854.528728276322;7857.882131768028;7114.71541138359;7129.251428599922;7243.637818109179;7347.412207023425;7366.558006519626;4967.850964471072;5114.744262786846;5114.769835357418;5117.488251174927;5135.922961155586;1490.9627259318604;1507.9698406031819;1510.0637604685166;1529.4799768078906;1545.6135966008499;845.7082306604211;859.952702601363;884.6284560484612;887.6671248281895;889.666375109334;7057.117860267466;7090.858182836314;7108.3957863581145;7119.860822268412;7160.785176444715;683.6479213205204;705.7917914215319;711.4770643576967;717.9748708795167;724.2540183610889;4595.632349412106;4662.813487460464;4808.182608956486;4890.144224760653;4931.605471562267;20046.298379556647;20059.39821805348;20883.269085582237;20959;20984;20142.69785953212;20316;20341.593168136555;20622.793772062087;20861.165553378;11010.174236932262;11016.614418495314;11033.227674062899;11094.500747466383;11149.944250278697;7735.806604834924;8129.4715843469985;8172.101068882537;8403.70587029451;8461.280791132822;17713.734293985344;17737.822621774132;18113;18116.18477168557;18512.0743962804;18086.81913180904;18269.634607307515;18545.072746362897;18711.1579978904;18791.060446977324;11807;11992.820107698566;12015.339156346485;12018.278903265833;12020.699482513008;13192.538261160813;13434;13471.730565388832;13533.593992180251;13535.932320338336;10894.509747061244;11195.776084478428;11209.047230985132;11247.606333778278;11359.659210223706;10799.730006749895;10968.780624387628;11061.668149955514;11133.832992504957;11144.387058711525;8960.551972401223;8995.23540499065;9051.32115091384;9057.818843623223;9115.680951166678;6581.703823327866;6636.83407914806;6666.966665166643;6778.4916131289365;6810.5913645181445;6859.9314006859295;6917.273686263071;6984.4761642878;6988.965055174692;6993.510454268152 08:36:14 INFO - PID 3570 | |4;prototype.html;494.7789596955207;500.8973160502097;513.427528305939;521.4316395129309;524.6222719641856;6121.6939153042285;6138.324784273726;6250.562460627758;6290.301618562997;6299.1496148020005;5912.852178695534;5991.700414979256;6009.399060093989;6010.75956961721;6174.8147555573405;4883.658143929926;4915.950840491603;4933.7533123343865;4958.107540642692;4985.875353116165;4815.686980346284;4920.335754673127;4930.137225985438;4954.7522623868845;4982.601391888658;4900.926486102711;4907.82822601209;4918.434380046287;4920.114379411704;4920.532549407801;4872.829450969199;4880.731559764212;4926.630502712311;4929.580985616227;4947.925781113287;4353.477582690066;4379.474463064453;4411.250087485135;4413.918589945484;4418.536053714346;6080.908786368208;6081.787137450212;6108.480779133734;6119.724612392453;6146.940774840434;5606.990741666498;5652.152177173416;5676.517496012844;5687.800926967578;5688.288963879515;6487.545871788977;6509.576877502947;6513.837154071139;6528.249251336109;6549.6070235786;4765.428148622153;4767.737774422405;4770.117528257283;4776.590905682832;4784.736839473828;6678.332166783282;6735.191776986744;6757.763478278237;6836.38472537474;6907.171139463297;4891.902161956741;4900.338454308694;4951.405831300195;4952.851414457572;4964.329815474937;4893.510648935149;4924.803007879645;4958.975205123951;4969.27945447908;5029.270755740397;5470.288862447856;5501.532369748536;5522;5571.804986825442;5622.550195984311;6529.575577587441;6560.540762146699;6612.140421745238;6619.371159739817;6643.40209381158;1645.276078525445;1676.1116608197674;1709.6495218480181;1720.5354554270277;1744.1366523570914;1158.530795028015;1192.5587532612988;1204.6205445284706;1204.8192771084407;1229.59423390281;5571.637843540157;5619.943800561942;5621.971890140605;5625.38120806711;5681.375048744635;6509.576877502947;6583.374579414948;6594.934050659528;6651.071189355032;6673.799786006428;5704.087346024616;5721.456461636138;5727.713614319267;5729.656220626775;5736.196932429463;3501.3172431375638;3509.894703158909;3520.559930008749;3521.5245941798044;3556.1643013891717;6232.532560058014;6249.156363890907;6266.154069200691;6369.8534263832025;6461.935380646228;6811.727530898708;6831.555948863308;6841.62371069586;6843.897341539781;6909.447244220551;6283.37166283368;6307.936920630918;6333.68331583419;6366.299707032223;6378.681065946684;6611.768588099393;6618.470522358103;6669.933300667125;6671.199456065303;6676.365745254193;6577.736890524326;6602.60384376939;6612.685560053943;6626.53614246998;6658.167729033871;6320.778772743116;6328.050792381179;6336.398042185985;6348.428641422294;6349.587276826992;4801.7118972861745;4842.903141937212;4873.561379475864;4882.536159064884;4906.141425250638;6425.614463132227;6647.9002814958785;6746.190457145174;6759.2564817869015;6786.626735529593;6214.378562143749;6349.238091429058;6378.808635740936;6420.646864422315;6440.774572889926;6362.377593713573;6402.775902843378;6406.647634379968;6431.871362572816;6493.8701225976165;6247.5001999840815;6257.812265632038;6290.402411770874;6316.526260530387;6451.3226111257645;6298.212723409574;6314.589551679126;6353.269374022047;6385.840353991188;6415.037744338387;6241.063840423791;6246.281677606951;6306.306306306211;6324.747010119544;6332.461740751904 08:36:14 INFO - PID 3570 | |5;yui.html;867.8431199107581;871.9128087191282;875.3303722652176;882.668999125328;887.6759982606346;18765.530861728446;19470.318538851145;19552.804471955274;19650;21045.684314735252;20749.792502074975;21425.57148857022;21434.356969290908;21460.248891288807;21602.675959860575;910.249044538257;935.8175155844613;941.5010044676333;946.3990366117496;947.5120313038791;950.9381890177151;952.4856577448204;952.9523523823816;953.9093786090345;955.412421360865;932.8507438809792;970.398353021128;975.3318976501084;978.0024375137356;984.3847595252967;973.8052389522123;975.2539307429822;976.0288512929609;976.3702411944256;977.0620204603554;715.7781087862779;718.0736849464184;720.0890873045602;720.7333286683908;721.3003386714878;17504.21231044606;18239.817601823943;18335.266589336545;18348;18391;20459.28392506255;20689;21514.354569362946;21531.892340538354;21774.782252177432;15771.29029193689;16199.838001619952;16436.424725134682;16446.095464749433;16473.505794826175;3687.3547129252274;3688.4467329900463;3726.087108658369;3733.4586484959527;3740.0462881964927;129008.35495822555;131547.34226328903;132216;133582.3320883399;134697.3265133668;16089.758653620205;16389.262483188286;16475.5881102971;16631;16637.25132369022;28760.856195719305;29735.256618584277;29822.701772981993;30051.398972020437;30318.696813032027;7361.2638736125955;7584.469087163846;7693.576853273124;7710.190430004769;7733.072031356273;3667.559892812826;3822.4075268333454;3845.2117315950163;3865.7873816940337;3877.0888841122314;4790.305405716222;4855.547948286093;4915.5330243626795;4939.3084968104495;4955.132851750929;985.9950700246453;994.7612572982432;999.2355847776457;999.4203362049993;1008.1380419741016;659.3900641906217;672.7241830849329;677.678102901118;684.1926526698544;690.2303931116769;11630.592929247436;11745.647630571097;12130.150889437655;12366.258024518558;12413.813792793115;661.4741280681869;670.4602794750273;673.66950273211;680.8025672554903;684.910961574992;5138.177891537336;5197.402298735618;5257.6056795739705;5422.05114105038;5431.049566325877;111184;111800;113370;113534;117637;93736.53131734297;94998;97603;99483.50258248663;101811;87469.56265218633;88291.55854220688;89525.55237223773;90626.54686726393;92738.53630731803;10452.477376131315;10503.42231177262;10558.208134389797;10679.57281708723;10899.346039237354;40291.19417611573;40579.391309129795;40952.18095638011;41017.384739228335;42730.359044614976;68141.65929170322;71384.64307678428;71603;72235.63882180555;74494;18206.45380638583;18290;18741;18855.340063097727;18939.147738352083;19414.417567473;19773.60452790965;19908.800911990696;20042.298519551747;20077.799222008176;16358.345666173696;16597;16614.66770664604;16782.66434671324;18904.338348157748;16380.83619163793;16530.173491325626;16609.584760381087;18321.3587524436;18992.24031038743;17580.73628895542;17762.46712598624;17848.28606855763;18367.632647346712;18479.260829566665;11925.582604608797;12328.07539434528;12335.876641233473;12443.440045197807;12503.4373453193;12118.575849845212;12474.18917770342;12731.681707957376;13522.79715804244;13675.316234188449 08:36:14 INFO - PID 3570 | __end_tp_report 08:36:14 INFO - PID 3570 | __start_cc_report 08:36:14 INFO - PID 3570 | _x_x_mozilla_cycle_collect,388 08:36:14 INFO - PID 3570 | __end_cc_report 08:36:14 INFO - PID 3570 | __startTimestamp1503502574130__endTimestamp 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | ------- Summary: start ------- 08:36:14 INFO - PID 3570 | Number of tests: 6 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#0] dojo.html Cycles:165 Average:5982.17 Median:6199.69 stddev:681.74 (11.0%) stddev-sans-first:647.53 08:36:14 INFO - PID 3570 | Values: 3184.3 3202.4 3233.8 3238.9 3261.6 5936.2 5976.8 6020.8 6126.3 6160.6 6057.8 6093.6 6130.6 6156.2 6169.0 5575.7 5636.2 5639.0 5668.7 5695.6 5502.2 5504.3 5552.3 5564.7 5617.9 5609.0 5616.1 5622.4 5644.4 5648.1 5569.8 5610.3 5641.8 5652.9 5656.7 5400.5 5520.0 5543.1 5563.3 5605.4 5880.3 5916.6 5939.7 6002.6 6023.8 6341.9 6404.6 6419.4 6439.1 6495.1 6424.2 6430.0 6471.5 6498.4 6556.9 5865.7 5934.4 6035.1 6042.2 6045.9 6743.0 6748.9 6750.6 6762.0 6776.0 6284.5 6372.0 6397.9 6454.2 6466.3 6343.5 6490.3 6543.1 6559.5 6560.0 6298.5 6342.0 6424.4 6424.6 6431.0 6523.6 6559.0 6559.4 6568.0 6570.4 5116.9 5182.4 5245.5 5253.7 5261.1 4454.6 4495.9 4552.5 4566.5 4586.3 5583.7 5600.1 5677.0 5702.1 5717.0 6486.6 6595.8 6600.9 6614.9 6630.3 5579.8 5640.7 5642.0 5674.5 5718.2 5537.7 5643.6 5653.3 5677.7 5713.8 6206.0 6225.5 6238.7 6243.0 6254.5 6421.0 6469.8 6474.1 6475.0 6482.0 6131.3 6144.5 6191.7 6199.7 6200.8 6371.9 6378.5 6421.3 6422.7 6437.2 6542.5 6557.5 6606.1 6620.3 6642.7 6353.3 6359.0 6422.6 6438.3 6444.5 6059.6 6204.5 6252.2 6261.3 6408.8 6173.0 6202.8 6226.0 6229.8 6275.3 6357.2 6360.8 6366.9 6416.6 6453.4 6168.0 6172.6 6246.0 6252.0 6260.1 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#1] ext.html Cycles:180 Average:36769.90 Median:35621.91 stddev:50629.62 (142.1%) stddev-sans-first:50699.58 08:36:14 INFO - PID 3570 | Values: 793.5 815.7 841.5 861.6 867.0 39106.4 39947.4 39975.2 39987.8 40058.8 35953.0 36288.0 36464.8 36507.3 36552.3 6905.7 6952.5 7015.2 7019.8 7020.6 6869.6 6947.7 6962.4 6999.1 7023.8 6986.2 7468.4 7724.7 7748.8 7759.7 7596.8 7647.6 7658.8 7660.2 7662.4 7508.8 7582.8 7599.0 7599.1 7604.9 37133.4 37387.4 37393.3 37397.3 37513.1 3419.7 3419.7 3448.8 3449.1 3449.9 30784.2 30842.2 30867.4 30898.8 30914.5 4982.7 5017.9 5036.8 5065.2 5173.0 177495.1 180840.0 185764.0 185982.0 196385.0 46355.5 46591.0 46669.0 46961.8 47034.5 48622.8 48676.5 48700.3 48719.5 48733.8 15103.2 15219.5 15243.8 15245.0 15385.5 12442.3 12493.7 12598.9 12609.7 12655.7 13370.2 13432.6 13467.9 13543.5 13629.3 5354.9 5438.5 5473.8 5483.3 5520.0 978.3 980.9 1000.8 1011.4 1017.6 21601.5 22362.3 22830.2 28138.4 29634.9 1058.0 1065.9 1072.3 1089.0 1090.9 15574.4 15677.6 15696.4 16176.6 16333.5 207877.0 209968.0 210330.0 210908.0 210938.0 54824.7 55188.7 55207.2 55223.4 55356.4 1359.1 1407.9 1412.5 1413.0 1418.4 27629.7 27662.0 27820.4 28015.0 28306.6 37286.3 37348.8 37491.3 37526.6 37567.0 190262.0 190421.1 191664.0 192345.0 193276.0 33844.5 35253.3 36954.4 36966.4 37044.1 43222.8 44680.0 45140.5 45416.8 45502.0 32885.2 32927.5 33231.7 33467.2 33529.7 32466.0 32575.2 32830.5 32978.0 33083.0 35290.8 36617.8 36697.0 36738.4 36870.4 31730.2 31757.7 31905.5 32416.5 32531.7 23503.6 23920.0 24198.3 24278.3 24901.0 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#2] jquery.html Cycles:180 Average:35777.90 Median:22003.50 stddev:84046.12 (382.0%) stddev-sans-first:84240.27 08:36:14 INFO - PID 3570 | Values: 551.2 556.0 556.0 560.2 573.2 21596.8 22196.0 22283.9 22409.6 22423.8 24231.9 26685.5 26688.2 26774.5 26853.5 7004.0 7175.0 7184.4 7205.8 7220.0 3954.1 4276.8 7107.7 7165.7 7182.1 6753.0 7096.6 7102.7 7112.1 7114.4 7112.1 7135.0 7143.6 7146.4 7153.2 6928.9 6944.5 6980.3 6994.9 6997.2 29701.4 30556.8 30925.5 31013.4 31190.2 2037.6 2061.7 2068.6 2068.9 2076.8 19962.9 20300.8 20375.9 20445.1 20451.0 2433.1 2438.7 2494.8 2533.1 2538.0 130648.3 133146.3 134922.0 134976.0 135115.0 19484.9 21192.6 21230.7 21520.9 21811.0 41307.6 41425.6 41468.8 41614.3 41628.0 11144.8 11170.7 11295.5 11325.9 11396.0 9368.2 9435.5 9438.6 9444.0 9482.7 8382.4 9093.1 10995.5 11505.7 11579.7 2494.9 2508.7 2520.6 2584.9 2615.8 918.3 940.1 948.5 964.6 975.3 19173.6 19387.6 19470.6 19786.9 20194.4 1002.5 1028.7 1045.4 1046.5 1062.5 10679.4 10773.4 10787.9 10841.4 10879.7 484511.0 488423.0 495943.0 509992.0 517564.0 123316.4 124625.0 125523.0 126504.0 127436.4 1156.4 1168.8 1193.0 1194.1 1207.2 16596.0 17139.9 17219.8 17264.3 17369.1 52883.5 53213.0 53788.7 54384.7 55487.2 68515.0 68754.0 68824.6 69111.7 69189.3 12063.8 14401.8 14454.6 14475.0 14631.0 18380.0 21043.7 22498.3 22788.1 23178.9 18133.5 18148.5 18316.1 18327.4 18379.9 16062.2 16497.3 16626.1 16866.9 17096.1 16422.8 18145.3 18183.4 18209.9 18211.1 13936.4 14162.0 14248.6 14336.7 14387.7 17804.2 18252.6 18737.8 18959.9 19169.3 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#3] mootools.html Cycles:180 Average:8982.06 Median:2611.32 stddev:6370.05 (243.9%) stddev-sans-first:6361.82 08:36:14 INFO - PID 3570 | Values: 1306.9 1353.6 1361.8 1362.3 1370.3 14077.6 14557.6 14744.3 14800.6 14840.7 14776.1 15209.8 15241.2 15250.0 15345.2 2639.3 2707.1 2710.1 2711.8 2715.1 2471.9 2569.6 2636.4 2648.8 2658.4 2629.0 2666.1 2681.3 2692.6 2696.5 2618.8 2638.2 2641.6 2642.2 2646.7 2530.7 2544.6 2580.7 2603.8 2630.8 14272.7 14606.8 14651.6 14665.4 14701.2 7799.4 8054.8 8073.8 8078.7 8100.1 4858.7 4927.3 5038.5 5096.0 5142.3 1721.4 1723.3 1747.8 1759.5 2277.6 24275.9 24474.0 24483.1 24557.8 24616.5 6346.5 6393.4 6478.2 6535.2 6624.9 15781.2 16144.5 16710.4 16753.6 16759.0 7615.5 7822.7 7850.9 7854.5 7857.9 7114.7 7129.3 7243.6 7347.4 7366.6 4967.9 5114.7 5114.8 5117.5 5135.9 1491.0 1508.0 1510.1 1529.5 1545.6 845.7 860.0 884.6 887.7 889.7 7057.1 7090.9 7108.4 7119.9 7160.8 683.6 705.8 711.5 718.0 724.3 4595.6 4662.8 4808.2 4890.1 4931.6 20046.3 20059.4 20883.3 20959.0 20984.0 20142.7 20316.0 20341.6 20622.8 20861.2 11010.2 11016.6 11033.2 11094.5 11149.9 7735.8 8129.5 8172.1 8403.7 8461.3 17713.7 17737.8 18113.0 18116.2 18512.1 18086.8 18269.6 18545.1 18711.2 18791.1 11807.0 11992.8 12015.3 12018.3 12020.7 13192.5 13434.0 13471.7 13533.6 13535.9 10894.5 11195.8 11209.0 11247.6 11359.7 10799.7 10968.8 11061.7 11133.8 11144.4 8960.6 8995.2 9051.3 9057.8 9115.7 6581.7 6636.8 6667.0 6778.5 6810.6 6859.9 6917.3 6984.5 6989.0 6993.5 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#4] prototype.html Cycles:180 Average:5428.58 Median:6095.13 stddev:1527.63 (25.1%) stddev-sans-first:1486.35 08:36:14 INFO - PID 3570 | Values: 494.8 500.9 513.4 521.4 524.6 6121.7 6138.3 6250.6 6290.3 6299.1 5912.9 5991.7 6009.4 6010.8 6174.8 4883.7 4916.0 4933.8 4958.1 4985.9 4815.7 4920.3 4930.1 4954.8 4982.6 4900.9 4907.8 4918.4 4920.1 4920.5 4872.8 4880.7 4926.6 4929.6 4947.9 4353.5 4379.5 4411.3 4413.9 4418.5 6080.9 6081.8 6108.5 6119.7 6146.9 5607.0 5652.2 5676.5 5687.8 5688.3 6487.5 6509.6 6513.8 6528.2 6549.6 4765.4 4767.7 4770.1 4776.6 4784.7 6678.3 6735.2 6757.8 6836.4 6907.2 4891.9 4900.3 4951.4 4952.9 4964.3 4893.5 4924.8 4959.0 4969.3 5029.3 5470.3 5501.5 5522.0 5571.8 5622.6 6529.6 6560.5 6612.1 6619.4 6643.4 1645.3 1676.1 1709.6 1720.5 1744.1 1158.5 1192.6 1204.6 1204.8 1229.6 5571.6 5619.9 5622.0 5625.4 5681.4 6509.6 6583.4 6594.9 6651.1 6673.8 5704.1 5721.5 5727.7 5729.7 5736.2 3501.3 3509.9 3520.6 3521.5 3556.2 6232.5 6249.2 6266.2 6369.9 6461.9 6811.7 6831.6 6841.6 6843.9 6909.4 6283.4 6307.9 6333.7 6366.3 6378.7 6611.8 6618.5 6669.9 6671.2 6676.4 6577.7 6602.6 6612.7 6626.5 6658.2 6320.8 6328.1 6336.4 6348.4 6349.6 4801.7 4842.9 4873.6 4882.5 4906.1 6425.6 6647.9 6746.2 6759.3 6786.6 6214.4 6349.2 6378.8 6420.6 6440.8 6362.4 6402.8 6406.6 6431.9 6493.9 6247.5 6257.8 6290.4 6316.5 6451.3 6298.2 6314.6 6353.3 6385.8 6415.0 6241.1 6246.3 6306.3 6324.7 6332.5 08:36:14 INFO - PID 3570 | 08:36:14 INFO - PID 3570 | [#5] yui.html Cycles:180 Average:23899.00 Median:30185.05 stddev:33269.83 (110.2%) stddev-sans-first:33318.21 08:36:14 INFO - PID 3570 | Values: 867.8 871.9 875.3 882.7 887.7 18765.5 19470.3 19552.8 19650.0 21045.7 20749.8 21425.6 21434.4 21460.2 21602.7 910.2 935.8 941.5 946.4 947.5 950.9 952.5 953.0 953.9 955.4 932.9 970.4 975.3 978.0 984.4 973.8 975.3 976.0 976.4 977.1 715.8 718.1 720.1 720.7 721.3 17504.2 18239.8 18335.3 18348.0 18391.0 20459.3 20689.0 21514.4 21531.9 21774.8 15771.3 16199.8 16436.4 16446.1 16473.5 3687.4 3688.4 3726.1 3733.5 3740.0 129008.4 131547.3 132216.0 133582.3 134697.3 16089.8 16389.3 16475.6 16631.0 16637.3 28760.9 29735.3 29822.7 30051.4 30318.7 7361.3 7584.5 7693.6 7710.2 7733.1 3667.6 3822.4 3845.2 3865.8 3877.1 4790.3 4855.5 4915.5 4939.3 4955.1 986.0 994.8 999.2 999.4 1008.1 659.4 672.7 677.7 684.2 690.2 11630.6 11745.6 12130.2 12366.3 12413.8 661.5 670.5 673.7 680.8 684.9 5138.2 5197.4 5257.6 5422.1 5431.0 111184.0 111800.0 113370.0 113534.0 117637.0 93736.5 94998.0 97603.0 99483.5 101811.0 87469.6 88291.6 89525.6 90626.5 92738.5 10452.5 10503.4 10558.2 10679.6 10899.3 40291.2 40579.4 40952.2 41017.4 42730.4 68141.7 71384.6 71603.0 72235.6 74494.0 18206.5 18290.0 18741.0 18855.3 18939.1 19414.4 19773.6 19908.8 20042.3 20077.8 16358.3 16597.0 16614.7 16782.7 18904.3 16380.8 16530.2 16609.6 18321.4 18992.2 17580.7 17762.5 17848.3 18367.6 18479.3 11925.6 12328.1 12335.9 12443.4 12503.4 12118.6 12474.2 12731.7 13522.8 13675.3 08:36:14 INFO - PID 3570 | -------- Summary: end -------- 08:36:14 INFO - PID 3570 | 08:36:15 INFO - TEST-INFO | 3570: exit 0 08:36:15 INFO - TEST-OK | dromaeo_css | took 1116427ms 08:36:15 INFO - TEST-START | kraken 08:36:15 INFO - Initialising browser for kraken test... 08:36:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57952/getInfo.html -profile /tmp/tmpeZt8so/profile 08:36:15 INFO - TEST-INFO | started process 3989 (/builds/slave/test/build/application/firefox/firefox http://localhost:57952/getInfo.html) 08:36:21 INFO - TEST-INFO | 3989: exit 0 08:36:21 INFO - Browser initialized. 08:36:21 INFO - Running cycle 1/1 for kraken test... 08:36:21 INFO - TEST-INFO | started process 4173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeZt8so/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:22 INFO - PID 4173 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:36:22 INFO - PID 4173 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:36:22 INFO - PID 4173 | 08:36:22 INFO - PID 4173 | (/builds/slave/test/build/application/firefox/firefox:4232): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:36:22 INFO - PID 4173 | 08:36:23 INFO - PID 4173 | 08:36:23 INFO - PID 4173 | (/builds/slave/test/build/application/firefox/firefox:4289): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:36:23 INFO - PID 4173 | 08:36:23 INFO - PID 4173 | __metrics Screen width/height:1600/1200 08:36:23 INFO - PID 4173 | colorDepth:24 08:36:23 INFO - PID 4173 | Browser inner width/height: 1024/768 08:36:23 INFO - PID 4173 | __metrics 08:36:33 INFO - PID 4173 | RSS: Main: 200273920 08:36:33 INFO - PID 4173 | 08:36:35 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57952/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:36 INFO - PID 4173 | RSS: Main: 208424960 08:36:36 INFO - PID 4173 | 08:36:39 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57952/tests/kraken/driver.html?testName=audio-dft) 08:36:40 INFO - PID 4173 | RSS: Main: 209166336 08:36:40 INFO - PID 4173 | 08:36:43 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57952/tests/kraken/driver.html?testName=audio-fft) 08:36:43 INFO - PID 4173 | RSS: Main: 203952128 08:36:43 INFO - PID 4173 | 08:36:46 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57952/tests/kraken/driver.html?testName=audio-oscillator) 08:36:46 INFO - PID 4173 | RSS: Main: 203476992 08:36:46 INFO - PID 4173 | 08:36:48 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:49 INFO - PID 4173 | RSS: Main: 204877824 08:36:49 INFO - PID 4173 | 08:36:52 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57952/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:53 INFO - PID 4173 | RSS: Main: 206397440 08:36:53 INFO - PID 4173 | 08:36:56 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57952/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:57 INFO - PID 4173 | RSS: Main: 205230080 08:36:57 INFO - PID 4173 | 08:37:00 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57952/tests/kraken/driver.html?testName=json-parse-financial) 08:37:01 INFO - PID 4173 | RSS: Main: 205389824 08:37:01 INFO - PID 4173 | 08:37:02 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:03 INFO - PID 4173 | RSS: Main: 204582912 08:37:03 INFO - PID 4173 | 08:37:05 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:05 INFO - PID 4173 | RSS: Main: 206082048 08:37:05 INFO - PID 4173 | 08:37:08 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:08 INFO - PID 4173 | RSS: Main: 205414400 08:37:08 INFO - PID 4173 | 08:37:11 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:12 INFO - PID 4173 | RSS: Main: 206544896 08:37:12 INFO - PID 4173 | 08:37:15 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:15 INFO - PID 4173 | RSS: Main: 205623296 08:37:15 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | Cycle 1(1): loaded http://localhost:57952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57952/tests/kraken/driver.html?testName=ai-astar) 08:37:17 INFO - PID 4173 | RSS: Main: 207958016 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | __start_tp_report 08:37:17 INFO - PID 4173 | _x_x_mozilla_page_load 08:37:17 INFO - PID 4173 | _x_x_mozilla_page_load_details 08:37:17 INFO - PID 4173 | |i|pagename|runs| 08:37:17 INFO - PID 4173 | |0;ai-astar;103;108;101;108;114;117;109;104;113;115 08:37:17 INFO - PID 4173 | |1;audio-beat-detection;157;122;144;187;120;152;145;124;185;127 08:37:17 INFO - PID 4173 | |2;audio-dft;163;164;163;166;170;165;164;166;164;164 08:37:17 INFO - PID 4173 | |3;audio-fft;82;81;75;161;75;75;79;76;159;77 08:37:17 INFO - PID 4173 | |4;audio-oscillator;85;81;136;80;81;80;135;80;82;140 08:37:17 INFO - PID 4173 | |5;imaging-gaussian-blur;119;115;114;114;121;117;113;120;114;120 08:37:17 INFO - PID 4173 | |6;imaging-darkroom;156;151;148;155;149;151;149;148;149;151 08:37:17 INFO - PID 4173 | |7;imaging-desaturate;97;103;97;108;95;96;95;99;100;98 08:37:17 INFO - PID 4173 | |8;json-parse-financial;59;59;53;54;56;54;54;53;55;53 08:37:17 INFO - PID 4173 | |9;json-stringify-tinderbox;62;62;56;57;59;56;61;57;56;65 08:37:17 INFO - PID 4173 | |10;stanford-crypto-aes;76;78;75;80;91;81;77;75;77;76 08:37:17 INFO - PID 4173 | |11;stanford-crypto-ccm;130;135;120;123;125;123;122;126;132;170 08:37:17 INFO - PID 4173 | |12;stanford-crypto-pbkdf2;168;177;176;176;179;184;173;178;176;173 08:37:17 INFO - PID 4173 | |13;stanford-crypto-sha256-iterative;68;66;66;67;66;65;65;65;64;63 08:37:17 INFO - PID 4173 | __end_tp_report 08:37:17 INFO - PID 4173 | __start_cc_report 08:37:17 INFO - PID 4173 | _x_x_mozilla_cycle_collect,946 08:37:17 INFO - PID 4173 | __end_cc_report 08:37:17 INFO - PID 4173 | __startTimestamp1503502637969__endTimestamp 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | ------- Summary: start ------- 08:37:17 INFO - PID 4173 | Number of tests: 14 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:5.45 (4.9%) stddev-sans-first:5.30 08:37:17 INFO - PID 4173 | Values: 103.0 108.0 101.0 108.0 114.0 117.0 109.0 104.0 113.0 115.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:148.50 stddev:24.63 (16.6%) stddev-sans-first:25.82 08:37:17 INFO - PID 4173 | Values: 157.0 122.0 144.0 187.0 120.0 152.0 145.0 124.0 185.0 127.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:2.08 (1.3%) stddev-sans-first:2.09 08:37:17 INFO - PID 4173 | Values: 163.0 164.0 163.0 166.0 170.0 165.0 164.0 166.0 164.0 164.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.50 stddev:34.88 (45.6%) stddev-sans-first:36.72 08:37:17 INFO - PID 4173 | Values: 82.0 81.0 75.0 161.0 75.0 75.0 79.0 76.0 159.0 77.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:80.50 stddev:26.98 (33.5%) stddev-sans-first:28.21 08:37:17 INFO - PID 4173 | Values: 85.0 81.0 136.0 80.0 81.0 80.0 135.0 80.0 82.0 140.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:118.00 stddev:3.06 (2.6%) stddev-sans-first:3.13 08:37:17 INFO - PID 4173 | Values: 119.0 115.0 114.0 114.0 121.0 117.0 113.0 120.0 114.0 120.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:2.79 (1.8%) stddev-sans-first:2.20 08:37:17 INFO - PID 4173 | Values: 156.0 151.0 148.0 155.0 149.0 151.0 149.0 148.0 149.0 151.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:96.50 stddev:4.05 (4.2%) stddev-sans-first:4.24 08:37:17 INFO - PID 4173 | Values: 97.0 103.0 97.0 108.0 95.0 96.0 95.0 99.0 100.0 98.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:2.31 (4.2%) stddev-sans-first:1.94 08:37:17 INFO - PID 4173 | Values: 59.0 59.0 53.0 54.0 56.0 54.0 54.0 53.0 55.0 53.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:60.00 stddev:3.21 (5.4%) stddev-sans-first:3.23 08:37:17 INFO - PID 4173 | Values: 62.0 62.0 56.0 57.0 59.0 56.0 61.0 57.0 56.0 65.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:4.79 (6.2%) stddev-sans-first:4.99 08:37:17 INFO - PID 4173 | Values: 76.0 78.0 75.0 80.0 91.0 81.0 77.0 75.0 77.0 76.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:128.00 stddev:14.64 (11.4%) stddev-sans-first:15.52 08:37:17 INFO - PID 4173 | Values: 130.0 135.0 120.0 123.0 125.0 123.0 122.0 126.0 132.0 170.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.50 stddev:4.22 (2.4%) stddev-sans-first:3.33 08:37:17 INFO - PID 4173 | Values: 168.0 177.0 176.0 176.0 179.0 184.0 173.0 178.0 176.0 173.0 08:37:17 INFO - PID 4173 | 08:37:17 INFO - PID 4173 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.20 08:37:17 INFO - PID 4173 | Values: 68.0 66.0 66.0 67.0 66.0 65.0 65.0 65.0 64.0 63.0 08:37:17 INFO - PID 4173 | -------- Summary: end -------- 08:37:17 INFO - PID 4173 | 08:37:18 INFO - PID 4173 | 08:37:18 INFO - PID 4173 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:37:18 INFO - PID 4173 | 08:37:18 INFO - PID 4173 | 08:37:18 INFO - PID 4173 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:37:18 INFO - PID 4173 | 08:37:18 INFO - PID 4173 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:37:18 INFO - TEST-INFO | 4173: exit 0 08:37:18 INFO - TEST-OK | kraken | took 63743ms 08:37:18 INFO - SUITE-END | took 1180s 08:37:19 INFO - Completed test suite (00:19:40) 08:37:19 INFO - javascript benchmark 08:37:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8409.084200234845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3184.283536204353, 3202.4075546024, 3233.838308084596, 3238.9190270243244, 3261.608606967164, 5936.228290322258, 5976.760929562824, 6020.789272375468, 6126.326104128542, 6160.630362178273, 6057.787977420791, 6093.634381937087, 6130.601510901799, 6156.230471191101, 6169.043798211284, 5575.721213939307, 5636.239107720467, 5638.971805140968, 5668.659880407178, 5695.601307908448, 5502.174673798922, 5504.256925315091, 5552.305961754781, 5564.721763911808, 5617.887642247153, 5609.046462101453, 5616.129499927518, 5622.437756224385, 5644.407337229593, 5648.096304591266, 5569.832905012816, 5610.326760788691, 5641.802536911188, 5652.943470565324, 5656.745446454919, 5400.486953739389, 5520.033994051025, 5543.113101903676, 5563.332400111972, 5605.383407825136, 5880.323762767293, 5916.645001299936, 5939.732712027969, 6002.559385747433, 6023.789167379165, 6341.936580634181, 6404.583702059351, 6419.390157934989, 6439.066335381343, 6495.123158373606, 6424.196975378078, 6430.035494675789, 6471.546991710582, 6498.350164983511, 6556.901646475307, 5865.706714664249, 5934.43622855828, 6035.064564992434, 6042.154098426224, 6045.909311360333, 6742.9662851685425, 6748.865022699519, 6750.561213521106, 6762.019507171432, 6775.966120169368, 6284.528660350492, 6372.0, 6397.8720425592155, 6454.225492940877, 6466.256380516207, 6343.524235682342, 6490.286068532458, 6543.1493905792895, 6559.47524198063, 6559.967200163968, 6298.496120310364, 6341.968290158612, 6424.38968298011, 6424.614523128627, 6430.967845160838, 6523.575967562093, 6559.0, 6559.376859198369, 6567.9671601641685, 6570.375814297634, 5116.948830511647, 5182.4299327073995, 5245.527902488794, 5253.711045892513, 5261.0793111205385, 4454.554544545519, 4495.910081798345, 4552.499225085238, 4566.520515345907, 4586.2661974083985, 5583.720813959286, 5600.103983362643, 5677.0, 5702.144678298206, 5716.971415142898, 6486.578372405778, 6595.8021259362295, 6600.900986485207, 6614.86770264592, 6630.270670226271, 5579.832605021856, 5640.746166422521, 5642.04085305499, 5674.517665998436, 5718.170865224519, 5537.695426751487, 5643.5767317451355, 5653.293338332708, 5677.744501497443, 5713.8285851424525, 6206.038064100072, 6225.501959843202, 6238.656873871981, 6242.968785156045, 6254.499640028786, 6420.967895160495, 6469.805905822833, 6474.093626892333, 6475.0, 6482.0, 6131.294901086432, 6144.508439324753, 6191.690415479298, 6199.690015499117, 6200.7519699213335, 6371.872562548816, 6378.521610879296, 6421.261554921057, 6422.678866056585, 6437.227532696106, 6542.54202205841, 6557.475401967927, 6606.075149478981, 6620.271770105381, 6642.701078451578, 6353.301136875032, 6358.96820515913, 6422.614643121427, 6438.323975982455, 6444.516661250331, 6059.6364218147055, 6204.534659900616, 6252.187215662117, 6261.279952805304, 6408.839779005376, 6173.012318029273, 6202.782902598387, 6226.0, 6229.844253893508, 6275.278342990615, 6357.205349331333, 6360.840978975562, 6366.936330636634, 6416.647084410402, 6453.386928241809, 6168.0439531872635, 6172.629642221481, 6246.0, 6252.030935205051, 6260.060990851409], "value": 5933.971571620253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.4644115222227, 815.7471183932978, 841.5035129273728, 861.6294993152942, 867.0289276010867, 39106.413403798964, 39947.40078898812, 39975.200495990066, 39987.800060999725, 40058.79970600143, 35953.0, 36288.0, 36464.81767591165, 36507.26985460289, 36552.26895462096, 6905.654717264142, 6952.5480843745, 7015.228324884284, 7019.789406317818, 7020.613866237355, 6869.622170780605, 6947.687354069079, 6962.373386395224, 6999.055127557791, 7023.82440438988, 6986.161660600709, 7468.365188958945, 7724.6523906424345, 7748.7675369739, 7759.728409505668, 7596.772096837104, 7647.579383133925, 7658.8468230635635, 7660.1573826879, 7662.387009039264, 7508.8122796929965, 7582.8483430331635, 7598.962005189994, 7599.050118735158, 7604.885926711104, 37133.44299835504, 37387.439188412194, 37393.25213495715, 37397.25205495902, 37513.06217344561, 3419.675130862564, 3419.726421886268, 3448.793072415663, 3449.0515108345153, 3449.862005519776, 30784.230394240098, 30842.228944276347, 30867.382652346827, 30898.845505772326, 30914.53628195579, 4982.651214414992, 5017.874553136201, 5036.798528058874, 5065.214891691757, 5173.017126745906, 177495.11252443783, 180840.0, 185764.0, 185982.0, 196385.0, 46355.5364446358, 46591.0, 46669.0, 46961.76519117383, 47034.529654703016, 48622.75688621534, 48676.5132348679, 48700.26949595759, 48719.5128048722, 48733.756331218116, 15103.244837758068, 15219.467318644016, 15243.847561524464, 15245.0, 15385.538433847003, 12442.253464792142, 12493.687657808447, 12598.874011259953, 12609.684757881127, 12655.683607909876, 13370.197788132744, 13432.597022089352, 13467.932660336635, 13543.525976590772, 13629.25039122838, 5354.866128346823, 5438.537724293479, 5473.781048758085, 5483.259759932438, 5519.972400138054, 978.3151793744407, 980.9166220871306, 1000.8198524265703, 1011.3729487717662, 1017.6031347774374, 21601.459963501038, 22362.329130126123, 22830.200942966916, 28138.43723125526, 29634.851825741163, 1057.9788404231872, 1065.8667666541683, 1072.254782925859, 1089.0470838016736, 1090.936337071349, 15574.377024919104, 15677.608059798367, 15696.372145114296, 16176.595585110232, 16333.509994700178, 207877.0, 209968.0, 210330.0, 210908.0, 210938.0, 54824.72587637116, 55188.72405637946, 55207.17189242165, 55223.44776552264, 55356.44643553513, 1359.1233654292926, 1407.9014468987277, 1412.512683124341, 1413.039133389305, 1418.4184484361363, 27629.723702762716, 27662.0, 27820.44359112766, 28015.0, 28306.575401368584, 37286.25427491489, 37348.81325593355, 37491.2501749958, 37526.62473375232, 37567.0, 190262.0, 190421.09578904588, 191664.0, 192345.0, 193276.0, 33844.492332615526, 35253.29493410169, 36954.44568331423, 36966.445503316936, 37044.07389815276, 43222.78388608037, 44680.0, 45140.54859451495, 45416.77291613521, 45502.0, 32885.17787055343, 32927.50608740823, 33231.667683322856, 33467.16332091717, 33529.66470335363, 32466.026019219462, 32575.18562035968, 32830.507542386404, 32978.0, 33083.00750977475, 35290.82354588211, 36617.81691091527, 36697.0, 36738.448923265634, 36870.446943295334, 31730.206744831565, 31757.682423175473, 31905.521417178297, 32416.513752294206, 32531.674683253812, 23503.647445288676, 23920.0, 24198.274051778473, 24278.27165185047, 24901.0], "value": 17028.099966347392, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1897510659329, 555.9583031272655, 555.9861003474913, 560.2240896358542, 573.2433188191587, 21596.784032159674, 22196.0, 22283.888580557075, 22409.55180896385, 22423.775762242374, 24231.878840605816, 26685.466290674223, 26688.19935401936, 26774.464510709822, 26853.46293074142, 7003.964980175092, 7175.031370764932, 7184.425245980336, 7205.819854503627, 7220.025296584972, 3954.1498577805764, 4276.764777937212, 7107.680154393039, 7165.713371465161, 7182.102237220348, 6752.966235168818, 7096.574205547658, 7102.680379382914, 7112.110986126734, 7114.395276401512, 7112.146542414892, 7134.965430012671, 7143.571385716822, 7146.4282857371545, 7153.177384600759, 6928.896066559006, 6944.479164062665, 6980.336867997583, 6994.860102797967, 6997.195322537922, 29701.405971880442, 30556.847215764003, 30925.536116958265, 31013.37973240545, 31190.22024449384, 2037.6434124028235, 2061.742282214723, 2068.5759419319, 2068.9482762931048, 2076.771555128935, 19962.900185499126, 20300.79699203004, 20375.898120509304, 20445.079971401323, 20451.0, 2433.148398060682, 2438.67077944477, 2494.837835540702, 2533.1128309409423, 2537.9873100634563, 130648.3467582656, 133146.33426832804, 134922.0, 134976.0, 135115.0, 19484.861185956976, 21192.576148476943, 21230.681539776917, 21520.89239553792, 21811.0, 41307.58692413098, 41425.55010574615, 41468.79265603652, 41614.25471707561, 41628.0, 11144.777104457866, 11170.664880053611, 11295.491702873225, 11325.886741132483, 11396.031337336253, 9368.156865882103, 9435.528223588793, 9438.622455101857, 9444.0, 9482.715518534455, 8382.413231073888, 9093.135417447558, 10995.505202265917, 11505.71235719097, 11579.652610421532, 2494.912678056259, 2508.686414198225, 2520.6345079963303, 2584.9224523264334, 2615.751503607154, 918.3296193778579, 940.1256831147099, 948.4735971535864, 964.5659453245927, 975.2782940623887, 19173.61652766937, 19387.612247754965, 19470.610587788164, 19786.90106549458, 20194.39416817498, 1002.5137808163036, 1028.711960651019, 1045.4145678419957, 1046.4767616191905, 1062.4634559547378, 10679.359238445719, 10773.353598784099, 10787.946060269649, 10841.403722795321, 10879.673609791718, 484511.0, 488423.0, 495943.0, 509992.0, 517564.0, 123316.38341808414, 124625.0, 125523.0, 126504.0, 127436.36281818531, 1156.3928937307812, 1168.7545615420686, 1193.039603119497, 1194.1044216837372, 1207.2213422342716, 16596.0, 17139.91430042842, 17219.82780172182, 17264.309427622753, 17369.13154342303, 52883.471165287854, 53213.0, 53788.73105634447, 54384.728076359366, 55487.16769248384, 68515.0, 68754.0, 68824.62350753057, 69111.65444172747, 69189.30810691828, 12063.81904271419, 14401.847852171592, 14454.638634034232, 14475.0, 14631.0, 18380.0, 21043.684344734535, 22498.325050248517, 22788.088476460754, 23178.884105579364, 18133.546661333574, 18148.546286342946, 18316.084195789892, 18327.35854245095, 18379.90810045941, 16062.196890155212, 16497.257623407215, 16626.085565294026, 16866.915665421595, 17096.0597167157, 16422.75365869489, 18145.274189032818, 18183.363582274556, 18209.908950455163, 18211.089445527934, 13936.442542298195, 14162.0, 14248.643783905485, 14336.713265734836, 14387.712245754818, 17804.198811053793, 18252.634947301245, 18737.812621874153, 18959.90520047391, 19169.32907348236], "value": 12376.306780827614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.8889144422724, 1353.6412850594595, 1361.7821148616224, 1362.3256488038423, 1370.3079944627964, 14077.577672669824, 14557.563273101798, 14744.33650485728, 14800.555983320504, 14840.703185936289, 14776.113433193988, 15209.77185342218, 15241.237938103079, 15250.0, 15345.15601641912, 2639.3269716222385, 2707.10665480391, 2710.0921191400807, 2711.7830573554165, 2715.0768738628863, 2471.8505894758932, 2569.5888657814753, 2636.433166869123, 2648.801339899506, 2658.4417272372825, 2628.9615601837263, 2666.0668765931964, 2681.302861256078, 2692.5557283048274, 2696.4741875334316, 2618.8297760645687, 2638.2349118755537, 2641.5641419165718, 2642.207337798672, 2646.722094180122, 2530.734272901337, 2544.5674235379843, 2580.658057809947, 2603.8177327587077, 2630.8026897982727, 14272.714545709028, 14606.780898286534, 14651.560453186421, 14665.413383464755, 14701.1914344711, 7799.3760499159935, 8054.838903221961, 8073.838523229502, 8078.717244896459, 8100.149484304181, 4858.659893807435, 4927.334809800667, 5038.5465308122075, 5096.0, 5142.30578871855, 1721.4405318271613, 1723.276223985929, 1747.8077411484726, 1759.480953118833, 2277.646964720471, 24275.87862060696, 24474.0, 24483.143089991943, 24557.754422455724, 24616.5076698465, 6346.4605508532295, 6393.392627700361, 6478.222613286436, 6535.248446428626, 6624.86750264992, 15781.210939452982, 16144.515664530083, 16710.4151354702, 16753.581160471087, 16759.0, 7615.5430674159725, 7822.726204582812, 7850.882236766453, 7854.528728276322, 7857.882131768028, 7114.71541138359, 7129.251428599922, 7243.637818109179, 7347.412207023425, 7366.558006519626, 4967.850964471072, 5114.744262786846, 5114.769835357418, 5117.488251174927, 5135.922961155586, 1490.9627259318604, 1507.9698406031819, 1510.0637604685166, 1529.4799768078906, 1545.6135966008499, 845.7082306604211, 859.952702601363, 884.6284560484612, 887.6671248281895, 889.666375109334, 7057.117860267466, 7090.858182836314, 7108.3957863581145, 7119.860822268412, 7160.785176444715, 683.6479213205204, 705.7917914215319, 711.4770643576967, 717.9748708795167, 724.2540183610889, 4595.632349412106, 4662.813487460464, 4808.182608956486, 4890.144224760653, 4931.605471562267, 20046.298379556647, 20059.39821805348, 20883.269085582237, 20959.0, 20984.0, 20142.69785953212, 20316.0, 20341.593168136555, 20622.793772062087, 20861.165553378, 11010.174236932262, 11016.614418495314, 11033.227674062899, 11094.500747466383, 11149.944250278697, 7735.806604834924, 8129.4715843469985, 8172.101068882537, 8403.70587029451, 8461.280791132822, 17713.734293985344, 17737.822621774132, 18113.0, 18116.18477168557, 18512.0743962804, 18086.81913180904, 18269.634607307515, 18545.072746362897, 18711.1579978904, 18791.060446977324, 11807.0, 11992.820107698566, 12015.339156346485, 12018.278903265833, 12020.699482513008, 13192.538261160813, 13434.0, 13471.730565388832, 13533.593992180251, 13535.932320338336, 10894.509747061244, 11195.776084478428, 11209.047230985132, 11247.606333778278, 11359.659210223706, 10799.730006749895, 10968.780624387628, 11061.668149955514, 11133.832992504957, 11144.387058711525, 8960.551972401223, 8995.23540499065, 9051.32115091384, 9057.818843623223, 9115.680951166678, 6581.703823327866, 6636.83407914806, 6666.966665166643, 6778.4916131289365, 6810.5913645181445, 6859.9314006859295, 6917.273686263071, 6984.4761642878, 6988.965055174692, 6993.510454268152], "value": 6398.60741909267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.7789596955207, 500.8973160502097, 513.427528305939, 521.4316395129309, 524.6222719641856, 6121.6939153042285, 6138.324784273726, 6250.562460627758, 6290.301618562997, 6299.1496148020005, 5912.852178695534, 5991.700414979256, 6009.399060093989, 6010.75956961721, 6174.8147555573405, 4883.658143929926, 4915.950840491603, 4933.7533123343865, 4958.107540642692, 4985.875353116165, 4815.686980346284, 4920.335754673127, 4930.137225985438, 4954.7522623868845, 4982.601391888658, 4900.926486102711, 4907.82822601209, 4918.434380046287, 4920.114379411704, 4920.532549407801, 4872.829450969199, 4880.731559764212, 4926.630502712311, 4929.580985616227, 4947.925781113287, 4353.477582690066, 4379.474463064453, 4411.250087485135, 4413.918589945484, 4418.536053714346, 6080.908786368208, 6081.787137450212, 6108.480779133734, 6119.724612392453, 6146.940774840434, 5606.990741666498, 5652.152177173416, 5676.517496012844, 5687.800926967578, 5688.288963879515, 6487.545871788977, 6509.576877502947, 6513.837154071139, 6528.249251336109, 6549.6070235786, 4765.428148622153, 4767.737774422405, 4770.117528257283, 4776.590905682832, 4784.736839473828, 6678.332166783282, 6735.191776986744, 6757.763478278237, 6836.38472537474, 6907.171139463297, 4891.902161956741, 4900.338454308694, 4951.405831300195, 4952.851414457572, 4964.329815474937, 4893.510648935149, 4924.803007879645, 4958.975205123951, 4969.27945447908, 5029.270755740397, 5470.288862447856, 5501.532369748536, 5522.0, 5571.804986825442, 5622.550195984311, 6529.575577587441, 6560.540762146699, 6612.140421745238, 6619.371159739817, 6643.40209381158, 1645.276078525445, 1676.1116608197674, 1709.6495218480181, 1720.5354554270277, 1744.1366523570914, 1158.530795028015, 1192.5587532612988, 1204.6205445284706, 1204.8192771084407, 1229.59423390281, 5571.637843540157, 5619.943800561942, 5621.971890140605, 5625.38120806711, 5681.375048744635, 6509.576877502947, 6583.374579414948, 6594.934050659528, 6651.071189355032, 6673.799786006428, 5704.087346024616, 5721.456461636138, 5727.713614319267, 5729.656220626775, 5736.196932429463, 3501.3172431375638, 3509.894703158909, 3520.559930008749, 3521.5245941798044, 3556.1643013891717, 6232.532560058014, 6249.156363890907, 6266.154069200691, 6369.8534263832025, 6461.935380646228, 6811.727530898708, 6831.555948863308, 6841.62371069586, 6843.897341539781, 6909.447244220551, 6283.37166283368, 6307.936920630918, 6333.68331583419, 6366.299707032223, 6378.681065946684, 6611.768588099393, 6618.470522358103, 6669.933300667125, 6671.199456065303, 6676.365745254193, 6577.736890524326, 6602.60384376939, 6612.685560053943, 6626.53614246998, 6658.167729033871, 6320.778772743116, 6328.050792381179, 6336.398042185985, 6348.428641422294, 6349.587276826992, 4801.7118972861745, 4842.903141937212, 4873.561379475864, 4882.536159064884, 4906.141425250638, 6425.614463132227, 6647.9002814958785, 6746.190457145174, 6759.2564817869015, 6786.626735529593, 6214.378562143749, 6349.238091429058, 6378.808635740936, 6420.646864422315, 6440.774572889926, 6362.377593713573, 6402.775902843378, 6406.647634379968, 6431.871362572816, 6493.8701225976165, 6247.5001999840815, 6257.812265632038, 6290.402411770874, 6316.526260530387, 6451.3226111257645, 6298.212723409574, 6314.589551679126, 6353.269374022047, 6385.840353991188, 6415.037744338387, 6241.063840423791, 6246.281677606951, 6306.306306306211, 6324.747010119544, 6332.461740751904], "value": 4978.99057368332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.8431199107581, 871.9128087191282, 875.3303722652176, 882.668999125328, 887.6759982606346, 18765.530861728446, 19470.318538851145, 19552.804471955274, 19650.0, 21045.684314735252, 20749.792502074975, 21425.57148857022, 21434.356969290908, 21460.248891288807, 21602.675959860575, 910.249044538257, 935.8175155844613, 941.5010044676333, 946.3990366117496, 947.5120313038791, 950.9381890177151, 952.4856577448204, 952.9523523823816, 953.9093786090345, 955.412421360865, 932.8507438809792, 970.398353021128, 975.3318976501084, 978.0024375137356, 984.3847595252967, 973.8052389522123, 975.2539307429822, 976.0288512929609, 976.3702411944256, 977.0620204603554, 715.7781087862779, 718.0736849464184, 720.0890873045602, 720.7333286683908, 721.3003386714878, 17504.21231044606, 18239.817601823943, 18335.266589336545, 18348.0, 18391.0, 20459.28392506255, 20689.0, 21514.354569362946, 21531.892340538354, 21774.782252177432, 15771.29029193689, 16199.838001619952, 16436.424725134682, 16446.095464749433, 16473.505794826175, 3687.3547129252274, 3688.4467329900463, 3726.087108658369, 3733.4586484959527, 3740.0462881964927, 129008.35495822555, 131547.34226328903, 132216.0, 133582.3320883399, 134697.3265133668, 16089.758653620205, 16389.262483188286, 16475.5881102971, 16631.0, 16637.25132369022, 28760.856195719305, 29735.256618584277, 29822.701772981993, 30051.398972020437, 30318.696813032027, 7361.2638736125955, 7584.469087163846, 7693.576853273124, 7710.190430004769, 7733.072031356273, 3667.559892812826, 3822.4075268333454, 3845.2117315950163, 3865.7873816940337, 3877.0888841122314, 4790.305405716222, 4855.547948286093, 4915.5330243626795, 4939.3084968104495, 4955.132851750929, 985.9950700246453, 994.7612572982432, 999.2355847776457, 999.4203362049993, 1008.1380419741016, 659.3900641906217, 672.7241830849329, 677.678102901118, 684.1926526698544, 690.2303931116769, 11630.592929247436, 11745.647630571097, 12130.150889437655, 12366.258024518558, 12413.813792793115, 661.4741280681869, 670.4602794750273, 673.66950273211, 680.8025672554903, 684.910961574992, 5138.177891537336, 5197.402298735618, 5257.6056795739705, 5422.05114105038, 5431.049566325877, 111184.0, 111800.0, 113370.0, 113534.0, 117637.0, 93736.53131734297, 94998.0, 97603.0, 99483.50258248663, 101811.0, 87469.56265218633, 88291.55854220688, 89525.55237223773, 90626.54686726393, 92738.53630731803, 10452.477376131315, 10503.42231177262, 10558.208134389797, 10679.57281708723, 10899.346039237354, 40291.19417611573, 40579.391309129795, 40952.18095638011, 41017.384739228335, 42730.359044614976, 68141.65929170322, 71384.64307678428, 71603.0, 72235.63882180555, 74494.0, 18206.45380638583, 18290.0, 18741.0, 18855.340063097727, 18939.147738352083, 19414.417567473, 19773.60452790965, 19908.800911990696, 20042.298519551747, 20077.799222008176, 16358.345666173696, 16597.0, 16614.66770664604, 16782.66434671324, 18904.338348157748, 16380.83619163793, 16530.173491325626, 16609.584760381087, 18321.3587524436, 18992.24031038743, 17580.73628895542, 17762.46712598624, 17848.28606855763, 18367.632647346712, 18479.260829566665, 11925.582604608797, 12328.07539434528, 12335.876641233473, 12443.440045197807, 12503.4373453193, 12118.575849845212, 12474.18917770342, 12731.681707957376, 13522.79715804244, 13675.316234188449], "value": 8874.313778897093, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 101.0, 108.0, 114.0, 117.0, 109.0, 104.0, 113.0, 115.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 144.0, 187.0, 120.0, 152.0, 145.0, 124.0, 185.0, 127.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 166.0, 170.0, 165.0, 164.0, 166.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 75.0, 161.0, 75.0, 75.0, 79.0, 76.0, 159.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 136.0, 80.0, 81.0, 80.0, 135.0, 80.0, 82.0, 140.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 114.0, 114.0, 121.0, 117.0, 113.0, 120.0, 114.0, 120.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 148.0, 155.0, 149.0, 151.0, 149.0, 148.0, 149.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 97.0, 108.0, 95.0, 96.0, 95.0, 99.0, 100.0, 98.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 53.0, 54.0, 56.0, 54.0, 54.0, 53.0, 55.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 56.0, 57.0, 59.0, 56.0, 61.0, 57.0, 56.0, 65.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 80.0, 91.0, 81.0, 77.0, 75.0, 77.0, 76.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 120.0, 123.0, 125.0, 123.0, 122.0, 126.0, 132.0, 170.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 177.0, 176.0, 176.0, 179.0, 184.0, 173.0, 178.0, 176.0, 173.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 65.0, 64.0, 63.0], "value": 65.5, "unit": "score"}]}]} 08:37:19 INFO - Return code: 0 08:37:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:19 INFO - # TBPL SUCCESS # 08:37:19 INFO - Running post-action listener: _package_coverage_data 08:37:19 INFO - Running post-action listener: _resource_record_post_action 08:37:19 INFO - [mozharness: 2017-08-23 15:37:19.271027Z] Finished run-tests step (success) 08:37:19 INFO - Running post-run listener: _resource_record_post_run 08:37:19 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 10199040; Write bytes: 432386048; Read time: 5092; Write time: 315060 08:37:19 INFO - TinderboxPrint: CPU usage
13.3% 08:37:19 INFO - TinderboxPrint: I/O read bytes / time
10,199,040 / 5,092 08:37:19 INFO - TinderboxPrint: I/O write bytes / time
432,386,048 / 315,060 08:37:19 INFO - TinderboxPrint: CPU idle
8,285.7 (86.7%) 08:37:19 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 08:37:19 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 126259200; Read time: 0; Write time: 114840 08:37:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:37:19 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 10199040; Write bytes: 178855936; Read time: 5092; Write time: 90280 08:37:19 INFO - Running post-run listener: _upload_blobber_files 08:37:19 INFO - Blob upload gear active. 08:37:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:20 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 08:37:20 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 08:37:20 INFO - (blobuploader) - INFO - Done attempting. 08:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:21 INFO - (blobuploader) - INFO - Done attempting. 08:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:23 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 08:37:23 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 08:37:23 INFO - (blobuploader) - INFO - Done attempting. 08:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:24 INFO - (blobuploader) - INFO - Done attempting. 08:37:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:24 INFO - Return code: 0 08:37:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": null, "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be1a4dfba6a042695652f4513ed302fcb1a60b23fa954ef49feb5f5615a42ac7e41b55ac3c70c3ada56d6278624bdb4f932b8e148e497ccea7bcc854a00113b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bc53982630565dbbb373d90a8e630816a4c521fa241a2b636d1d54bbc9ae102ed55956df71c849a61c98158a3a46519e692fc6cf7a19f6c1ee5f0f938c26c", "resource-usage.json": null} 08:37:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:24 INFO - Contents: 08:37:24 INFO - blobber_files:{"perfherder-data.json": null, "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be1a4dfba6a042695652f4513ed302fcb1a60b23fa954ef49feb5f5615a42ac7e41b55ac3c70c3ada56d6278624bdb4f932b8e148e497ccea7bcc854a00113b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bc53982630565dbbb373d90a8e630816a4c521fa241a2b636d1d54bbc9ae102ed55956df71c849a61c98158a3a46519e692fc6cf7a19f6c1ee5f0f938c26c", "resource-usage.json": null} 08:37:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:24 INFO - Copying logs to upload dir... 08:37:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.735091 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-23 08:37:24.133499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:24.140206) ========= 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=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": null, "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be1a4dfba6a042695652f4513ed302fcb1a60b23fa954ef49feb5f5615a42ac7e41b55ac3c70c3ada56d6278624bdb4f932b8e148e497ccea7bcc854a00113b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bc53982630565dbbb373d90a8e630816a4c521fa241a2b636d1d54bbc9ae102ed55956df71c849a61c98158a3a46519e692fc6cf7a19f6c1ee5f0f938c26c", "resource-usage.json": null} build_url:https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": null, "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be1a4dfba6a042695652f4513ed302fcb1a60b23fa954ef49feb5f5615a42ac7e41b55ac3c70c3ada56d6278624bdb4f932b8e148e497ccea7bcc854a00113b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bc53982630565dbbb373d90a8e630816a4c521fa241a2b636d1d54bbc9ae102ed55956df71c849a61c98158a3a46519e692fc6cf7a19f6c1ee5f0f938c26c", "resource-usage.json": null}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:24.168061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:24.168375) ========= 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=a0d2d2de893abaa8702a9954000001a7-1503491902.28305-1004211434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:24.252684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:37:24.256009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:37:24.256276) ========= ========= Total master_lag: 0.15 =========