builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1505815590.19 results: success (0) revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.194784) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.195319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.195609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.219699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.220080) ========= 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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 03:06:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 68.3M=0s 2017-09-19 03:06:30 (68.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.409726 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.657945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.658284) ========= 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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:30.707764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-19 03:06:30.708105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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 e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 03:06:30,759 truncating revision to first 12 chars 2017-09-19 03:06:30,759 Setting DEBUG logging. 2017-09-19 03:06:30,759 attempt 1/10 2017-09-19 03:06:30,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e4261f5b96eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 03:06:31,981 unpacking tar archive at: mozilla-central-e4261f5b96eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.521453 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-19 03:06:32.457998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:32.458318) ========= script_repo_revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:32.458733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:32.459007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:06:32.472466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-19 03:06:32.472748) ========= /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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:32 INFO - MultiFileLogger online at 20170919 03:06:32 in /builds/slave/test 03:06:32 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 03:06:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:32 INFO - {'append_to_log': False, 03:06:32 INFO - 'base_work_dir': '/builds/slave/test', 03:06:32 INFO - 'blob_upload_branch': 'Firefox', 03:06:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:32 INFO - 'branch': 'Firefox', 03:06:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:32 INFO - 'code_coverage': False, 03:06:32 INFO - 'config_files': ('talos/linux_config.py',), 03:06:32 INFO - 'default_actions': ('clobber', 03:06:32 INFO - 'read-buildbot-config', 03:06:32 INFO - 'download-and-extract', 03:06:32 INFO - 'populate-webroot', 03:06:32 INFO - 'create-virtualenv', 03:06:32 INFO - 'install', 03:06:32 INFO - 'setup-mitmproxy', 03:06:32 INFO - 'run-tests'), 03:06:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:32 INFO - 'disable_ccov_upload': False, 03:06:32 INFO - 'disable_stylo': False, 03:06:32 INFO - 'download_minidump_stackwalk': True, 03:06:32 INFO - 'download_symbols': 'ondemand', 03:06:32 INFO - 'enable_stylo': False, 03:06:32 INFO - 'enable_webrender': False, 03:06:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:06:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:32 INFO - 'gecko_profile': False, 03:06:32 INFO - 'gecko_profile_interval': 0, 03:06:32 INFO - 'installer_path': 'installer.exe', 03:06:32 INFO - 'log_level': 'info', 03:06:32 INFO - 'log_name': 'talos', 03:06:32 INFO - 'log_to_console': True, 03:06:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:32 INFO - 'opt_config_files': (), 03:06:32 INFO - 'pip_index': False, 03:06:32 INFO - 'suite': 'dromaeojs-e10s', 03:06:32 INFO - 'system_bits': '32', 03:06:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:32 INFO - 'title': 'talos-linux64-ix-043', 03:06:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:32 INFO - 'use_talos_json': True, 03:06:32 INFO - 'verify': 'False', 03:06:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:32 INFO - 'work_dir': 'build'} 03:06:32 INFO - [mozharness: 2017-09-19 10:06:32.755464Z] Running clobber step. 03:06:32 INFO - Running pre-action listener: _resource_record_pre_action 03:06:32 INFO - Running main action method: clobber 03:06:32 INFO - rmtree: /builds/slave/test/build 03:06:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:33 INFO - Running post-action listener: _resource_record_post_action 03:06:33 INFO - [mozharness: 2017-09-19 10:06:33.701338Z] Finished clobber step (success) 03:06:33 INFO - [mozharness: 2017-09-19 10:06:33.701494Z] Running read-buildbot-config step. 03:06:33 INFO - Running pre-action listener: _resource_record_pre_action 03:06:33 INFO - Running main action method: read_buildbot_config 03:06:33 INFO - Using buildbot properties: 03:06:33 INFO - { 03:06:33 INFO - "project": "", 03:06:33 INFO - "product": "firefox", 03:06:33 INFO - "who": "archaeopteryx@coole-files.de", 03:06:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:06:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:06:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:06:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:06:33 INFO - "stage_platform": "linux64-qr", 03:06:33 INFO - "basedir": "/builds/slave/test", 03:06:33 INFO - "buildnumber": 66, 03:06:33 INFO - "platform": "ubuntu64_hw_qr", 03:06:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:06:33 INFO - "slavebuilddir": "test", 03:06:33 INFO - "taskId": "ewJFfKAKT4e5kG1n637sZg", 03:06:33 INFO - "branch": "mozilla-central", 03:06:33 INFO - "script_repo_revision": "production", 03:06:33 INFO - "revision": "e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5", 03:06:33 INFO - "slavename": "talos-linux64-ix-043", 03:06:33 INFO - "repo_path": "mozilla-central" 03:06:33 INFO - } 03:06:33 INFO - Finding installer, test and symbols from parent task. 03:06:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewJFfKAKT4e5kG1n637sZg'}, attempt #1 03:06:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewJFfKAKT4e5kG1n637sZg'}, attempt #1 03:06:34 INFO - Task dependencies: AgMWzaeiTGuANcVMqKHEPA 03:06:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA'}, attempt #1 03:06:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:06:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json 03:06:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip 03:06:35 INFO - Running post-action listener: _resource_record_post_action 03:06:35 INFO - [mozharness: 2017-09-19 10:06:35.066644Z] Finished read-buildbot-config step (success) 03:06:35 INFO - [mozharness: 2017-09-19 10:06:35.066860Z] Running download-and-extract step. 03:06:35 INFO - Running pre-action listener: _resource_record_pre_action 03:06:35 INFO - Running main action method: download_and_extract 03:06:35 INFO - mkdir: /builds/slave/test/build/tests 03:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:35 INFO - trying https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json 03:06:35 INFO - Downloading https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:06:35 INFO - Downloaded 989 bytes. 03:06:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:06:35 INFO - Using the following test package requirements: 03:06:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:06:35 INFO - u'common': [u'target.common.tests.zip'], 03:06:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:06:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:06:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:06:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:06:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:06:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:06:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:06:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:06:35 INFO - u'target.web-platform.tests.tar.gz'], 03:06:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:06:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:06:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip 03:06:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:35 INFO - Fetch https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip into memory 03:06:36 INFO - Content-Length response header: 54731519 03:06:36 INFO - Bytes received: 54731519 03:06:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip 03:06:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:06:47 INFO - Fetch https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip into memory 03:06:48 INFO - Content-Length response header: 14508787 03:06:48 INFO - Bytes received: 14508787 03:06:48 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')]} 03:06:48 INFO - trying https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:06:48 INFO - Downloading https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:06:49 INFO - Downloaded 61456923 bytes. 03:06:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:06:49 INFO - mkdir: /builds/slave/test/properties 03:06:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:49 INFO - Contents: 03:06:49 INFO - build_url:https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:06:49 INFO - Running post-action listener: _resource_record_post_action 03:06:49 INFO - Running post-action listener: find_tests_for_verification 03:06:49 INFO - Running post-action listener: set_extra_try_arguments 03:06:49 INFO - [mozharness: 2017-09-19 10:06:49.757091Z] Finished download-and-extract step (success) 03:06:49 INFO - [mozharness: 2017-09-19 10:06:49.757189Z] Running populate-webroot step. 03:06:49 INFO - Running pre-action listener: _resource_record_pre_action 03:06:49 INFO - Running main action method: populate_webroot 03:06:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['tresize', 03:06:49 INFO - 'tcanvasmark']}, 03:06:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['dromaeo_css', 03:06:49 INFO - 'kraken']}, 03:06:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'tests': ['damp', 'tps']}, 03:06:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['damp', 'tps']}, 03:06:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['dromaeo_dom']}, 03:06:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:06:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['basic_compositor_video', 03:06:49 INFO - 'glvideo']}, 03:06:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:06:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['ts_paint_webext', 03:06:49 INFO - 'tp5o_webext']}, 03:06:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:49 INFO - 'ts_paint', 03:06:49 INFO - 'tpaint', 03:06:49 INFO - 'sessionrestore', 03:06:49 INFO - 'sessionrestore_many_windows', 03:06:49 INFO - 'sessionrestore_no_auto_restore', 03:06:49 INFO - 'tabpaint']}, 03:06:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['a11yr', 03:06:49 INFO - 'ts_paint', 03:06:49 INFO - 'tpaint', 03:06:49 INFO - 'sessionrestore', 03:06:49 INFO - 'sessionrestore_many_windows', 03:06:49 INFO - 'sessionrestore_no_auto_restore', 03:06:49 INFO - 'tabpaint']}, 03:06:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:06:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:06:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['perf_reftest_singletons']}, 03:06:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['bloom_basic']}, 03:06:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:49 INFO - 'tsvgr_opacity', 03:06:49 INFO - 'tart', 03:06:49 INFO - 'tscrollx', 03:06:49 INFO - 'tsvg_static']}, 03:06:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['tsvgx', 03:06:49 INFO - 'tsvgr_opacity', 03:06:49 INFO - 'tart', 03:06:49 INFO - 'tscrollx', 03:06:49 INFO - 'tsvg_static']}, 03:06:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:06:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo'], 03:06:49 INFO - 'tests': ['tp5o']}, 03:06:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:49 INFO - 'talos_options': ['--mitmproxy', 03:06:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:49 INFO - '--firstNonBlankPaint'], 03:06:49 INFO - 'tests': ['tp6_google', 03:06:49 INFO - 'tp6_youtube', 03:06:49 INFO - 'tp6_amazon', 03:06:49 INFO - 'tp6_facebook']}, 03:06:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo', 03:06:49 INFO - '--mitmproxy', 03:06:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:49 INFO - '--firstNonBlankPaint'], 03:06:49 INFO - 'tests': ['tp6_google', 03:06:49 INFO - 'tp6_youtube', 03:06:49 INFO - 'tp6_amazon', 03:06:49 INFO - 'tp6_facebook']}, 03:06:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:49 INFO - 'talos_options': ['--stylo-threads=1', 03:06:49 INFO - '--mitmproxy', 03:06:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:49 INFO - '--firstNonBlankPaint'], 03:06:49 INFO - 'tests': ['tp6_google', 03:06:49 INFO - 'tp6_youtube', 03:06:49 INFO - 'tp6_amazon', 03:06:49 INFO - 'tp6_facebook']}, 03:06:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--xperf_path', 03:06:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:49 INFO - 'tests': ['tp5n']}, 03:06:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:06:49 INFO - 'talos_options': ['--disable-stylo', 03:06:49 INFO - '--xperf_path', 03:06:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:49 INFO - 'tests': ['tp5n']}}} 03:06:49 INFO - Running post-action listener: _resource_record_post_action 03:06:49 INFO - [mozharness: 2017-09-19 10:06:49.772310Z] Finished populate-webroot step (success) 03:06:49 INFO - [mozharness: 2017-09-19 10:06:49.772398Z] Running create-virtualenv step. 03:06:49 INFO - Running pre-action listener: _resource_record_pre_action 03:06:49 INFO - Running main action method: create_virtualenv 03:06:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:06:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:06:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:06:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:51 INFO - Installing pip...............done. 03:06:51 INFO - Return code: 0 03:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:06:51 INFO - Reading from file tmpfile_stdout 03:06:51 INFO - Output received: 03:06:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:06:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:51 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')]} 03:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:51 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')]} 03:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:51 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:06:51 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 03:06:51 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 03:06:51 INFO - Using env: {'DISPLAY': ':0', 03:06:51 INFO - 'HOME': '/home/cltbld', 03:06:51 INFO - 'LANG': 'en_US.UTF-8', 03:06:51 INFO - 'LANGUAGE': 'en_US:en', 03:06:51 INFO - 'LOGNAME': 'cltbld', 03:06:51 INFO - 'MAIL': '/var/mail/cltbld', 03:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:51 INFO - 'MOZ_NO_REMOTE': '1', 03:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:51 INFO - 'NO_EM_RESTART': '1', 03:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:51 INFO - 'PWD': '/builds/slave/test', 03:06:51 INFO - 'SHELL': '/bin/bash', 03:06:51 INFO - 'SHLVL': '1', 03:06:51 INFO - 'TERM': 'linux', 03:06:51 INFO - 'TMOUT': '86400', 03:06:51 INFO - 'USER': 'cltbld', 03:06:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:51 INFO - '_': '/tools/buildbot/bin/python'} 03:06:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:06:52 INFO - Downloading/unpacking pip>=1.5 03:06:52 INFO - Running setup.py egg_info for package pip 03:06:52 INFO - warning: no files found matching 'pip/cacert.pem' 03:06:52 INFO - warning: no files found matching '*.html' under directory 'docs' 03:06:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:06:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:06:52 INFO - Installing collected packages: pip 03:06:52 INFO - Found existing installation: pip 1.1 03:06:52 INFO - Uninstalling pip: 03:06:52 INFO - Successfully uninstalled pip 03:06:52 INFO - Running setup.py install for pip 03:06:52 INFO - warning: no files found matching 'pip/cacert.pem' 03:06:52 INFO - warning: no files found matching '*.html' under directory 'docs' 03:06:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:06:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:06:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Successfully installed pip 03:06:52 INFO - Cleaning up... 03:06:52 INFO - Return code: 0 03:06:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:52 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:06:52 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 03:06:52 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 03:06:52 INFO - Using env: {'DISPLAY': ':0', 03:06:52 INFO - 'HOME': '/home/cltbld', 03:06:52 INFO - 'LANG': 'en_US.UTF-8', 03:06:52 INFO - 'LANGUAGE': 'en_US:en', 03:06:52 INFO - 'LOGNAME': 'cltbld', 03:06:52 INFO - 'MAIL': '/var/mail/cltbld', 03:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:52 INFO - 'MOZ_NO_REMOTE': '1', 03:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:52 INFO - 'NO_EM_RESTART': '1', 03:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:52 INFO - 'PWD': '/builds/slave/test', 03:06:52 INFO - 'SHELL': '/bin/bash', 03:06:52 INFO - 'SHLVL': '1', 03:06:52 INFO - 'TERM': 'linux', 03:06:52 INFO - 'TMOUT': '86400', 03:06:52 INFO - 'USER': 'cltbld', 03:06:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:52 INFO - '_': '/tools/buildbot/bin/python'} 03:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:53 INFO - Downloading/unpacking psutil>=3.1.1 03:06: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 03:06: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 03:06: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 03:06: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 03:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:54 INFO - Installing collected packages: psutil 03:06:54 INFO - Running setup.py install for psutil 03:06:54 INFO - building 'psutil._psutil_linux' extension 03:06:54 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 03:06:55 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 03:06:55 INFO - building 'psutil._psutil_posix' extension 03:06:55 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 03:06:55 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 03:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:55 INFO - Successfully installed psutil 03:06:55 INFO - Cleaning up... 03:06:55 INFO - Return code: 0 03:06:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06: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')]} 03:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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')]} 03:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:06: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 mozsystemmonitor==0.3 03:06:55 INFO - Using env: {'DISPLAY': ':0', 03:06:55 INFO - 'HOME': '/home/cltbld', 03:06:55 INFO - 'LANG': 'en_US.UTF-8', 03:06:55 INFO - 'LANGUAGE': 'en_US:en', 03:06:55 INFO - 'LOGNAME': 'cltbld', 03:06:55 INFO - 'MAIL': '/var/mail/cltbld', 03:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:55 INFO - 'MOZ_NO_REMOTE': '1', 03:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:55 INFO - 'NO_EM_RESTART': '1', 03:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:55 INFO - 'PWD': '/builds/slave/test', 03:06:55 INFO - 'SHELL': '/bin/bash', 03:06:55 INFO - 'SHLVL': '1', 03:06:55 INFO - 'TERM': 'linux', 03:06:55 INFO - 'TMOUT': '86400', 03:06:55 INFO - 'USER': 'cltbld', 03:06:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:55 INFO - '_': '/tools/buildbot/bin/python'} 03:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:57 INFO - Installing collected packages: mozsystemmonitor 03:06:57 INFO - Running setup.py install for mozsystemmonitor 03:06:57 INFO - Successfully installed mozsystemmonitor 03:06:57 INFO - Cleaning up... 03:06:57 INFO - Return code: 0 03:06:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:57 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')]} 03:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:57 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')]} 03:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:57 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:06:57 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 03:06:57 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 03:06:57 INFO - Using env: {'DISPLAY': ':0', 03:06:57 INFO - 'HOME': '/home/cltbld', 03:06:57 INFO - 'LANG': 'en_US.UTF-8', 03:06:57 INFO - 'LANGUAGE': 'en_US:en', 03:06:57 INFO - 'LOGNAME': 'cltbld', 03:06:57 INFO - 'MAIL': '/var/mail/cltbld', 03:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:57 INFO - 'MOZ_NO_REMOTE': '1', 03:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:57 INFO - 'NO_EM_RESTART': '1', 03:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:57 INFO - 'PWD': '/builds/slave/test', 03:06:57 INFO - 'SHELL': '/bin/bash', 03:06:57 INFO - 'SHLVL': '1', 03:06:57 INFO - 'TERM': 'linux', 03:06:57 INFO - 'TMOUT': '86400', 03:06:57 INFO - 'USER': 'cltbld', 03:06:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:57 INFO - '_': '/tools/buildbot/bin/python'} 03:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:57 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 03:06:57 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 03:06:57 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 03:06:57 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 03:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:06:58 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 03:06:58 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 03:06:58 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 03:06:58 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 03:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:58 INFO - warning: no files found matching '*.txt' 03:06:58 INFO - no previously-included directories found matching 'build' 03:06:58 INFO - no previously-included directories found matching 'dist' 03:06:58 INFO - no previously-included directories found matching '.git*' 03:06:58 INFO - Installing collected packages: jsonschema, functools32 03:06:59 INFO - Running setup.py install for functools32 03:07:00 INFO - warning: no files found matching '*.txt' 03:07:00 INFO - no previously-included directories found matching 'build' 03:07:00 INFO - no previously-included directories found matching 'dist' 03:07:00 INFO - no previously-included directories found matching '.git*' 03:07:00 INFO - Successfully installed jsonschema functools32 03:07:00 INFO - Cleaning up... 03:07:00 INFO - Return code: 0 03:07:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:00 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')]} 03:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:00 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')]} 03:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:00 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:00 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 03:07:00 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 03:07:00 INFO - Using env: {'DISPLAY': ':0', 03:07:00 INFO - 'HOME': '/home/cltbld', 03:07:00 INFO - 'LANG': 'en_US.UTF-8', 03:07:00 INFO - 'LANGUAGE': 'en_US:en', 03:07:00 INFO - 'LOGNAME': 'cltbld', 03:07:00 INFO - 'MAIL': '/var/mail/cltbld', 03:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:00 INFO - 'MOZ_NO_REMOTE': '1', 03:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:00 INFO - 'NO_EM_RESTART': '1', 03:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:00 INFO - 'PWD': '/builds/slave/test', 03:07:00 INFO - 'SHELL': '/bin/bash', 03:07:00 INFO - 'SHLVL': '1', 03:07:00 INFO - 'TERM': 'linux', 03:07:00 INFO - 'TMOUT': '86400', 03:07:00 INFO - 'USER': 'cltbld', 03:07:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:00 INFO - '_': '/tools/buildbot/bin/python'} 03:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:00 INFO - Cleaning up... 03:07:00 INFO - Return code: 0 03:07:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:00 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')]} 03:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:00 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')]} 03:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:00 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:00 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 03:07:00 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 03:07:00 INFO - Using env: {'DISPLAY': ':0', 03:07:00 INFO - 'HOME': '/home/cltbld', 03:07:00 INFO - 'LANG': 'en_US.UTF-8', 03:07:00 INFO - 'LANGUAGE': 'en_US:en', 03:07:00 INFO - 'LOGNAME': 'cltbld', 03:07:00 INFO - 'MAIL': '/var/mail/cltbld', 03:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:00 INFO - 'MOZ_NO_REMOTE': '1', 03:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:00 INFO - 'NO_EM_RESTART': '1', 03:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:00 INFO - 'PWD': '/builds/slave/test', 03:07:00 INFO - 'SHELL': '/bin/bash', 03:07:00 INFO - 'SHLVL': '1', 03:07:00 INFO - 'TERM': 'linux', 03:07:00 INFO - 'TMOUT': '86400', 03:07:00 INFO - 'USER': 'cltbld', 03:07:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:00 INFO - '_': '/tools/buildbot/bin/python'} 03:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:00 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 03:07:00 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 03:07:00 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 03:07:00 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 03:07:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:01 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 03:07:01 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 03:07:01 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 03:07:01 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 03:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:02 INFO - Downloading docopt-0.6.1.tar.gz 03:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:02 INFO - Running setup.py install for blobuploader 03:07:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:02 INFO - Running setup.py install for requests 03:07:03 INFO - Running setup.py install for docopt 03:07:03 INFO - Successfully installed blobuploader requests docopt 03:07:03 INFO - Cleaning up... 03:07:03 INFO - Return code: 0 03:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:03 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')]} 03:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:03 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')]} 03:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:03 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:03 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 03:07:03 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 03:07:03 INFO - Using env: {'DISPLAY': ':0', 03:07:03 INFO - 'HOME': '/home/cltbld', 03:07:03 INFO - 'LANG': 'en_US.UTF-8', 03:07:03 INFO - 'LANGUAGE': 'en_US:en', 03:07:03 INFO - 'LOGNAME': 'cltbld', 03:07:03 INFO - 'MAIL': '/var/mail/cltbld', 03:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:03 INFO - 'MOZ_NO_REMOTE': '1', 03:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:03 INFO - 'NO_EM_RESTART': '1', 03:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:03 INFO - 'PWD': '/builds/slave/test', 03:07:03 INFO - 'SHELL': '/bin/bash', 03:07:03 INFO - 'SHLVL': '1', 03:07:03 INFO - 'TERM': 'linux', 03:07:03 INFO - 'TMOUT': '86400', 03:07:03 INFO - 'USER': 'cltbld', 03:07:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:03 INFO - '_': '/tools/buildbot/bin/python'} 03:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:03 INFO - Running setup.py (path:/tmp/pip-2eeOp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:03 INFO - Running setup.py (path:/tmp/pip-DZqSue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:03 INFO - Running setup.py (path:/tmp/pip-8KGBIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:03 INFO - Running setup.py (path:/tmp/pip-bBgPON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:03 INFO - Running setup.py (path:/tmp/pip-0uUEWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:03 INFO - Running setup.py (path:/tmp/pip-4xLaEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:03 INFO - Running setup.py (path:/tmp/pip-0cpPqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:03 INFO - Running setup.py (path:/tmp/pip-3Vz84c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:03 INFO - Running setup.py (path:/tmp/pip-nnyXGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:03 INFO - Running setup.py (path:/tmp/pip-_9fCcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:03 INFO - Running setup.py (path:/tmp/pip-eT9L_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:04 INFO - Running setup.py (path:/tmp/pip-VXBFNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:04 INFO - Running setup.py (path:/tmp/pip-fZ5jjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:04 INFO - Running setup.py (path:/tmp/pip-6t_Oqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:04 INFO - Running setup.py (path:/tmp/pip-yRBLjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:04 INFO - Running setup.py (path:/tmp/pip-XPI07o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:04 INFO - Running setup.py (path:/tmp/pip-loPTPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:04 INFO - Running setup.py install for manifestparser 03:07:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:04 INFO - Running setup.py install for mozcrash 03:07:04 INFO - Running setup.py install for mozdebug 03:07:04 INFO - Running setup.py install for mozdevice 03:07:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:04 INFO - Running setup.py install for mozfile 03:07:04 INFO - Running setup.py install for mozhttpd 03:07:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozinfo 03:07:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozInstall 03:07:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozleak 03:07:05 INFO - Running setup.py install for mozlog 03:07:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for moznetwork 03:07:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozprocess 03:07:05 INFO - Running setup.py install for mozprofile 03:07:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozrunner 03:07:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:05 INFO - Running setup.py install for mozscreenshot 03:07:05 INFO - Running setup.py install for moztest 03:07:06 INFO - Running setup.py install for mozversion 03:07:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:06 INFO - Cleaning up... 03:07:06 INFO - Return code: 0 03:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:06 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:06 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 03:07:06 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 03:07:06 INFO - Using env: {'DISPLAY': ':0', 03:07:06 INFO - 'HOME': '/home/cltbld', 03:07:06 INFO - 'LANG': 'en_US.UTF-8', 03:07:06 INFO - 'LANGUAGE': 'en_US:en', 03:07:06 INFO - 'LOGNAME': 'cltbld', 03:07:06 INFO - 'MAIL': '/var/mail/cltbld', 03:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:06 INFO - 'MOZ_NO_REMOTE': '1', 03:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:06 INFO - 'NO_EM_RESTART': '1', 03:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:06 INFO - 'PWD': '/builds/slave/test', 03:07:06 INFO - 'SHELL': '/bin/bash', 03:07:06 INFO - 'SHLVL': '1', 03:07:06 INFO - 'TERM': 'linux', 03:07:06 INFO - 'TMOUT': '86400', 03:07:06 INFO - 'USER': 'cltbld', 03:07:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:06 INFO - '_': '/tools/buildbot/bin/python'} 03:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:06 INFO - Running setup.py (path:/tmp/pip-G4t1hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:06 INFO - Running setup.py (path:/tmp/pip-pzgv3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:06 INFO - Running setup.py (path:/tmp/pip-k4ZzWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:06 INFO - Running setup.py (path:/tmp/pip-9q874z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:06 INFO - Running setup.py (path:/tmp/pip-0uQSbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:06 INFO - Running setup.py (path:/tmp/pip-3CdP_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:06 INFO - Running setup.py (path:/tmp/pip-JBr6IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:06 INFO - Running setup.py (path:/tmp/pip-0U6z_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:06 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)) 03:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:06 INFO - Running setup.py (path:/tmp/pip-uxvFGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:07 INFO - Running setup.py (path:/tmp/pip-rUrCIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:07 INFO - Running setup.py (path:/tmp/pip-qHVyAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:07 INFO - Running setup.py (path:/tmp/pip-exIOhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:07 INFO - Running setup.py (path:/tmp/pip-753j9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:07 INFO - Running setup.py (path:/tmp/pip-z8K93m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:07 INFO - Running setup.py (path:/tmp/pip-q1jixE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:07 INFO - Running setup.py (path:/tmp/pip-FZeYef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:07 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)) 03:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:07 INFO - Running setup.py (path:/tmp/pip-6WhVvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:07 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)) 03:07:07 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)) 03:07:07 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)) 03:07:07 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)) 03:07:07 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)) 03:07:07 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)) 03:07:07 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)) 03:07:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:08 INFO - Downloading blessings-1.6.tar.gz 03:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:08 INFO - Installing collected packages: blessings 03:07:08 INFO - Running setup.py install for blessings 03:07:08 INFO - Successfully installed blessings 03:07:08 INFO - Cleaning up... 03:07:09 INFO - Return code: 0 03:07:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:09 INFO - Reading from file tmpfile_stdout 03:07:09 INFO - Current package versions: 03:07:09 INFO - argparse == 1.2.1 03:07:09 INFO - blessings == 1.6 03:07:09 INFO - blobuploader == 1.2.4 03:07:09 INFO - docopt == 0.6.1 03:07:09 INFO - functools32 == 3.2.3-2 03:07:09 INFO - jsonschema == 2.5.1 03:07:09 INFO - manifestparser == 1.1 03:07:09 INFO - mozInstall == 1.13 03:07:09 INFO - mozcrash == 1.0 03:07:09 INFO - mozdebug == 0.1 03:07:09 INFO - mozdevice == 0.51 03:07:09 INFO - mozfile == 1.2 03:07:09 INFO - mozhttpd == 0.7 03:07:09 INFO - mozinfo == 0.10 03:07:09 INFO - mozleak == 0.1 03:07:09 INFO - mozlog == 3.5 03:07:09 INFO - moznetwork == 0.27 03:07:09 INFO - mozprocess == 0.25 03:07:09 INFO - mozprofile == 0.28 03:07:09 INFO - mozrunner == 6.13 03:07:09 INFO - mozscreenshot == 0.1 03:07:09 INFO - mozsystemmonitor == 0.3 03:07:09 INFO - moztest == 0.8 03:07:09 INFO - mozversion == 1.4 03:07:09 INFO - psutil == 3.1.1 03:07:09 INFO - requests == 1.2.3 03:07:09 INFO - wsgiref == 0.1.2 03:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07: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')]} 03:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:09 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 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:09 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 03:07:09 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 03:07:09 INFO - Using env: {'DISPLAY': ':0', 03:07:09 INFO - 'HOME': '/home/cltbld', 03:07:09 INFO - 'LANG': 'en_US.UTF-8', 03:07:09 INFO - 'LANGUAGE': 'en_US:en', 03:07:09 INFO - 'LOGNAME': 'cltbld', 03:07:09 INFO - 'MAIL': '/var/mail/cltbld', 03:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:09 INFO - 'MOZ_NO_REMOTE': '1', 03:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:09 INFO - 'NO_EM_RESTART': '1', 03:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:09 INFO - 'PWD': '/builds/slave/test', 03:07:09 INFO - 'SHELL': '/bin/bash', 03:07:09 INFO - 'SHLVL': '1', 03:07:09 INFO - 'TERM': 'linux', 03:07:09 INFO - 'TMOUT': '86400', 03:07:09 INFO - 'USER': 'cltbld', 03:07:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:09 INFO - '_': '/tools/buildbot/bin/python'} 03:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 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)) 03:07:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:07:10 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)) 03:07:10 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)) 03:07:10 INFO - Installing collected packages: simplejson 03:07:10 INFO - Running setup.py install for simplejson 03:07:10 INFO - building 'simplejson._speedups' extension 03:07:10 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 03:07:11 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 03:07:11 INFO - Successfully installed simplejson 03:07:11 INFO - Cleaning up... 03:07:11 INFO - Return code: 0 03:07:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, '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': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', '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 03:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:07:11 INFO - Using env: {'DISPLAY': ':0', 03:07:11 INFO - 'HOME': '/home/cltbld', 03:07:11 INFO - 'LANG': 'en_US.UTF-8', 03:07:11 INFO - 'LANGUAGE': 'en_US:en', 03:07:11 INFO - 'LOGNAME': 'cltbld', 03:07:11 INFO - 'MAIL': '/var/mail/cltbld', 03:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:11 INFO - 'MOZ_NO_REMOTE': '1', 03:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:11 INFO - 'NO_EM_RESTART': '1', 03:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:11 INFO - 'PWD': '/builds/slave/test', 03:07:11 INFO - 'SHELL': '/bin/bash', 03:07:11 INFO - 'SHLVL': '1', 03:07:11 INFO - 'TERM': 'linux', 03:07:11 INFO - 'TMOUT': '86400', 03:07:11 INFO - 'USER': 'cltbld', 03:07:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:11 INFO - '_': '/tools/buildbot/bin/python'} 03:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:11 INFO - Cleaning up... 03:07:11 INFO - Return code: 0 03:07:11 INFO - Running post-action listener: _resource_record_post_action 03:07:11 INFO - Running post-action listener: _start_resource_monitoring 03:07:11 INFO - Starting resource monitoring. 03:07:11 INFO - [mozharness: 2017-09-19 10:07:11.961787Z] Finished create-virtualenv step (success) 03:07:11 INFO - [mozharness: 2017-09-19 10:07:11.962916Z] Running install step. 03:07:11 INFO - Running pre-action listener: _resource_record_pre_action 03:07:11 INFO - Running main action method: install 03:07:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:12 INFO - Reading from file tmpfile_stdout 03:07:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:12 INFO - Reading from file tmpfile_stdout 03:07:12 INFO - Output received: 03:07:12 INFO - Usage: mozinstall [options] installer 03:07:12 INFO - Options: 03:07:12 INFO - -h, --help show this help message and exit 03:07:12 INFO - -d DEST, --destination=DEST 03:07:12 INFO - Directory to install application into. [default: 03:07:12 INFO - "/builds/slave/test"] 03:07:12 INFO - --app=APP Application being installed. [default: firefox] 03:07:12 INFO - mkdir: /builds/slave/test/build/application 03:07:12 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'] 03:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:07:30 INFO - Reading from file tmpfile_stdout 03:07:30 INFO - Output received: 03:07:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:30 INFO - Running post-action listener: _resource_record_post_action 03:07:30 INFO - [mozharness: 2017-09-19 10:07:30.099701Z] Finished install step (success) 03:07:30 INFO - [mozharness: 2017-09-19 10:07:30.099955Z] Running setup-mitmproxy step. 03:07:30 INFO - Running pre-action listener: _resource_record_pre_action 03:07:30 INFO - Running main action method: setup_mitmproxy 03:07:30 INFO - Skipping: mitmproxy is not required 03:07:30 INFO - Running post-action listener: _resource_record_post_action 03:07:30 INFO - [mozharness: 2017-09-19 10:07:30.101074Z] Finished setup-mitmproxy step (success) 03:07:30 INFO - [mozharness: 2017-09-19 10:07:30.101292Z] Running run-tests step. 03:07:30 INFO - Running pre-action listener: _resource_record_pre_action 03:07:30 INFO - Running pre-action listener: _set_gcov_prefix 03:07:30 INFO - Running main action method: run_tests 03:07:30 WARNING - Try message not found. 03:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:30 INFO - Python 2.7.3 03:07:30 INFO - Return code: 0 03:07:30 INFO - grabbing minidump binary from tooltool 03:07:30 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')]} 03:07:30 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 0x1b70090>, '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 0x1b70d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:30 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 03:07:30 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 03:07:30 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 03:07:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:30 INFO - Return code: 0 03:07:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:30 INFO - ENV: RUST_BACKTRACE is now full 03:07:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:30 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/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:07:30 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/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 03:07:30 INFO - Using env: {'DISPLAY': ':0', 03:07:30 INFO - 'HOME': '/home/cltbld', 03:07:30 INFO - 'LANG': 'en_US.UTF-8', 03:07:30 INFO - 'LANGUAGE': 'en_US:en', 03:07:30 INFO - 'LOGNAME': 'cltbld', 03:07:30 INFO - 'MAIL': '/var/mail/cltbld', 03:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:30 INFO - 'MOZ_ACCELERATED': '1', 03:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:30 INFO - 'MOZ_NO_REMOTE': '1', 03:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:30 INFO - 'MOZ_WEBRENDER': '1', 03:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:30 INFO - 'NO_EM_RESTART': '1', 03:07:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:30 INFO - 'PWD': '/builds/slave/test', 03:07:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:30 INFO - 'RUST_BACKTRACE': 'full', 03:07:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:07:30 INFO - 'SHELL': '/bin/bash', 03:07:30 INFO - 'SHLVL': '1', 03:07:30 INFO - 'TERM': 'linux', 03:07:30 INFO - 'TMOUT': '86400', 03:07:30 INFO - 'USER': 'cltbld', 03:07:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:30 INFO - '_': '/tools/buildbot/bin/python'} 03:07:30 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/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:07:30 INFO - mozversion application_buildid: 20170919091230 03:07:30 INFO - mozversion application_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:07:30 INFO - mozversion application_display_name: Nightly 03:07:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:30 INFO - mozversion application_name: Firefox 03:07:30 INFO - mozversion application_remotingname: firefox 03:07:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:07:30 INFO - mozversion application_vendor: Mozilla 03:07:30 INFO - mozversion application_version: 57.0a1 03:07:30 INFO - mozversion platform_buildid: 20170919091230 03:07:30 INFO - mozversion platform_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:07:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:07:30 INFO - mozversion platform_version: 57.0a1 03:07:30 INFO - using testdate: 1505815650 03:07:30 INFO - actual date: 1505815650 03:07:30 INFO - starting webserver on 'localhost:35674' 03:07:30 INFO - SUITE-START | Running 2 tests 03:07:30 INFO - TEST-START | dromaeo_css 03:07:30 INFO - Initialising browser for dromaeo_css test... 03:07:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35674/getInfo.html -profile /tmp/tmpfr9BOK/profile 03:07:30 INFO - TEST-INFO | started process 3556 (/builds/slave/test/build/application/firefox/firefox http://localhost:35674/getInfo.html) 03:07:39 INFO - TEST-INFO | 3556: exit 0 03:07:39 INFO - Browser initialized. 03:07:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:39 INFO - Using env: {'DISPLAY': ':0', 03:07:39 INFO - 'HOME': '/home/cltbld', 03:07:39 INFO - 'JSGC_DISABLE_POISONING': '1', 03:07:39 INFO - 'LANG': 'en_US.UTF-8', 03:07:39 INFO - 'LANGUAGE': 'en_US:en', 03:07:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:07:39 INFO - 'LOGNAME': 'cltbld', 03:07:39 INFO - 'MAIL': '/var/mail/cltbld', 03:07:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:39 INFO - 'MOZ_ACCELERATED': '1', 03:07:39 INFO - 'MOZ_CRASHREPORTER': '1', 03:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:07:39 INFO - 'MOZ_NO_REMOTE': '1', 03:07:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:39 INFO - 'MOZ_WEBRENDER': '1', 03:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:39 INFO - 'NO_EM_RESTART': '1', 03:07:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:39 INFO - 'PWD': '/builds/slave/test', 03:07:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:39 INFO - 'RUST_BACKTRACE': 'full', 03:07:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:07:39 INFO - 'SHELL': '/bin/bash', 03:07:39 INFO - 'SHLVL': '1', 03:07:39 INFO - 'TERM': 'linux', 03:07:39 INFO - 'TMOUT': '86400', 03:07:39 INFO - 'USER': 'cltbld', 03:07:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:39 INFO - '_': '/tools/buildbot/bin/python'} 03:07:39 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfr9BOK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:40 INFO - PID 3800 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:07:40 INFO - PID 3800 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:07:41 INFO - PID 3800 | 03:07:41 INFO - PID 3800 | (/builds/slave/test/build/application/firefox/firefox:3860): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:07:41 INFO - PID 3800 | 03:07:51 INFO - PID 3800 | RSS: Main: 199487488 03:07:51 INFO - PID 3800 | 03:10:48 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35674/tests/dromaeo/cssquery-ext.html) 03:10:50 INFO - PID 3800 | RSS: Main: 201732096 03:10:50 INFO - PID 3800 | 03:13:52 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-ext.html (next: http://localhost:35674/tests/dromaeo/cssquery-jquery.html) 03:13:53 INFO - PID 3800 | RSS: Main: 202162176 03:13:53 INFO - PID 3800 | 03:16:55 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35674/tests/dromaeo/cssquery-mootools.html) 03:16:55 INFO - PID 3800 | RSS: Main: 206594048 03:16:55 INFO - PID 3800 | 03:19:58 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35674/tests/dromaeo/cssquery-prototype.html) 03:19:58 INFO - PID 3800 | RSS: Main: 202129408 03:19:58 INFO - PID 3800 | 03:23:02 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35674/tests/dromaeo/cssquery-yui.html) 03:23:02 INFO - PID 3800 | RSS: Main: 201592832 03:23:02 INFO - PID 3800 | 03:26:04 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:35674/tests/dromaeo/cssquery-yui.html (next: http://localhost:35674/tests/dromaeo/cssquery-dojo.html) 03:26:05 INFO - PID 3800 | RSS: Main: 206782464 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | __start_tp_report 03:26:05 INFO - PID 3800 | _x_x_mozilla_page_load 03:26:05 INFO - PID 3800 | _x_x_mozilla_page_load_details 03:26:05 INFO - PID 3800 | |i|pagename|runs| 03:26:05 INFO - PID 3800 | |0;dojo.html;3122.266267427155;3134.2164458885277;3148.8268145252;3152.6216853977526;3163.066895265896;6062.605930614507;6317.589356691818;6363.777267795628;6385.904211436827;6440.323766004566;6146.477549408306;6262.84342891428;6280.65456399899;6311.652859092748;6344.904826427596;5762.250907382045;5784.074548072309;5789.565782566325;5793.188953546507;5870.060790273557;5844.707764611774;5862.824115276549;5906.704664766745;5945.821625351246;5990.820275391723;561.7692346740214;5836.795712150076;5862.32583252925;5905.852353691171;5928.436798504135;5682.232898558683;5703.714814259312;5730.169125476783;5840.3575606683235;5843.152742852305;5692.203091567184;5780.71096445176;5788.652680839121;5840.853978650525;5857.648541087548;6292.244930608356;6320.74717011319;6340.524460665469;6376.39424254695;6390.840228994266;6717.865642687168;6793.286704895964;6800.761973330909;6851.588904665686;6865.244823069508;6872.037914691947;6878.518503704742;6954.826129346807;6957.5129740918155;6959.6868140933775;6123.050927106306;6271.560990730651;6273.843153921142;6274.466670333073;6333.429991300805;6836.316368363124;6836.487263455261;6867.759628412981;6870.038194652752;6896;6570.474362051024;6590.373914478117;6600.1089852869245;6622.86754264912;6656.70044847983;6722.798316050526;6740.393364597112;6759.831004224835;6786.185657721105;6849.349311815469;6684.331566843277;6707.128073350434;6727.62998035103;6795.490338224653;6828.556143850733;6570.868582628321;6686.431653309523;6695.966520167368;6721.932780672229;6871.278515755874;5238.895222095537;5245.632805703564;5293.100172970604;5299.735013249322;5304.151335786333;4607.631389488833;4627.143978363946;4651.325557794101;4713.363695901009;4732.645051621073;5756.33802112754;5793.623414478046;5860.355360910296;5883.058710606282;5884.08796636522;6760.864782704417;6775.1192344995825;6865.244823069458;6884.48366372514;6886;5613.775448982076;5719.628224165416;5749.1663708762835;5783;5849.181114643953;5803.738831752581;5850.151727999501;5864;5897.970510147422;5911.261092363455;6515.055316979012;6550.181227346582;6564.86870262592;6619.966900165468;6620.337966203341;6844.726210951606;6846.418054465426;6875.037494750839;6922.2731613180895;6932.341427564374;6312.3056463788025;6400.55196136266;6511.2512061113575;6512.218533775977;6596.967015164893;6513.316101809241;6586.077949087227;6587.604743715392;6597.043428702716;6621.702023408862;6617.305182955721;6678.699458524281;6755.2231493378895;6770.627615480998;6855.828604284733;6625.138731964814;6649.501287403367;6669.46644268467;6694.698738556874;6741.662916854236;6612.471002319707;6621.735130594915;6690.59856408617;6705.0612914193025;6722.697478613376;6301.275353334425;6379.138816259746;6439.83900402475;6510.837229069311;6515.413612774873;6490.188726409199;6528.249251336157;6573.704183311666;6584.703688333941;6598.967005164944;6103;6240.12638230639;6363.140975968185;6391.58454700443;6435.03474478832 03:26:05 INFO - PID 3800 | |1;ext.html;853.053111046738;877.2324216310726;884.1379654836531;889.1197714262878;902.9006809250977;41485.79257103714;42294.36558451626;42356.15287694244;42371.788141059325;42402.36396454056;37531.62468375315;37815;37822.24355512888;37842.24315513688;37898.81050594743;7222.1333439987275;7279.708811647554;7309.34215920567;7318.926810731904;7339.412846972256;7181.748638797643;7269;7269.454790890704;7284.053073100489;7290.234525374839;7241.746538871141;7263.491555591111;7263.946727724477;7268.636568171597;7664.310212080912;7819.100803407596;7872.606369681493;7924.564148971805;7958.164392738795;7959.084705258853;7732.1108072571815;7849.882251766228;7896.7236146734585;7906.44654874159;7930.603469826543;36792.26415471676;38923.805380973194;39361.803190984145;39607.603923960676;39701.80149099265;3490.1623610333336;3517.876874309387;3537.5047493350694;3546.078019714867;3550.218951830593;31807.522887156712;31819.204519886956;32012.519812202834;32097.51853722196;32143.51784723231;5132.74336283188;5147.124988751883;5160.716160611165;5175.353080864892;5191.922121168185;185634;186012.99999999863;187872;188356;188901.99999999863;39771;40713.796431017654;48897;49650.255246171335;49767.25349119766;50749.746251269244;50881.23678144831;50886;50964.74517627388;50991.745041275295;15922.840771592137;16019.759703604455;16192.75710864338;16196.838031619533;16232.350705971865;13236;13239.338033098307;13416.329183540784;13426.261555614536;13449.260290683911;14572.125672459686;14592;14614.34235459407;14646.26768661584;14746.926265368604;5735.1970724098655;5820.883582328414;5823.30120385548;5842.941570584325;5989.700514974234;984.3186482555192;987.2792861211356;998.5805961496189;1003.3929472669076;1015.2740790334946;22145.889270553544;22356.77643223547;22440.55118897613;22637.094516219167;22901.541969160855;1106.2753896198003;1107.1751545098953;1107.9335239885634;1110.3892858927718;1114.142110574869;11836.349000804867;11899.643010709693;11945.462454189408;11994.400279986141;12021.398930053463;208290;210195;210316;210941;211002;50744;50971.7451412748;51032.744836276324;51320;51469.48530514722;1365.938532766028;1418.4680744720729;1418.666613345863;1420.1266221273843;1429.814124163852;21630.67553986723;22340.106395743987;22507.43731406728;22527.436814079778;22681.88659056694;35624.28751424905;35636.821815890755;35859;35890.10274743048;35924.64075359317;183609;184837;185039;185078;185080;29827.85086074556;30623.846880765454;30650.693493065675;31635.52546711755;34234.82882585571;40896.1820763589;42342.78828605837;42425.36361954511;42450.36324455074;43613.127737445706;30298.394032119675;30832;31026.68973310328;31165.844170779;31278.374432510765;30001.549976750804;30050.3989920196;30263.848680757335;30408.543871842383;30753.231169220948;35377.82311088531;35742;35969.100772480895;36229.637703622626;36244.456333155555;29979;30258.697413025588;30332.84833575818;31286.061418157493;31399.058028259187;22908.541829163656;23099.422514437272;23270.76729232686;23392;23526.176583819484 03:26:05 INFO - PID 3800 | |2;jquery.html;562.9437056294371;570.9172170035345;579.4615296388091;582.4059459351462;610.2250142319255;21486.355409337724;21915.67126493104;22030.88984555075;22235.110595576178;22402.775972240273;23833.28500144994;24003.75996240037;24332.87833560834;24443;24717.75282247177;6400.551961362707;6433.549651524372;6459;6484.675766211694;6569.507286953473;6390.265119511269;6418.261899881527;6475.125858009179;6479.546431749756;6506.284308726036;6186.783462578811;6370.2355717313985;6459.709313080923;6479.5788273762055;6483.967580162092;6481.83795405114;6508.446782023487;6519.445847103002;6529.444997175222;6532.7060282287175;6076.3316035236085;6080.118382834508;6121.571489995702;6123.142760013601;6128.3565225651555;25861.35346616331;27585.724142758718;27858.3035424114;27965.580516292273;28046.018389356275;2024.1397406102349;2035.9898200508903;2040.8877511736848;2047;2053.3531937439657;18539.629207415775;18809.81190188094;18832.5291867703;19080.522986925298;19142.61714765697;2389.2039744903104;2406.2660888429023;2460.938476538101;2471.0980492120425;2486.8632225227607;116422;119531;127516.36241818825;132185.339073305;134547.32726336404;14590;14670.413183472541;14761.33573989173;14812.851871481147;14851;22563.887180563994;22646.886765566065;22653.660195097087;22716.65925011126;22809.31572052841;9985.20118390527;10151.289409741246;10182.490875456198;10253.231007674454;10401.995231835646;9364.859527107099;9514.096160864707;9541.952290238505;9573.521323933775;9641.710748677551;8848.20366167048;8888.73333799987;9027.187553120251;9166.770830729152;9273.211776998896;2627.52858399297;2634.394089359458;2660.1221596872983;2728.8499132547504;2739.4247208086126;947.6825263536655;963.1043129889271;964.9083337082966;975.5561219645044;982.729749318943;18558.257669693063;18866.71699924502;19056.428307150807;19377.709334359995;19580.412587622395;1013.5793645637126;1031.293563908725;1039.0077476010542;1042.593388578455;1063.7340664833791;10373.27387082912;10434.530446129942;10627.202959777893;10632.41521716313;10897.128229741602;468358;480555;483753;491022.5448872733;493430;106164;106838;107182.46408767907;108256;110735;1005.5877090392904;1121.3328069798456;1141.5890279499374;1200.4117982188839;1203.506562309449;19601.31395401154;20271.4932126698;20280.188792448138;20526.38420847377;20627.8968605162;52322;53194;53486.73256633692;53803;55028;68234.3176568228;68455.65772171108;68631.3136868645;68829;70535;13862.722745545234;14344.56966291013;14345.426182952566;14474.421023159377;14560.49038283655;22152.113915443846;22166.88916555407;22168.778312217317;22211;22522;17743.645127097643;17983.730244046088;18064.63870722552;18085.457436276934;18586.44240672782;15048.172350520827;15688;16056.759148612546;16062.67874642524;16858.072805995296;17527.123643818013;18468.81531184671;18546.907265463586;18577.814221857607;18636.44090677282;14067.437302507786;14165.716685666022;14221.857781422053;14307.070040447337;14312.427502900184;18120.18459169314;18124;18126.365577204735;18329.633407332047;18523.44429667112 03:26:05 INFO - PID 3800 | |3;mootools.html;1303.406949837824;1375.8348998120227;1383.664763503219;1388.4168649167348;1394.9093308934912;14117.435302587897;14845.62885927851;14846.55460336189;14867.330970106344;14882.851171488282;14491;14514.927425362885;14533.418663253457;14590.854091459109;14670.413183472649;2725.809193356466;2800.663920329553;2805.424887897986;2815.985920070397;2818.436312737461;2713.0575783192717;2744.163030275765;2750.092469485075;2764.8064635475425;2775;2643.986780066097;2662.8934842606272;2667.7999150063824;2696.042904768808;2698.5547384681504;2600.531904257233;2606.296299998999;2661.4810112028067;2730.276476733667;2733.016114198887;2661.813673042888;2673.358393985449;2674.0774432820645;2677.6251324814543;2682.061278552491;14081.366338514792;14241.71516569673;14266.92866535671;14366.066205696701;14449.349779259854;7565.394768418513;7978;7985.041794984639;7986.7603971880935;7990.360771138295;5036.395632524121;5292.68243905363;5404.081306177959;5436.836894893159;5509.338879334466;1964.1063316191098;2007.458815974712;2015.5263513074415;2020.7069974853564;2032.1972820735875;22104.557908841733;22810.885945570168;24659.876700616383;25566.488670226492;25614.231573052653;7097.82255443618;7178.784636460915;7196;7366.116066072105;7448.962755186298;18887.244510219713;18933.62132757337;19068.33260835864;19111.426657200307;19182.328618498286;7834.4124190685925;8160.836783264302;8181.590920454072;8191.79520511992;8193.50838949665;7227.819304517324;7340.743073992385;7440.218777028443;7454.962725186448;7517.887231691529;5461.617686761968;5652.378238393773;5675.517581005578;5687.800926967537;5689.118186680988;1751.579620890977;1767.8320559546823;1785.8303461171167;1807.1957978699352;1815.8184181582;888.6800751729372;899.0964081098455;914.4239129348468;921.424109931293;922.5940586142076;7295.267016962037;7320.780376588711;7337.209707876817;7349.338559529561;7432.665530051161;711.4486273138359;718.3570704219694;724.5471580262337;730.630068621335;741.0921621014322;4524.88687782808;4594.402727645452;4622.306654001926;4666.416697912761;4750.216214324667;19493.512662183275;19874.90062549678;20450.284240051526;20602.175912963612;20743.1702731889;19989.400317990483;20161.899190503955;20472.69290960637;20474.692879606817;20496.897515512326;10592.258541901992;10707.785844283071;10875.45622718861;10985;10999.450027498433;8190.262876341158;8234.423590348857;8316.251537361666;8348.916510834813;8376.83246335082;17200.69473558112;17206;17450.127493625016;17531.649367012844;17938.820611793715;17289.221985010958;18339.724904126182;18411.907940460213;18715;18950.43148705541;11537.192396532162;11549.307041577533;11560.47977841016;11645.301281923112;11719.589814356457;12615.432305546456;13159.67100822487;13201.735965280832;13297.401616927455;13319.400626971616;9720.951395242979;9993.900060999296;10016.949915250378;10225.181985440999;10249.590016399261;10709.946450267698;10860.348379097279;10889;10912.945435272773;10913.508892099715;9488.95255523718;9594.568244428878;9653.03469653029;9667.226621870373;9667.419954802734;7056;7148.714051438093;7175.103112110986;7277.126744790447;7283;6917.342852429011;7048.330408611174;7060.894086588808;7181.455986962828;7203.963980180275 03:26:05 INFO - PID 3800 | |4;prototype.html;497.45528646132493;515.7395515264791;524.3471877512497;526.4551189518847;537.1191246355975;6131.693415329238;6208.596441231322;6234.657093859836;6240.15757872687;6280.780172693957;6048.3649216832255;6140.692965351737;6163.229596300463;6176.413240742122;6184.628922264667;4776.47458779534;4880.585150262232;4975.154223781966;4976.676516026456;5004.549590536851;4959.206526955688;4968.0376251380685;5020.874478138039;5030.84907452777;5045.571126454256;4948.777305021283;4950.257461380804;4968.40379154502;4984.651074424792;5006.4492905780335;4922.990786888679;4953.529414705616;4980.800767969277;5010.62420318474;5020.7740651670765;4512.278035514335;4518.096380723869;4519.548045195487;4524.16302983949;4535.63714902807;6129.601575897553;6157.198474694003;6160.1991741073825;6205.1623030890705;6218.440340369343;5730.341010783772;5733.652591640961;5741.62679425836;5744.770209191627;5790.392008839053;6468.547201695883;6499.447546958514;6502.284748677689;6537.248216455121;6573.244076931119;4826.227803551415;4861.496329390367;4863.8297659582095;4882.829100981484;4890.119778439879;6804.659767011679;6919.688614012382;6932.202796678345;6957.16514018316;6960.756373526953;4948.678335908155;4955.35580374549;4980.302757613937;5003.924941125886;5004.799808007711;5027.773750181251;5037.269595908573;5043.041822053871;5045.974770126126;5058.898822023539;5629.1423830135955;5685.754127119764;5707.971460142673;5711.571632127607;5735.799247026334;6316.589421687668;6351.094671598502;6504.317046710122;6652.667366631649;6682.26261172089;1632.6571420001933;1733.2633630706898;1734.6123101518735;1737.687216301078;1746.5458980665119;1202.1705023533734;1212.4362171590253;1213.3205404973244;1215.3619349841404;1239.900807935363;5621.241132447149;5649.830505084854;5675.262215911905;5688.914666280009;5724.627899186623;6527.792358413709;6625.536212465081;6625.668716564152;6642.83392915181;6688.598684078971;5549.334079910436;5621.18492818539;5627.746751396197;5647.745851436695;5658.321001479849;3488.970753627635;3509.6314886937016;3517.806520641338;3528.4707293906117;3528.5412896323314;6134.098429486873;6373.936260637427;6377.7448902044325;6388.840278993062;6415.358464153547;6760.898586521206;6834.077399550997;6864.965675171592;6951.548149370275;6960.895586566206;6442.065900444316;6443.452306553995;6450.838729031718;6513.250976137805;6543;6716.328367163244;6773.661316934035;6791.252962174256;6812.352826481477;6849.760258391132;6657.2677005528385;6692.531522793358;6741.629210393476;6766.357196066366;6809.65951702403;6214.751409943552;6435.903461447989;6441.3880681335195;6466.644334561644;6489.1888513935755;4981.925665554848;5007.799688012438;5019.945811379651;5022.146235140108;5028.547430731105;6434.710438030394;6565.441937435371;6715.395614394728;6763.560368576027;6861.176658800976;6283.622982621057;6360.173177486897;6426.935730642634;6518.5111116667385;6584.374484423972;6409.198850143732;6419.197600299963;6482.721403873421;6528.608283503005;6544.705488253136;6332.493400527855;6413.679316034273;6461.676916154268;6473.805785826433;6499.870002599827;6469.611823290617;6548.755736410067;6574.441172500391;6608.43828274602;6611.049740326519;6289.245290565162;6317.810465686037;6332.398422149889;6396.872062558816;6397.3282805306635 03:26:05 INFO - PID 3800 | |5;yui.html;889.1597440418807;912.1608120529113;912.7489940266425;917.4403613795588;940.6660635474407;18873.62252754944;19592.70610940835;19628.116734746935;19659.31192408266;19678.803211967876;18005;18559.536011599717;18803.52991175218;18993.525161870926;19202;920.5305294299905;928.8235235305305;932.7668082979255;933.943963362197;934.6588495199271;941.3128416256137;944.489975413276;946.280826571807;947.8388673925415;953.2802733935904;988.5452691761798;1018.7707765752721;1022.1209759606733;1025.4718819807806;1025.9432784232215;1020.2297265564489;1021.7139201023725;1029.7734498410339;1030.9793804123951;1031.2471895516278;728.3917928529684;739.4195556488131;741.3476140995944;745.6011034096787;751.2412463411939;20174.092165852424;20227.79772202274;20341.288054918008;20384.388468345973;20414.285500007427;21301.467463313387;21445.67831482529;21665.133394664193;21691.783082169135;21797.891010544845;16224.837751622568;16430.507084787474;16647.084410357427;16766.41317553892;16866.746998795028;3705.0922523981526;3709.5548534176073;3710.07248187953;3732.328180927432;3747.2880152770886;137733;139145;142873;144590.27704861513;144932;14396.568102956719;15263.847361526465;15351.539453816404;15509.689806203813;15650.843491565167;30547.541786873215;31118.22204444907;31171.68828311733;31489.212769680482;31814.409279535932;8223.54770487629;8299.087100418948;8345.874811877828;8361.122082181406;8372.288355489729;4002.799860006988;4042.656374208166;4064;4068.7355321903983;4080.9387859182134;5268.736563171826;5419.34967803866;5515.669059856422;5534.4742249486235;5537.058700021006;959.1224030012461;984.7636567223815;994.9154321882577;1009.5154325923597;1011.8431643095332;668.7759600533778;697.3549466743242;706.9540479868792;708.1537562612629;710.6659869861157;11191.888081119247;11588.88411115878;11951.760964780655;12459.439325230387;12531.18547294423;669.1100835888257;688.8760023195773;693.743314973463;695.422799076765;709.4891677991837;5535.7785688572;5543.556515478752;5560.77756889728;5575.219469274305;5654.208410822488;119890;120562;121676;121875;123040;104303.4784826071;104498;106145;110070;110490.44754776175;89253;90877;91248.54375728079;91366;91675.54162229146;10189.082982531607;10190.133838623504;10415;10546.8417973732;10571.418571978615;43929.56070439383;44347.33478997882;44766.55233447624;45273;45417.091658167315;56288.437115628316;58235.70882145562;58761;59394.70302648459;59783.70108149431;14960.17719025464;15060.171690556686;15106.622334441727;15154.621134471285;15284.617884552976;16469.670606587562;16622.16889155513;16802.747958780874;16822.15889205559;16836;15275.465358712392;15305.387784488496;15356.539303820904;15535.84464155344;15578.532644020697;14792.334344954717;15094.471693490676;15259.771103433235;15421.614459638598;15492.767608486107;14980.1011939284;15050.774238386652;15143.394264229748;15210.16344101085;15449.768253475982;10680.679579612624;10710.464476776286;10766.515506802056;11123.332600044023;11211.271267367594;10817.972292632187;11091.168162388014;11147.442627868411;11312.773744525228;11323.490442929924 03:26:05 INFO - PID 3800 | __end_tp_report 03:26:05 INFO - PID 3800 | __start_cc_report 03:26:05 INFO - PID 3800 | _x_x_mozilla_cycle_collect,312 03:26:05 INFO - PID 3800 | __end_cc_report 03:26:05 INFO - PID 3800 | __startTimestamp1505816765173__endTimestamp 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | ------- Summary: start ------- 03:26:05 INFO - PID 3800 | Number of tests: 6 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#0] dojo.html Cycles:165 Average:6179.92 Median:6435.03 stddev:868.26 (13.5%) stddev-sans-first:837.14 03:26:05 INFO - PID 3800 | Values: 3122.3 3134.2 3148.8 3152.6 3163.1 6062.6 6317.6 6363.8 6385.9 6440.3 6146.5 6262.8 6280.7 6311.7 6344.9 5762.3 5784.1 5789.6 5793.2 5870.1 5844.7 5862.8 5906.7 5945.8 5990.8 561.8 5836.8 5862.3 5905.9 5928.4 5682.2 5703.7 5730.2 5840.4 5843.2 5692.2 5780.7 5788.7 5840.9 5857.6 6292.2 6320.7 6340.5 6376.4 6390.8 6717.9 6793.3 6800.8 6851.6 6865.2 6872.0 6878.5 6954.8 6957.5 6959.7 6123.1 6271.6 6273.8 6274.5 6333.4 6836.3 6836.5 6867.8 6870.0 6896.0 6570.5 6590.4 6600.1 6622.9 6656.7 6722.8 6740.4 6759.8 6786.2 6849.3 6684.3 6707.1 6727.6 6795.5 6828.6 6570.9 6686.4 6696.0 6721.9 6871.3 5238.9 5245.6 5293.1 5299.7 5304.2 4607.6 4627.1 4651.3 4713.4 4732.6 5756.3 5793.6 5860.4 5883.1 5884.1 6760.9 6775.1 6865.2 6884.5 6886.0 5613.8 5719.6 5749.2 5783.0 5849.2 5803.7 5850.2 5864.0 5898.0 5911.3 6515.1 6550.2 6564.9 6620.0 6620.3 6844.7 6846.4 6875.0 6922.3 6932.3 6312.3 6400.6 6511.3 6512.2 6597.0 6513.3 6586.1 6587.6 6597.0 6621.7 6617.3 6678.7 6755.2 6770.6 6855.8 6625.1 6649.5 6669.5 6694.7 6741.7 6612.5 6621.7 6690.6 6705.1 6722.7 6301.3 6379.1 6439.8 6510.8 6515.4 6490.2 6528.2 6573.7 6584.7 6599.0 6103.0 6240.1 6363.1 6391.6 6435.0 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#1] ext.html Cycles:180 Average:36078.52 Median:19461.95 stddev:50267.44 (258.3%) stddev-sans-first:50338.86 03:26:05 INFO - PID 3800 | Values: 853.1 877.2 884.1 889.1 902.9 41485.8 42294.4 42356.2 42371.8 42402.4 37531.6 37815.0 37822.2 37842.2 37898.8 7222.1 7279.7 7309.3 7318.9 7339.4 7181.7 7269.0 7269.5 7284.1 7290.2 7241.7 7263.5 7263.9 7268.6 7664.3 7819.1 7872.6 7924.6 7958.2 7959.1 7732.1 7849.9 7896.7 7906.4 7930.6 36792.3 38923.8 39361.8 39607.6 39701.8 3490.2 3517.9 3537.5 3546.1 3550.2 31807.5 31819.2 32012.5 32097.5 32143.5 5132.7 5147.1 5160.7 5175.4 5191.9 185634.0 186013.0 187872.0 188356.0 188902.0 39771.0 40713.8 48897.0 49650.3 49767.3 50749.7 50881.2 50886.0 50964.7 50991.7 15922.8 16019.8 16192.8 16196.8 16232.4 13236.0 13239.3 13416.3 13426.3 13449.3 14572.1 14592.0 14614.3 14646.3 14746.9 5735.2 5820.9 5823.3 5842.9 5989.7 984.3 987.3 998.6 1003.4 1015.3 22145.9 22356.8 22440.6 22637.1 22901.5 1106.3 1107.2 1107.9 1110.4 1114.1 11836.3 11899.6 11945.5 11994.4 12021.4 208290.0 210195.0 210316.0 210941.0 211002.0 50744.0 50971.7 51032.7 51320.0 51469.5 1365.9 1418.5 1418.7 1420.1 1429.8 21630.7 22340.1 22507.4 22527.4 22681.9 35624.3 35636.8 35859.0 35890.1 35924.6 183609.0 184837.0 185039.0 185078.0 185080.0 29827.9 30623.8 30650.7 31635.5 34234.8 40896.2 42342.8 42425.4 42450.4 43613.1 30298.4 30832.0 31026.7 31165.8 31278.4 30001.5 30050.4 30263.8 30408.5 30753.2 35377.8 35742.0 35969.1 36229.6 36244.5 29979.0 30258.7 30332.8 31286.1 31399.1 22908.5 23099.4 23270.8 23392.0 23526.2 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#2] jquery.html Cycles:180 Average:33688.27 Median:22223.06 stddev:80945.84 (364.2%) stddev-sans-first:81134.70 03:26:05 INFO - PID 3800 | Values: 562.9 570.9 579.5 582.4 610.2 21486.4 21915.7 22030.9 22235.1 22402.8 23833.3 24003.8 24332.9 24443.0 24717.8 6400.6 6433.5 6459.0 6484.7 6569.5 6390.3 6418.3 6475.1 6479.5 6506.3 6186.8 6370.2 6459.7 6479.6 6484.0 6481.8 6508.4 6519.4 6529.4 6532.7 6076.3 6080.1 6121.6 6123.1 6128.4 25861.4 27585.7 27858.3 27965.6 28046.0 2024.1 2036.0 2040.9 2047.0 2053.4 18539.6 18809.8 18832.5 19080.5 19142.6 2389.2 2406.3 2460.9 2471.1 2486.9 116422.0 119531.0 127516.4 132185.3 134547.3 14590.0 14670.4 14761.3 14812.9 14851.0 22563.9 22646.9 22653.7 22716.7 22809.3 9985.2 10151.3 10182.5 10253.2 10402.0 9364.9 9514.1 9542.0 9573.5 9641.7 8848.2 8888.7 9027.2 9166.8 9273.2 2627.5 2634.4 2660.1 2728.8 2739.4 947.7 963.1 964.9 975.6 982.7 18558.3 18866.7 19056.4 19377.7 19580.4 1013.6 1031.3 1039.0 1042.6 1063.7 10373.3 10434.5 10627.2 10632.4 10897.1 468358.0 480555.0 483753.0 491022.5 493430.0 106164.0 106838.0 107182.5 108256.0 110735.0 1005.6 1121.3 1141.6 1200.4 1203.5 19601.3 20271.5 20280.2 20526.4 20627.9 52322.0 53194.0 53486.7 53803.0 55028.0 68234.3 68455.7 68631.3 68829.0 70535.0 13862.7 14344.6 14345.4 14474.4 14560.5 22152.1 22166.9 22168.8 22211.0 22522.0 17743.6 17983.7 18064.6 18085.5 18586.4 15048.2 15688.0 16056.8 16062.7 16858.1 17527.1 18468.8 18546.9 18577.8 18636.4 14067.4 14165.7 14221.9 14307.1 14312.4 18120.2 18124.0 18126.4 18329.6 18523.4 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#3] mootools.html Cycles:180 Average:9047.18 Median:2673.72 stddev:6303.56 (235.8%) stddev-sans-first:6294.38 03:26:05 INFO - PID 3800 | Values: 1303.4 1375.8 1383.7 1388.4 1394.9 14117.4 14845.6 14846.6 14867.3 14882.9 14491.0 14514.9 14533.4 14590.9 14670.4 2725.8 2800.7 2805.4 2816.0 2818.4 2713.1 2744.2 2750.1 2764.8 2775.0 2644.0 2662.9 2667.8 2696.0 2698.6 2600.5 2606.3 2661.5 2730.3 2733.0 2661.8 2673.4 2674.1 2677.6 2682.1 14081.4 14241.7 14266.9 14366.1 14449.3 7565.4 7978.0 7985.0 7986.8 7990.4 5036.4 5292.7 5404.1 5436.8 5509.3 1964.1 2007.5 2015.5 2020.7 2032.2 22104.6 22810.9 24659.9 25566.5 25614.2 7097.8 7178.8 7196.0 7366.1 7449.0 18887.2 18933.6 19068.3 19111.4 19182.3 7834.4 8160.8 8181.6 8191.8 8193.5 7227.8 7340.7 7440.2 7455.0 7517.9 5461.6 5652.4 5675.5 5687.8 5689.1 1751.6 1767.8 1785.8 1807.2 1815.8 888.7 899.1 914.4 921.4 922.6 7295.3 7320.8 7337.2 7349.3 7432.7 711.4 718.4 724.5 730.6 741.1 4524.9 4594.4 4622.3 4666.4 4750.2 19493.5 19874.9 20450.3 20602.2 20743.2 19989.4 20161.9 20472.7 20474.7 20496.9 10592.3 10707.8 10875.5 10985.0 10999.5 8190.3 8234.4 8316.3 8348.9 8376.8 17200.7 17206.0 17450.1 17531.6 17938.8 17289.2 18339.7 18411.9 18715.0 18950.4 11537.2 11549.3 11560.5 11645.3 11719.6 12615.4 13159.7 13201.7 13297.4 13319.4 9721.0 9993.9 10016.9 10225.2 10249.6 10709.9 10860.3 10889.0 10912.9 10913.5 9489.0 9594.6 9653.0 9667.2 9667.4 7056.0 7148.7 7175.1 7277.1 7283.0 6917.3 7048.3 7060.9 7181.5 7204.0 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#4] prototype.html Cycles:180 Average:5489.97 Median:6158.70 stddev:1541.18 (25.0%) stddev-sans-first:1499.26 03:26:05 INFO - PID 3800 | Values: 497.5 515.7 524.3 526.5 537.1 6131.7 6208.6 6234.7 6240.2 6280.8 6048.4 6140.7 6163.2 6176.4 6184.6 4776.5 4880.6 4975.2 4976.7 5004.5 4959.2 4968.0 5020.9 5030.8 5045.6 4948.8 4950.3 4968.4 4984.7 5006.4 4923.0 4953.5 4980.8 5010.6 5020.8 4512.3 4518.1 4519.5 4524.2 4535.6 6129.6 6157.2 6160.2 6205.2 6218.4 5730.3 5733.7 5741.6 5744.8 5790.4 6468.5 6499.4 6502.3 6537.2 6573.2 4826.2 4861.5 4863.8 4882.8 4890.1 6804.7 6919.7 6932.2 6957.2 6960.8 4948.7 4955.4 4980.3 5003.9 5004.8 5027.8 5037.3 5043.0 5046.0 5058.9 5629.1 5685.8 5708.0 5711.6 5735.8 6316.6 6351.1 6504.3 6652.7 6682.3 1632.7 1733.3 1734.6 1737.7 1746.5 1202.2 1212.4 1213.3 1215.4 1239.9 5621.2 5649.8 5675.3 5688.9 5724.6 6527.8 6625.5 6625.7 6642.8 6688.6 5549.3 5621.2 5627.7 5647.7 5658.3 3489.0 3509.6 3517.8 3528.5 3528.5 6134.1 6373.9 6377.7 6388.8 6415.4 6760.9 6834.1 6865.0 6951.5 6960.9 6442.1 6443.5 6450.8 6513.3 6543.0 6716.3 6773.7 6791.3 6812.4 6849.8 6657.3 6692.5 6741.6 6766.4 6809.7 6214.8 6435.9 6441.4 6466.6 6489.2 4981.9 5007.8 5019.9 5022.1 5028.5 6434.7 6565.4 6715.4 6763.6 6861.2 6283.6 6360.2 6426.9 6518.5 6584.4 6409.2 6419.2 6482.7 6528.6 6544.7 6332.5 6413.7 6461.7 6473.8 6499.9 6469.6 6548.8 6574.4 6608.4 6611.0 6289.2 6317.8 6332.4 6396.9 6397.3 03:26:05 INFO - PID 3800 | 03:26:05 INFO - PID 3800 | [#5] yui.html Cycles:180 Average:24018.96 Median:19926.45 stddev:35148.04 (176.4%) stddev-sans-first:35203.73 03:26:05 INFO - PID 3800 | Values: 889.2 912.2 912.7 917.4 940.7 18873.6 19592.7 19628.1 19659.3 19678.8 18005.0 18559.5 18803.5 18993.5 19202.0 920.5 928.8 932.8 933.9 934.7 941.3 944.5 946.3 947.8 953.3 988.5 1018.8 1022.1 1025.5 1025.9 1020.2 1021.7 1029.8 1031.0 1031.2 728.4 739.4 741.3 745.6 751.2 20174.1 20227.8 20341.3 20384.4 20414.3 21301.5 21445.7 21665.1 21691.8 21797.9 16224.8 16430.5 16647.1 16766.4 16866.7 3705.1 3709.6 3710.1 3732.3 3747.3 137733.0 139145.0 142873.0 144590.3 144932.0 14396.6 15263.8 15351.5 15509.7 15650.8 30547.5 31118.2 31171.7 31489.2 31814.4 8223.5 8299.1 8345.9 8361.1 8372.3 4002.8 4042.7 4064.0 4068.7 4080.9 5268.7 5419.3 5515.7 5534.5 5537.1 959.1 984.8 994.9 1009.5 1011.8 668.8 697.4 707.0 708.2 710.7 11191.9 11588.9 11951.8 12459.4 12531.2 669.1 688.9 693.7 695.4 709.5 5535.8 5543.6 5560.8 5575.2 5654.2 119890.0 120562.0 121676.0 121875.0 123040.0 104303.5 104498.0 106145.0 110070.0 110490.4 89253.0 90877.0 91248.5 91366.0 91675.5 10189.1 10190.1 10415.0 10546.8 10571.4 43929.6 44347.3 44766.6 45273.0 45417.1 56288.4 58235.7 58761.0 59394.7 59783.7 14960.2 15060.2 15106.6 15154.6 15284.6 16469.7 16622.2 16802.7 16822.2 16836.0 15275.5 15305.4 15356.5 15535.8 15578.5 14792.3 15094.5 15259.8 15421.6 15492.8 14980.1 15050.8 15143.4 15210.2 15449.8 10680.7 10710.5 10766.5 11123.3 11211.3 10818.0 11091.2 11147.4 11312.8 11323.5 03:26:05 INFO - PID 3800 | -------- Summary: end -------- 03:26:05 INFO - PID 3800 | 03:26:06 INFO - TEST-INFO | 3800: exit 0 03:26:06 INFO - TEST-OK | dromaeo_css | took 1115397ms 03:26:06 INFO - TEST-START | kraken 03:26:06 INFO - Initialising browser for kraken test... 03:26:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35674/getInfo.html -profile /tmp/tmp7djME9/profile 03:26:06 INFO - TEST-INFO | started process 4230 (/builds/slave/test/build/application/firefox/firefox http://localhost:35674/getInfo.html) 03:26:11 INFO - TEST-INFO | 4230: exit 0 03:26:11 INFO - Browser initialized. 03:26:11 INFO - Running cycle 1/1 for kraken test... 03:26:11 INFO - Using env: {'DISPLAY': ':0', 03:26:11 INFO - 'HOME': '/home/cltbld', 03:26:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:11 INFO - 'LANG': 'en_US.UTF-8', 03:26:11 INFO - 'LANGUAGE': 'en_US:en', 03:26:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:11 INFO - 'LOGNAME': 'cltbld', 03:26:11 INFO - 'MAIL': '/var/mail/cltbld', 03:26:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:11 INFO - 'MOZ_ACCELERATED': '1', 03:26:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:11 INFO - 'MOZ_NO_REMOTE': '1', 03:26:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:11 INFO - 'MOZ_WEBRENDER': '1', 03:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:11 INFO - 'NO_EM_RESTART': '1', 03:26:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:11 INFO - 'PWD': '/builds/slave/test', 03:26:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:11 INFO - 'RUST_BACKTRACE': 'full', 03:26:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:11 INFO - 'SHELL': '/bin/bash', 03:26:11 INFO - 'SHLVL': '1', 03:26:11 INFO - 'TERM': 'linux', 03:26:11 INFO - 'TMOUT': '86400', 03:26:11 INFO - 'USER': 'cltbld', 03:26:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568', 03:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:11 INFO - '_': '/tools/buildbot/bin/python'} 03:26:11 INFO - TEST-INFO | started process 4467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7djME9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:12 INFO - PID 4467 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:26:12 INFO - PID 4467 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:26:12 INFO - PID 4467 | 03:26:12 INFO - PID 4467 | (/builds/slave/test/build/application/firefox/firefox:4526): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:12 INFO - PID 4467 | 03:26:22 INFO - PID 4467 | RSS: Main: 205197312 03:26:22 INFO - PID 4467 | 03:26:25 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35674/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:26 INFO - PID 4467 | RSS: Main: 202776576 03:26:26 INFO - PID 4467 | 03:26:29 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35674/tests/kraken/driver.html?testName=audio-dft) 03:26:29 INFO - PID 4467 | RSS: Main: 204038144 03:26:29 INFO - PID 4467 | 03:26:33 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35674/tests/kraken/driver.html?testName=audio-fft) 03:26:33 INFO - PID 4467 | RSS: Main: 201150464 03:26:33 INFO - PID 4467 | 03:26:35 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35674/tests/kraken/driver.html?testName=audio-oscillator) 03:26:36 INFO - PID 4467 | RSS: Main: 200429568 03:26:36 INFO - PID 4467 | 03:26:38 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:39 INFO - PID 4467 | RSS: Main: 201097216 03:26:39 INFO - PID 4467 | 03:26:42 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35674/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:43 INFO - PID 4467 | RSS: Main: 203833344 03:26:43 INFO - PID 4467 | 03:26:46 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35674/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:47 INFO - PID 4467 | RSS: Main: 202317824 03:26:47 INFO - PID 4467 | 03:26:50 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35674/tests/kraken/driver.html?testName=json-parse-financial) 03:26:51 INFO - PID 4467 | RSS: Main: 204390400 03:26:51 INFO - PID 4467 | 03:26:52 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:53 INFO - PID 4467 | RSS: Main: 204230656 03:26:53 INFO - PID 4467 | 03:26:55 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:55 INFO - PID 4467 | RSS: Main: 200318976 03:26:55 INFO - PID 4467 | 03:26:57 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:58 INFO - PID 4467 | RSS: Main: 200802304 03:26:58 INFO - PID 4467 | 03:27:01 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:01 INFO - PID 4467 | RSS: Main: 200966144 03:27:01 INFO - PID 4467 | 03:27:04 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:05 INFO - PID 4467 | RSS: Main: 200183808 03:27:05 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | Cycle 1(1): loaded http://localhost:35674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35674/tests/kraken/driver.html?testName=ai-astar) 03:27:07 INFO - PID 4467 | RSS: Main: 202219520 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | __start_tp_report 03:27:07 INFO - PID 4467 | _x_x_mozilla_page_load 03:27:07 INFO - PID 4467 | _x_x_mozilla_page_load_details 03:27:07 INFO - PID 4467 | |i|pagename|runs| 03:27:07 INFO - PID 4467 | |0;ai-astar;111;111;106;108;108;117;112;110;114;109 03:27:07 INFO - PID 4467 | |1;audio-beat-detection;127;121;119;120;121;116;125;122;123;124 03:27:07 INFO - PID 4467 | |2;audio-dft;162;169;167;164;175;166;168;165;167;166 03:27:07 INFO - PID 4467 | |3;audio-fft;75;82;76;77;76;87;81;81;76;80 03:27:07 INFO - PID 4467 | |4;audio-oscillator;84;81;84;79;89;84;80;80;86;82 03:27:07 INFO - PID 4467 | |5;imaging-gaussian-blur;116;114;113;114;116;114;114;117;117;115 03:27:07 INFO - PID 4467 | |6;imaging-darkroom;159;148;147;152;150;156;154;159;149;151 03:27:07 INFO - PID 4467 | |7;imaging-desaturate;103;94;96;95;95;100;101;94;95;95 03:27:07 INFO - PID 4467 | |8;json-parse-financial;55;55;55;52;53;54;60;53;53;59 03:27:07 INFO - PID 4467 | |9;json-stringify-tinderbox;45;40;43;40;47;44;42;48;38;42 03:27:07 INFO - PID 4467 | |10;stanford-crypto-aes;76;82;87;79;77;84;81;79;76;83 03:27:07 INFO - PID 4467 | |11;stanford-crypto-ccm;118;126;120;118;115;119;118;125;116;123 03:27:07 INFO - PID 4467 | |12;stanford-crypto-pbkdf2;186;193;184;185;183;177;176;177;174;188 03:27:07 INFO - PID 4467 | |13;stanford-crypto-sha256-iterative;67;75;70;68;65;69;67;66;70;71 03:27:07 INFO - PID 4467 | __end_tp_report 03:27:07 INFO - PID 4467 | __start_cc_report 03:27:07 INFO - PID 4467 | _x_x_mozilla_cycle_collect,761 03:27:07 INFO - PID 4467 | __end_cc_report 03:27:07 INFO - PID 4467 | __startTimestamp1505816827634__endTimestamp 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | ------- Summary: start ------- 03:27:07 INFO - PID 4467 | Number of tests: 14 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:3.40 03:27:07 INFO - PID 4467 | Values: 111.0 111.0 106.0 108.0 108.0 117.0 112.0 110.0 114.0 109.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:122.50 stddev:3.16 (2.6%) stddev-sans-first:2.73 03:27:07 INFO - PID 4467 | Values: 127.0 121.0 119.0 120.0 121.0 116.0 125.0 122.0 123.0 124.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#2] audio-dft Cycles:10 Average:166.90 Median:167.00 stddev:3.48 (2.1%) stddev-sans-first:3.21 03:27:07 INFO - PID 4467 | Values: 162.0 169.0 167.0 164.0 175.0 166.0 168.0 165.0 167.0 166.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#3] audio-fft Cycles:10 Average:79.10 Median:80.50 stddev:3.78 (4.7%) stddev-sans-first:3.71 03:27:07 INFO - PID 4467 | Values: 75.0 82.0 76.0 77.0 76.0 87.0 81.0 81.0 76.0 80.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:84.00 stddev:3.11 (3.7%) stddev-sans-first:3.27 03:27:07 INFO - PID 4467 | Values: 84.0 81.0 84.0 79.0 89.0 84.0 80.0 80.0 86.0 82.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.50 stddev:1.41 (1.2%) stddev-sans-first:1.45 03:27:07 INFO - PID 4467 | Values: 116.0 114.0 113.0 114.0 116.0 114.0 114.0 117.0 117.0 115.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:153.00 stddev:4.35 (2.8%) stddev-sans-first:3.93 03:27:07 INFO - PID 4467 | Values: 159.0 148.0 147.0 152.0 150.0 156.0 154.0 159.0 149.0 151.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:95.00 stddev:3.26 (3.4%) stddev-sans-first:2.57 03:27:07 INFO - PID 4467 | Values: 103.0 94.0 96.0 95.0 95.0 100.0 101.0 94.0 95.0 95.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:2.64 (4.8%) stddev-sans-first:2.80 03:27:07 INFO - PID 4467 | Values: 55.0 55.0 55.0 52.0 53.0 54.0 60.0 53.0 53.0 59.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#9] json-stringify-tinderbox Cycles:10 Average:42.90 Median:43.50 stddev:3.18 (7.3%) stddev-sans-first:3.28 03:27:07 INFO - PID 4467 | Values: 45.0 40.0 43.0 40.0 47.0 44.0 42.0 48.0 38.0 42.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:81.50 stddev:3.66 (4.5%) stddev-sans-first:3.52 03:27:07 INFO - PID 4467 | Values: 76.0 82.0 87.0 79.0 77.0 84.0 81.0 79.0 76.0 83.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:119.50 stddev:3.71 (3.1%) stddev-sans-first:3.87 03:27:07 INFO - PID 4467 | Values: 118.0 126.0 120.0 118.0 115.0 119.0 118.0 125.0 116.0 123.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:184.50 stddev:6.11 (3.3%) stddev-sans-first:6.33 03:27:07 INFO - PID 4467 | Values: 186.0 193.0 184.0 185.0 183.0 177.0 176.0 177.0 174.0 188.0 03:27:07 INFO - PID 4467 | 03:27:07 INFO - PID 4467 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:2.90 (4.2%) stddev-sans-first:3.00 03:27:07 INFO - PID 4467 | Values: 67.0 75.0 70.0 68.0 65.0 69.0 67.0 66.0 70.0 71.0 03:27:07 INFO - PID 4467 | -------- Summary: end -------- 03:27:07 INFO - PID 4467 | 03:27:08 INFO - PID 4467 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:27:08 INFO - TEST-INFO | 4467: exit 0 03:27:08 INFO - TEST-OK | kraken | took 62348ms 03:27:08 INFO - SUITE-END | took 1177s 03:27:08 INFO - Completed test suite (00:19:38) 03:27:08 INFO - javascript benchmark 03:27:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8389.293791238142, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.266267427155, 3134.2164458885277, 3148.8268145252, 3152.6216853977526, 3163.066895265896, 6062.605930614507, 6317.589356691818, 6363.777267795628, 6385.904211436827, 6440.323766004566, 6146.477549408306, 6262.84342891428, 6280.65456399899, 6311.652859092748, 6344.904826427596, 5762.250907382045, 5784.074548072309, 5789.565782566325, 5793.188953546507, 5870.060790273557, 5844.707764611774, 5862.824115276549, 5906.704664766745, 5945.821625351246, 5990.820275391723, 561.7692346740214, 5836.795712150076, 5862.32583252925, 5905.852353691171, 5928.436798504135, 5682.232898558683, 5703.714814259312, 5730.169125476783, 5840.3575606683235, 5843.152742852305, 5692.203091567184, 5780.71096445176, 5788.652680839121, 5840.853978650525, 5857.648541087548, 6292.244930608356, 6320.74717011319, 6340.524460665469, 6376.39424254695, 6390.840228994266, 6717.865642687168, 6793.286704895964, 6800.761973330909, 6851.588904665686, 6865.244823069508, 6872.037914691947, 6878.518503704742, 6954.826129346807, 6957.5129740918155, 6959.6868140933775, 6123.050927106306, 6271.560990730651, 6273.843153921142, 6274.466670333073, 6333.429991300805, 6836.316368363124, 6836.487263455261, 6867.759628412981, 6870.038194652752, 6896.0, 6570.474362051024, 6590.373914478117, 6600.1089852869245, 6622.86754264912, 6656.70044847983, 6722.798316050526, 6740.393364597112, 6759.831004224835, 6786.185657721105, 6849.349311815469, 6684.331566843277, 6707.128073350434, 6727.62998035103, 6795.490338224653, 6828.556143850733, 6570.868582628321, 6686.431653309523, 6695.966520167368, 6721.932780672229, 6871.278515755874, 5238.895222095537, 5245.632805703564, 5293.100172970604, 5299.735013249322, 5304.151335786333, 4607.631389488833, 4627.143978363946, 4651.325557794101, 4713.363695901009, 4732.645051621073, 5756.33802112754, 5793.623414478046, 5860.355360910296, 5883.058710606282, 5884.08796636522, 6760.864782704417, 6775.1192344995825, 6865.244823069458, 6884.48366372514, 6886.0, 5613.775448982076, 5719.628224165416, 5749.1663708762835, 5783.0, 5849.181114643953, 5803.738831752581, 5850.151727999501, 5864.0, 5897.970510147422, 5911.261092363455, 6515.055316979012, 6550.181227346582, 6564.86870262592, 6619.966900165468, 6620.337966203341, 6844.726210951606, 6846.418054465426, 6875.037494750839, 6922.2731613180895, 6932.341427564374, 6312.3056463788025, 6400.55196136266, 6511.2512061113575, 6512.218533775977, 6596.967015164893, 6513.316101809241, 6586.077949087227, 6587.604743715392, 6597.043428702716, 6621.702023408862, 6617.305182955721, 6678.699458524281, 6755.2231493378895, 6770.627615480998, 6855.828604284733, 6625.138731964814, 6649.501287403367, 6669.46644268467, 6694.698738556874, 6741.662916854236, 6612.471002319707, 6621.735130594915, 6690.59856408617, 6705.0612914193025, 6722.697478613376, 6301.275353334425, 6379.138816259746, 6439.83900402475, 6510.837229069311, 6515.413612774873, 6490.188726409199, 6528.249251336157, 6573.704183311666, 6584.703688333941, 6598.967005164944, 6103.0, 6240.12638230639, 6363.140975968185, 6391.58454700443, 6435.03474478832], "value": 6117.540454225295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.053111046738, 877.2324216310726, 884.1379654836531, 889.1197714262878, 902.9006809250977, 41485.79257103714, 42294.36558451626, 42356.15287694244, 42371.788141059325, 42402.36396454056, 37531.62468375315, 37815.0, 37822.24355512888, 37842.24315513688, 37898.81050594743, 7222.1333439987275, 7279.708811647554, 7309.34215920567, 7318.926810731904, 7339.412846972256, 7181.748638797643, 7269.0, 7269.454790890704, 7284.053073100489, 7290.234525374839, 7241.746538871141, 7263.491555591111, 7263.946727724477, 7268.636568171597, 7664.310212080912, 7819.100803407596, 7872.606369681493, 7924.564148971805, 7958.164392738795, 7959.084705258853, 7732.1108072571815, 7849.882251766228, 7896.7236146734585, 7906.44654874159, 7930.603469826543, 36792.26415471676, 38923.805380973194, 39361.803190984145, 39607.603923960676, 39701.80149099265, 3490.1623610333336, 3517.876874309387, 3537.5047493350694, 3546.078019714867, 3550.218951830593, 31807.522887156712, 31819.204519886956, 32012.519812202834, 32097.51853722196, 32143.51784723231, 5132.74336283188, 5147.124988751883, 5160.716160611165, 5175.353080864892, 5191.922121168185, 185634.0, 186012.99999999863, 187872.0, 188356.0, 188901.99999999863, 39771.0, 40713.796431017654, 48897.0, 49650.255246171335, 49767.25349119766, 50749.746251269244, 50881.23678144831, 50886.0, 50964.74517627388, 50991.745041275295, 15922.840771592137, 16019.759703604455, 16192.75710864338, 16196.838031619533, 16232.350705971865, 13236.0, 13239.338033098307, 13416.329183540784, 13426.261555614536, 13449.260290683911, 14572.125672459686, 14592.0, 14614.34235459407, 14646.26768661584, 14746.926265368604, 5735.1970724098655, 5820.883582328414, 5823.30120385548, 5842.941570584325, 5989.700514974234, 984.3186482555192, 987.2792861211356, 998.5805961496189, 1003.3929472669076, 1015.2740790334946, 22145.889270553544, 22356.77643223547, 22440.55118897613, 22637.094516219167, 22901.541969160855, 1106.2753896198003, 1107.1751545098953, 1107.9335239885634, 1110.3892858927718, 1114.142110574869, 11836.349000804867, 11899.643010709693, 11945.462454189408, 11994.400279986141, 12021.398930053463, 208290.0, 210195.0, 210316.0, 210941.0, 211002.0, 50744.0, 50971.7451412748, 51032.744836276324, 51320.0, 51469.48530514722, 1365.938532766028, 1418.4680744720729, 1418.666613345863, 1420.1266221273843, 1429.814124163852, 21630.67553986723, 22340.106395743987, 22507.43731406728, 22527.436814079778, 22681.88659056694, 35624.28751424905, 35636.821815890755, 35859.0, 35890.10274743048, 35924.64075359317, 183609.0, 184837.0, 185039.0, 185078.0, 185080.0, 29827.85086074556, 30623.846880765454, 30650.693493065675, 31635.52546711755, 34234.82882585571, 40896.1820763589, 42342.78828605837, 42425.36361954511, 42450.36324455074, 43613.127737445706, 30298.394032119675, 30832.0, 31026.68973310328, 31165.844170779, 31278.374432510765, 30001.549976750804, 30050.3989920196, 30263.848680757335, 30408.543871842383, 30753.231169220948, 35377.82311088531, 35742.0, 35969.100772480895, 36229.637703622626, 36244.456333155555, 29979.0, 30258.697413025588, 30332.84833575818, 31286.061418157493, 31399.058028259187, 22908.541829163656, 23099.422514437272, 23270.76729232686, 23392.0, 23526.176583819484], "value": 16807.134240586664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9437056294371, 570.9172170035345, 579.4615296388091, 582.4059459351462, 610.2250142319255, 21486.355409337724, 21915.67126493104, 22030.88984555075, 22235.110595576178, 22402.775972240273, 23833.28500144994, 24003.75996240037, 24332.87833560834, 24443.0, 24717.75282247177, 6400.551961362707, 6433.549651524372, 6459.0, 6484.675766211694, 6569.507286953473, 6390.265119511269, 6418.261899881527, 6475.125858009179, 6479.546431749756, 6506.284308726036, 6186.783462578811, 6370.2355717313985, 6459.709313080923, 6479.5788273762055, 6483.967580162092, 6481.83795405114, 6508.446782023487, 6519.445847103002, 6529.444997175222, 6532.7060282287175, 6076.3316035236085, 6080.118382834508, 6121.571489995702, 6123.142760013601, 6128.3565225651555, 25861.35346616331, 27585.724142758718, 27858.3035424114, 27965.580516292273, 28046.018389356275, 2024.1397406102349, 2035.9898200508903, 2040.8877511736848, 2047.0, 2053.3531937439657, 18539.629207415775, 18809.81190188094, 18832.5291867703, 19080.522986925298, 19142.61714765697, 2389.2039744903104, 2406.2660888429023, 2460.938476538101, 2471.0980492120425, 2486.8632225227607, 116422.0, 119531.0, 127516.36241818825, 132185.339073305, 134547.32726336404, 14590.0, 14670.413183472541, 14761.33573989173, 14812.851871481147, 14851.0, 22563.887180563994, 22646.886765566065, 22653.660195097087, 22716.65925011126, 22809.31572052841, 9985.20118390527, 10151.289409741246, 10182.490875456198, 10253.231007674454, 10401.995231835646, 9364.859527107099, 9514.096160864707, 9541.952290238505, 9573.521323933775, 9641.710748677551, 8848.20366167048, 8888.73333799987, 9027.187553120251, 9166.770830729152, 9273.211776998896, 2627.52858399297, 2634.394089359458, 2660.1221596872983, 2728.8499132547504, 2739.4247208086126, 947.6825263536655, 963.1043129889271, 964.9083337082966, 975.5561219645044, 982.729749318943, 18558.257669693063, 18866.71699924502, 19056.428307150807, 19377.709334359995, 19580.412587622395, 1013.5793645637126, 1031.293563908725, 1039.0077476010542, 1042.593388578455, 1063.7340664833791, 10373.27387082912, 10434.530446129942, 10627.202959777893, 10632.41521716313, 10897.128229741602, 468358.0, 480555.0, 483753.0, 491022.5448872733, 493430.0, 106164.0, 106838.0, 107182.46408767907, 108256.0, 110735.0, 1005.5877090392904, 1121.3328069798456, 1141.5890279499374, 1200.4117982188839, 1203.506562309449, 19601.31395401154, 20271.4932126698, 20280.188792448138, 20526.38420847377, 20627.8968605162, 52322.0, 53194.0, 53486.73256633692, 53803.0, 55028.0, 68234.3176568228, 68455.65772171108, 68631.3136868645, 68829.0, 70535.0, 13862.722745545234, 14344.56966291013, 14345.426182952566, 14474.421023159377, 14560.49038283655, 22152.113915443846, 22166.88916555407, 22168.778312217317, 22211.0, 22522.0, 17743.645127097643, 17983.730244046088, 18064.63870722552, 18085.457436276934, 18586.44240672782, 15048.172350520827, 15688.0, 16056.759148612546, 16062.67874642524, 16858.072805995296, 17527.123643818013, 18468.81531184671, 18546.907265463586, 18577.814221857607, 18636.44090677282, 14067.437302507786, 14165.716685666022, 14221.857781422053, 14307.070040447337, 14312.427502900184, 18120.18459169314, 18124.0, 18126.365577204735, 18329.633407332047, 18523.44429667112], "value": 11750.898904500487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.406949837824, 1375.8348998120227, 1383.664763503219, 1388.4168649167348, 1394.9093308934912, 14117.435302587897, 14845.62885927851, 14846.55460336189, 14867.330970106344, 14882.851171488282, 14491.0, 14514.927425362885, 14533.418663253457, 14590.854091459109, 14670.413183472649, 2725.809193356466, 2800.663920329553, 2805.424887897986, 2815.985920070397, 2818.436312737461, 2713.0575783192717, 2744.163030275765, 2750.092469485075, 2764.8064635475425, 2775.0, 2643.986780066097, 2662.8934842606272, 2667.7999150063824, 2696.042904768808, 2698.5547384681504, 2600.531904257233, 2606.296299998999, 2661.4810112028067, 2730.276476733667, 2733.016114198887, 2661.813673042888, 2673.358393985449, 2674.0774432820645, 2677.6251324814543, 2682.061278552491, 14081.366338514792, 14241.71516569673, 14266.92866535671, 14366.066205696701, 14449.349779259854, 7565.394768418513, 7978.0, 7985.041794984639, 7986.7603971880935, 7990.360771138295, 5036.395632524121, 5292.68243905363, 5404.081306177959, 5436.836894893159, 5509.338879334466, 1964.1063316191098, 2007.458815974712, 2015.5263513074415, 2020.7069974853564, 2032.1972820735875, 22104.557908841733, 22810.885945570168, 24659.876700616383, 25566.488670226492, 25614.231573052653, 7097.82255443618, 7178.784636460915, 7196.0, 7366.116066072105, 7448.962755186298, 18887.244510219713, 18933.62132757337, 19068.33260835864, 19111.426657200307, 19182.328618498286, 7834.4124190685925, 8160.836783264302, 8181.590920454072, 8191.79520511992, 8193.50838949665, 7227.819304517324, 7340.743073992385, 7440.218777028443, 7454.962725186448, 7517.887231691529, 5461.617686761968, 5652.378238393773, 5675.517581005578, 5687.800926967537, 5689.118186680988, 1751.579620890977, 1767.8320559546823, 1785.8303461171167, 1807.1957978699352, 1815.8184181582, 888.6800751729372, 899.0964081098455, 914.4239129348468, 921.424109931293, 922.5940586142076, 7295.267016962037, 7320.780376588711, 7337.209707876817, 7349.338559529561, 7432.665530051161, 711.4486273138359, 718.3570704219694, 724.5471580262337, 730.630068621335, 741.0921621014322, 4524.88687782808, 4594.402727645452, 4622.306654001926, 4666.416697912761, 4750.216214324667, 19493.512662183275, 19874.90062549678, 20450.284240051526, 20602.175912963612, 20743.1702731889, 19989.400317990483, 20161.899190503955, 20472.69290960637, 20474.692879606817, 20496.897515512326, 10592.258541901992, 10707.785844283071, 10875.45622718861, 10985.0, 10999.450027498433, 8190.262876341158, 8234.423590348857, 8316.251537361666, 8348.916510834813, 8376.83246335082, 17200.69473558112, 17206.0, 17450.127493625016, 17531.649367012844, 17938.820611793715, 17289.221985010958, 18339.724904126182, 18411.907940460213, 18715.0, 18950.43148705541, 11537.192396532162, 11549.307041577533, 11560.47977841016, 11645.301281923112, 11719.589814356457, 12615.432305546456, 13159.67100822487, 13201.735965280832, 13297.401616927455, 13319.400626971616, 9720.951395242979, 9993.900060999296, 10016.949915250378, 10225.181985440999, 10249.590016399261, 10709.946450267698, 10860.348379097279, 10889.0, 10912.945435272773, 10913.508892099715, 9488.95255523718, 9594.568244428878, 9653.03469653029, 9667.226621870373, 9667.419954802734, 7056.0, 7148.714051438093, 7175.103112110986, 7277.126744790447, 7283.0, 6917.342852429011, 7048.330408611174, 7060.894086588808, 7181.455986962828, 7203.963980180275], "value": 6537.321737662781, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.45528646132493, 515.7395515264791, 524.3471877512497, 526.4551189518847, 537.1191246355975, 6131.693415329238, 6208.596441231322, 6234.657093859836, 6240.15757872687, 6280.780172693957, 6048.3649216832255, 6140.692965351737, 6163.229596300463, 6176.413240742122, 6184.628922264667, 4776.47458779534, 4880.585150262232, 4975.154223781966, 4976.676516026456, 5004.549590536851, 4959.206526955688, 4968.0376251380685, 5020.874478138039, 5030.84907452777, 5045.571126454256, 4948.777305021283, 4950.257461380804, 4968.40379154502, 4984.651074424792, 5006.4492905780335, 4922.990786888679, 4953.529414705616, 4980.800767969277, 5010.62420318474, 5020.7740651670765, 4512.278035514335, 4518.096380723869, 4519.548045195487, 4524.16302983949, 4535.63714902807, 6129.601575897553, 6157.198474694003, 6160.1991741073825, 6205.1623030890705, 6218.440340369343, 5730.341010783772, 5733.652591640961, 5741.62679425836, 5744.770209191627, 5790.392008839053, 6468.547201695883, 6499.447546958514, 6502.284748677689, 6537.248216455121, 6573.244076931119, 4826.227803551415, 4861.496329390367, 4863.8297659582095, 4882.829100981484, 4890.119778439879, 6804.659767011679, 6919.688614012382, 6932.202796678345, 6957.16514018316, 6960.756373526953, 4948.678335908155, 4955.35580374549, 4980.302757613937, 5003.924941125886, 5004.799808007711, 5027.773750181251, 5037.269595908573, 5043.041822053871, 5045.974770126126, 5058.898822023539, 5629.1423830135955, 5685.754127119764, 5707.971460142673, 5711.571632127607, 5735.799247026334, 6316.589421687668, 6351.094671598502, 6504.317046710122, 6652.667366631649, 6682.26261172089, 1632.6571420001933, 1733.2633630706898, 1734.6123101518735, 1737.687216301078, 1746.5458980665119, 1202.1705023533734, 1212.4362171590253, 1213.3205404973244, 1215.3619349841404, 1239.900807935363, 5621.241132447149, 5649.830505084854, 5675.262215911905, 5688.914666280009, 5724.627899186623, 6527.792358413709, 6625.536212465081, 6625.668716564152, 6642.83392915181, 6688.598684078971, 5549.334079910436, 5621.18492818539, 5627.746751396197, 5647.745851436695, 5658.321001479849, 3488.970753627635, 3509.6314886937016, 3517.806520641338, 3528.4707293906117, 3528.5412896323314, 6134.098429486873, 6373.936260637427, 6377.7448902044325, 6388.840278993062, 6415.358464153547, 6760.898586521206, 6834.077399550997, 6864.965675171592, 6951.548149370275, 6960.895586566206, 6442.065900444316, 6443.452306553995, 6450.838729031718, 6513.250976137805, 6543.0, 6716.328367163244, 6773.661316934035, 6791.252962174256, 6812.352826481477, 6849.760258391132, 6657.2677005528385, 6692.531522793358, 6741.629210393476, 6766.357196066366, 6809.65951702403, 6214.751409943552, 6435.903461447989, 6441.3880681335195, 6466.644334561644, 6489.1888513935755, 4981.925665554848, 5007.799688012438, 5019.945811379651, 5022.146235140108, 5028.547430731105, 6434.710438030394, 6565.441937435371, 6715.395614394728, 6763.560368576027, 6861.176658800976, 6283.622982621057, 6360.173177486897, 6426.935730642634, 6518.5111116667385, 6584.374484423972, 6409.198850143732, 6419.197600299963, 6482.721403873421, 6528.608283503005, 6544.705488253136, 6332.493400527855, 6413.679316034273, 6461.676916154268, 6473.805785826433, 6499.870002599827, 6469.611823290617, 6548.755736410067, 6574.441172500391, 6608.43828274602, 6611.049740326519, 6289.245290565162, 6317.810465686037, 6332.398422149889, 6396.872062558816, 6397.3282805306635], "value": 5037.178749354551, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.1597440418807, 912.1608120529113, 912.7489940266425, 917.4403613795588, 940.6660635474407, 18873.62252754944, 19592.70610940835, 19628.116734746935, 19659.31192408266, 19678.803211967876, 18005.0, 18559.536011599717, 18803.52991175218, 18993.525161870926, 19202.0, 920.5305294299905, 928.8235235305305, 932.7668082979255, 933.943963362197, 934.6588495199271, 941.3128416256137, 944.489975413276, 946.280826571807, 947.8388673925415, 953.2802733935904, 988.5452691761798, 1018.7707765752721, 1022.1209759606733, 1025.4718819807806, 1025.9432784232215, 1020.2297265564489, 1021.7139201023725, 1029.7734498410339, 1030.9793804123951, 1031.2471895516278, 728.3917928529684, 739.4195556488131, 741.3476140995944, 745.6011034096787, 751.2412463411939, 20174.092165852424, 20227.79772202274, 20341.288054918008, 20384.388468345973, 20414.285500007427, 21301.467463313387, 21445.67831482529, 21665.133394664193, 21691.783082169135, 21797.891010544845, 16224.837751622568, 16430.507084787474, 16647.084410357427, 16766.41317553892, 16866.746998795028, 3705.0922523981526, 3709.5548534176073, 3710.07248187953, 3732.328180927432, 3747.2880152770886, 137733.0, 139145.0, 142873.0, 144590.27704861513, 144932.0, 14396.568102956719, 15263.847361526465, 15351.539453816404, 15509.689806203813, 15650.843491565167, 30547.541786873215, 31118.22204444907, 31171.68828311733, 31489.212769680482, 31814.409279535932, 8223.54770487629, 8299.087100418948, 8345.874811877828, 8361.122082181406, 8372.288355489729, 4002.799860006988, 4042.656374208166, 4064.0, 4068.7355321903983, 4080.9387859182134, 5268.736563171826, 5419.34967803866, 5515.669059856422, 5534.4742249486235, 5537.058700021006, 959.1224030012461, 984.7636567223815, 994.9154321882577, 1009.5154325923597, 1011.8431643095332, 668.7759600533778, 697.3549466743242, 706.9540479868792, 708.1537562612629, 710.6659869861157, 11191.888081119247, 11588.88411115878, 11951.760964780655, 12459.439325230387, 12531.18547294423, 669.1100835888257, 688.8760023195773, 693.743314973463, 695.422799076765, 709.4891677991837, 5535.7785688572, 5543.556515478752, 5560.77756889728, 5575.219469274305, 5654.208410822488, 119890.0, 120562.0, 121676.0, 121875.0, 123040.0, 104303.4784826071, 104498.0, 106145.0, 110070.0, 110490.44754776175, 89253.0, 90877.0, 91248.54375728079, 91366.0, 91675.54162229146, 10189.082982531607, 10190.133838623504, 10415.0, 10546.8417973732, 10571.418571978615, 43929.56070439383, 44347.33478997882, 44766.55233447624, 45273.0, 45417.091658167315, 56288.437115628316, 58235.70882145562, 58761.0, 59394.70302648459, 59783.70108149431, 14960.17719025464, 15060.171690556686, 15106.622334441727, 15154.621134471285, 15284.617884552976, 16469.670606587562, 16622.16889155513, 16802.747958780874, 16822.15889205559, 16836.0, 15275.465358712392, 15305.387784488496, 15356.539303820904, 15535.84464155344, 15578.532644020697, 14792.334344954717, 15094.471693490676, 15259.771103433235, 15421.614459638598, 15492.767608486107, 14980.1011939284, 15050.774238386652, 15143.394264229748, 15210.16344101085, 15449.768253475982, 10680.679579612624, 10710.464476776286, 10766.515506802056, 11123.332600044023, 11211.271267367594, 10817.972292632187, 11091.168162388014, 11147.442627868411, 11312.773744525228, 11323.490442929924], "value": 8761.898054027037, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 108.0, 108.0, 117.0, 112.0, 110.0, 114.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 119.0, 120.0, 121.0, 116.0, 125.0, 122.0, 123.0, 124.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 167.0, 164.0, 175.0, 166.0, 168.0, 165.0, 167.0, 166.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 76.0, 77.0, 76.0, 87.0, 81.0, 81.0, 76.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 84.0, 79.0, 89.0, 84.0, 80.0, 80.0, 86.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 114.0, 116.0, 114.0, 114.0, 117.0, 117.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 148.0, 147.0, 152.0, 150.0, 156.0, 154.0, 159.0, 149.0, 151.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 94.0, 96.0, 95.0, 95.0, 100.0, 101.0, 94.0, 95.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 52.0, 53.0, 54.0, 60.0, 53.0, 53.0, 59.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 40.0, 43.0, 40.0, 47.0, 44.0, 42.0, 48.0, 38.0, 42.0], "value": 42.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 87.0, 79.0, 77.0, 84.0, 81.0, 79.0, 76.0, 83.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 126.0, 120.0, 118.0, 115.0, 119.0, 118.0, 125.0, 116.0, 123.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 193.0, 184.0, 185.0, 183.0, 177.0, 176.0, 177.0, 174.0, 188.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 70.0, 68.0, 65.0, 69.0, 67.0, 66.0, 70.0, 71.0], "value": 68.8, "unit": "score"}]}]} 03:27:08 INFO - Return code: 0 03:27:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:08 INFO - # TBPL SUCCESS # 03:27:08 INFO - Running post-action listener: _package_coverage_data 03:27:08 INFO - Running post-action listener: _resource_record_post_action 03:27:08 INFO - [mozharness: 2017-09-19 10:27:08.937876Z] Finished run-tests step (success) 03:27:08 INFO - Running post-run listener: _resource_record_post_run 03:27:09 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 22179840; Write bytes: 327294976; Read time: 7972; Write time: 374864 03:27:09 INFO - TinderboxPrint: CPU usage
13.3% 03:27:09 INFO - TinderboxPrint: I/O read bytes / time
22,179,840 / 7,972 03:27:09 INFO - TinderboxPrint: I/O write bytes / time
327,294,976 / 374,864 03:27:09 INFO - TinderboxPrint: CPU idle
8,261.8 (86.7%) 03:27:09 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 03:27:09 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 55660544; Read time: 0; Write time: 25432 03:27:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:27:09 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 19808256; Write bytes: 196747264; Read time: 7368; Write time: 242004 03:27:09 INFO - Running post-run listener: _upload_blobber_files 03:27:09 INFO - Blob upload gear active. 03:27:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:09 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 03:27:09 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'] 03:27:09 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 03:27:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:11 INFO - (blobuploader) - INFO - Done attempting. 03:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:11 INFO - (blobuploader) - INFO - Done attempting. 03:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:18 INFO - (blobuploader) - INFO - Done attempting. 03:27:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:27:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:27:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:19 INFO - (blobuploader) - INFO - Done attempting. 03:27:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:19 INFO - Return code: 0 03:27:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce95c90ddc3c90cb3a314ea12b7d6affd9ecd820a4d328beb00e8ec4974c4ec196f511041dbf78c8da047e96732cb7b5ca87fbe914e460886cefe65ebd1bf35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3b984ad4bc402897334f717c47d8dfd262088ea224b62541d106d998ff239b4d8c490276e0ea105db7684eeaaa495d213f79e278581597f6c7e0b34e4e6b9b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76bef21f4c8fe21adda6b154b72f58a2c9272616f6600068c08414c7a45913a4bc194a1ddbbd84fc3bb3f9eb1294bfc15ae32d7c9247b9ba677bf53518c7270f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4a4fc6686fa15aba87459bfb5d1d503f1746cd5d5d260ce8c28d6126a5b2fcf0cfa89f04742d0d87107114fcd2c418b4c44dbf404c2eae359be7a139ae12cb"} 03:27:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:19 INFO - Contents: 03:27:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce95c90ddc3c90cb3a314ea12b7d6affd9ecd820a4d328beb00e8ec4974c4ec196f511041dbf78c8da047e96732cb7b5ca87fbe914e460886cefe65ebd1bf35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3b984ad4bc402897334f717c47d8dfd262088ea224b62541d106d998ff239b4d8c490276e0ea105db7684eeaaa495d213f79e278581597f6c7e0b34e4e6b9b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76bef21f4c8fe21adda6b154b72f58a2c9272616f6600068c08414c7a45913a4bc194a1ddbbd84fc3bb3f9eb1294bfc15ae32d7c9247b9ba677bf53518c7270f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4a4fc6686fa15aba87459bfb5d1d503f1746cd5d5d260ce8c28d6126a5b2fcf0cfa89f04742d0d87107114fcd2c418b4c44dbf404c2eae359be7a139ae12cb"} 03:27:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:19 INFO - Copying logs to upload dir... 03:27:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.379211 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-19 03:27:19.879890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:19.883657) ========= 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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce95c90ddc3c90cb3a314ea12b7d6affd9ecd820a4d328beb00e8ec4974c4ec196f511041dbf78c8da047e96732cb7b5ca87fbe914e460886cefe65ebd1bf35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3b984ad4bc402897334f717c47d8dfd262088ea224b62541d106d998ff239b4d8c490276e0ea105db7684eeaaa495d213f79e278581597f6c7e0b34e4e6b9b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76bef21f4c8fe21adda6b154b72f58a2c9272616f6600068c08414c7a45913a4bc194a1ddbbd84fc3bb3f9eb1294bfc15ae32d7c9247b9ba677bf53518c7270f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4a4fc6686fa15aba87459bfb5d1d503f1746cd5d5d260ce8c28d6126a5b2fcf0cfa89f04742d0d87107114fcd2c418b4c44dbf404c2eae359be7a139ae12cb"} build_url:https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce95c90ddc3c90cb3a314ea12b7d6affd9ecd820a4d328beb00e8ec4974c4ec196f511041dbf78c8da047e96732cb7b5ca87fbe914e460886cefe65ebd1bf35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3b984ad4bc402897334f717c47d8dfd262088ea224b62541d106d998ff239b4d8c490276e0ea105db7684eeaaa495d213f79e278581597f6c7e0b34e4e6b9b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76bef21f4c8fe21adda6b154b72f58a2c9272616f6600068c08414c7a45913a4bc194a1ddbbd84fc3bb3f9eb1294bfc15ae32d7c9247b9ba677bf53518c7270f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4a4fc6686fa15aba87459bfb5d1d503f1746cd5d5d260ce8c28d6126a5b2fcf0cfa89f04742d0d87107114fcd2c418b4c44dbf404c2eae359be7a139ae12cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:19.911820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:19.912195) ========= 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=d2a8c569965ab8367867b893000001a1-1505815588.950995-1074470568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:19.997038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:27:19.997364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:27:19.997667) ========= ========= Total master_lag: 0.42 =========