builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1504281185.36 results: success (0) revision: cc85091ab81c7eb865d2cfb31539702c1bb7a18d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.362949) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.363381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.363664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.379408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.379676) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 08:53:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2017-09-01 08:53:05 (16.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.211448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.606188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.606516) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:05.656662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 08:53:05.656999) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc85091ab81c7eb865d2cfb31539702c1bb7a18d --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 cc85091ab81c7eb865d2cfb31539702c1bb7a18d --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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 08:53:05,704 truncating revision to first 12 chars 2017-09-01 08:53:05,704 Setting DEBUG logging. 2017-09-01 08:53:05,704 attempt 1/10 2017-09-01 08:53:05,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc85091ab81c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 08:53:06,674 unpacking tar archive at: mozilla-central-cc85091ab81c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 08:53:06.948817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:06.949154) ========= script_repo_revision: cc85091ab81c7eb865d2cfb31539702c1bb7a18d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:06.949565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:06.949828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 08:53:06.960590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-01 08:53:06.960886) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:07 INFO - MultiFileLogger online at 20170901 08:53:07 in /builds/slave/test 08:53:07 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:53:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:07 INFO - {'append_to_log': False, 08:53:07 INFO - 'base_work_dir': '/builds/slave/test', 08:53:07 INFO - 'blob_upload_branch': 'Firefox', 08:53:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:07 INFO - 'branch': 'Firefox', 08:53:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:07 INFO - 'code_coverage': False, 08:53:07 INFO - 'config_files': ('talos/linux_config.py',), 08:53:07 INFO - 'default_actions': ('clobber', 08:53:07 INFO - 'read-buildbot-config', 08:53:07 INFO - 'download-and-extract', 08:53:07 INFO - 'populate-webroot', 08:53:07 INFO - 'create-virtualenv', 08:53:07 INFO - 'install', 08:53:07 INFO - 'setup-mitmproxy', 08:53:07 INFO - 'run-tests'), 08:53:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:07 INFO - 'disable_ccov_upload': False, 08:53:07 INFO - 'disable_stylo': False, 08:53:07 INFO - 'download_minidump_stackwalk': True, 08:53:07 INFO - 'download_symbols': 'ondemand', 08:53:07 INFO - 'enable_stylo': False, 08:53:07 INFO - 'enable_webrender': False, 08:53:07 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:53:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:07 INFO - 'gecko_profile': False, 08:53:07 INFO - 'gecko_profile_interval': 0, 08:53:07 INFO - 'installer_path': 'installer.exe', 08:53:07 INFO - 'log_level': 'info', 08:53:07 INFO - 'log_name': 'talos', 08:53:07 INFO - 'log_to_console': True, 08:53:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:07 INFO - 'opt_config_files': (), 08:53:07 INFO - 'pip_index': False, 08:53:07 INFO - 'suite': 'dromaeojs-e10s', 08:53:07 INFO - 'system_bits': '32', 08:53:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:07 INFO - 'title': 'talos-linux64-ix-061', 08:53:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:07 INFO - 'use_talos_json': True, 08:53:07 INFO - 'verify': 'False', 08:53:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:07 INFO - 'work_dir': 'build'} 08:53:07 INFO - [mozharness: 2017-09-01 15:53:07.159337Z] Running clobber step. 08:53:07 INFO - Running pre-action listener: _resource_record_pre_action 08:53:07 INFO - Running main action method: clobber 08:53:07 INFO - rmtree: /builds/slave/test/build 08:53:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:08 INFO - Running post-action listener: _resource_record_post_action 08:53:08 INFO - [mozharness: 2017-09-01 15:53:08.173190Z] Finished clobber step (success) 08:53:08 INFO - [mozharness: 2017-09-01 15:53:08.173287Z] Running read-buildbot-config step. 08:53:08 INFO - Running pre-action listener: _resource_record_pre_action 08:53:08 INFO - Running main action method: read_buildbot_config 08:53:08 INFO - Using buildbot properties: 08:53:08 INFO - { 08:53:08 INFO - "project": "", 08:53:08 INFO - "product": "firefox", 08:53:08 INFO - "who": "archaeopteryx@coole-files.de", 08:53:08 INFO - "installer_path": "public/build/target.tar.bz2", 08:53:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:53:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:53:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:53:08 INFO - "stage_platform": "linux64-stylosequential", 08:53:08 INFO - "basedir": "/builds/slave/test", 08:53:08 INFO - "buildnumber": 224, 08:53:08 INFO - "platform": "ubuntu64_hw_styloseq", 08:53:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:53:08 INFO - "slavebuilddir": "test", 08:53:08 INFO - "taskId": "bMntSmOQSB6of2T87CAJpA", 08:53:08 INFO - "branch": "mozilla-central", 08:53:08 INFO - "script_repo_revision": "production", 08:53:08 INFO - "revision": "cc85091ab81c7eb865d2cfb31539702c1bb7a18d", 08:53:08 INFO - "slavename": "talos-linux64-ix-061", 08:53:08 INFO - "repo_path": "mozilla-central" 08:53:08 INFO - } 08:53:08 INFO - Finding installer, test and symbols from parent task. 08:53:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMntSmOQSB6of2T87CAJpA'}, attempt #1 08:53:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMntSmOQSB6of2T87CAJpA'}, attempt #1 08:53:09 INFO - Task dependencies: P0kX4SRdS6ifTGg50JASWg 08:53:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg'}, attempt #1 08:53:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 08:53:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.test_packages.json 08:53:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.crashreporter-symbols.zip 08:53:09 INFO - Running post-action listener: _resource_record_post_action 08:53:09 INFO - [mozharness: 2017-09-01 15:53:09.560425Z] Finished read-buildbot-config step (success) 08:53:09 INFO - [mozharness: 2017-09-01 15:53:09.560640Z] Running download-and-extract step. 08:53:09 INFO - Running pre-action listener: _resource_record_pre_action 08:53:09 INFO - Running main action method: download_and_extract 08:53:09 INFO - mkdir: /builds/slave/test/build/tests 08:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:09 INFO - trying https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.test_packages.json 08:53:09 INFO - Downloading https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:53:10 INFO - Downloaded 989 bytes. 08:53:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:53:10 INFO - Using the following test package requirements: 08:53:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:53:10 INFO - u'common': [u'target.common.tests.zip'], 08:53:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:53:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:53:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:53:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:53:10 INFO - u'mozbase': [u'target.common.tests.zip'], 08:53:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:53:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:53:10 INFO - u'web-platform': [u'target.common.tests.zip', 08:53:10 INFO - u'target.web-platform.tests.tar.gz'], 08:53:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:53:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:53:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip 08:53:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:53:10 INFO - Fetch https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip into memory 08:53:11 INFO - Content-Length response header: 54957468 08:53:11 INFO - Bytes received: 54957468 08:53:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip 08:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.common.tests.zip into memory 08:53:23 INFO - Content-Length response header: 54957468 08:53:23 INFO - Bytes received: 54957468 08:53:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.talos.tests.zip 08:53:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:53:35 INFO - Fetch https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.talos.tests.zip into memory 08:53:35 INFO - Content-Length response header: 14496650 08:53:35 INFO - Bytes received: 14496650 08:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:36 INFO - trying https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 08:53:36 INFO - Downloading https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:53:37 INFO - Downloaded 62657924 bytes. 08:53:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 08:53:37 INFO - mkdir: /builds/slave/test/properties 08:53:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:37 INFO - Contents: 08:53:37 INFO - build_url:https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 08:53:37 INFO - Running post-action listener: _resource_record_post_action 08:53:37 INFO - Running post-action listener: find_tests_for_verification 08:53:37 INFO - Running post-action listener: set_extra_try_arguments 08:53:37 INFO - [mozharness: 2017-09-01 15:53:37.241688Z] Finished download-and-extract step (success) 08:53:37 INFO - [mozharness: 2017-09-01 15:53:37.241784Z] Running populate-webroot step. 08:53:37 INFO - Running pre-action listener: _resource_record_pre_action 08:53:37 INFO - Running main action method: populate_webroot 08:53:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:37 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:37 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:37 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'tests': ['damp', 'tps']}, 08:53:37 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['damp', 'tps']}, 08:53:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:53:37 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:53:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:53:37 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:53:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:37 INFO - 'ts_paint', 08:53:37 INFO - 'tpaint', 08:53:37 INFO - 'sessionrestore', 08:53:37 INFO - 'sessionrestore_many_windows', 08:53:37 INFO - 'sessionrestore_no_auto_restore', 08:53:37 INFO - 'tabpaint']}, 08:53:37 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['a11yr', 08:53:37 INFO - 'ts_paint', 08:53:37 INFO - 'tpaint', 08:53:37 INFO - 'sessionrestore', 08:53:37 INFO - 'sessionrestore_many_windows', 08:53:37 INFO - 'sessionrestore_no_auto_restore', 08:53:37 INFO - 'tabpaint']}, 08:53:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:53:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:53:37 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['bloom_basic_singleton']}, 08:53:37 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['bloom_basic']}, 08:53:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:37 INFO - 'tsvgr_opacity', 08:53:37 INFO - 'tart', 08:53:37 INFO - 'tscrollx', 08:53:37 INFO - 'tsvg_static']}, 08:53:37 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['tsvgx', 08:53:37 INFO - 'tsvgr_opacity', 08:53:37 INFO - 'tart', 08:53:37 INFO - 'tscrollx', 08:53:37 INFO - 'tsvg_static']}, 08:53:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:37 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo'], 08:53:37 INFO - 'tests': ['tp5o']}, 08:53:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:53:37 INFO - 'talos_options': ['--mitmproxy', 08:53:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:53:37 INFO - '--firstNonBlankPaint'], 08:53:37 INFO - 'tests': ['tp6_google', 08:53:37 INFO - 'tp6_youtube', 08:53:37 INFO - 'tp6_amazon', 08:53:37 INFO - 'tp6_facebook']}, 08:53:37 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo', 08:53:37 INFO - '--mitmproxy', 08:53:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:53:37 INFO - '--firstNonBlankPaint'], 08:53:37 INFO - 'tests': ['tp6_google', 08:53:37 INFO - 'tp6_youtube', 08:53:37 INFO - 'tp6_amazon', 08:53:37 INFO - 'tp6_facebook']}, 08:53:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo', 08:53:37 INFO - '--stylo-threads=1', 08:53:37 INFO - '--mitmproxy', 08:53:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:53:37 INFO - '--firstNonBlankPaint'], 08:53:37 INFO - 'tests': ['tp6_google', 08:53:37 INFO - 'tp6_youtube', 08:53:37 INFO - 'tp6_amazon', 08:53:37 INFO - 'tp6_facebook']}, 08:53:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--xperf_path', 08:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:37 INFO - 'tests': ['tp5n']}, 08:53:37 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:53:37 INFO - 'talos_options': ['--enable-stylo', 08:53:37 INFO - '--xperf_path', 08:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:37 INFO - 'tests': ['tp5n']}}} 08:53:37 INFO - Running post-action listener: _resource_record_post_action 08:53:37 INFO - [mozharness: 2017-09-01 15:53:37.255999Z] Finished populate-webroot step (success) 08:53:37 INFO - [mozharness: 2017-09-01 15:53:37.256088Z] Running create-virtualenv step. 08:53:37 INFO - Running pre-action listener: _resource_record_pre_action 08:53:37 INFO - Running main action method: create_virtualenv 08:53:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:53:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:53:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:53:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:38 INFO - Installing pip...............done. 08:53:38 INFO - Return code: 0 08:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:38 INFO - Reading from file tmpfile_stdout 08:53:38 INFO - Output received: 08:53:38 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:53:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:38 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:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 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:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:38 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:53:38 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:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:39 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:53:39 INFO - Downloading/unpacking pip>=1.5 08:53:39 INFO - Running setup.py egg_info for package pip 08:53:39 INFO - warning: no files found matching 'pip/cacert.pem' 08:53:39 INFO - warning: no files found matching '*.html' under directory 'docs' 08:53:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:53:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:53:39 INFO - Installing collected packages: pip 08:53:39 INFO - Found existing installation: pip 1.1 08:53:39 INFO - Uninstalling pip: 08:53:39 INFO - Successfully uninstalled pip 08:53:39 INFO - Running setup.py install for pip 08:53:39 INFO - warning: no files found matching 'pip/cacert.pem' 08:53:39 INFO - warning: no files found matching '*.html' under directory 'docs' 08:53:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:53:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:53:39 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Successfully installed pip 08:53:39 INFO - Cleaning up... 08:53:39 INFO - Return code: 0 08:53:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:39 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:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:39 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:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:39 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:39 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:53:39 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:53:39 INFO - Using env: {'DISPLAY': ':0', 08:53:39 INFO - 'HOME': '/home/cltbld', 08:53:39 INFO - 'LANG': 'en_US.UTF-8', 08:53:39 INFO - 'LANGUAGE': 'en_US:en', 08:53:39 INFO - 'LOGNAME': 'cltbld', 08:53:39 INFO - 'MAIL': '/var/mail/cltbld', 08:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:39 INFO - 'MOZ_NO_REMOTE': '1', 08:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:39 INFO - 'NO_EM_RESTART': '1', 08:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:39 INFO - 'PWD': '/builds/slave/test', 08:53:39 INFO - 'SHELL': '/bin/bash', 08:53:39 INFO - 'SHLVL': '1', 08:53:39 INFO - 'TERM': 'linux', 08:53:39 INFO - 'TMOUT': '86400', 08:53:39 INFO - 'USER': 'cltbld', 08:53:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:39 INFO - '_': '/tools/buildbot/bin/python'} 08:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:39 INFO - Downloading/unpacking psutil>=3.1.1 08:53:39 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:53:39 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:53:39 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:53:39 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:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:40 INFO - Installing collected packages: psutil 08:53:40 INFO - Running setup.py install for psutil 08:53:40 INFO - building 'psutil._psutil_linux' extension 08:53:40 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:53:41 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:53:41 INFO - building 'psutil._psutil_posix' extension 08:53:41 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:53:41 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:53:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:41 INFO - Successfully installed psutil 08:53:41 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:53:41 INFO - Using env: {'DISPLAY': ':0', 08:53:41 INFO - 'HOME': '/home/cltbld', 08:53:41 INFO - 'LANG': 'en_US.UTF-8', 08:53:41 INFO - 'LANGUAGE': 'en_US:en', 08:53:41 INFO - 'LOGNAME': 'cltbld', 08:53:41 INFO - 'MAIL': '/var/mail/cltbld', 08:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:41 INFO - 'MOZ_NO_REMOTE': '1', 08:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:41 INFO - 'NO_EM_RESTART': '1', 08:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:41 INFO - 'PWD': '/builds/slave/test', 08:53:41 INFO - 'SHELL': '/bin/bash', 08:53:41 INFO - 'SHLVL': '1', 08:53:41 INFO - 'TERM': 'linux', 08:53:41 INFO - 'TMOUT': '86400', 08:53:41 INFO - 'USER': 'cltbld', 08:53:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:41 INFO - '_': '/tools/buildbot/bin/python'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:42 INFO - Installing collected packages: mozsystemmonitor 08:53:42 INFO - Running setup.py install for mozsystemmonitor 08:53:42 INFO - Successfully installed mozsystemmonitor 08:53:42 INFO - Cleaning up... 08:53:42 INFO - Return code: 0 08:53:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:42 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:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:42 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:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:42 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:42 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:53:42 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:53:42 INFO - Using env: {'DISPLAY': ':0', 08:53:42 INFO - 'HOME': '/home/cltbld', 08:53:42 INFO - 'LANG': 'en_US.UTF-8', 08:53:42 INFO - 'LANGUAGE': 'en_US:en', 08:53:42 INFO - 'LOGNAME': 'cltbld', 08:53:42 INFO - 'MAIL': '/var/mail/cltbld', 08:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:42 INFO - 'MOZ_NO_REMOTE': '1', 08:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:42 INFO - 'NO_EM_RESTART': '1', 08:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:42 INFO - 'PWD': '/builds/slave/test', 08:53:42 INFO - 'SHELL': '/bin/bash', 08:53:42 INFO - 'SHLVL': '1', 08:53:42 INFO - 'TERM': 'linux', 08:53:42 INFO - 'TMOUT': '86400', 08:53:42 INFO - 'USER': 'cltbld', 08:53:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:42 INFO - '_': '/tools/buildbot/bin/python'} 08:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:43 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:53:43 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:53:43 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:53:43 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:53:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:44 INFO - warning: no files found matching '*.txt' 08:53:44 INFO - no previously-included directories found matching 'build' 08:53:44 INFO - no previously-included directories found matching 'dist' 08:53:44 INFO - no previously-included directories found matching '.git*' 08:53:44 INFO - Installing collected packages: jsonschema, functools32 08:53:44 INFO - Running setup.py install for functools32 08:53:44 INFO - warning: no files found matching '*.txt' 08:53:44 INFO - no previously-included directories found matching 'build' 08:53:44 INFO - no previously-included directories found matching 'dist' 08:53:44 INFO - no previously-included directories found matching '.git*' 08:53:44 INFO - Successfully installed jsonschema functools32 08:53:44 INFO - Cleaning up... 08:53:44 INFO - Return code: 0 08:53:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:53:44 INFO - Using env: {'DISPLAY': ':0', 08:53:44 INFO - 'HOME': '/home/cltbld', 08:53:44 INFO - 'LANG': 'en_US.UTF-8', 08:53:44 INFO - 'LANGUAGE': 'en_US:en', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MAIL': '/var/mail/cltbld', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SHLVL': '1', 08:53:44 INFO - 'TERM': 'linux', 08:53:44 INFO - 'TMOUT': '86400', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - '_': '/tools/buildbot/bin/python'} 08:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:44 INFO - Cleaning up... 08:53:44 INFO - Return code: 0 08:53:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:44 INFO - Using env: {'DISPLAY': ':0', 08:53:44 INFO - 'HOME': '/home/cltbld', 08:53:44 INFO - 'LANG': 'en_US.UTF-8', 08:53:44 INFO - 'LANGUAGE': 'en_US:en', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MAIL': '/var/mail/cltbld', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SHLVL': '1', 08:53:44 INFO - 'TERM': 'linux', 08:53:44 INFO - 'TMOUT': '86400', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - '_': '/tools/buildbot/bin/python'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:46 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:53:46 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:53:46 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:53:46 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:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:46 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:53:46 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:53:46 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:53:46 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:53:46 INFO - Downloading docopt-0.6.1.tar.gz 08:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:46 INFO - Running setup.py install for blobuploader 08:53:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:46 INFO - Running setup.py install for requests 08:53:47 INFO - Running setup.py install for docopt 08:53:47 INFO - Successfully installed blobuploader requests docopt 08:53:47 INFO - Cleaning up... 08:53:47 INFO - Return code: 0 08:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:47 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:47 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:53:47 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:53:47 INFO - Using env: {'DISPLAY': ':0', 08:53:47 INFO - 'HOME': '/home/cltbld', 08:53:47 INFO - 'LANG': 'en_US.UTF-8', 08:53:47 INFO - 'LANGUAGE': 'en_US:en', 08:53:47 INFO - 'LOGNAME': 'cltbld', 08:53:47 INFO - 'MAIL': '/var/mail/cltbld', 08:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:47 INFO - 'MOZ_NO_REMOTE': '1', 08:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:47 INFO - 'NO_EM_RESTART': '1', 08:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:47 INFO - 'PWD': '/builds/slave/test', 08:53:47 INFO - 'SHELL': '/bin/bash', 08:53:47 INFO - 'SHLVL': '1', 08:53:47 INFO - 'TERM': 'linux', 08:53:47 INFO - 'TMOUT': '86400', 08:53:47 INFO - 'USER': 'cltbld', 08:53:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:47 INFO - '_': '/tools/buildbot/bin/python'} 08:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:47 INFO - Running setup.py (path:/tmp/pip-NigWPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:47 INFO - Running setup.py (path:/tmp/pip-lHUDzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:47 INFO - Running setup.py (path:/tmp/pip-yhEZ9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:47 INFO - Running setup.py (path:/tmp/pip-vC03AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:47 INFO - Running setup.py (path:/tmp/pip-m9v6NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:47 INFO - Running setup.py (path:/tmp/pip-RtUASZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:48 INFO - Running setup.py (path:/tmp/pip-2XCtxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:48 INFO - Running setup.py (path:/tmp/pip-RO52XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:48 INFO - Running setup.py (path:/tmp/pip-ys9QO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:48 INFO - Running setup.py (path:/tmp/pip-SzF0NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:48 INFO - Running setup.py (path:/tmp/pip-H2AiV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:48 INFO - Running setup.py (path:/tmp/pip-jMZYVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:48 INFO - Running setup.py (path:/tmp/pip-pNO1F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:48 INFO - Running setup.py (path:/tmp/pip-owtPFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:48 INFO - Running setup.py (path:/tmp/pip-JRQ331-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:48 INFO - Running setup.py (path:/tmp/pip-WPCM8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:48 INFO - Running setup.py (path:/tmp/pip-mmJzcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:48 INFO - Running setup.py install for manifestparser 08:53:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Running setup.py install for mozcrash 08:53:48 INFO - Running setup.py install for mozdebug 08:53:49 INFO - Running setup.py install for mozdevice 08:53:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozfile 08:53:49 INFO - Running setup.py install for mozhttpd 08:53:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozinfo 08:53:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozInstall 08:53:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozleak 08:53:49 INFO - Running setup.py install for mozlog 08:53:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for moznetwork 08:53:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozprocess 08:53:49 INFO - Running setup.py install for mozprofile 08:53:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:50 INFO - Running setup.py install for mozrunner 08:53:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:50 INFO - Running setup.py install for mozscreenshot 08:53:50 INFO - Running setup.py install for moztest 08:53:50 INFO - Running setup.py install for mozversion 08:53:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:50 INFO - Cleaning up... 08:53:50 INFO - Return code: 0 08:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:50 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:50 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:53:50 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:53:50 INFO - Using env: {'DISPLAY': ':0', 08:53:50 INFO - 'HOME': '/home/cltbld', 08:53:50 INFO - 'LANG': 'en_US.UTF-8', 08:53:50 INFO - 'LANGUAGE': 'en_US:en', 08:53:50 INFO - 'LOGNAME': 'cltbld', 08:53:50 INFO - 'MAIL': '/var/mail/cltbld', 08:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:50 INFO - 'MOZ_NO_REMOTE': '1', 08:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:50 INFO - 'NO_EM_RESTART': '1', 08:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:50 INFO - 'PWD': '/builds/slave/test', 08:53:50 INFO - 'SHELL': '/bin/bash', 08:53:50 INFO - 'SHLVL': '1', 08:53:50 INFO - 'TERM': 'linux', 08:53:50 INFO - 'TMOUT': '86400', 08:53:50 INFO - 'USER': 'cltbld', 08:53:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:50 INFO - '_': '/tools/buildbot/bin/python'} 08:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:50 INFO - Running setup.py (path:/tmp/pip-gwWOHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:50 INFO - Running setup.py (path:/tmp/pip-kutV3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 INFO - Running setup.py (path:/tmp/pip-8hJSNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:50 INFO - Running setup.py (path:/tmp/pip-Cu4C0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:51 INFO - Running setup.py (path:/tmp/pip-8D0_Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:51 INFO - Running setup.py (path:/tmp/pip-urUdd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:51 INFO - Running setup.py (path:/tmp/pip-yw0leH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:51 INFO - Running setup.py (path:/tmp/pip-FYlBpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:51 INFO - Running setup.py (path:/tmp/pip-Hfmvq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:51 INFO - Running setup.py (path:/tmp/pip-g3k5GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:51 INFO - Running setup.py (path:/tmp/pip-ff1PPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:51 INFO - Running setup.py (path:/tmp/pip-1GS_Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 INFO - Running setup.py (path:/tmp/pip-uLeHBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 INFO - Running setup.py (path:/tmp/pip-UF_tQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 INFO - Running setup.py (path:/tmp/pip-65kaN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:51 INFO - Running setup.py (path:/tmp/pip-5iP2nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:51 INFO - Running setup.py (path:/tmp/pip-vtp5EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:51 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:53:51 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:53:51 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:53:51 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:53:51 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:53:51 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:53:51 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:53:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:51 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:53:51 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:53:51 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:53:51 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:53:53 INFO - Downloading blessings-1.6.tar.gz 08:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:53 INFO - Installing collected packages: blessings 08:53:53 INFO - Running setup.py install for blessings 08:53:53 INFO - Successfully installed blessings 08:53:53 INFO - Cleaning up... 08:53:53 INFO - Return code: 0 08:53:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:53 INFO - Reading from file tmpfile_stdout 08:53:53 INFO - Current package versions: 08:53:53 INFO - argparse == 1.2.1 08:53:53 INFO - blessings == 1.6 08:53:53 INFO - blobuploader == 1.2.4 08:53:53 INFO - docopt == 0.6.1 08:53:53 INFO - functools32 == 3.2.3-2 08:53:53 INFO - jsonschema == 2.5.1 08:53:53 INFO - manifestparser == 1.1 08:53:53 INFO - mozInstall == 1.13 08:53:53 INFO - mozcrash == 1.0 08:53:53 INFO - mozdebug == 0.1 08:53:53 INFO - mozdevice == 0.51 08:53:53 INFO - mozfile == 1.2 08:53:53 INFO - mozhttpd == 0.7 08:53:53 INFO - mozinfo == 0.10 08:53:53 INFO - mozleak == 0.1 08:53:53 INFO - mozlog == 3.5 08:53:53 INFO - moznetwork == 0.27 08:53:53 INFO - mozprocess == 0.25 08:53:53 INFO - mozprofile == 0.28 08:53:53 INFO - mozrunner == 6.13 08:53:53 INFO - mozscreenshot == 0.1 08:53:53 INFO - mozsystemmonitor == 0.3 08:53:53 INFO - moztest == 0.8 08:53:53 INFO - mozversion == 1.4 08:53:53 INFO - psutil == 3.1.1 08:53:53 INFO - requests == 1.2.3 08:53:53 INFO - wsgiref == 0.1.2 08:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:53 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 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:53 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:53:53 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:53:53 INFO - Using env: {'DISPLAY': ':0', 08:53:53 INFO - 'HOME': '/home/cltbld', 08:53:53 INFO - 'LANG': 'en_US.UTF-8', 08:53:53 INFO - 'LANGUAGE': 'en_US:en', 08:53:53 INFO - 'LOGNAME': 'cltbld', 08:53:53 INFO - 'MAIL': '/var/mail/cltbld', 08:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:53 INFO - 'MOZ_NO_REMOTE': '1', 08:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:53 INFO - 'NO_EM_RESTART': '1', 08:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:53 INFO - 'PWD': '/builds/slave/test', 08:53:53 INFO - 'SHELL': '/bin/bash', 08:53:53 INFO - 'SHLVL': '1', 08:53:53 INFO - 'TERM': 'linux', 08:53:53 INFO - 'TMOUT': '86400', 08:53:53 INFO - 'USER': 'cltbld', 08:53:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:53 INFO - '_': '/tools/buildbot/bin/python'} 08:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:53:54 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:53:54 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:53:54 INFO - Installing collected packages: simplejson 08:53:54 INFO - Running setup.py install for simplejson 08:53:55 INFO - building 'simplejson._speedups' extension 08:53:55 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:53:55 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:53:55 INFO - Successfully installed simplejson 08:53:55 INFO - Cleaning up... 08:53:55 INFO - Return code: 0 08:53:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', '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:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:55 INFO - Using env: {'DISPLAY': ':0', 08:53:55 INFO - 'HOME': '/home/cltbld', 08:53:55 INFO - 'LANG': 'en_US.UTF-8', 08:53:55 INFO - 'LANGUAGE': 'en_US:en', 08:53:55 INFO - 'LOGNAME': 'cltbld', 08:53:55 INFO - 'MAIL': '/var/mail/cltbld', 08:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:55 INFO - 'MOZ_NO_REMOTE': '1', 08:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:55 INFO - 'NO_EM_RESTART': '1', 08:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:55 INFO - 'PWD': '/builds/slave/test', 08:53:55 INFO - 'SHELL': '/bin/bash', 08:53:55 INFO - 'SHLVL': '1', 08:53:55 INFO - 'TERM': 'linux', 08:53:55 INFO - 'TMOUT': '86400', 08:53:55 INFO - 'USER': 'cltbld', 08:53:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:55 INFO - '_': '/tools/buildbot/bin/python'} 08:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:56 INFO - Cleaning up... 08:53:56 INFO - Return code: 0 08:53:56 INFO - Running post-action listener: _resource_record_post_action 08:53:56 INFO - Running post-action listener: _start_resource_monitoring 08:53:56 INFO - Starting resource monitoring. 08:53:56 INFO - [mozharness: 2017-09-01 15:53:56.216322Z] Finished create-virtualenv step (success) 08:53:56 INFO - [mozharness: 2017-09-01 15:53:56.216792Z] Running install step. 08:53:56 INFO - Running pre-action listener: _resource_record_pre_action 08:53:56 INFO - Running main action method: install 08:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:56 INFO - Reading from file tmpfile_stdout 08:53:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:56 INFO - Reading from file tmpfile_stdout 08:53:56 INFO - Output received: 08:53:56 INFO - Usage: mozinstall [options] installer 08:53:56 INFO - Options: 08:53:56 INFO - -h, --help show this help message and exit 08:53:56 INFO - -d DEST, --destination=DEST 08:53:56 INFO - Directory to install application into. [default: 08:53:56 INFO - "/builds/slave/test"] 08:53:56 INFO - --app=APP Application being installed. [default: firefox] 08:53:56 INFO - mkdir: /builds/slave/test/build/application 08:53:56 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:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:54:13 INFO - Reading from file tmpfile_stdout 08:54:13 INFO - Output received: 08:54:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:54:13 INFO - Running post-action listener: _resource_record_post_action 08:54:13 INFO - [mozharness: 2017-09-01 15:54:13.112382Z] Finished install step (success) 08:54:13 INFO - [mozharness: 2017-09-01 15:54:13.112633Z] Running setup-mitmproxy step. 08:54:13 INFO - Running pre-action listener: _resource_record_pre_action 08:54:13 INFO - Running main action method: setup_mitmproxy 08:54:13 INFO - Skipping: mitmproxy is not required 08:54:13 INFO - Running post-action listener: _resource_record_post_action 08:54:13 INFO - [mozharness: 2017-09-01 15:54:13.113750Z] Finished setup-mitmproxy step (success) 08:54:13 INFO - [mozharness: 2017-09-01 15:54:13.113968Z] Running run-tests step. 08:54:13 INFO - Running pre-action listener: _resource_record_pre_action 08:54:13 INFO - Running pre-action listener: _set_gcov_prefix 08:54:13 INFO - Running main action method: run_tests 08:54:13 WARNING - Try message not found. 08:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:13 INFO - Python 2.7.3 08:54:13 INFO - Return code: 0 08:54:13 INFO - grabbing minidump binary from tooltool 08:54:13 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:54:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2090>, '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 0x20e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:54:13 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:54:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:54:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:13 INFO - Return code: 0 08:54:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:54:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:13 INFO - ENV: RUST_BACKTRACE is now full 08:54:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:54:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:13 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/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:54:13 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/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test', 08:54:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:13 INFO - 'RUST_BACKTRACE': 'full', 08:54:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'STYLO_FORCE_ENABLED': '1', 08:54:13 INFO - 'STYLO_THREADS': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 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/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:54:13 INFO - mozversion application_buildid: 20170901150340 08:54:13 INFO - mozversion application_changeset: cc85091ab81c7eb865d2cfb31539702c1bb7a18d 08:54:13 INFO - mozversion application_display_name: Nightly 08:54:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:13 INFO - mozversion application_name: Firefox 08:54:13 INFO - mozversion application_remotingname: firefox 08:54:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:13 INFO - mozversion application_vendor: Mozilla 08:54:13 INFO - mozversion application_version: 57.0a1 08:54:13 INFO - mozversion platform_buildid: 20170901150340 08:54:13 INFO - mozversion platform_changeset: cc85091ab81c7eb865d2cfb31539702c1bb7a18d 08:54:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:13 INFO - mozversion platform_version: 57.0a1 08:54:13 INFO - using testdate: 1504281253 08:54:13 INFO - actual date: 1504281253 08:54:13 INFO - starting webserver on 'localhost:51108' 08:54:13 INFO - SUITE-START | Running 2 tests 08:54:13 INFO - TEST-START | dromaeo_css 08:54:13 INFO - Initialising browser for dromaeo_css test... 08:54:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51108/getInfo.html -profile /tmp/tmpsQ86IA/profile 08:54:13 INFO - TEST-INFO | started process 27258 (/builds/slave/test/build/application/firefox/firefox http://localhost:51108/getInfo.html) 08:54:19 INFO - TEST-INFO | 27258: exit 0 08:54:19 INFO - Browser initialized. 08:54:19 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:19 INFO - Using env: {'DISPLAY': ':0', 08:54:19 INFO - 'HOME': '/home/cltbld', 08:54:19 INFO - 'JSGC_DISABLE_POISONING': '1', 08:54:19 INFO - 'LANG': 'en_US.UTF-8', 08:54:19 INFO - 'LANGUAGE': 'en_US:en', 08:54:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:54:19 INFO - 'LOGNAME': 'cltbld', 08:54:19 INFO - 'MAIL': '/var/mail/cltbld', 08:54:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:19 INFO - 'MOZ_CRASHREPORTER': '1', 08:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:54:19 INFO - 'MOZ_NO_REMOTE': '1', 08:54:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:19 INFO - 'NO_EM_RESTART': '1', 08:54:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:19 INFO - 'PWD': '/builds/slave/test', 08:54:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:19 INFO - 'RUST_BACKTRACE': 'full', 08:54:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:54:19 INFO - 'SHELL': '/bin/bash', 08:54:19 INFO - 'SHLVL': '1', 08:54:19 INFO - 'STYLO_FORCE_ENABLED': '1', 08:54:19 INFO - 'STYLO_THREADS': '1', 08:54:19 INFO - 'TERM': 'linux', 08:54:19 INFO - 'TMOUT': '86400', 08:54:19 INFO - 'USER': 'cltbld', 08:54:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 08:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:19 INFO - '_': '/tools/buildbot/bin/python'} 08:54:19 INFO - TEST-INFO | started process 27441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsQ86IA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:20 INFO - PID 27441 | 08:54:20 INFO - PID 27441 | (/builds/slave/test/build/application/firefox/firefox:27493): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:54:20 INFO - PID 27441 | 08:54:30 INFO - PID 27441 | RSS: Main: 172720128 08:54:30 INFO - PID 27441 | 08:57:29 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51108/tests/dromaeo/cssquery-ext.html) 08:57:30 INFO - PID 27441 | RSS: Main: 174944256 08:57:30 INFO - PID 27441 | 09:00:32 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-ext.html (next: http://localhost:51108/tests/dromaeo/cssquery-jquery.html) 09:00:32 INFO - PID 27441 | RSS: Main: 170819584 09:00:32 INFO - PID 27441 | 09:03:34 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51108/tests/dromaeo/cssquery-mootools.html) 09:03:35 INFO - PID 27441 | RSS: Main: 173395968 09:03:35 INFO - PID 27441 | 09:06:36 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51108/tests/dromaeo/cssquery-prototype.html) 09:06:37 INFO - PID 27441 | RSS: Main: 172277760 09:06:37 INFO - PID 27441 | 09:09:41 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51108/tests/dromaeo/cssquery-yui.html) 09:09:41 INFO - PID 27441 | RSS: Main: 173133824 09:09:41 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | Cycle 1(1): loaded http://localhost:51108/tests/dromaeo/cssquery-yui.html (next: http://localhost:51108/tests/dromaeo/cssquery-dojo.html) 09:12:43 INFO - PID 27441 | RSS: Main: 175652864 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | __start_tp_report 09:12:43 INFO - PID 27441 | _x_x_mozilla_page_load 09:12:43 INFO - PID 27441 | _x_x_mozilla_page_load_details 09:12:43 INFO - PID 27441 | |i|pagename|runs| 09:12:43 INFO - PID 27441 | |0;dojo.html;3324.218808579985;3327.550780644613;3338.382399256137;3360.042387919442;3361.44536151535;6405.519586031043;6423.935760642392;6449.580777249482;6452.8386790330205;6477.222733272014;6312.053192021199;6409.455196308308;6422.58253213542;6428.228612566499;6437.935620643804;5889.116632505126;5906.26171728534;5928;5954.374790646984;5955.017422125366;5929.703514824263;5937.851553711149;5968.641881487103;5998.950183717854;6001.699915004254;5977.521798256129;5981.282246130449;6005.039193728982;6033.27600687918;6069.08963655453;5818.330891947396;5936.109583562457;5949.940500594982;5983.58114931955;6024.21685180928;5805.245318108661;5840;5894.58737888348;5897.3218079920925;5972.522198224132;6411.198600174978;6429.871402571969;6452.1289625900845;6461.967690161519;6511.25120611131;6715.865682686368;6753.392194702451;6814.965925170392;6842.4868134890085;6895.655217239168;6950.826229344257;6966.79099627007;6974.058502102202;6991.930080699179;7007.649617519103;6440.5491615586925;6466.967665161644;6476.8704625907685;6485.481161507115;6489.253735820394;7046.894296585555;7062.964685176644;7069.540479868792;7130.465215108888;7194.028806111212;6575.112359831457;6773.221079575912;6789.219239787389;6850.109485766819;6874.381305682513;6791.422729068085;6816.897746533806;6847.760328388483;6896.448284137257;6932.168139823153;6846.075779769767;6872.931270687229;6878.621675807879;6879.071325371111;6920.723171073201;6825.078614387094;6881.965590172017;6908;6962.7911162665205;6963.373296403348;5397.568194544427;5413.648112872651;5480.013597552479;5486.835394938078;5491.0116179087345;4703.223968045234;4703.717776933395;4769.403824521934;4808.3989501312335;4812.205986012339;5974.61165024272;6006.3693312201585;6088.330283668793;6094.329623741385;6094.451499365078;6985.441164706811;6991.685374158175;7000.754973576002;7001.684924178424;7006.684699188549;6011.609245399035;6015.218021657157;6087.604305720114;6089.238845144357;6094.9695251524345;5942.3166335871065;5946.048632218824;6001.729922153426;6015.06766451192;6017.909731354033;6556.082148499214;6661.367170118831;6676.298988606223;6752.3247675231105;6774.627395493197;6860.279670634711;6924.272951340036;6934.16789985205;6948.513604047668;6995.930040699528;6662.600243985376;6669.666516674244;6764.289749576224;6768;6775.322467753185;6787.694553744995;6788.422984046411;6813.012113243452;6890.517663763489;6893.345132212432;6776.830579235361;6836.077129587442;6907.827304317432;6913.308669133046;6932.896006559805;6675.198976122702;6728.495362847708;6744.5616034957575;6748.966255168692;6798.252192258947;6700.195976482658;6714.865702686016;6788.898166527407;6789.219239787488;6796.116504854535;6569.113169722026;6622.70197841108;6623.503237257129;6710.698018589273;6726.495512836655;6740.6966686498245;6747;6761.256261811295;6781.42357899584;6781.796546103625;6456.903146452901;6517.348265173445;6567.146270984741;6575.243846957661;6601.471882249504 09:12:43 INFO - PID 27441 | |1;ext.html;807.1121766057335;811.9512829230247;854.8162145138796;875.991240087599;883.8232353529291;38551.80724096379;39200.21599568007;39272.03639818012;39311.21377572451;39325.99999999996;35672.286554268896;36314.09214769632;36353.0911727207;36391.27217455649;36460.45309320362;6897.862042759154;7031.367176954073;7032.8945065824055;7033.753818616349;7035.613041282727;6752.696128674222;6812.557183783063;6816.42060424862;6818.829529261759;6821.420179284767;6700.3969642732145;6783.830404239884;6804.863902721942;6811.318868113199;6816.147981502312;6737.831554211135;6752.426043786284;6754.054432379471;6764.425023872976;6769.796906092825;6310.242770867525;6311;6350.142730731338;6358.0462930560325;6364.840878978016;32112;32322.838385808154;32354.029379118663;32381.514277285623;32426.513602295985;3342.29811739535;3362.277110421271;3364.327134573071;3365.865365385406;3369.5956485221686;25798.484030319287;25917.61123583129;25996.610050849253;26054.478910421876;26278.343041423926;2749.8212616179885;2865.28367908023;2885.1200383882906;2900.76793856491;2901.8694158762696;176406;183827;190462;190668;194026;45565;46351;46357;46590.5340946593;46707.29939050917;47744.28383574249;47943.760281199066;47953;47973;48076.51923480791;14206.431742730176;14300.785488217685;14336.49822256216;14338.856611433752;14424.278786060864;11837.112216583791;11844.170908036527;11845.763084738257;11854.110941679408;11863.347515886537;12431;12447.564335248222;12448.31534265606;12452.252864828139;12560.937195314147;5379.838604841861;5415.241866138744;5453.127499600124;5462.453754624586;5546.833594992157;999.1008092716613;1012.2307046644456;1016.867807185076;1021.667957913681;1032.200044965158;22393.55212895733;28631.713682862905;28675.713242867303;28978.855105724757;29138.562921556193;1079.3146352066337;1081.7457897394106;1082.2478377527543;1091.7434402915308;1096.9067629251444;12201.877981220252;12219.144659873724;12222.511099556095;12257.877421225674;12267.509299628093;219252;220004;220356;221782;222321;48479.5152048475;48611.27083093757;48642.75678621655;48651.756741216064;48732.512674873506;1357.2060344698461;1403.7927382451085;1405.641561401836;1426.1514398932825;1429.9857001430062;20801;21015.369538913856;21544.89227553915;21630.459238519165;21767.23814666479;34416.65583344134;34606.480902786985;34704.132396690286;34721.13197170091;34842;190444;192205;193138.03430982755;194572;194639;29901.850490747405;30052.398952021274;31660.050198494082;33164.33671326608;33313.500297496044;43478.34782478328;43649;43923.34114988342;44211.77894110509;44237.11525769531;32442.188945276557;32592;32903.34193316168;32996.34007319888;33029;30985.69014309828;31669.524957125202;31772.841135795097;31970.52044219385;32078;34718.82640586781;34842.82578587091;35054.64945350514;35089.64910350864;35444.46833297554;32130.196745080626;32162.517562236117;32175.51736723998;32293.35413291768;32519.349613008082;23578.410539735956;23816.88091559531;24274.878625606758;24311.51376972486;24362.26913192607 09:12:43 INFO - PID 27441 | |2;jquery.html;551.2558046637038;559.2673597587161;559.3036669346662;576.4638885836171;578.3233616668499;21770.455738606543;22354.21760238392;22605.208817691386;22643.660345094795;22672.659910101363;26151.73848261517;26628.201153965412;26641.467170656575;26646.60030099545;26690.866545667293;6579.374959378863;6728.461723062168;6729.7644582439625;6731.56244844086;6740.764073257437;6388.105665206875;6588;6644.43522300605;6656.667166641672;6665.566738162028;6593.67031648418;6622.53642245043;6624.171978502687;6627.569208001489;6639;6615.206175258952;6618.602883826986;6619.040239165318;6628.734850606018;6629.867402651968;6116.785912493041;6136.631802091889;6143.139960405502;6149.2313460817395;6163.8150855474405;28147.85926070377;29521.852390738124;29974.100776976724;30116.849415753;30319.545206821917;1975;2010.6179825833192;2011.1854698846844;2011.265887950902;2011.5373464103338;19667.901660491607;20283;20288.79711202884;20334.694979575317;20336.186552538027;2352.3226265006288;2364.290712786157;2405.6271277951946;2433.0997530913496;2447.9755202447927;137246;141538;141553;141559;142067.99999999895;14167.858321416654;14811.555653330417;14916.552503424915;14919.254037298091;15203.695926081416;22727.545449091256;22739.204127855446;22777.202797902326;22950.885245573667;23463.88268058649;9744.366616169926;9745.756356091013;9856.620073189759;9913;10034.44810535413;8959.148880856308;9035.954820225988;9070.319726020574;9149.588268527932;9166.770830729152;8992.8651070234;9072.228860546928;9075.91089069316;9340.439573625605;9444.527773611291;2652.9602055969176;2697.1234348836706;2742.450515458799;2753.6420265365373;2786.8885244590397;962.5187406296851;963.604921981984;974.3763991045737;977.3256453047375;997.2470784557613;19720.30978915731;20200.393988180378;20387;20489.07799149042;20628.587428251652;999.5651891427252;1026.2867307221409;1031.293563908725;1033.4316126130598;1039.2569312941284;10944.4527773611;10977.83533247002;11188;11222.719432014264;11363.886361136283;463558;466755;490121;491231;499984;115451;119250.4037479807;120284.3985780083;121255.39372303082;123010;1195.8266051422495;1201.1742151929018;1235.3329202230696;1237.5915947737406;1249.4689756853302;20937.16251349929;21099.683504747132;21215.151393944685;21533;21602.675959860928;47893.982020518386;48657.756711216214;57887.710561446926;59618.40381596128;61435.69282153561;71421;73954.63022684852;74228.62885685537;74614;75483.24516754982;14308.356123974238;14435.639109022359;14576.562703118923;14640.04839685417;14677.853221468076;22837;22993.195238166583;23181.304560863202;23413.76586234184;23436;18307.54231144232;18469.168887400367;18490.722639160154;18592.81407185911;18625.44123676292;15424.843136764563;16337.183140843148;16579.834201658312;16797.66404671924;16907.492775216764;17740;18735.437936861916;18782.812171878108;18884.905575472585;18999.620007599493;14382.208978506282;14460.566183014527;14469.78295325592;14483;14608.561743147722;18145.727814083064;18259.54351141179;18283.451496455127;18340.26638934481;18438.81561184371 09:12:43 INFO - PID 27441 | |3;mootools.html;1296.2157894473844;1350.7298540291938;1353.4045020191115;1356.1456282541997;1375.4429456070295;14796.77804832927;15468.69062618747;15532.611684707888;15545.06729596225;15567.221638918052;12775.872241277584;13200.669983250424;15163.696726065473;15498.225088745574;15553.144577048259;2752.2568906395263;2831.2214141111153;2831.3629433377428;2833.688294287627;2840.573913912919;2736.220177249484;2758.517259479593;2792.4833905727505;2805.705400932903;2807.1578526442086;2778.9305267368377;2791.6510436195476;2804.2008027712104;2804.957925631117;2805.957910631342;2700.837949723013;2701.284159697672;2722.2377734234346;2726.1412655013605;2734.767544758698;2719;2724.2508310214653;2729.4404647047504;2741.4791189673897;2744.3687951771203;14575.635609109857;15099.094054356774;15118.924405378013;15123.773143402857;15131.924340378338;7994.680212791482;8284.420090593661;8300.83398332036;8301.128381519913;8302.501849889026;5517.36550296717;5583.162525621189;5594.496495315441;5743.253377060997;5769.980506822579;1924.8171423714725;1934.177974360905;1960.980390196094;1967.881927084365;2005.3081686818025;25248.873755631288;25481;25489.23532294034;25929.351766205808;27241.1827645169;6813.557118787263;6922.342377474232;6937.826554336081;7007.93265986525;7151.642417879085;17173.398931037602;17258.568535786704;17260;17272.740908886375;17290.308387664605;8032.879506807402;8153.918460815435;8156.796080098045;8158.388120890957;8167.469114507538;7376.594287314142;7485.1017877855;7495.400367970549;7523.059617547807;7545.283198096172;5171.086697921793;5308.362996440452;5338.91991620126;5352.9732351338;5365.946340536622;1524.3521503361249;1524.9390024399122;1527.8013858198585;1533.2563706602289;1546.876249900028;900.504722402676;903.9457632542069;915.3866909170871;923.0953665407937;927.8515437529962;7639.427042971799;7654.196309387546;7656.961715191388;7732.884006739903;7738.303552680286;688.896665500179;689.9724011039602;695.1658010387555;728.0026363881516;735.0224201811578;4653.092646933816;4722.598579120813;4755.9286610700865;5070.645054846199;5322.068637988336;20897.37307880766;21761.129554817948;21811.78188218129;21823;21864.125434982423;21147.78852211489;21439.142434302452;21806.89096554507;21923.890380547997;21945.341639750834;10089.293749437616;10404.479776011169;10464.843027354747;11172.44137793107;11421.371824549564;8755.212030917248;9101.726948191565;9104;9190.080991900757;9196.54017299119;18318.72521912199;18479.630407392047;18616.627667446846;18985.24059037623;19168.520786980436;18450.169742361893;18476.630467390307;18477.90761046186;18801.341953031577;18831.24675012984;12049.578264760692;12279.386030698608;12476.06429517808;12483.251004939733;12517.874821252035;13989.370478328703;13994.440222391398;14170.504032358818;14172.433102675777;14223.928880355532;11439.199256052329;11456.656300311004;11773.352465614473;11785.410729463663;11852.407379631157;11380.715482112682;11529.1929564933;11536.653900383002;11675.591354302558;11856.680129563736;9155.450672959643;9359.251259899327;9364.20404265645;9497.192738617296;9498.955114937213;7303.744368947274;7324.230955749569;7327.816804579715;7359.4480413968095;7410.2219266978345;7280.854382912206;7354.705811767683;7381.704731810667;7382.889256661262;7395.371393431618 09:12:43 INFO - PID 27441 | |4;prototype.html;498.3919618065958;507.9695218286903;533.8718707510199;536.8282149712091;545.0434487474482;6462.806115816533;6467.223933128025;6477.477792718707;6497.935020649792;6510.061412845232;6165.599236049654;6269.216347956505;6269.843253918643;6276.623402595847;6291.245050593935;5014.373203349582;5066.240063990413;5078.21287700407;5116.260471439709;5131.512506311894;4875.171220892456;5035.823746168885;5046.268291097788;5046.82336118236;5102.770375333119;4950;4955.157623204046;4961.727105009223;4993.201087825949;5003.949960500385;4901.38254376055;4929.827456039057;4935.679180853251;4946.455889852114;4995.675281106753;4426.84506042287;4436.844710435119;4491.887702807423;4501.684882058257;4520.389747384094;6218.4714299284615;6220.595661282047;6230.345813689588;6249.218847644044;6317.87364252717;5680.6141420603035;5754.913676294859;5760.7695692172265;5767.307923049261;5792.304923409218;6575.441087507567;6635.502337324671;6658.467322614228;6729.49528785343;6761.594304341756;4783.641226907996;4797.856064318076;4804.471508134103;4815.374001379833;4854.878628034327;6815.659217039129;6915.305750091159;6919.584824910521;6976.511843985041;7017.508774385795;4999.325091112726;5011.949880501221;5034.421041580192;5046.798128074836;5051.6716413433005;5096.980603879239;5115.795368185305;5119.334486516804;5159.251908473326;5183.50756678115;5727.828165155052;5730.656160630376;5770.826875193751;5788.363280039192;5812.994516891666;6563.278039415661;6619.801405957829;6695.196576410862;6699.296573859675;6815.829604259834;1632.4041724770373;1695.279506209856;1696.2027846912179;1709.3419033671878;1740.634466761969;1184.9170558060853;1240.3674126195706;1244.869288724671;1250.337321219755;1257.69186549296;5907.320658124285;5910.822675319747;5922.585419020714;5946.762129514771;5979.415454904454;6762.323767623198;6781.8643627127185;6836;6841.2132604750095;6880.931190688129;5892.587518873637;5897.705114744245;5909.674967876808;5916.940830591725;5921.378255283219;3481.7040551552896;3589.838457269429;3622.728295377857;3650.4889315495852;3665.3585622515952;6616.404523592803;6678.298778628174;6690.13028306317;6717.261101278856;6730;6996;7025.086738724035;7030.824229394306;7062.821730221421;7077.52286699651;6641.734330626721;6648.667566621746;6678.265390807007;6682.966585167043;6692.498062645321;6781.6763840385065;6822.897656535255;6835.282295359115;6863.725450982104;6866.279040700654;6585.934140658724;6735.966320168368;6763.560368576027;6775.525713200029;6790.966045169743;6481.546291759531;6566.573172743756;6608.8347791305605;6641.9667901662115;6650.301718319507;5004.199328107486;5016.272640467038;5041.924371134362;5057.797688092435;5082.263071854486;6661;6711.966440167963;6735.562188457735;6751.628660423724;6777.830554236183;6480;6539.574927629689;6548.1814773153355;6583.572067815577;6623.50971031514;6605.919135472311;6627.204735431586;6628.469722422291;6628.867422651423;6646.136002319668;6527.379898909596;6549.377809108127;6570.310117437601;6575.769848055295;6633.834154146185;6434.324395938359;6489.3510648934725;6506.186726659168;6604.570702904296;6642.8742802302795;5860.736266867916;6360.0919724083515;6387.169667943138;6403.167588213502;6447.194100737408 09:12:43 INFO - PID 27441 | |5;yui.html;918.8621706743987;924.4730503612943;927.7912469694315;934.429997701402;937.0254934867738;19048.238070477182;19528;19632.312869049587;19655.410337689875;22459.55080898381;19267.421977340666;21279.787202127973;21608.243711470102;21613.351599452002;21659.025343859525;971.6793458158826;977.1157102821923;977.5112443778111;977.9706608801747;978.7210644966186;997.4414327976357;1004.8693669822912;1006.1498034161123;1006.8288390973515;1011.5852500474807;1043.5408420295084;1051.6319288249128;1056.8414737789317;1062.978740425191;1063.3991794636045;1037.9429131397733;1044.6082718980383;1044.9164066874632;1046.785408991155;1053.1943063556384;775.3409601838449;775.9146493885668;776.1307335783958;776.5379599138504;777.4480119115435;18380.264789408408;18961.90519047396;19086.33197838069;20132.29536966199;20224;21250.36248912535;21480.355589332346;21769.564608707737;21825.454363641034;21870.343889683336;16609.4186703466;17536.29854805806;17658.11709414537;17663.470095897013;17823.197956092008;3755.1550901047317;3800.7909564973916;3802.619738026203;3806.9428958565645;3806.9809650951843;128053;129043;129238;130506;132779;15904.204789760466;15969.281382337822;16203.108829014518;16409.507714768577;16474.258658360402;29242.26894327616;30226.84886575553;30265.848670756506;31292.84353578263;31362.05913822589;7004.684789184499;7301.1968683444775;8577.270931970728;8672.089430609694;8830.293576513863;4060.796960151981;4192.958070419318;4200.85297014603;4210.0948296116485;4216.641585465209;5162.199859021857;5291.285676433709;5293.417724050351;5299.5230429261555;5343.385510666245;1055.6199768083484;1067.9092277156528;1069.6844430892904;1086.9293495922739;1091.3779145886926;627.7771391156074;636.2396935661932;637.1207733327977;639.0956796133419;652.8596351784295;11541.249818761753;11745.706357341134;12155.270683758827;12725.172863763826;12815.487380504861;700.509643249717;702.1083224305104;703.521605308385;707.8831992721247;714.5783987447431;5743.770249190069;5749.9712501437225;5806.564507661942;5896.292444906639;5966.194563733927;113233.43383283031;114605;115292;116635;121614;102687;103418;105530.47234763777;109292;110226;82339;82397.58801205955;83483.58258208548;85524;86968.56515717381;10865.891341086488;12186.2078964867;12217.877821221675;12459.377031148588;12477.500899964263;42379.15241695211;44620.55379446164;45169.0966180668;45321.32018019798;46051.53948460473;76231.61884190544;77490;80733;83115.16884831074;88440;18774.342897998504;19138.23447062102;19304.903475483094;19943.401697949084;20171.798282016993;16428.753568696717;16721.5819604506;16743.413980510624;20003.899980500006;20739.585208296052;17360.913195433943;17599.560010999827;17971.101444927965;18645.533861653566;18720.344787932358;16450.341986320414;16498.34006639721;18290.176942037906;19256.22975080981;19336.419907402236;15939.043657380595;15970.68058638844;16027.759583606023;16617.169141543116;18860.622787544446;12860.807087893876;13242.735145297233;13415.128016678884;13571.86428135706;13817.240051797247;11978.58074967372;12099.57651482194;12122.27266364021;12436.396883447045;13482.123661961941 09:12:43 INFO - PID 27441 | __end_tp_report 09:12:43 INFO - PID 27441 | __start_cc_report 09:12:43 INFO - PID 27441 | _x_x_mozilla_cycle_collect,365 09:12:43 INFO - PID 27441 | __end_cc_report 09:12:43 INFO - PID 27441 | __startTimestamp1504282363690__endTimestamp 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | ------- Summary: start ------- 09:12:43 INFO - PID 27441 | Number of tests: 6 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#0] dojo.html Cycles:165 Average:6362.31 Median:6601.47 stddev:739.69 (11.2%) stddev-sans-first:702.52 09:12:43 INFO - PID 27441 | Values: 3324.2 3327.6 3338.4 3360.0 3361.4 6405.5 6423.9 6449.6 6452.8 6477.2 6312.1 6409.5 6422.6 6428.2 6437.9 5889.1 5906.3 5928.0 5954.4 5955.0 5929.7 5937.9 5968.6 5999.0 6001.7 5977.5 5981.3 6005.0 6033.3 6069.1 5818.3 5936.1 5949.9 5983.6 6024.2 5805.2 5840.0 5894.6 5897.3 5972.5 6411.2 6429.9 6452.1 6462.0 6511.3 6715.9 6753.4 6815.0 6842.5 6895.7 6950.8 6966.8 6974.1 6991.9 7007.6 6440.5 6467.0 6476.9 6485.5 6489.3 7046.9 7063.0 7069.5 7130.5 7194.0 6575.1 6773.2 6789.2 6850.1 6874.4 6791.4 6816.9 6847.8 6896.4 6932.2 6846.1 6872.9 6878.6 6879.1 6920.7 6825.1 6882.0 6908.0 6962.8 6963.4 5397.6 5413.6 5480.0 5486.8 5491.0 4703.2 4703.7 4769.4 4808.4 4812.2 5974.6 6006.4 6088.3 6094.3 6094.5 6985.4 6991.7 7000.8 7001.7 7006.7 6011.6 6015.2 6087.6 6089.2 6095.0 5942.3 5946.0 6001.7 6015.1 6017.9 6556.1 6661.4 6676.3 6752.3 6774.6 6860.3 6924.3 6934.2 6948.5 6995.9 6662.6 6669.7 6764.3 6768.0 6775.3 6787.7 6788.4 6813.0 6890.5 6893.3 6776.8 6836.1 6907.8 6913.3 6932.9 6675.2 6728.5 6744.6 6749.0 6798.3 6700.2 6714.9 6788.9 6789.2 6796.1 6569.1 6622.7 6623.5 6710.7 6726.5 6740.7 6747.0 6761.3 6781.4 6781.8 6456.9 6517.3 6567.1 6575.2 6601.5 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#1] ext.html Cycles:180 Average:35914.38 Median:32434.35 stddev:52098.04 (160.6%) stddev-sans-first:52177.49 09:12:43 INFO - PID 27441 | Values: 807.1 812.0 854.8 876.0 883.8 38551.8 39200.2 39272.0 39311.2 39326.0 35672.3 36314.1 36353.1 36391.3 36460.5 6897.9 7031.4 7032.9 7033.8 7035.6 6752.7 6812.6 6816.4 6818.8 6821.4 6700.4 6783.8 6804.9 6811.3 6816.1 6737.8 6752.4 6754.1 6764.4 6769.8 6310.2 6311.0 6350.1 6358.0 6364.8 32112.0 32322.8 32354.0 32381.5 32426.5 3342.3 3362.3 3364.3 3365.9 3369.6 25798.5 25917.6 25996.6 26054.5 26278.3 2749.8 2865.3 2885.1 2900.8 2901.9 176406.0 183827.0 190462.0 190668.0 194026.0 45565.0 46351.0 46357.0 46590.5 46707.3 47744.3 47943.8 47953.0 47973.0 48076.5 14206.4 14300.8 14336.5 14338.9 14424.3 11837.1 11844.2 11845.8 11854.1 11863.3 12431.0 12447.6 12448.3 12452.3 12560.9 5379.8 5415.2 5453.1 5462.5 5546.8 999.1 1012.2 1016.9 1021.7 1032.2 22393.6 28631.7 28675.7 28978.9 29138.6 1079.3 1081.7 1082.2 1091.7 1096.9 12201.9 12219.1 12222.5 12257.9 12267.5 219252.0 220004.0 220356.0 221782.0 222321.0 48479.5 48611.3 48642.8 48651.8 48732.5 1357.2 1403.8 1405.6 1426.2 1430.0 20801.0 21015.4 21544.9 21630.5 21767.2 34416.7 34606.5 34704.1 34721.1 34842.0 190444.0 192205.0 193138.0 194572.0 194639.0 29901.9 30052.4 31660.1 33164.3 33313.5 43478.3 43649.0 43923.3 44211.8 44237.1 32442.2 32592.0 32903.3 32996.3 33029.0 30985.7 31669.5 31772.8 31970.5 32078.0 34718.8 34842.8 35054.6 35089.6 35444.5 32130.2 32162.5 32175.5 32293.4 32519.3 23578.4 23816.9 24274.9 24311.5 24362.3 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#2] jquery.html Cycles:180 Average:34914.87 Median:23087.25 stddev:81651.15 (353.7%) stddev-sans-first:81839.44 09:12:43 INFO - PID 27441 | Values: 551.3 559.3 559.3 576.5 578.3 21770.5 22354.2 22605.2 22643.7 22672.7 26151.7 26628.2 26641.5 26646.6 26690.9 6579.4 6728.5 6729.8 6731.6 6740.8 6388.1 6588.0 6644.4 6656.7 6665.6 6593.7 6622.5 6624.2 6627.6 6639.0 6615.2 6618.6 6619.0 6628.7 6629.9 6116.8 6136.6 6143.1 6149.2 6163.8 28147.9 29521.9 29974.1 30116.8 30319.5 1975.0 2010.6 2011.2 2011.3 2011.5 19667.9 20283.0 20288.8 20334.7 20336.2 2352.3 2364.3 2405.6 2433.1 2448.0 137246.0 141538.0 141553.0 141559.0 142068.0 14167.9 14811.6 14916.6 14919.3 15203.7 22727.5 22739.2 22777.2 22950.9 23463.9 9744.4 9745.8 9856.6 9913.0 10034.4 8959.1 9036.0 9070.3 9149.6 9166.8 8992.9 9072.2 9075.9 9340.4 9444.5 2653.0 2697.1 2742.5 2753.6 2786.9 962.5 963.6 974.4 977.3 997.2 19720.3 20200.4 20387.0 20489.1 20628.6 999.6 1026.3 1031.3 1033.4 1039.3 10944.5 10977.8 11188.0 11222.7 11363.9 463558.0 466755.0 490121.0 491231.0 499984.0 115451.0 119250.4 120284.4 121255.4 123010.0 1195.8 1201.2 1235.3 1237.6 1249.5 20937.2 21099.7 21215.2 21533.0 21602.7 47894.0 48657.8 57887.7 59618.4 61435.7 71421.0 73954.6 74228.6 74614.0 75483.2 14308.4 14435.6 14576.6 14640.0 14677.9 22837.0 22993.2 23181.3 23413.8 23436.0 18307.5 18469.2 18490.7 18592.8 18625.4 15424.8 16337.2 16579.8 16797.7 16907.5 17740.0 18735.4 18782.8 18884.9 18999.6 14382.2 14460.6 14469.8 14483.0 14608.6 18145.7 18259.5 18283.5 18340.3 18438.8 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#3] mootools.html Cycles:180 Average:9355.96 Median:2727.79 stddev:6616.42 (242.6%) stddev-sans-first:6607.27 09:12:43 INFO - PID 27441 | Values: 1296.2 1350.7 1353.4 1356.1 1375.4 14796.8 15468.7 15532.6 15545.1 15567.2 12775.9 13200.7 15163.7 15498.2 15553.1 2752.3 2831.2 2831.4 2833.7 2840.6 2736.2 2758.5 2792.5 2805.7 2807.2 2778.9 2791.7 2804.2 2805.0 2806.0 2700.8 2701.3 2722.2 2726.1 2734.8 2719.0 2724.3 2729.4 2741.5 2744.4 14575.6 15099.1 15118.9 15123.8 15131.9 7994.7 8284.4 8300.8 8301.1 8302.5 5517.4 5583.2 5594.5 5743.3 5770.0 1924.8 1934.2 1961.0 1967.9 2005.3 25248.9 25481.0 25489.2 25929.4 27241.2 6813.6 6922.3 6937.8 7007.9 7151.6 17173.4 17258.6 17260.0 17272.7 17290.3 8032.9 8153.9 8156.8 8158.4 8167.5 7376.6 7485.1 7495.4 7523.1 7545.3 5171.1 5308.4 5338.9 5353.0 5365.9 1524.4 1524.9 1527.8 1533.3 1546.9 900.5 903.9 915.4 923.1 927.9 7639.4 7654.2 7657.0 7732.9 7738.3 688.9 690.0 695.2 728.0 735.0 4653.1 4722.6 4755.9 5070.6 5322.1 20897.4 21761.1 21811.8 21823.0 21864.1 21147.8 21439.1 21806.9 21923.9 21945.3 10089.3 10404.5 10464.8 11172.4 11421.4 8755.2 9101.7 9104.0 9190.1 9196.5 18318.7 18479.6 18616.6 18985.2 19168.5 18450.2 18476.6 18477.9 18801.3 18831.2 12049.6 12279.4 12476.1 12483.3 12517.9 13989.4 13994.4 14170.5 14172.4 14223.9 11439.2 11456.7 11773.4 11785.4 11852.4 11380.7 11529.2 11536.7 11675.6 11856.7 9155.5 9359.3 9364.2 9497.2 9499.0 7303.7 7324.2 7327.8 7359.4 7410.2 7280.9 7354.7 7381.7 7382.9 7395.4 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#4] prototype.html Cycles:180 Average:5579.58 Median:6259.22 stddev:1581.01 (25.3%) stddev-sans-first:1538.76 09:12:43 INFO - PID 27441 | Values: 498.4 508.0 533.9 536.8 545.0 6462.8 6467.2 6477.5 6497.9 6510.1 6165.6 6269.2 6269.8 6276.6 6291.2 5014.4 5066.2 5078.2 5116.3 5131.5 4875.2 5035.8 5046.3 5046.8 5102.8 4950.0 4955.2 4961.7 4993.2 5003.9 4901.4 4929.8 4935.7 4946.5 4995.7 4426.8 4436.8 4491.9 4501.7 4520.4 6218.5 6220.6 6230.3 6249.2 6317.9 5680.6 5754.9 5760.8 5767.3 5792.3 6575.4 6635.5 6658.5 6729.5 6761.6 4783.6 4797.9 4804.5 4815.4 4854.9 6815.7 6915.3 6919.6 6976.5 7017.5 4999.3 5011.9 5034.4 5046.8 5051.7 5097.0 5115.8 5119.3 5159.3 5183.5 5727.8 5730.7 5770.8 5788.4 5813.0 6563.3 6619.8 6695.2 6699.3 6815.8 1632.4 1695.3 1696.2 1709.3 1740.6 1184.9 1240.4 1244.9 1250.3 1257.7 5907.3 5910.8 5922.6 5946.8 5979.4 6762.3 6781.9 6836.0 6841.2 6880.9 5892.6 5897.7 5909.7 5916.9 5921.4 3481.7 3589.8 3622.7 3650.5 3665.4 6616.4 6678.3 6690.1 6717.3 6730.0 6996.0 7025.1 7030.8 7062.8 7077.5 6641.7 6648.7 6678.3 6683.0 6692.5 6781.7 6822.9 6835.3 6863.7 6866.3 6585.9 6736.0 6763.6 6775.5 6791.0 6481.5 6566.6 6608.8 6642.0 6650.3 5004.2 5016.3 5041.9 5057.8 5082.3 6661.0 6712.0 6735.6 6751.6 6777.8 6480.0 6539.6 6548.2 6583.6 6623.5 6605.9 6627.2 6628.5 6628.9 6646.1 6527.4 6549.4 6570.3 6575.8 6633.8 6434.3 6489.4 6506.2 6604.6 6642.9 5860.7 6360.1 6387.2 6403.2 6447.2 09:12:43 INFO - PID 27441 | 09:12:43 INFO - PID 27441 | [#5] yui.html Cycles:180 Average:24568.58 Median:19580.16 stddev:33964.57 (173.5%) stddev-sans-first:34013.43 09:12:43 INFO - PID 27441 | Values: 918.9 924.5 927.8 934.4 937.0 19048.2 19528.0 19632.3 19655.4 22459.6 19267.4 21279.8 21608.2 21613.4 21659.0 971.7 977.1 977.5 978.0 978.7 997.4 1004.9 1006.1 1006.8 1011.6 1043.5 1051.6 1056.8 1063.0 1063.4 1037.9 1044.6 1044.9 1046.8 1053.2 775.3 775.9 776.1 776.5 777.4 18380.3 18961.9 19086.3 20132.3 20224.0 21250.4 21480.4 21769.6 21825.5 21870.3 16609.4 17536.3 17658.1 17663.5 17823.2 3755.2 3800.8 3802.6 3806.9 3807.0 128053.0 129043.0 129238.0 130506.0 132779.0 15904.2 15969.3 16203.1 16409.5 16474.3 29242.3 30226.8 30265.8 31292.8 31362.1 7004.7 7301.2 8577.3 8672.1 8830.3 4060.8 4193.0 4200.9 4210.1 4216.6 5162.2 5291.3 5293.4 5299.5 5343.4 1055.6 1067.9 1069.7 1086.9 1091.4 627.8 636.2 637.1 639.1 652.9 11541.2 11745.7 12155.3 12725.2 12815.5 700.5 702.1 703.5 707.9 714.6 5743.8 5750.0 5806.6 5896.3 5966.2 113233.4 114605.0 115292.0 116635.0 121614.0 102687.0 103418.0 105530.5 109292.0 110226.0 82339.0 82397.6 83483.6 85524.0 86968.6 10865.9 12186.2 12217.9 12459.4 12477.5 42379.2 44620.6 45169.1 45321.3 46051.5 76231.6 77490.0 80733.0 83115.2 88440.0 18774.3 19138.2 19304.9 19943.4 20171.8 16428.8 16721.6 16743.4 20003.9 20739.6 17360.9 17599.6 17971.1 18645.5 18720.3 16450.3 16498.3 18290.2 19256.2 19336.4 15939.0 15970.7 16027.8 16617.2 18860.6 12860.8 13242.7 13415.1 13571.9 13817.2 11978.6 12099.6 12122.3 12436.4 13482.1 09:12:43 INFO - PID 27441 | -------- Summary: end -------- 09:12:43 INFO - PID 27441 | 09:12:44 INFO - TEST-INFO | 27441: exit 0 09:12:44 INFO - TEST-OK | dromaeo_css | took 1110964ms 09:12:44 INFO - TEST-START | kraken 09:12:44 INFO - Initialising browser for kraken test... 09:12:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51108/getInfo.html -profile /tmp/tmp0pP1fu/profile 09:12:44 INFO - TEST-INFO | started process 27812 (/builds/slave/test/build/application/firefox/firefox http://localhost:51108/getInfo.html) 09:12:50 INFO - TEST-INFO | 27812: exit 0 09:12:50 INFO - Browser initialized. 09:12:50 INFO - Running cycle 1/1 for kraken test... 09:12:50 INFO - Using env: {'DISPLAY': ':0', 09:12:50 INFO - 'HOME': '/home/cltbld', 09:12:50 INFO - 'JSGC_DISABLE_POISONING': '1', 09:12:50 INFO - 'LANG': 'en_US.UTF-8', 09:12:50 INFO - 'LANGUAGE': 'en_US:en', 09:12:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:12:50 INFO - 'LOGNAME': 'cltbld', 09:12:50 INFO - 'MAIL': '/var/mail/cltbld', 09:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:50 INFO - 'MOZ_CRASHREPORTER': '1', 09:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:12:50 INFO - 'MOZ_NO_REMOTE': '1', 09:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:50 INFO - 'NO_EM_RESTART': '1', 09:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:50 INFO - 'PWD': '/builds/slave/test', 09:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:50 INFO - 'RUST_BACKTRACE': 'full', 09:12:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:12:50 INFO - 'SHELL': '/bin/bash', 09:12:50 INFO - 'SHLVL': '1', 09:12:50 INFO - 'STYLO_FORCE_ENABLED': '1', 09:12:50 INFO - 'STYLO_THREADS': '1', 09:12:50 INFO - 'TERM': 'linux', 09:12:50 INFO - 'TMOUT': '86400', 09:12:50 INFO - 'USER': 'cltbld', 09:12:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348', 09:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:50 INFO - '_': '/tools/buildbot/bin/python'} 09:12:50 INFO - TEST-INFO | started process 27994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0pP1fu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:51 INFO - PID 27994 | 09:12:51 INFO - PID 27994 | (/builds/slave/test/build/application/firefox/firefox:28045): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:12:51 INFO - PID 27994 | 09:13:02 INFO - PID 27994 | RSS: Main: 167145472 09:13:02 INFO - PID 27994 | 09:13:04 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51108/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:05 INFO - PID 27994 | RSS: Main: 172023808 09:13:05 INFO - PID 27994 | 09:13:08 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51108/tests/kraken/driver.html?testName=audio-dft) 09:13:08 INFO - PID 27994 | RSS: Main: 175255552 09:13:08 INFO - PID 27994 | 09:13:11 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51108/tests/kraken/driver.html?testName=audio-fft) 09:13:12 INFO - PID 27994 | RSS: Main: 170360832 09:13:12 INFO - PID 27994 | 09:13:14 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51108/tests/kraken/driver.html?testName=audio-oscillator) 09:13:15 INFO - PID 27994 | RSS: Main: 170328064 09:13:15 INFO - PID 27994 | 09:13:17 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:18 INFO - PID 27994 | RSS: Main: 170573824 09:13:18 INFO - PID 27994 | 09:13:21 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51108/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:21 INFO - PID 27994 | RSS: Main: 171892736 09:13:21 INFO - PID 27994 | 09:13:25 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51108/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:26 INFO - PID 27994 | RSS: Main: 171692032 09:13:26 INFO - PID 27994 | 09:13:28 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51108/tests/kraken/driver.html?testName=json-parse-financial) 09:13:29 INFO - PID 27994 | RSS: Main: 171954176 09:13:29 INFO - PID 27994 | 09:13:31 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:31 INFO - PID 27994 | RSS: Main: 171982848 09:13:31 INFO - PID 27994 | 09:13:33 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:34 INFO - PID 27994 | RSS: Main: 172457984 09:13:34 INFO - PID 27994 | 09:13:36 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:36 INFO - PID 27994 | RSS: Main: 172077056 09:13:36 INFO - PID 27994 | 09:13:39 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:40 INFO - PID 27994 | RSS: Main: 172453888 09:13:40 INFO - PID 27994 | 09:13:43 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:43 INFO - PID 27994 | RSS: Main: 172462080 09:13:43 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | Cycle 1(1): loaded http://localhost:51108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51108/tests/kraken/driver.html?testName=ai-astar) 09:13:45 INFO - PID 27994 | RSS: Main: 173940736 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | __start_tp_report 09:13:45 INFO - PID 27994 | _x_x_mozilla_page_load 09:13:45 INFO - PID 27994 | _x_x_mozilla_page_load_details 09:13:45 INFO - PID 27994 | |i|pagename|runs| 09:13:45 INFO - PID 27994 | |0;ai-astar;97;107;99;109;107;111;109;97;105;111 09:13:45 INFO - PID 27994 | |1;audio-beat-detection;143;118;140;171;117;147;146;115;160;121 09:13:45 INFO - PID 27994 | |2;audio-dft;166;163;162;161;164;162;163;165;169;164 09:13:45 INFO - PID 27994 | |3;audio-fft;83;74;80;177;74;74;74;74;156;76 09:13:45 INFO - PID 27994 | |4;audio-oscillator;79;79;136;80;80;79;143;82;80;127 09:13:45 INFO - PID 27994 | |5;imaging-gaussian-blur;113;115;114;113;115;113;114;114;114;115 09:13:45 INFO - PID 27994 | |6;imaging-darkroom;149;149;148;148;147;149;149;149;148;150 09:13:45 INFO - PID 27994 | |7;imaging-desaturate;94;94;94;94;94;95;97;95;93;95 09:13:45 INFO - PID 27994 | |8;json-parse-financial;54;55;54;53;58;55;55;62;54;54 09:13:45 INFO - PID 27994 | |9;json-stringify-tinderbox;38;38;39;38;39;38;39;40;39;39 09:13:45 INFO - PID 27994 | |10;stanford-crypto-aes;75;81;73;76;74;73;74;77;74;81 09:13:45 INFO - PID 27994 | |11;stanford-crypto-ccm;133;122;126;129;117;122;116;116;129;156 09:13:45 INFO - PID 27994 | |12;stanford-crypto-pbkdf2;179;178;176;176;184;183;177;184;176;172 09:13:45 INFO - PID 27994 | |13;stanford-crypto-sha256-iterative;65;65;65;66;64;64;64;66;64;64 09:13:45 INFO - PID 27994 | __end_tp_report 09:13:45 INFO - PID 27994 | __start_cc_report 09:13:45 INFO - PID 27994 | _x_x_mozilla_cycle_collect,919 09:13:45 INFO - PID 27994 | __end_cc_report 09:13:45 INFO - PID 27994 | __startTimestamp1504282425864__endTimestamp 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | ------- Summary: start ------- 09:13:45 INFO - PID 27994 | Number of tests: 14 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#0] ai-astar Cycles:10 Average:105.20 Median:111.00 stddev:5.53 (5.0%) stddev-sans-first:5.01 09:13:45 INFO - PID 27994 | Values: 97.0 107.0 99.0 109.0 107.0 111.0 109.0 97.0 105.0 111.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:144.50 stddev:19.45 (13.5%) stddev-sans-first:20.54 09:13:45 INFO - PID 27994 | Values: 143.0 118.0 140.0 171.0 117.0 147.0 146.0 115.0 160.0 121.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 09:13:45 INFO - PID 27994 | Values: 166.0 163.0 162.0 161.0 164.0 162.0 163.0 165.0 169.0 164.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#3] audio-fft Cycles:10 Average:94.20 Median:74.00 stddev:38.55 (52.1%) stddev-sans-first:40.67 09:13:45 INFO - PID 27994 | Values: 83.0 74.0 80.0 177.0 74.0 74.0 74.0 74.0 156.0 76.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.50 stddev:27.08 (34.1%) stddev-sans-first:27.97 09:13:45 INFO - PID 27994 | Values: 79.0 79.0 136.0 80.0 80.0 79.0 143.0 82.0 80.0 127.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 09:13:45 INFO - PID 27994 | Values: 113.0 115.0 114.0 113.0 115.0 113.0 114.0 114.0 114.0 115.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 09:13:45 INFO - PID 27994 | Values: 149.0 149.0 148.0 148.0 147.0 149.0 149.0 149.0 148.0 150.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 09:13:45 INFO - PID 27994 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 97.0 95.0 93.0 95.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.67 (4.9%) stddev-sans-first:2.79 09:13:45 INFO - PID 27994 | Values: 54.0 55.0 54.0 53.0 58.0 55.0 55.0 62.0 54.0 54.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.67 (1.7%) stddev-sans-first:0.67 09:13:45 INFO - PID 27994 | Values: 38.0 38.0 39.0 38.0 39.0 38.0 39.0 40.0 39.0 39.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:3.01 (4.0%) stddev-sans-first:3.18 09:13:45 INFO - PID 27994 | Values: 75.0 81.0 73.0 76.0 74.0 73.0 74.0 77.0 74.0 81.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:127.50 stddev:11.91 (9.3%) stddev-sans-first:12.40 09:13:45 INFO - PID 27994 | Values: 133.0 122.0 126.0 129.0 117.0 122.0 116.0 116.0 129.0 156.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.50 stddev:4.01 (2.2%) stddev-sans-first:4.25 09:13:45 INFO - PID 27994 | Values: 179.0 178.0 176.0 176.0 184.0 183.0 177.0 184.0 176.0 172.0 09:13:45 INFO - PID 27994 | 09:13:45 INFO - PID 27994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 09:13:45 INFO - PID 27994 | Values: 65.0 65.0 65.0 66.0 64.0 64.0 64.0 66.0 64.0 64.0 09:13:45 INFO - PID 27994 | -------- Summary: end -------- 09:13:45 INFO - PID 27994 | 09:13:46 INFO - PID 27994 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:13:46 INFO - TEST-INFO | 27994: exit 0 09:13:46 INFO - TEST-OK | kraken | took 62341ms 09:13:46 INFO - SUITE-END | took 1173s 09:13:47 INFO - Completed test suite (00:19:33) 09:13:47 INFO - javascript benchmark 09:13:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8517.581916599676, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.218808579985, 3327.550780644613, 3338.382399256137, 3360.042387919442, 3361.44536151535, 6405.519586031043, 6423.935760642392, 6449.580777249482, 6452.8386790330205, 6477.222733272014, 6312.053192021199, 6409.455196308308, 6422.58253213542, 6428.228612566499, 6437.935620643804, 5889.116632505126, 5906.26171728534, 5928.0, 5954.374790646984, 5955.017422125366, 5929.703514824263, 5937.851553711149, 5968.641881487103, 5998.950183717854, 6001.699915004254, 5977.521798256129, 5981.282246130449, 6005.039193728982, 6033.27600687918, 6069.08963655453, 5818.330891947396, 5936.109583562457, 5949.940500594982, 5983.58114931955, 6024.21685180928, 5805.245318108661, 5840.0, 5894.58737888348, 5897.3218079920925, 5972.522198224132, 6411.198600174978, 6429.871402571969, 6452.1289625900845, 6461.967690161519, 6511.25120611131, 6715.865682686368, 6753.392194702451, 6814.965925170392, 6842.4868134890085, 6895.655217239168, 6950.826229344257, 6966.79099627007, 6974.058502102202, 6991.930080699179, 7007.649617519103, 6440.5491615586925, 6466.967665161644, 6476.8704625907685, 6485.481161507115, 6489.253735820394, 7046.894296585555, 7062.964685176644, 7069.540479868792, 7130.465215108888, 7194.028806111212, 6575.112359831457, 6773.221079575912, 6789.219239787389, 6850.109485766819, 6874.381305682513, 6791.422729068085, 6816.897746533806, 6847.760328388483, 6896.448284137257, 6932.168139823153, 6846.075779769767, 6872.931270687229, 6878.621675807879, 6879.071325371111, 6920.723171073201, 6825.078614387094, 6881.965590172017, 6908.0, 6962.7911162665205, 6963.373296403348, 5397.568194544427, 5413.648112872651, 5480.013597552479, 5486.835394938078, 5491.0116179087345, 4703.223968045234, 4703.717776933395, 4769.403824521934, 4808.3989501312335, 4812.205986012339, 5974.61165024272, 6006.3693312201585, 6088.330283668793, 6094.329623741385, 6094.451499365078, 6985.441164706811, 6991.685374158175, 7000.754973576002, 7001.684924178424, 7006.684699188549, 6011.609245399035, 6015.218021657157, 6087.604305720114, 6089.238845144357, 6094.9695251524345, 5942.3166335871065, 5946.048632218824, 6001.729922153426, 6015.06766451192, 6017.909731354033, 6556.082148499214, 6661.367170118831, 6676.298988606223, 6752.3247675231105, 6774.627395493197, 6860.279670634711, 6924.272951340036, 6934.16789985205, 6948.513604047668, 6995.930040699528, 6662.600243985376, 6669.666516674244, 6764.289749576224, 6768.0, 6775.322467753185, 6787.694553744995, 6788.422984046411, 6813.012113243452, 6890.517663763489, 6893.345132212432, 6776.830579235361, 6836.077129587442, 6907.827304317432, 6913.308669133046, 6932.896006559805, 6675.198976122702, 6728.495362847708, 6744.5616034957575, 6748.966255168692, 6798.252192258947, 6700.195976482658, 6714.865702686016, 6788.898166527407, 6789.219239787488, 6796.116504854535, 6569.113169722026, 6622.70197841108, 6623.503237257129, 6710.698018589273, 6726.495512836655, 6740.6966686498245, 6747.0, 6761.256261811295, 6781.42357899584, 6781.796546103625, 6456.903146452901, 6517.348265173445, 6567.146270984741, 6575.243846957661, 6601.471882249504], "value": 6308.020084663691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.1121766057335, 811.9512829230247, 854.8162145138796, 875.991240087599, 883.8232353529291, 38551.80724096379, 39200.21599568007, 39272.03639818012, 39311.21377572451, 39325.99999999996, 35672.286554268896, 36314.09214769632, 36353.0911727207, 36391.27217455649, 36460.45309320362, 6897.862042759154, 7031.367176954073, 7032.8945065824055, 7033.753818616349, 7035.613041282727, 6752.696128674222, 6812.557183783063, 6816.42060424862, 6818.829529261759, 6821.420179284767, 6700.3969642732145, 6783.830404239884, 6804.863902721942, 6811.318868113199, 6816.147981502312, 6737.831554211135, 6752.426043786284, 6754.054432379471, 6764.425023872976, 6769.796906092825, 6310.242770867525, 6311.0, 6350.142730731338, 6358.0462930560325, 6364.840878978016, 32112.0, 32322.838385808154, 32354.029379118663, 32381.514277285623, 32426.513602295985, 3342.29811739535, 3362.277110421271, 3364.327134573071, 3365.865365385406, 3369.5956485221686, 25798.484030319287, 25917.61123583129, 25996.610050849253, 26054.478910421876, 26278.343041423926, 2749.8212616179885, 2865.28367908023, 2885.1200383882906, 2900.76793856491, 2901.8694158762696, 176406.0, 183827.0, 190462.0, 190668.0, 194026.0, 45565.0, 46351.0, 46357.0, 46590.5340946593, 46707.29939050917, 47744.28383574249, 47943.760281199066, 47953.0, 47973.0, 48076.51923480791, 14206.431742730176, 14300.785488217685, 14336.49822256216, 14338.856611433752, 14424.278786060864, 11837.112216583791, 11844.170908036527, 11845.763084738257, 11854.110941679408, 11863.347515886537, 12431.0, 12447.564335248222, 12448.31534265606, 12452.252864828139, 12560.937195314147, 5379.838604841861, 5415.241866138744, 5453.127499600124, 5462.453754624586, 5546.833594992157, 999.1008092716613, 1012.2307046644456, 1016.867807185076, 1021.667957913681, 1032.200044965158, 22393.55212895733, 28631.713682862905, 28675.713242867303, 28978.855105724757, 29138.562921556193, 1079.3146352066337, 1081.7457897394106, 1082.2478377527543, 1091.7434402915308, 1096.9067629251444, 12201.877981220252, 12219.144659873724, 12222.511099556095, 12257.877421225674, 12267.509299628093, 219252.0, 220004.0, 220356.0, 221782.0, 222321.0, 48479.5152048475, 48611.27083093757, 48642.75678621655, 48651.756741216064, 48732.512674873506, 1357.2060344698461, 1403.7927382451085, 1405.641561401836, 1426.1514398932825, 1429.9857001430062, 20801.0, 21015.369538913856, 21544.89227553915, 21630.459238519165, 21767.23814666479, 34416.65583344134, 34606.480902786985, 34704.132396690286, 34721.13197170091, 34842.0, 190444.0, 192205.0, 193138.03430982755, 194572.0, 194639.0, 29901.850490747405, 30052.398952021274, 31660.050198494082, 33164.33671326608, 33313.500297496044, 43478.34782478328, 43649.0, 43923.34114988342, 44211.77894110509, 44237.11525769531, 32442.188945276557, 32592.0, 32903.34193316168, 32996.34007319888, 33029.0, 30985.69014309828, 31669.524957125202, 31772.841135795097, 31970.52044219385, 32078.0, 34718.82640586781, 34842.82578587091, 35054.64945350514, 35089.64910350864, 35444.46833297554, 32130.196745080626, 32162.517562236117, 32175.51736723998, 32293.35413291768, 32519.349613008082, 23578.410539735956, 23816.88091559531, 24274.878625606758, 24311.51376972486, 24362.26913192607], "value": 15958.958695750067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2558046637038, 559.2673597587161, 559.3036669346662, 576.4638885836171, 578.3233616668499, 21770.455738606543, 22354.21760238392, 22605.208817691386, 22643.660345094795, 22672.659910101363, 26151.73848261517, 26628.201153965412, 26641.467170656575, 26646.60030099545, 26690.866545667293, 6579.374959378863, 6728.461723062168, 6729.7644582439625, 6731.56244844086, 6740.764073257437, 6388.105665206875, 6588.0, 6644.43522300605, 6656.667166641672, 6665.566738162028, 6593.67031648418, 6622.53642245043, 6624.171978502687, 6627.569208001489, 6639.0, 6615.206175258952, 6618.602883826986, 6619.040239165318, 6628.734850606018, 6629.867402651968, 6116.785912493041, 6136.631802091889, 6143.139960405502, 6149.2313460817395, 6163.8150855474405, 28147.85926070377, 29521.852390738124, 29974.100776976724, 30116.849415753, 30319.545206821917, 1975.0, 2010.6179825833192, 2011.1854698846844, 2011.265887950902, 2011.5373464103338, 19667.901660491607, 20283.0, 20288.79711202884, 20334.694979575317, 20336.186552538027, 2352.3226265006288, 2364.290712786157, 2405.6271277951946, 2433.0997530913496, 2447.9755202447927, 137246.0, 141538.0, 141553.0, 141559.0, 142067.99999999895, 14167.858321416654, 14811.555653330417, 14916.552503424915, 14919.254037298091, 15203.695926081416, 22727.545449091256, 22739.204127855446, 22777.202797902326, 22950.885245573667, 23463.88268058649, 9744.366616169926, 9745.756356091013, 9856.620073189759, 9913.0, 10034.44810535413, 8959.148880856308, 9035.954820225988, 9070.319726020574, 9149.588268527932, 9166.770830729152, 8992.8651070234, 9072.228860546928, 9075.91089069316, 9340.439573625605, 9444.527773611291, 2652.9602055969176, 2697.1234348836706, 2742.450515458799, 2753.6420265365373, 2786.8885244590397, 962.5187406296851, 963.604921981984, 974.3763991045737, 977.3256453047375, 997.2470784557613, 19720.30978915731, 20200.393988180378, 20387.0, 20489.07799149042, 20628.587428251652, 999.5651891427252, 1026.2867307221409, 1031.293563908725, 1033.4316126130598, 1039.2569312941284, 10944.4527773611, 10977.83533247002, 11188.0, 11222.719432014264, 11363.886361136283, 463558.0, 466755.0, 490121.0, 491231.0, 499984.0, 115451.0, 119250.4037479807, 120284.3985780083, 121255.39372303082, 123010.0, 1195.8266051422495, 1201.1742151929018, 1235.3329202230696, 1237.5915947737406, 1249.4689756853302, 20937.16251349929, 21099.683504747132, 21215.151393944685, 21533.0, 21602.675959860928, 47893.982020518386, 48657.756711216214, 57887.710561446926, 59618.40381596128, 61435.69282153561, 71421.0, 73954.63022684852, 74228.62885685537, 74614.0, 75483.24516754982, 14308.356123974238, 14435.639109022359, 14576.562703118923, 14640.04839685417, 14677.853221468076, 22837.0, 22993.195238166583, 23181.304560863202, 23413.76586234184, 23436.0, 18307.54231144232, 18469.168887400367, 18490.722639160154, 18592.81407185911, 18625.44123676292, 15424.843136764563, 16337.183140843148, 16579.834201658312, 16797.66404671924, 16907.492775216764, 17740.0, 18735.437936861916, 18782.812171878108, 18884.905575472585, 18999.620007599493, 14382.208978506282, 14460.566183014527, 14469.78295325592, 14483.0, 14608.561743147722, 18145.727814083064, 18259.54351141179, 18283.451496455127, 18340.26638934481, 18438.81561184371], "value": 12066.488282456032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.2157894473844, 1350.7298540291938, 1353.4045020191115, 1356.1456282541997, 1375.4429456070295, 14796.77804832927, 15468.69062618747, 15532.611684707888, 15545.06729596225, 15567.221638918052, 12775.872241277584, 13200.669983250424, 15163.696726065473, 15498.225088745574, 15553.144577048259, 2752.2568906395263, 2831.2214141111153, 2831.3629433377428, 2833.688294287627, 2840.573913912919, 2736.220177249484, 2758.517259479593, 2792.4833905727505, 2805.705400932903, 2807.1578526442086, 2778.9305267368377, 2791.6510436195476, 2804.2008027712104, 2804.957925631117, 2805.957910631342, 2700.837949723013, 2701.284159697672, 2722.2377734234346, 2726.1412655013605, 2734.767544758698, 2719.0, 2724.2508310214653, 2729.4404647047504, 2741.4791189673897, 2744.3687951771203, 14575.635609109857, 15099.094054356774, 15118.924405378013, 15123.773143402857, 15131.924340378338, 7994.680212791482, 8284.420090593661, 8300.83398332036, 8301.128381519913, 8302.501849889026, 5517.36550296717, 5583.162525621189, 5594.496495315441, 5743.253377060997, 5769.980506822579, 1924.8171423714725, 1934.177974360905, 1960.980390196094, 1967.881927084365, 2005.3081686818025, 25248.873755631288, 25481.0, 25489.23532294034, 25929.351766205808, 27241.1827645169, 6813.557118787263, 6922.342377474232, 6937.826554336081, 7007.93265986525, 7151.642417879085, 17173.398931037602, 17258.568535786704, 17260.0, 17272.740908886375, 17290.308387664605, 8032.879506807402, 8153.918460815435, 8156.796080098045, 8158.388120890957, 8167.469114507538, 7376.594287314142, 7485.1017877855, 7495.400367970549, 7523.059617547807, 7545.283198096172, 5171.086697921793, 5308.362996440452, 5338.91991620126, 5352.9732351338, 5365.946340536622, 1524.3521503361249, 1524.9390024399122, 1527.8013858198585, 1533.2563706602289, 1546.876249900028, 900.504722402676, 903.9457632542069, 915.3866909170871, 923.0953665407937, 927.8515437529962, 7639.427042971799, 7654.196309387546, 7656.961715191388, 7732.884006739903, 7738.303552680286, 688.896665500179, 689.9724011039602, 695.1658010387555, 728.0026363881516, 735.0224201811578, 4653.092646933816, 4722.598579120813, 4755.9286610700865, 5070.645054846199, 5322.068637988336, 20897.37307880766, 21761.129554817948, 21811.78188218129, 21823.0, 21864.125434982423, 21147.78852211489, 21439.142434302452, 21806.89096554507, 21923.890380547997, 21945.341639750834, 10089.293749437616, 10404.479776011169, 10464.843027354747, 11172.44137793107, 11421.371824549564, 8755.212030917248, 9101.726948191565, 9104.0, 9190.080991900757, 9196.54017299119, 18318.72521912199, 18479.630407392047, 18616.627667446846, 18985.24059037623, 19168.520786980436, 18450.169742361893, 18476.630467390307, 18477.90761046186, 18801.341953031577, 18831.24675012984, 12049.578264760692, 12279.386030698608, 12476.06429517808, 12483.251004939733, 12517.874821252035, 13989.370478328703, 13994.440222391398, 14170.504032358818, 14172.433102675777, 14223.928880355532, 11439.199256052329, 11456.656300311004, 11773.352465614473, 11785.410729463663, 11852.407379631157, 11380.715482112682, 11529.1929564933, 11536.653900383002, 11675.591354302558, 11856.680129563736, 9155.450672959643, 9359.251259899327, 9364.20404265645, 9497.192738617296, 9498.955114937213, 7303.744368947274, 7324.230955749569, 7327.816804579715, 7359.4480413968095, 7410.2219266978345, 7280.854382912206, 7354.705811767683, 7381.704731810667, 7382.889256661262, 7395.371393431618], "value": 6672.910443299514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.3919618065958, 507.9695218286903, 533.8718707510199, 536.8282149712091, 545.0434487474482, 6462.806115816533, 6467.223933128025, 6477.477792718707, 6497.935020649792, 6510.061412845232, 6165.599236049654, 6269.216347956505, 6269.843253918643, 6276.623402595847, 6291.245050593935, 5014.373203349582, 5066.240063990413, 5078.21287700407, 5116.260471439709, 5131.512506311894, 4875.171220892456, 5035.823746168885, 5046.268291097788, 5046.82336118236, 5102.770375333119, 4950.0, 4955.157623204046, 4961.727105009223, 4993.201087825949, 5003.949960500385, 4901.38254376055, 4929.827456039057, 4935.679180853251, 4946.455889852114, 4995.675281106753, 4426.84506042287, 4436.844710435119, 4491.887702807423, 4501.684882058257, 4520.389747384094, 6218.4714299284615, 6220.595661282047, 6230.345813689588, 6249.218847644044, 6317.87364252717, 5680.6141420603035, 5754.913676294859, 5760.7695692172265, 5767.307923049261, 5792.304923409218, 6575.441087507567, 6635.502337324671, 6658.467322614228, 6729.49528785343, 6761.594304341756, 4783.641226907996, 4797.856064318076, 4804.471508134103, 4815.374001379833, 4854.878628034327, 6815.659217039129, 6915.305750091159, 6919.584824910521, 6976.511843985041, 7017.508774385795, 4999.325091112726, 5011.949880501221, 5034.421041580192, 5046.798128074836, 5051.6716413433005, 5096.980603879239, 5115.795368185305, 5119.334486516804, 5159.251908473326, 5183.50756678115, 5727.828165155052, 5730.656160630376, 5770.826875193751, 5788.363280039192, 5812.994516891666, 6563.278039415661, 6619.801405957829, 6695.196576410862, 6699.296573859675, 6815.829604259834, 1632.4041724770373, 1695.279506209856, 1696.2027846912179, 1709.3419033671878, 1740.634466761969, 1184.9170558060853, 1240.3674126195706, 1244.869288724671, 1250.337321219755, 1257.69186549296, 5907.320658124285, 5910.822675319747, 5922.585419020714, 5946.762129514771, 5979.415454904454, 6762.323767623198, 6781.8643627127185, 6836.0, 6841.2132604750095, 6880.931190688129, 5892.587518873637, 5897.705114744245, 5909.674967876808, 5916.940830591725, 5921.378255283219, 3481.7040551552896, 3589.838457269429, 3622.728295377857, 3650.4889315495852, 3665.3585622515952, 6616.404523592803, 6678.298778628174, 6690.13028306317, 6717.261101278856, 6730.0, 6996.0, 7025.086738724035, 7030.824229394306, 7062.821730221421, 7077.52286699651, 6641.734330626721, 6648.667566621746, 6678.265390807007, 6682.966585167043, 6692.498062645321, 6781.6763840385065, 6822.897656535255, 6835.282295359115, 6863.725450982104, 6866.279040700654, 6585.934140658724, 6735.966320168368, 6763.560368576027, 6775.525713200029, 6790.966045169743, 6481.546291759531, 6566.573172743756, 6608.8347791305605, 6641.9667901662115, 6650.301718319507, 5004.199328107486, 5016.272640467038, 5041.924371134362, 5057.797688092435, 5082.263071854486, 6661.0, 6711.966440167963, 6735.562188457735, 6751.628660423724, 6777.830554236183, 6480.0, 6539.574927629689, 6548.1814773153355, 6583.572067815577, 6623.50971031514, 6605.919135472311, 6627.204735431586, 6628.469722422291, 6628.867422651423, 6646.136002319668, 6527.379898909596, 6549.377809108127, 6570.310117437601, 6575.769848055295, 6633.834154146185, 6434.324395938359, 6489.3510648934725, 6506.186726659168, 6604.570702904296, 6642.8742802302795, 5860.736266867916, 6360.0919724083515, 6387.169667943138, 6403.167588213502, 6447.194100737408], "value": 5112.618165527044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.8621706743987, 924.4730503612943, 927.7912469694315, 934.429997701402, 937.0254934867738, 19048.238070477182, 19528.0, 19632.312869049587, 19655.410337689875, 22459.55080898381, 19267.421977340666, 21279.787202127973, 21608.243711470102, 21613.351599452002, 21659.025343859525, 971.6793458158826, 977.1157102821923, 977.5112443778111, 977.9706608801747, 978.7210644966186, 997.4414327976357, 1004.8693669822912, 1006.1498034161123, 1006.8288390973515, 1011.5852500474807, 1043.5408420295084, 1051.6319288249128, 1056.8414737789317, 1062.978740425191, 1063.3991794636045, 1037.9429131397733, 1044.6082718980383, 1044.9164066874632, 1046.785408991155, 1053.1943063556384, 775.3409601838449, 775.9146493885668, 776.1307335783958, 776.5379599138504, 777.4480119115435, 18380.264789408408, 18961.90519047396, 19086.33197838069, 20132.29536966199, 20224.0, 21250.36248912535, 21480.355589332346, 21769.564608707737, 21825.454363641034, 21870.343889683336, 16609.4186703466, 17536.29854805806, 17658.11709414537, 17663.470095897013, 17823.197956092008, 3755.1550901047317, 3800.7909564973916, 3802.619738026203, 3806.9428958565645, 3806.9809650951843, 128053.0, 129043.0, 129238.0, 130506.0, 132779.0, 15904.204789760466, 15969.281382337822, 16203.108829014518, 16409.507714768577, 16474.258658360402, 29242.26894327616, 30226.84886575553, 30265.848670756506, 31292.84353578263, 31362.05913822589, 7004.684789184499, 7301.1968683444775, 8577.270931970728, 8672.089430609694, 8830.293576513863, 4060.796960151981, 4192.958070419318, 4200.85297014603, 4210.0948296116485, 4216.641585465209, 5162.199859021857, 5291.285676433709, 5293.417724050351, 5299.5230429261555, 5343.385510666245, 1055.6199768083484, 1067.9092277156528, 1069.6844430892904, 1086.9293495922739, 1091.3779145886926, 627.7771391156074, 636.2396935661932, 637.1207733327977, 639.0956796133419, 652.8596351784295, 11541.249818761753, 11745.706357341134, 12155.270683758827, 12725.172863763826, 12815.487380504861, 700.509643249717, 702.1083224305104, 703.521605308385, 707.8831992721247, 714.5783987447431, 5743.770249190069, 5749.9712501437225, 5806.564507661942, 5896.292444906639, 5966.194563733927, 113233.43383283031, 114605.0, 115292.0, 116635.0, 121614.0, 102687.0, 103418.0, 105530.47234763777, 109292.0, 110226.0, 82339.0, 82397.58801205955, 83483.58258208548, 85524.0, 86968.56515717381, 10865.891341086488, 12186.2078964867, 12217.877821221675, 12459.377031148588, 12477.500899964263, 42379.15241695211, 44620.55379446164, 45169.0966180668, 45321.32018019798, 46051.53948460473, 76231.61884190544, 77490.0, 80733.0, 83115.16884831074, 88440.0, 18774.342897998504, 19138.23447062102, 19304.903475483094, 19943.401697949084, 20171.798282016993, 16428.753568696717, 16721.5819604506, 16743.413980510624, 20003.899980500006, 20739.585208296052, 17360.913195433943, 17599.560010999827, 17971.101444927965, 18645.533861653566, 18720.344787932358, 16450.341986320414, 16498.34006639721, 18290.176942037906, 19256.22975080981, 19336.419907402236, 15939.043657380595, 15970.68058638844, 16027.759583606023, 16617.169141543116, 18860.622787544446, 12860.807087893876, 13242.735145297233, 13415.128016678884, 13571.86428135706, 13817.240051797247, 11978.58074967372, 12099.57651482194, 12122.27266364021, 12436.396883447045, 13482.123661961941], "value": 9213.772014786178, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 99.0, 109.0, 107.0, 111.0, 109.0, 97.0, 105.0, 111.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 140.0, 171.0, 117.0, 147.0, 146.0, 115.0, 160.0, 121.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 161.0, 164.0, 162.0, 163.0, 165.0, 169.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 80.0, 177.0, 74.0, 74.0, 74.0, 74.0, 156.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 80.0, 80.0, 79.0, 143.0, 82.0, 80.0, 127.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 149.0, 148.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 97.0, 95.0, 93.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 58.0, 55.0, 55.0, 62.0, 54.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 40.0, 39.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 73.0, 76.0, 74.0, 73.0, 74.0, 77.0, 74.0, 81.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 126.0, 129.0, 117.0, 122.0, 116.0, 116.0, 129.0, 156.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 176.0, 176.0, 184.0, 183.0, 177.0, 184.0, 176.0, 172.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0], "value": 64.7, "unit": "score"}]}]} 09:13:47 INFO - Return code: 0 09:13:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:47 INFO - # TBPL SUCCESS # 09:13:47 INFO - Running post-action listener: _package_coverage_data 09:13:47 INFO - Running post-action listener: _resource_record_post_action 09:13:47 INFO - [mozharness: 2017-09-01 16:13:47.154359Z] Finished run-tests step (success) 09:13:47 INFO - Running post-run listener: _resource_record_post_run 09:13:47 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394555392; Read time: 12; Write time: 195020 09:13:47 INFO - TinderboxPrint: CPU usage
13.1% 09:13:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:13:47 INFO - TinderboxPrint: I/O write bytes / time
394,555,392 / 195,020 09:13:47 INFO - TinderboxPrint: CPU idle
8,243.7 (86.9%) 09:13:47 INFO - TinderboxPrint: CPU user
1,193.0 (12.6%) 09:13:47 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107319296; Read time: 0; Write time: 53060 09:13:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:13:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287236096; Read time: 12; Write time: 141960 09:13:47 INFO - Running post-run listener: _upload_blobber_files 09:13:47 INFO - Blob upload gear active. 09:13:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:47 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 09:13:47 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'] 09:13:47 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 09:13:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:13:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:49 INFO - (blobuploader) - INFO - Done attempting. 09:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:50 INFO - (blobuploader) - INFO - Done attempting. 09:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:53 INFO - (blobuploader) - INFO - Done attempting. 09:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:54 INFO - (blobuploader) - INFO - Done attempting. 09:13:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:54 INFO - Return code: 0 09:13:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7d8cea9304707cc84a5b0856c31f34164458b6934f93a1eae7abcad0d1b9be8c2d6825165353833d7ecbb0a1610e2692c319526584c2355f5736051bbed668", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a0ab97c7ec94e91bdd7f5be39761308bd4817ea7812723a1d15ab46674d7685c78d18442b58892d67a2a59570f284e065f0e6c5a6c8da00616790e0fc48c88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42da2064933392fef7dc8cdbdfbdc7f83c06bc0cb13931c436062d9c3fb56e4ee1da29c1084ef1920f0bcdf387935922e8d7d6ceb21b5c7cb841d5273f0ec9a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3c8b5773f87e02fe7efcd1aedbbcb258e556442d07fcf472d2da6bfa47ccc87ce68c1962a249c1c517f251473fb7f095b8ca298a8c19018356c7fffdb07050"} 09:13:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:54 INFO - Contents: 09:13:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7d8cea9304707cc84a5b0856c31f34164458b6934f93a1eae7abcad0d1b9be8c2d6825165353833d7ecbb0a1610e2692c319526584c2355f5736051bbed668", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a0ab97c7ec94e91bdd7f5be39761308bd4817ea7812723a1d15ab46674d7685c78d18442b58892d67a2a59570f284e065f0e6c5a6c8da00616790e0fc48c88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42da2064933392fef7dc8cdbdfbdc7f83c06bc0cb13931c436062d9c3fb56e4ee1da29c1084ef1920f0bcdf387935922e8d7d6ceb21b5c7cb841d5273f0ec9a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3c8b5773f87e02fe7efcd1aedbbcb258e556442d07fcf472d2da6bfa47ccc87ce68c1962a249c1c517f251473fb7f095b8ca298a8c19018356c7fffdb07050"} 09:13:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:54 INFO - Copying logs to upload dir... 09:13:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.483300 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-01 09:13:54.474598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 09:13:54.477853) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7d8cea9304707cc84a5b0856c31f34164458b6934f93a1eae7abcad0d1b9be8c2d6825165353833d7ecbb0a1610e2692c319526584c2355f5736051bbed668", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a0ab97c7ec94e91bdd7f5be39761308bd4817ea7812723a1d15ab46674d7685c78d18442b58892d67a2a59570f284e065f0e6c5a6c8da00616790e0fc48c88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42da2064933392fef7dc8cdbdfbdc7f83c06bc0cb13931c436062d9c3fb56e4ee1da29c1084ef1920f0bcdf387935922e8d7d6ceb21b5c7cb841d5273f0ec9a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3c8b5773f87e02fe7efcd1aedbbcb258e556442d07fcf472d2da6bfa47ccc87ce68c1962a249c1c517f251473fb7f095b8ca298a8c19018356c7fffdb07050"} build_url:https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011079 build_url: 'https://queue.taskcluster.net/v1/task/P0kX4SRdS6ifTGg50JASWg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7d8cea9304707cc84a5b0856c31f34164458b6934f93a1eae7abcad0d1b9be8c2d6825165353833d7ecbb0a1610e2692c319526584c2355f5736051bbed668", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a0ab97c7ec94e91bdd7f5be39761308bd4817ea7812723a1d15ab46674d7685c78d18442b58892d67a2a59570f284e065f0e6c5a6c8da00616790e0fc48c88", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42da2064933392fef7dc8cdbdfbdc7f83c06bc0cb13931c436062d9c3fb56e4ee1da29c1084ef1920f0bcdf387935922e8d7d6ceb21b5c7cb841d5273f0ec9a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3c8b5773f87e02fe7efcd1aedbbcb258e556442d07fcf472d2da6bfa47ccc87ce68c1962a249c1c517f251473fb7f095b8ca298a8c19018356c7fffdb07050"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 09:13:54.506494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 09:13:54.506864) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504281183.818976-1681449348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 09:13:54.593030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 09:13:54.593395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 09:13:54.593923) ========= ========= Total master_lag: 0.19 =========