builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1505904924.81 results: success (0) revision: c0769d228dd3ba666d6e9b02896bebef7e996ad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:24.810816) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:24.811293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:24.811570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:24.830405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:24.830803) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 03:55:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 67.3M=0s 2017-09-20 03:55:25 (67.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.430857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:25.277435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:25.277835) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013367 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:25.329023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:25.329572) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0769d228dd3ba666d6e9b02896bebef7e996ad5 --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 c0769d228dd3ba666d6e9b02896bebef7e996ad5 --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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 03:55:25,411 truncating revision to first 12 chars 2017-09-20 03:55:25,411 Setting DEBUG logging. 2017-09-20 03:55:25,411 attempt 1/10 2017-09-20 03:55:25,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0769d228dd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 03:55:25,845 unpacking tar archive at: mozilla-central-c0769d228dd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704413 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:26.088473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:26.088916) ========= script_repo_revision: c0769d228dd3ba666d6e9b02896bebef7e996ad5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:26.089537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:26.090023) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 03:55:26.104705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-20 03:55:26.105131) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:26 INFO - MultiFileLogger online at 20170920 03:55:26 in /builds/slave/test 03:55:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:55:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:55:26 INFO - {'append_to_log': False, 03:55:26 INFO - 'base_work_dir': '/builds/slave/test', 03:55:26 INFO - 'blob_upload_branch': 'Firefox', 03:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:55:26 INFO - 'branch': 'Firefox', 03:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:26 INFO - 'code_coverage': False, 03:55:26 INFO - 'config_files': ('talos/linux_config.py',), 03:55:26 INFO - 'default_actions': ('clobber', 03:55:26 INFO - 'read-buildbot-config', 03:55:26 INFO - 'download-and-extract', 03:55:26 INFO - 'populate-webroot', 03:55:26 INFO - 'create-virtualenv', 03:55:26 INFO - 'install', 03:55:26 INFO - 'setup-mitmproxy', 03:55:26 INFO - 'run-tests'), 03:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:26 INFO - 'disable_ccov_upload': False, 03:55:26 INFO - 'disable_stylo': False, 03:55:26 INFO - 'download_minidump_stackwalk': True, 03:55:26 INFO - 'download_symbols': 'ondemand', 03:55:26 INFO - 'enable_stylo': False, 03:55:26 INFO - 'enable_webrender': False, 03:55:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:26 INFO - 'gecko_profile': False, 03:55:26 INFO - 'gecko_profile_interval': 0, 03:55:26 INFO - 'installer_path': 'installer.exe', 03:55:26 INFO - 'log_level': 'info', 03:55:26 INFO - 'log_name': 'talos', 03:55:26 INFO - 'log_to_console': True, 03:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:26 INFO - 'opt_config_files': (), 03:55:26 INFO - 'pip_index': False, 03:55:26 INFO - 'suite': 'dromaeojs-e10s', 03:55:26 INFO - 'system_bits': '32', 03:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:26 INFO - 'title': 'talos-linux64-ix-064', 03:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:26 INFO - 'use_talos_json': True, 03:55:26 INFO - 'verify': 'False', 03:55:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:26 INFO - 'work_dir': 'build'} 03:55:26 INFO - [mozharness: 2017-09-20 10:55:26.383247Z] Running clobber step. 03:55:26 INFO - Running pre-action listener: _resource_record_pre_action 03:55:26 INFO - Running main action method: clobber 03:55:26 INFO - rmtree: /builds/slave/test/build 03:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:55:27 INFO - Running post-action listener: _resource_record_post_action 03:55:27 INFO - [mozharness: 2017-09-20 10:55:27.330817Z] Finished clobber step (success) 03:55:27 INFO - [mozharness: 2017-09-20 10:55:27.330915Z] Running read-buildbot-config step. 03:55:27 INFO - Running pre-action listener: _resource_record_pre_action 03:55:27 INFO - Running main action method: read_buildbot_config 03:55:27 INFO - Using buildbot properties: 03:55:27 INFO - { 03:55:27 INFO - "project": "", 03:55:27 INFO - "product": "firefox", 03:55:27 INFO - "who": "archaeopteryx@coole-files.de", 03:55:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:55:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:55:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:55:27 INFO - "stage_platform": "linux64-pgo", 03:55:27 INFO - "basedir": "/builds/slave/test", 03:55:27 INFO - "buildnumber": 194, 03:55:27 INFO - "platform": "ubuntu64_hw", 03:55:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:55:27 INFO - "slavebuilddir": "test", 03:55:27 INFO - "taskId": "It-q3_r-TuS0ybyI_-6dvQ", 03:55:27 INFO - "branch": "mozilla-central", 03:55:27 INFO - "script_repo_revision": "production", 03:55:27 INFO - "revision": "c0769d228dd3ba666d6e9b02896bebef7e996ad5", 03:55:27 INFO - "slavename": "talos-linux64-ix-064", 03:55:27 INFO - "repo_path": "mozilla-central" 03:55:27 INFO - } 03:55:27 INFO - Finding installer, test and symbols from parent task. 03:55:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/It-q3_r-TuS0ybyI_-6dvQ'}, attempt #1 03:55:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/It-q3_r-TuS0ybyI_-6dvQ'}, attempt #1 03:55:28 INFO - Task dependencies: adKXr-mFS7q1uKnWoKqiJA 03:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA'}, attempt #1 03:55:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 03:55:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.test_packages.json 03:55:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.crashreporter-symbols.zip 03:55:28 INFO - Running post-action listener: _resource_record_post_action 03:55:28 INFO - [mozharness: 2017-09-20 10:55:28.664063Z] Finished read-buildbot-config step (success) 03:55:28 INFO - [mozharness: 2017-09-20 10:55:28.664286Z] Running download-and-extract step. 03:55:28 INFO - Running pre-action listener: _resource_record_pre_action 03:55:28 INFO - Running main action method: download_and_extract 03:55:28 INFO - mkdir: /builds/slave/test/build/tests 03:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:28 INFO - trying https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.test_packages.json 03:55:28 INFO - Downloading https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:55:29 INFO - Downloaded 989 bytes. 03:55:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:55:29 INFO - Using the following test package requirements: 03:55:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:55:29 INFO - u'common': [u'target.common.tests.zip'], 03:55:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:55:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:55:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:55:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:55:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:55:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:55:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:55:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:55:29 INFO - u'target.web-platform.tests.tar.gz'], 03:55:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:55:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:55:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.common.tests.zip 03:55:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:55:29 INFO - Fetch https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.common.tests.zip into memory 03:55:30 INFO - Content-Length response header: 55323088 03:55:30 INFO - Bytes received: 55323088 03:55:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.talos.tests.zip 03:55:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:55:41 INFO - Fetch https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.talos.tests.zip into memory 03:55:42 INFO - Content-Length response header: 14508893 03:55:42 INFO - Bytes received: 14508893 03:55:43 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:55:43 INFO - trying https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 03:55:43 INFO - Downloading https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:55:44 INFO - Downloaded 62315732 bytes. 03:55:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 03:55:44 INFO - mkdir: /builds/slave/test/properties 03:55:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:44 INFO - Contents: 03:55:44 INFO - build_url:https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 03:55:44 INFO - Running post-action listener: _resource_record_post_action 03:55:44 INFO - Running post-action listener: find_tests_for_verification 03:55:44 INFO - Running post-action listener: set_extra_try_arguments 03:55:44 INFO - [mozharness: 2017-09-20 10:55:44.121225Z] Finished download-and-extract step (success) 03:55:44 INFO - [mozharness: 2017-09-20 10:55:44.121323Z] Running populate-webroot step. 03:55:44 INFO - Running pre-action listener: _resource_record_pre_action 03:55:44 INFO - Running main action method: populate_webroot 03:55:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['tresize', 03:55:44 INFO - 'tcanvasmark']}, 03:55:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['dromaeo_css', 03:55:44 INFO - 'kraken']}, 03:55:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'tests': ['damp', 'tps']}, 03:55:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['damp', 'tps']}, 03:55:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['dromaeo_dom']}, 03:55:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:55:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['basic_compositor_video', 03:55:44 INFO - 'glvideo']}, 03:55:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:55:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['ts_paint_webext', 03:55:44 INFO - 'tp5o_webext']}, 03:55:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:44 INFO - 'ts_paint', 03:55:44 INFO - 'tpaint', 03:55:44 INFO - 'sessionrestore', 03:55:44 INFO - 'sessionrestore_many_windows', 03:55:44 INFO - 'sessionrestore_no_auto_restore', 03:55:44 INFO - 'tabpaint']}, 03:55:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['a11yr', 03:55:44 INFO - 'ts_paint', 03:55:44 INFO - 'tpaint', 03:55:44 INFO - 'sessionrestore', 03:55:44 INFO - 'sessionrestore_many_windows', 03:55:44 INFO - 'sessionrestore_no_auto_restore', 03:55:44 INFO - 'tabpaint']}, 03:55:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:55:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:55:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['perf_reftest_singletons']}, 03:55:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['bloom_basic']}, 03:55:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:44 INFO - 'tsvgr_opacity', 03:55:44 INFO - 'tart', 03:55:44 INFO - 'tscrollx', 03:55:44 INFO - 'tsvg_static']}, 03:55:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['tsvgx', 03:55:44 INFO - 'tsvgr_opacity', 03:55:44 INFO - 'tart', 03:55:44 INFO - 'tscrollx', 03:55:44 INFO - 'tsvg_static']}, 03:55:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:55:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo'], 03:55:44 INFO - 'tests': ['tp5o']}, 03:55:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:44 INFO - 'talos_options': ['--mitmproxy', 03:55:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:44 INFO - '--firstNonBlankPaint'], 03:55:44 INFO - 'tests': ['tp6_google', 03:55:44 INFO - 'tp6_youtube', 03:55:44 INFO - 'tp6_amazon', 03:55:44 INFO - 'tp6_facebook']}, 03:55:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo', 03:55:44 INFO - '--mitmproxy', 03:55:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:44 INFO - '--firstNonBlankPaint'], 03:55:44 INFO - 'tests': ['tp6_google', 03:55:44 INFO - 'tp6_youtube', 03:55:44 INFO - 'tp6_amazon', 03:55:44 INFO - 'tp6_facebook']}, 03:55:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:55:44 INFO - 'talos_options': ['--stylo-threads=1', 03:55:44 INFO - '--mitmproxy', 03:55:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:55:44 INFO - '--firstNonBlankPaint'], 03:55:44 INFO - 'tests': ['tp6_google', 03:55:44 INFO - 'tp6_youtube', 03:55:44 INFO - 'tp6_amazon', 03:55:44 INFO - 'tp6_facebook']}, 03:55:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--xperf_path', 03:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:44 INFO - 'tests': ['tp5n']}, 03:55:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:55:44 INFO - 'talos_options': ['--disable-stylo', 03:55:44 INFO - '--xperf_path', 03:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:44 INFO - 'tests': ['tp5n']}}} 03:55:44 INFO - Running post-action listener: _resource_record_post_action 03:55:44 INFO - [mozharness: 2017-09-20 10:55:44.138140Z] Finished populate-webroot step (success) 03:55:44 INFO - [mozharness: 2017-09-20 10:55:44.138231Z] Running create-virtualenv step. 03:55:44 INFO - Running pre-action listener: _resource_record_pre_action 03:55:44 INFO - Running main action method: create_virtualenv 03:55:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:55:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:55:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:55:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:46 INFO - Installing pip...............done. 03:55:46 INFO - Return code: 0 03:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:55:47 INFO - Reading from file tmpfile_stdout 03:55:47 INFO - Output received: 03:55:47 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:55:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:47 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55:47 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:55:47 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:55:47 INFO - Using env: {'DISPLAY': ':0', 03:55:47 INFO - 'HOME': '/home/cltbld', 03:55:47 INFO - 'LANG': 'en_US.UTF-8', 03:55:47 INFO - 'LANGUAGE': 'en_US:en', 03:55:47 INFO - 'LOGNAME': 'cltbld', 03:55:47 INFO - 'MAIL': '/var/mail/cltbld', 03:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:47 INFO - 'MOZ_NO_REMOTE': '1', 03:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:47 INFO - 'NO_EM_RESTART': '1', 03:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:47 INFO - 'PWD': '/builds/slave/test', 03:55:47 INFO - 'SHELL': '/bin/bash', 03:55:47 INFO - 'SHLVL': '1', 03:55:47 INFO - 'TERM': 'linux', 03:55:47 INFO - 'TMOUT': '86400', 03:55:47 INFO - 'USER': 'cltbld', 03:55:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:47 INFO - '_': '/tools/buildbot/bin/python'} 03:55:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:55:48 INFO - Downloading/unpacking pip>=1.5 03:55:48 INFO - Running setup.py egg_info for package pip 03:55:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:55:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:55:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:55:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:55:48 INFO - Installing collected packages: pip 03:55:48 INFO - Found existing installation: pip 1.1 03:55:48 INFO - Uninstalling pip: 03:55:48 INFO - Successfully uninstalled pip 03:55:48 INFO - Running setup.py install for pip 03:55:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:55:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:55:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:55:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:55:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:55:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:55:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:55:48 INFO - Successfully installed pip 03:55:48 INFO - Cleaning up... 03:55:48 INFO - Return code: 0 03:55:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55: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:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:48 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55:48 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:55:48 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:55:48 INFO - Using env: {'DISPLAY': ':0', 03:55:48 INFO - 'HOME': '/home/cltbld', 03:55:48 INFO - 'LANG': 'en_US.UTF-8', 03:55:48 INFO - 'LANGUAGE': 'en_US:en', 03:55:48 INFO - 'LOGNAME': 'cltbld', 03:55:48 INFO - 'MAIL': '/var/mail/cltbld', 03:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:48 INFO - 'MOZ_NO_REMOTE': '1', 03:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:48 INFO - 'NO_EM_RESTART': '1', 03:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:48 INFO - 'PWD': '/builds/slave/test', 03:55:48 INFO - 'SHELL': '/bin/bash', 03:55:48 INFO - 'SHLVL': '1', 03:55:48 INFO - 'TERM': 'linux', 03:55:48 INFO - 'TMOUT': '86400', 03:55:48 INFO - 'USER': 'cltbld', 03:55:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:48 INFO - '_': '/tools/buildbot/bin/python'} 03:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:48 INFO - Downloading/unpacking psutil>=3.1.1 03:55:48 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:55:48 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:55:48 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:55:48 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:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:50 INFO - Installing collected packages: psutil 03:55:50 INFO - Running setup.py install for psutil 03:55:50 INFO - building 'psutil._psutil_linux' extension 03:55:50 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:55:51 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:55:51 INFO - building 'psutil._psutil_posix' extension 03:55:51 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:55:51 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:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:51 INFO - Successfully installed psutil 03:55:51 INFO - Cleaning up... 03:55:52 INFO - Return code: 0 03:55:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55: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:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:55: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 mozsystemmonitor==0.3 03:55:52 INFO - Using env: {'DISPLAY': ':0', 03:55:52 INFO - 'HOME': '/home/cltbld', 03:55:52 INFO - 'LANG': 'en_US.UTF-8', 03:55:52 INFO - 'LANGUAGE': 'en_US:en', 03:55:52 INFO - 'LOGNAME': 'cltbld', 03:55:52 INFO - 'MAIL': '/var/mail/cltbld', 03:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:52 INFO - 'MOZ_NO_REMOTE': '1', 03:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:52 INFO - 'NO_EM_RESTART': '1', 03:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:52 INFO - 'PWD': '/builds/slave/test', 03:55:52 INFO - 'SHELL': '/bin/bash', 03:55:52 INFO - 'SHLVL': '1', 03:55:52 INFO - 'TERM': 'linux', 03:55:52 INFO - 'TMOUT': '86400', 03:55:52 INFO - 'USER': 'cltbld', 03:55:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:52 INFO - '_': '/tools/buildbot/bin/python'} 03:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55:52 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:55:52 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:55:52 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:55:52 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:55:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:53 INFO - Installing collected packages: mozsystemmonitor 03:55:53 INFO - Running setup.py install for mozsystemmonitor 03:55:53 INFO - Successfully installed mozsystemmonitor 03:55:53 INFO - Cleaning up... 03:55:53 INFO - Return code: 0 03:55:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:53 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55:53 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:55:53 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:55:53 INFO - Using env: {'DISPLAY': ':0', 03:55:53 INFO - 'HOME': '/home/cltbld', 03:55:53 INFO - 'LANG': 'en_US.UTF-8', 03:55:53 INFO - 'LANGUAGE': 'en_US:en', 03:55:53 INFO - 'LOGNAME': 'cltbld', 03:55:53 INFO - 'MAIL': '/var/mail/cltbld', 03:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:53 INFO - 'MOZ_NO_REMOTE': '1', 03:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:53 INFO - 'NO_EM_RESTART': '1', 03:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:53 INFO - 'PWD': '/builds/slave/test', 03:55:53 INFO - 'SHELL': '/bin/bash', 03:55:53 INFO - 'SHLVL': '1', 03:55:53 INFO - 'TERM': 'linux', 03:55:53 INFO - 'TMOUT': '86400', 03:55:53 INFO - 'USER': 'cltbld', 03:55:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:53 INFO - '_': '/tools/buildbot/bin/python'} 03:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:55:54 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:55:54 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:55:54 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:55:54 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:55:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:55 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:55:55 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:55:55 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:55:55 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:55:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:55 INFO - warning: no files found matching '*.txt' 03:55:55 INFO - no previously-included directories found matching 'build' 03:55:55 INFO - no previously-included directories found matching 'dist' 03:55:55 INFO - no previously-included directories found matching '.git*' 03:55:55 INFO - Installing collected packages: jsonschema, functools32 03:55:55 INFO - Running setup.py install for functools32 03:55:55 INFO - warning: no files found matching '*.txt' 03:55:55 INFO - no previously-included directories found matching 'build' 03:55:55 INFO - no previously-included directories found matching 'dist' 03:55:55 INFO - no previously-included directories found matching '.git*' 03:55:55 INFO - Successfully installed jsonschema functools32 03:55:55 INFO - Cleaning up... 03:55:55 INFO - Return code: 0 03:55:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55: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:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55: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', '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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:55: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 functools32==3.2.3-2 03:55:55 INFO - Using env: {'DISPLAY': ':0', 03:55:55 INFO - 'HOME': '/home/cltbld', 03:55:55 INFO - 'LANG': 'en_US.UTF-8', 03:55:55 INFO - 'LANGUAGE': 'en_US:en', 03:55:55 INFO - 'LOGNAME': 'cltbld', 03:55:55 INFO - 'MAIL': '/var/mail/cltbld', 03:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:55 INFO - 'MOZ_NO_REMOTE': '1', 03:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:55 INFO - 'NO_EM_RESTART': '1', 03:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:55 INFO - 'PWD': '/builds/slave/test', 03:55:55 INFO - 'SHELL': '/bin/bash', 03:55:55 INFO - 'SHLVL': '1', 03:55:55 INFO - 'TERM': 'linux', 03:55:55 INFO - 'TMOUT': '86400', 03:55:55 INFO - 'USER': 'cltbld', 03:55:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:55 INFO - '_': '/tools/buildbot/bin/python'} 03:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:55 INFO - Cleaning up... 03:55:55 INFO - Return code: 0 03:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55: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:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55: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:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55: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', '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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:55: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 blobuploader==1.2.4 03:55:55 INFO - Using env: {'DISPLAY': ':0', 03:55:55 INFO - 'HOME': '/home/cltbld', 03:55:55 INFO - 'LANG': 'en_US.UTF-8', 03:55:55 INFO - 'LANGUAGE': 'en_US:en', 03:55:55 INFO - 'LOGNAME': 'cltbld', 03:55:55 INFO - 'MAIL': '/var/mail/cltbld', 03:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:55 INFO - 'MOZ_NO_REMOTE': '1', 03:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:55 INFO - 'NO_EM_RESTART': '1', 03:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:55 INFO - 'PWD': '/builds/slave/test', 03:55:55 INFO - 'SHELL': '/bin/bash', 03:55:55 INFO - 'SHLVL': '1', 03:55:55 INFO - 'TERM': 'linux', 03:55:55 INFO - 'TMOUT': '86400', 03:55:55 INFO - 'USER': 'cltbld', 03:55:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:55 INFO - '_': '/tools/buildbot/bin/python'} 03:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:55 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:55:55 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:55:55 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:55:55 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:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55: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:55: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:55: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:55: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:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55: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:55: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:55: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:55: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:55:58 INFO - Downloading docopt-0.6.1.tar.gz 03:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:58 INFO - Running setup.py install for blobuploader 03:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:58 INFO - Running setup.py install for requests 03:55:59 INFO - Running setup.py install for docopt 03:55:59 INFO - Successfully installed blobuploader requests docopt 03:55:59 INFO - Cleaning up... 03:55:59 INFO - Return code: 0 03:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:59 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:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:59 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:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:59 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:55:59 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:55:59 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:55:59 INFO - Using env: {'DISPLAY': ':0', 03:55:59 INFO - 'HOME': '/home/cltbld', 03:55:59 INFO - 'LANG': 'en_US.UTF-8', 03:55:59 INFO - 'LANGUAGE': 'en_US:en', 03:55:59 INFO - 'LOGNAME': 'cltbld', 03:55:59 INFO - 'MAIL': '/var/mail/cltbld', 03:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:59 INFO - 'MOZ_NO_REMOTE': '1', 03:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:59 INFO - 'NO_EM_RESTART': '1', 03:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:59 INFO - 'PWD': '/builds/slave/test', 03:55:59 INFO - 'SHELL': '/bin/bash', 03:55:59 INFO - 'SHLVL': '1', 03:55:59 INFO - 'TERM': 'linux', 03:55:59 INFO - 'TMOUT': '86400', 03:55:59 INFO - 'USER': 'cltbld', 03:55:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:59 INFO - '_': '/tools/buildbot/bin/python'} 03:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:59 INFO - Running setup.py (path:/tmp/pip-nKmAbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:59 INFO - Running setup.py (path:/tmp/pip-27QjVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:59 INFO - Running setup.py (path:/tmp/pip-Izf61p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:59 INFO - Running setup.py (path:/tmp/pip-bimALA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:59 INFO - Running setup.py (path:/tmp/pip-DPLTC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:59 INFO - Running setup.py (path:/tmp/pip-w_0ry9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:59 INFO - Running setup.py (path:/tmp/pip-u_EDig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:00 INFO - Running setup.py (path:/tmp/pip-ACTBzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:00 INFO - Running setup.py (path:/tmp/pip-OUftQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:00 INFO - Running setup.py (path:/tmp/pip-B5vNJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:00 INFO - Running setup.py (path:/tmp/pip-TMN1ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:00 INFO - Running setup.py (path:/tmp/pip-tt_WYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:00 INFO - Running setup.py (path:/tmp/pip-iKSSCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:00 INFO - Running setup.py (path:/tmp/pip-J3DJls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:00 INFO - Running setup.py (path:/tmp/pip-OV2SiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:00 INFO - Running setup.py (path:/tmp/pip-ieEAV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:00 INFO - Running setup.py (path:/tmp/pip-mBkYoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:00 INFO - Running setup.py install for manifestparser 03:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:00 INFO - Running setup.py install for mozcrash 03:56:00 INFO - Running setup.py install for mozdebug 03:56:01 INFO - Running setup.py install for mozdevice 03:56:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozfile 03:56:01 INFO - Running setup.py install for mozhttpd 03:56:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozinfo 03:56:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozInstall 03:56:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozleak 03:56:01 INFO - Running setup.py install for mozlog 03:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for moznetwork 03:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozprocess 03:56:01 INFO - Running setup.py install for mozprofile 03:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:56:01 INFO - Running setup.py install for mozrunner 03:56:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:56:02 INFO - Running setup.py install for mozscreenshot 03:56:02 INFO - Running setup.py install for moztest 03:56:02 INFO - Running setup.py install for mozversion 03:56:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:02 INFO - Cleaning up... 03:56:02 INFO - Return code: 0 03:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:02 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:56:02 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:56:02 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:56:02 INFO - Using env: {'DISPLAY': ':0', 03:56:02 INFO - 'HOME': '/home/cltbld', 03:56:02 INFO - 'LANG': 'en_US.UTF-8', 03:56:02 INFO - 'LANGUAGE': 'en_US:en', 03:56:02 INFO - 'LOGNAME': 'cltbld', 03:56:02 INFO - 'MAIL': '/var/mail/cltbld', 03:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:02 INFO - 'MOZ_NO_REMOTE': '1', 03:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:02 INFO - 'NO_EM_RESTART': '1', 03:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:02 INFO - 'PWD': '/builds/slave/test', 03:56:02 INFO - 'SHELL': '/bin/bash', 03:56:02 INFO - 'SHLVL': '1', 03:56:02 INFO - 'TERM': 'linux', 03:56:02 INFO - 'TMOUT': '86400', 03:56:02 INFO - 'USER': 'cltbld', 03:56:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:02 INFO - '_': '/tools/buildbot/bin/python'} 03:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:02 INFO - Running setup.py (path:/tmp/pip-zCX3fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:02 INFO - Running setup.py (path:/tmp/pip-5NlhOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:02 INFO - Running setup.py (path:/tmp/pip-7Ic1vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:02 INFO - Running setup.py (path:/tmp/pip-GJXLE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:02 INFO - Running setup.py (path:/tmp/pip-LT2SvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:02 INFO - Running setup.py (path:/tmp/pip-wv0E9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:03 INFO - Running setup.py (path:/tmp/pip-MkpLsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:03 INFO - Running setup.py (path:/tmp/pip-JJm6ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:03 INFO - Running setup.py (path:/tmp/pip-t6JGg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:03 INFO - Running setup.py (path:/tmp/pip-F87Dxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:03 INFO - Running setup.py (path:/tmp/pip-nEz2RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:03 INFO - Running setup.py (path:/tmp/pip-MtjePs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:03 INFO - Running setup.py (path:/tmp/pip-5aePq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:03 INFO - Running setup.py (path:/tmp/pip-1vG0YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:03 INFO - Running setup.py (path:/tmp/pip-voXzjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:03 INFO - Running setup.py (path:/tmp/pip-qwzIq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:03 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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:03 INFO - Running setup.py (path:/tmp/pip-7WIKqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:03 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:56:03 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:56:03 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:56:03 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:56:04 INFO - Downloading blessings-1.6.tar.gz 03:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:05 INFO - Installing collected packages: blessings 03:56:05 INFO - Running setup.py install for blessings 03:56:05 INFO - Successfully installed blessings 03:56:05 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:05 INFO - Reading from file tmpfile_stdout 03:56:05 INFO - Current package versions: 03:56:05 INFO - argparse == 1.2.1 03:56:05 INFO - blessings == 1.6 03:56:05 INFO - blobuploader == 1.2.4 03:56:05 INFO - docopt == 0.6.1 03:56:05 INFO - functools32 == 3.2.3-2 03:56:05 INFO - jsonschema == 2.5.1 03:56:05 INFO - manifestparser == 1.1 03:56:05 INFO - mozInstall == 1.13 03:56:05 INFO - mozcrash == 1.0 03:56:05 INFO - mozdebug == 0.1 03:56:05 INFO - mozdevice == 0.51 03:56:05 INFO - mozfile == 1.2 03:56:05 INFO - mozhttpd == 0.7 03:56:05 INFO - mozinfo == 0.10 03:56:05 INFO - mozleak == 0.1 03:56:05 INFO - mozlog == 3.5 03:56:05 INFO - moznetwork == 0.27 03:56:05 INFO - mozprocess == 0.25 03:56:05 INFO - mozprofile == 0.28 03:56:05 INFO - mozrunner == 6.13 03:56:05 INFO - mozscreenshot == 0.1 03:56:05 INFO - mozsystemmonitor == 0.3 03:56:05 INFO - moztest == 0.8 03:56:05 INFO - mozversion == 1.4 03:56:05 INFO - psutil == 3.1.1 03:56:05 INFO - requests == 1.2.3 03:56:05 INFO - wsgiref == 0.1.2 03:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:05 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:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:05 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:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:05 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:56:05 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:56:05 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:56:05 INFO - Using env: {'DISPLAY': ':0', 03:56:05 INFO - 'HOME': '/home/cltbld', 03:56:05 INFO - 'LANG': 'en_US.UTF-8', 03:56:05 INFO - 'LANGUAGE': 'en_US:en', 03:56:05 INFO - 'LOGNAME': 'cltbld', 03:56:05 INFO - 'MAIL': '/var/mail/cltbld', 03:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:05 INFO - 'MOZ_NO_REMOTE': '1', 03:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:05 INFO - 'NO_EM_RESTART': '1', 03:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:05 INFO - 'PWD': '/builds/slave/test', 03:56:05 INFO - 'SHELL': '/bin/bash', 03:56:05 INFO - 'SHLVL': '1', 03:56:05 INFO - 'TERM': 'linux', 03:56:05 INFO - 'TMOUT': '86400', 03:56:05 INFO - 'USER': 'cltbld', 03:56:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:05 INFO - '_': '/tools/buildbot/bin/python'} 03:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:56:13 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:56:13 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:56:13 INFO - Installing collected packages: simplejson 03:56:13 INFO - Running setup.py install for simplejson 03:56:13 INFO - building 'simplejson._speedups' extension 03:56:13 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:56:14 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:56:14 INFO - Successfully installed simplejson 03:56:14 INFO - Cleaning up... 03:56:14 INFO - Return code: 0 03:56:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:14 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 0x106d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1236a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', '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:56:14 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:56:14 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:56:14 INFO - Using env: {'DISPLAY': ':0', 03:56:14 INFO - 'HOME': '/home/cltbld', 03:56:14 INFO - 'LANG': 'en_US.UTF-8', 03:56:14 INFO - 'LANGUAGE': 'en_US:en', 03:56:14 INFO - 'LOGNAME': 'cltbld', 03:56:14 INFO - 'MAIL': '/var/mail/cltbld', 03:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:14 INFO - 'MOZ_NO_REMOTE': '1', 03:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:14 INFO - 'NO_EM_RESTART': '1', 03:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:14 INFO - 'PWD': '/builds/slave/test', 03:56:14 INFO - 'SHELL': '/bin/bash', 03:56:14 INFO - 'SHLVL': '1', 03:56:14 INFO - 'TERM': 'linux', 03:56:14 INFO - 'TMOUT': '86400', 03:56:14 INFO - 'USER': 'cltbld', 03:56:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:14 INFO - '_': '/tools/buildbot/bin/python'} 03:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:56:15 INFO - Cleaning up... 03:56:15 INFO - Return code: 0 03:56:15 INFO - Running post-action listener: _resource_record_post_action 03:56:15 INFO - Running post-action listener: _start_resource_monitoring 03:56:15 INFO - Starting resource monitoring. 03:56:15 INFO - [mozharness: 2017-09-20 10:56:15.230708Z] Finished create-virtualenv step (success) 03:56:15 INFO - [mozharness: 2017-09-20 10:56:15.231711Z] Running install step. 03:56:15 INFO - Running pre-action listener: _resource_record_pre_action 03:56:15 INFO - Running main action method: install 03:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:15 INFO - Reading from file tmpfile_stdout 03:56:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:15 INFO - Reading from file tmpfile_stdout 03:56:15 INFO - Output received: 03:56:15 INFO - Usage: mozinstall [options] installer 03:56:15 INFO - Options: 03:56:15 INFO - -h, --help show this help message and exit 03:56:15 INFO - -d DEST, --destination=DEST 03:56:15 INFO - Directory to install application into. [default: 03:56:15 INFO - "/builds/slave/test"] 03:56:15 INFO - --app=APP Application being installed. [default: firefox] 03:56:15 INFO - mkdir: /builds/slave/test/build/application 03:56:15 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:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:56:33 INFO - Reading from file tmpfile_stdout 03:56:33 INFO - Output received: 03:56:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:56:33 INFO - Running post-action listener: _resource_record_post_action 03:56:33 INFO - [mozharness: 2017-09-20 10:56:33.385473Z] Finished install step (success) 03:56:33 INFO - [mozharness: 2017-09-20 10:56:33.385726Z] Running setup-mitmproxy step. 03:56:33 INFO - Running pre-action listener: _resource_record_pre_action 03:56:33 INFO - Running main action method: setup_mitmproxy 03:56:33 INFO - Skipping: mitmproxy is not required 03:56:33 INFO - Running post-action listener: _resource_record_post_action 03:56:33 INFO - [mozharness: 2017-09-20 10:56:33.386845Z] Finished setup-mitmproxy step (success) 03:56:33 INFO - [mozharness: 2017-09-20 10:56:33.387065Z] Running run-tests step. 03:56:33 INFO - Running pre-action listener: _resource_record_pre_action 03:56:33 INFO - Running pre-action listener: _set_gcov_prefix 03:56:33 INFO - Running main action method: run_tests 03:56:33 WARNING - Try message not found. 03:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:33 INFO - Python 2.7.3 03:56:33 INFO - Return code: 0 03:56:33 INFO - grabbing minidump binary from tooltool 03:56:33 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:56:33 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 0x13dd090>, '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 0x13ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d7f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:33 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:56:33 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:56:33 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:56:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:33 INFO - Return code: 0 03:56:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:56:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:33 INFO - ENV: RUST_BACKTRACE is now full 03:56:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:56:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:33 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/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:56:33 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/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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:56:33 INFO - Using env: {'DISPLAY': ':0', 03:56:33 INFO - 'HOME': '/home/cltbld', 03:56:33 INFO - 'LANG': 'en_US.UTF-8', 03:56:33 INFO - 'LANGUAGE': 'en_US:en', 03:56:33 INFO - 'LOGNAME': 'cltbld', 03:56:33 INFO - 'MAIL': '/var/mail/cltbld', 03:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:33 INFO - 'MOZ_NO_REMOTE': '1', 03:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:33 INFO - 'NO_EM_RESTART': '1', 03:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:33 INFO - 'PWD': '/builds/slave/test', 03:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:33 INFO - 'RUST_BACKTRACE': 'full', 03:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:56:33 INFO - 'SHELL': '/bin/bash', 03:56:33 INFO - 'SHLVL': '1', 03:56:33 INFO - 'TERM': 'linux', 03:56:33 INFO - 'TMOUT': '86400', 03:56:33 INFO - 'USER': 'cltbld', 03:56:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:33 INFO - '_': '/tools/buildbot/bin/python'} 03:56:33 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/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:56:33 INFO - mozversion application_buildid: 20170920093924 03:56:33 INFO - mozversion application_changeset: c0769d228dd3ba666d6e9b02896bebef7e996ad5 03:56:33 INFO - mozversion application_display_name: Nightly 03:56:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:33 INFO - mozversion application_name: Firefox 03:56:33 INFO - mozversion application_remotingname: firefox 03:56:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:56:33 INFO - mozversion application_vendor: Mozilla 03:56:33 INFO - mozversion application_version: 57.0a1 03:56:33 INFO - mozversion platform_buildid: 20170920093924 03:56:33 INFO - mozversion platform_changeset: c0769d228dd3ba666d6e9b02896bebef7e996ad5 03:56:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:56:33 INFO - mozversion platform_version: 57.0a1 03:56:33 INFO - using testdate: 1505904993 03:56:33 INFO - actual date: 1505904993 03:56:33 INFO - starting webserver on 'localhost:54857' 03:56:33 INFO - SUITE-START | Running 2 tests 03:56:33 INFO - TEST-START | dromaeo_css 03:56:33 INFO - Initialising browser for dromaeo_css test... 03:56:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54857/getInfo.html -profile /tmp/tmpEwnBLI/profile 03:56:33 INFO - TEST-INFO | started process 3549 (/builds/slave/test/build/application/firefox/firefox http://localhost:54857/getInfo.html) 03:56:40 INFO - TEST-INFO | 3549: exit 0 03:56:41 INFO - Browser initialized. 03:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:41 INFO - Using env: {'DISPLAY': ':0', 03:56:41 INFO - 'HOME': '/home/cltbld', 03:56:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:56:41 INFO - 'LANG': 'en_US.UTF-8', 03:56:41 INFO - 'LANGUAGE': 'en_US:en', 03:56:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:56:41 INFO - 'LOGNAME': 'cltbld', 03:56:41 INFO - 'MAIL': '/var/mail/cltbld', 03:56:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:56:41 INFO - 'MOZ_NO_REMOTE': '1', 03:56:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:41 INFO - 'NO_EM_RESTART': '1', 03:56:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:41 INFO - 'PWD': '/builds/slave/test', 03:56:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:41 INFO - 'RUST_BACKTRACE': 'full', 03:56:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:56:41 INFO - 'SHELL': '/bin/bash', 03:56:41 INFO - 'SHLVL': '1', 03:56:41 INFO - 'TERM': 'linux', 03:56:41 INFO - 'TMOUT': '86400', 03:56:41 INFO - 'USER': 'cltbld', 03:56:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 03:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:41 INFO - '_': '/tools/buildbot/bin/python'} 03:56:41 INFO - TEST-INFO | started process 3785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEwnBLI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:41 INFO - PID 3785 | 03:56:41 INFO - PID 3785 | (/builds/slave/test/build/application/firefox/firefox:3834): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:56:41 INFO - PID 3785 | 03:56:52 INFO - PID 3785 | RSS: Main: 143400960 03:56:52 INFO - PID 3785 | 03:59:49 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54857/tests/dromaeo/cssquery-ext.html) 03:59:50 INFO - PID 3785 | RSS: Main: 150278144 03:59:50 INFO - PID 3785 | 04:02:52 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-ext.html (next: http://localhost:54857/tests/dromaeo/cssquery-jquery.html) 04:02:53 INFO - PID 3785 | RSS: Main: 148029440 04:02:53 INFO - PID 3785 | 04:05:54 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54857/tests/dromaeo/cssquery-mootools.html) 04:05:55 INFO - PID 3785 | RSS: Main: 149942272 04:05:55 INFO - PID 3785 | 04:08:56 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54857/tests/dromaeo/cssquery-prototype.html) 04:08:57 INFO - PID 3785 | RSS: Main: 148619264 04:08:57 INFO - PID 3785 | 04:12:00 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54857/tests/dromaeo/cssquery-yui.html) 04:12:01 INFO - PID 3785 | RSS: Main: 150044672 04:12:01 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | Cycle 1(1): loaded http://localhost:54857/tests/dromaeo/cssquery-yui.html (next: http://localhost:54857/tests/dromaeo/cssquery-dojo.html) 04:15:02 INFO - PID 3785 | RSS: Main: 152879104 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | __start_tp_report 04:15:02 INFO - PID 3785 | _x_x_mozilla_page_load 04:15:02 INFO - PID 3785 | _x_x_mozilla_page_load_details 04:15:02 INFO - PID 3785 | |i|pagename|runs| 04:15:02 INFO - PID 3785 | |0;dojo.html;3879.9806000969998;3884.6309600587942;3906.1015966327745;3935.468711723918;3941.783201923893;6148.8462788430315;6238.625682459045;6329.145565348676;6378.553501254914;6395.13665655137;6319.747210111602;6320.968395158029;6373.904391434132;6438.227412710481;6453.612783232998;5677.602567820254;5712.2574065371655;5726.828195154152;5741.224934633834;5753.108268218432;154.55556163085288;5678.914816277738;5767.509761670263;5795.855103622401;5817.447342502476;5674.971625141848;5694.2312787773535;5769.249997500298;5778.59549831512;5788.334341550712;5684.403137670568;5716.885662286731;5761.971190144022;5787.421257874221;5789.218455508537;5665.915011274793;5679.772809087632;5756.769729210827;5781.739821708034;5783.826485205451;6313.305536390993;6318.399752023551;6342.460890824285;6409.583377080475;6417.93582064178;6730.83172920676;6819.045333653293;6853.725850965955;6954.061201737752;6959.652017399109;6863.485238607124;6864.347886950732;6913.343232392915;6925.549839260432;6929.029935808991;6441;6463.48292136628;6478.255000674889;6492.7402903883785;6504.902426463559;7018.684159212848;7059.047028651066;7067.363937245673;7147.857042859114;7173.6771845267085;6670.599764014175;6752.5948443093575;6785.830354241085;6834.4874134440115;6855.383015528527;6815.625140617313;6829.180498340231;6849.794506164823;6860.485463590251;6864.141982252218;6807.931920680829;6812.216595091529;6871.587704737632;6880.346367095118;6940.236573976858;6721.092652491949;6803.693833777492;6826.829329266808;6912.274211207851;6947.340002699735;4927;5003.099442100384;5006.123928312531;5011.6241281904;5020.272060551272;4516.16450956574;4524.04994951064;4528.298113792367;4556.863294101182;4571.954280457219;6216.285127210429;6243.656598887014;6262.624242545462;6343.5876668016435;6426.132472116205;6782.796516104525;6783.864322713617;6790.388865002174;6800.047993280945;6800.149981252343;6261.655608941461;6273.937260627426;6282.560220784592;6295.842603934938;6302.275238347557;5528.917066244009;5543.861403464945;5595.272614560081;5623.3533143689;5639.154126880919;7108.71565137399;7118.822029449305;7157.713691452388;7211.819704507325;7227;6608.471322294109;6706.295838936841;6864.24493305726;6938.548994315353;6958.47811414146;6995.755148569776;7082.645867706698;7091.858162836611;7153.6423178839805;7159.534630249017;6841.042254084333;6850.8287292816085;6897.2757860423935;6905.102336696398;6906.309369063053;6879.828004299732;6890.689918953559;6894.965525172342;6980.336867997532;6984.40632546219;6462.515311351762;6604.603723776589;6617.933820661924;6700.363465470772;6702.430293425114;6635.834104147435;6698.497612678971;6703.229128650268;6704.664766761545;6708.094407254958;6540.313267107075;6543;6575.375339342755;6624.867502649824;6627.1716035495565;6670.7665231716655;6674.866502669823;6792.932070679428;6804.829879253059;6809.353111454404;6350.079238510482;6464;6503.772367967098;6506.934930650633;6574.572652777554 04:15:02 INFO - PID 3785 | |1;ext.html;923.9630414783409;925.255169588481;952.9999999999999;968.259281649538;982.8083523712879;43945;44425.55574444254;44525.33212001818;44573.55426445731;44763.552364476345;41855.58144418555;42090.36864447028;42151;42162.156756864846;42163.57836421635;7689.769306920802;7831.725889593866;7837.529748215097;7840.372770178372;7842.294193522582;7690.2694244046725;7748.612569371537;7753.18591547885;7791.805204869867;7793.376529877596;8359.707410240642;8560.871586926201;8562.529060901648;8563;8570;8432.704855330065;8503.617337219777;8509.48943063412;8515.23362897336;8515.95742021289;8119.634616442274;8277.420580559363;8306.501609903366;8361.916380836175;8366.205210504992;41432.37851432231;41526.79236603828;41581;41970.580294196974;41984.580154198375;3694;3758.849646014156;3764.3412402829395;3786.5645450773236;3787.886363409102;33811;34060.48909266363;34139.4879076814;34158.658413416044;34177.316453670785;5388.272583201296;5391.73041347931;5411.864703382407;5430.076886929192;5496.725163741837;234791;235344;236312;237493;238644;53444;53807.73096134494;53921.460785391646;53996.46003539993;54023.729881350344;56155.43844561584;56221;56339.43660563342;56394.7180264096;56483.43516564864;15445.691086178438;15656.295466703798;15716;15748.055116693035;15764.369425222863;12413.503459861504;12508.624741257594;12512.249265044127;12531.31077790712;12538.937305313415;14866.702665946621;15195.544133676007;15250.161241131622;15357.15535645528;15370.538883833502;6062.272527296753;6081.452669259699;6122.173506576644;6187.195664563668;6254.312025677172;1034.4930983818026;1081.8809930907594;1085.1102096280974;1089.3355053417408;1098.2751384086464;25479.49041019169;25489.23532294034;25605.871970640026;25752.871235644077;25763.742362576133;1167.229628445222;1191.9165658403829;1197.784398808223;1205.6684411786828;1210.8002179640262;13497.19016858972;13652.726945461036;13695.726085478234;13734.65663358424;13950;294404;295754;295949;296519;296910;58850;59375;59612.403875960685;63639;64567.677161613894;1501.1068414293477;1519.1720512320812;1526.3589292497177;1533.6395946952234;1533.7776022476678;30227.395452090394;30253.394932101673;30565.847170764006;30868.536971945887;30949.69050309468;41857;42306.15387692291;42373;42428.93927651834;42451;227558;228690;229322;229747;230267;35093.47359789554;35202.29595408026;35265.64734352624;35335.29329413346;35479.82260088683;44056.559434405244;45425.77287113675;45920.77039614914;45986.77006614945;46061.539384607066;33693;33702.79823416771;33937.32125357528;34099.829500852335;34399;34131.82934085413;34349.82825085858;34553.30893382169;34555;34708;38683;39569.208615828094;40003.399949001374;40086.1982760349;40189.19621607493;33187;33353.66646333506;33390.666093338754;33570;33637.495437567966;25009.624855626815;25107.121250756136;25366.873165634053;25408.74591254064;25481.745182547937 04:15:02 INFO - PID 3785 | |2;jquery.html;604.1330690459195;613.6195558753574;615.4860691322743;619.687058035692;637;23223.651645225294;23729.644055339162;24420.02319907204;24467.388315292148;24518.75481245187;25943.35141621456;26217.86891065542;26367;26383.3404164896;26415.339616509547;6509.1863517060365;6589.80230593083;6623.9006414903815;6624.8012559623285;6640.269570347258;6396.424321811036;6464.903026454607;6581.111549940744;6636.966815165917;6646.401823835878;6595.736170553172;6602.471802255808;6608.471322294205;6633.966830165842;6637.203535575738;6500.3174666660025;6616;6745.258021617618;6795.320467953215;6805.387515123638;6314.147590075327;6339.936600634027;6352.714127864211;6355.396237357444;6369.904451433232;29847.70152298471;30413.23966900823;30426.84786576053;30456.54315185252;30458.390832183453;2336.33414476875;2337.2637619149914;2342.9179978700836;2362.7164740231283;2364.1725396111397;19829.10769015398;20675.483112922146;20697.482562935897;20710.378688639365;20714.171433142656;2392.940176495584;2408.1812183857396;2454.987725061363;2460.323411061954;2461.6184491403683;136115;140740;152395;159697;160140;16086;16248.512544623443;16342.673146537003;16462.506124816275;16662;25529.489410211692;25556.74443255581;25581.23256302314;25681.22956311314;25685.357866053124;10783.352998820095;10799.83800242997;10947.56209751601;10967.83548246777;11007.944960275147;10024.24818138628;10087;10149.746256343651;10257.281990260759;10269.486525673836;9314.230296243692;9901.356411833207;9950.253730970062;9981.500924953723;10111.544980475895;2852.958670085404;2907.7819163562817;2940.705929407085;2971.85140742962;3106.2079169811554;1023.2530252915265;1053.104860868271;1053.6154303679102;1057.7778666479971;1060.7772367802847;20476.488087797923;20824.375268741962;20936.895315523325;21100.47248818792;21447;1126.5831642292405;1130.463030060731;1132.213111887247;1133.4729350851894;1147.3402793393666;11609.825852612217;11618;11646.359450230319;11656.009239214593;11760.000399965927;537348;557757;563042;570535.6119392515;573672;131904.340478297;132034.33982830023;133538;134331.32834335766;134842.32578837042;1196.3360335014152;1206.5598597162352;1232.5747617072095;1236.110000799423;1237.4678888078033;18743.718844217074;18925.43223703291;18960.62078758445;19130.434782608474;19402.70895936534;59273.407265928516;59815.40184598098;59819;60414.69792651009;61201;74519.62740186264;75616.62191689006;75728.24271757212;75995.62002189954;76116;15156.545303640909;15224.543263702106;15503.612409689847;15580.376784928929;15605.673517751118;23266.65100023535;23857.52284954326;23886;23893.522129556965;24198.87900560486;19105.426837194907;19302.61394772125;19388.903055484632;19642;19683;17042.744358834378;17065.488035358958;17352.132393380532;17540;18043;19447;19738.40784776459;20111.698324524852;20151.79848201499;20231.19075236974;15288.312025959081;15301.46444874424;15315.310811013755;15355.923220383827;15472;18943.052847357852;18985.43043708691;19036.714449282994;19065.71401428952;19283 04:15:02 INFO - PID 3785 | |3;mootools.html;1403.5859421470666;1470.3603932289448;1495.581237253569;1504.3907217576877;1520.6274462756626;16563.58591035223;17332.913335433306;17345.7398139028;17359.739603905935;17439.564010899732;16658.0838053907;16698.916505417455;16718.58203544912;16771;16807.66384672306;2831.815931964426;2868.7131286871354;2905.753010994068;2911.359500909807;2921.1966709155045;2781.666200055986;2802.5095608268575;2805.2566069991367;2812.817166884146;2815.6621205455376;2640.603909413584;2776.9028084017064;2792.4833905727505;2916.8541572921376;2926.89755858545;2794.552871540554;2823.4353129374103;2825.6326677531997;2827.406244688608;2833.39082097348;2698.3254186453387;2710.874986880442;2729.8089133760645;2743.6570428696414;2834.9716502834913;16442.095684737335;16636.83363166365;16644.251008704636;16645.41741039058;16661.6667666646;8374.41379103463;8638.395312328139;8663.826723465558;8667.479951202948;8670.34972377068;5758.596898217126;5992.280926288873;6033.336333003366;6039.909401358983;6109.3890610939;1920.6446807340687;1932.053293886;1937.3606709785736;1961.892095934723;1966.5771859050374;30138.24654383636;30258.54612180819;30343.848280758455;30349.848250758827;30424.239394015327;7274.818129546804;7315.853682926312;7332.340089391873;7540.886886696704;7626.580538070349;19254.903725481283;19726;19774.703379449318;20036.39890803278;20048.39854804358;8292.958535207285;8466.19571140753;8515.914840851636;8517.36119791018;8527.957360213159;7738.729144479917;7787.805304867424;7814.648340824677;7866;7925.762227133196;5551.139573366135;5722.856928576735;5795.217645617788;5809;5828.242328497268;1670.098147000606;1684.519911825124;1715.4339068107495;1717.6822287876782;1719.5615118144792;995.9352642078242;1018.5365658625308;1022.8056669232822;1022.8619136416488;1040.698197522725;8255;8930.553472326488;8962.955185224033;9029.09709029105;9069.818603627891;774.941879359039;801.587182600961;803.5098589860181;806.1132753970703;806.3025482957318;5206.401263854629;5289.233061206103;5320.802819365612;5368.7047212403695;5386.272853164851;23502.529949400916;24910.252692419257;25302.746972530407;25341;25352.239432817045;24098.39754006164;24297.75702242955;24602.876985614956;24661.26016219516;24788.132415365737;12436.502539898303;12480.563180288827;12524.81212781809;12593.811092833615;12696;9232.353735238468;9452.243820494481;9733.61065557398;9795.706128816148;9894.604215831287;20791.79208207959;20943.685844712647;21360.145594176058;21596.784032159478;21614.783852161276;21625.35123946284;21698.457538561663;21783.891080544498;21931;22268.331950041524;12294.262344259372;12365.690857728629;12459.252444853339;12475.064370172091;12542.561010364594;15529.611759706098;15781.763273550676;15872;15907.840921590636;15909.124998125215;12484.56304029391;12555.435005424595;12575.119741617998;12703.174293670882;12994.610161695164;12413.131080824256;12547.560835370718;12582.937085314516;12617.179883307555;12698.746025079632;11202.327860328407;11292.040176585082;11361.37512436824;11380.146489013192;11384.14618903569;7654.961725191339;7706.691732330644;7735.613219339123;7777.883331749915;7815.882761758465;8044.235797599219;8093.87859182101;8198.877016844634;8315.251627353568;8320.958395207985 04:15:02 INFO - PID 3785 | |4;prototype.html;547.113675845131;561.7809054468756;574.0843354849015;585.9209006784083;587.4742105815295;6120.908186377203;6180.794745024722;6199.628022318653;6229.595076320036;6230.781922632703;6029.125776762377;6036.3661815509395;6058.787942422016;6141.692915354226;6145.784897528587;4832.516748325174;5003.974980125113;5016.2224855147515;5050.191969284915;5068.290439338495;4901.779419926112;4922.901541969159;4938.925916111261;4977.7262250576205;4981.302617633534;4851.927221091686;4880.511948805127;4893.314935908976;4905.2642103684375;4943.629227807911;4906.1168989581865;4917.311576379309;4920.6801557898625;4962.60299176065;4967.90064198714;4515.774211289455;4516.164509565708;4528.660350473728;4534.070515544338;4549.181147393468;6054.273487181523;6058.454739073504;6109.14471973924;6146.877062458726;6164.445199932027;5765.394633563457;5776.191333213354;5776.422357764232;5785.82642520725;5792.175464728597;6522.510811689142;6563.934360656428;6565.54041217115;6581.835454113638;6583;4768.713877167381;4987.900241995176;4996.300517927493;4997.62517811162;5001.674891132065;6669.633170175687;6750.459963202932;6785.1518560179975;6788.524803263774;6794;5128.717920514333;5141.691498510101;5142.61430392722;5151.871203219875;5177.559907407913;5149.150390185578;5162.6128040397125;5182.740862956837;5197.532222100029;5241.161414173714;5669.319681638147;5709;5806.912896306559;5838.620489668158;5884;6559.737610495622;6577.276499585042;6619.60988192485;6653.567518111307;6666.400023997863;1790.006546366779;1806.121633501144;1809.0412081596776;1818.818118188197;1826.4155470249393;1212.6183464115582;1259.106034715344;1283.7432513497338;1286.0740267007739;1289.5808862119848;6098.963176260047;6107.572469927062;6158.599691020159;6165.414285642857;6181.84545386369;6488.740450382026;6549.6070235786;6583.967080164569;6595.637239951753;6629.906065499139;5922.519370157461;5990.281166260077;6122.234720659918;6151.507879369639;6161.921663708833;3477.913052173716;3529.505869178317;3529.6293889141784;3531.4638132412483;3536.469529570585;6854.554453960476;6886.931130688629;6906.689198986058;6914.723411063501;6924.58452492852;6818.693158807866;6865.798485265059;6878.38094571481;6882.518223724392;6899.896501552481;6873.5565531238;6881.93118068833;6887.414569761526;6888.586684798928;6901.309869013058;6366.331535188924;6495.707693153725;6516.771912983023;6602.863639771071;6650.004998500527;6618.385737633512;6636.350007495761;6642.933570664231;6665.933340666531;6682.3317668232785;6824.624645644339;6857.937019761945;6899.724011039502;6941.895871562032;6973.47698922593;5047.848564543069;5114.411842638145;5124.333836601218;5129.87175320605;5137.768800404066;6387.808365749035;6398.456131228898;6533;6650.567713098633;6714.261431242657;6439.549231553746;6449.226092868886;6453.774117906039;6499.837504062247;6525.477961763143;6389.520785941166;6391;6457.354264573693;6461.547691661726;6479.676016199265;6216.689165541795;6280.466160376419;6303.401176888188;6307.684615769285;6411.230652321751;6462.321456247027;6477.611343319416;6478.870422591616;6527.5757075789925;6574.3754343337305;6319.115323854756;6324.810255692337;6327;6364.045393190873;6393.328700486568 04:15:02 INFO - PID 3785 | |5;yui.html;977.7360112769552;988.9923455385567;989.4904124375947;1004.352192835621;1012.1346248957146;19079.809201907978;19445;19477.123529441174;19481.610367792637;19504.804951950475;17214.39749608764;17353.39263125791;17370.392036278732;17496.47510574685;17800.376986805466;1019.2915923433235;1050.2228351020228;1051.3271506236015;1051.3586712105648;1051.5110473629761;1068.4230515521608;1068.7648717282186;1069.2301542889106;1069.550788668761;1072.0298130192189;1079.6653037558342;1115.1190559458018;1116.5031560955379;1118.9216754827166;1126.5212284778936;1098.4343063322394;1103.1560855945208;1105.6075093341829;1107.1530279336234;1108.384846410242;788.2393490281848;804.3926835239415;823.3289868756943;827.4332082523491;828.7555171224443;21585.56828863414;21788.782112178833;21800.127994880186;21822.781772182392;21832.781672183235;21904;22108.778912210993;22209.22267720638;22210.88894555533;22459.213927512457;18940.147693353832;18946.52633684155;19230.71153932692;19279.93960332181;19420.805791942043;4004.83980640774;4031.879043628696;4035.25347810653;4036.6367026967714;4037.7981100944835;130027;160378;163060;163370;163940;18466.630667386577;18503.53741156482;18592.721109183374;18879.905600472186;19093.045347732837;33744.325113497594;34973.82513087469;35085.29829403449;35500;35658.28683426317;9578.185854202331;9678.17735492491;9684.903150968541;9703.66037188695;9711.5144242789;4205.516365617932;4265.4881414230495;4345;4356.956430435655;4376.343548467692;5970.671613061323;6095.420935011167;6097;6111.144439778434;6114.144019837227;1243.384524660299;1254.6988722706485;1284.4862055178003;1287.7617640736494;1296.5138073222543;719.9208087110413;737.0639288104078;738.9778306650809;742.7697413801739;760.0499375780274;13209.40557674907;13321.866781332257;13554.728905422033;13802.861971380158;13904.026718129837;734.2290594875466;740.5926740292817;751.6279441676296;752.8005078654161;754.3248792330943;5696.515796157373;5766.538676905838;5859.355470898197;5880.26496687914;6002;155295;155966;157616;159552.20223899037;164087;137316;138088.30955845155;138136;141385;144563.27718361342;117663;119423.99999999827;119544;119925.40037299758;121543;11004.889951100708;11073;11176.608818691308;11185.552577896793;11238.438078096226;57465.71267143638;57588.42411575831;58124.4187558119;58188.12717809321;58456.4154358468;74205.62897185479;75368.1157971055;75428.62285688757;75865.62067189849;76506.2349376499;15775.921120394325;16354.100524471269;16412.261448234618;16535.173241338125;16643.084630345445;20056.799432005493;20116.798832011493;20250.797492024893;20514.69227961552;20551.69172462444;16681.416150434678;16980.660386792442;16982.23579938881;17140.40008599693;17142.828571714123;17334.73997890058;17455.12724363802;17539.123043848012;17634.91182544079;17654.55863603369;16867.7469837955;16904.57738556546;16947.32210711558;17057.48827535176;17156.39952601653;12646.367681615699;12664.366781660696;12679.556215532411;12771.552995645108;12872.292023938773;12538.811917821058;12586.18189817659;12632.479823260413;12708.618741437771;12715.364231788559 04:15:02 INFO - PID 3785 | __end_tp_report 04:15:02 INFO - PID 3785 | __start_cc_report 04:15:02 INFO - PID 3785 | _x_x_mozilla_cycle_collect,269 04:15:02 INFO - PID 3785 | __end_cc_report 04:15:02 INFO - PID 3785 | __startTimestamp1505906102844__endTimestamp 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | ------- Summary: start ------- 04:15:02 INFO - PID 3785 | Number of tests: 6 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#0] dojo.html Cycles:165 Average:6293.72 Median:6574.57 stddev:887.89 (13.5%) stddev-sans-first:870.19 04:15:02 INFO - PID 3785 | Values: 3880.0 3884.6 3906.1 3935.5 3941.8 6148.8 6238.6 6329.1 6378.6 6395.1 6319.7 6321.0 6373.9 6438.2 6453.6 5677.6 5712.3 5726.8 5741.2 5753.1 154.6 5678.9 5767.5 5795.9 5817.4 5675.0 5694.2 5769.2 5778.6 5788.3 5684.4 5716.9 5762.0 5787.4 5789.2 5665.9 5679.8 5756.8 5781.7 5783.8 6313.3 6318.4 6342.5 6409.6 6417.9 6730.8 6819.0 6853.7 6954.1 6959.7 6863.5 6864.3 6913.3 6925.5 6929.0 6441.0 6463.5 6478.3 6492.7 6504.9 7018.7 7059.0 7067.4 7147.9 7173.7 6670.6 6752.6 6785.8 6834.5 6855.4 6815.6 6829.2 6849.8 6860.5 6864.1 6807.9 6812.2 6871.6 6880.3 6940.2 6721.1 6803.7 6826.8 6912.3 6947.3 4927.0 5003.1 5006.1 5011.6 5020.3 4516.2 4524.0 4528.3 4556.9 4572.0 6216.3 6243.7 6262.6 6343.6 6426.1 6782.8 6783.9 6790.4 6800.0 6800.1 6261.7 6273.9 6282.6 6295.8 6302.3 5528.9 5543.9 5595.3 5623.4 5639.2 7108.7 7118.8 7157.7 7211.8 7227.0 6608.5 6706.3 6864.2 6938.5 6958.5 6995.8 7082.6 7091.9 7153.6 7159.5 6841.0 6850.8 6897.3 6905.1 6906.3 6879.8 6890.7 6895.0 6980.3 6984.4 6462.5 6604.6 6617.9 6700.4 6702.4 6635.8 6698.5 6703.2 6704.7 6708.1 6540.3 6543.0 6575.4 6624.9 6627.2 6670.8 6674.9 6792.9 6804.8 6809.4 6350.1 6464.0 6503.8 6506.9 6574.6 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#1] ext.html Cycles:180 Average:43313.91 Median:3726.42 stddev:66546.78 (1785.8%) stddev-sans-first:66657.34 04:15:02 INFO - PID 3785 | Values: 924.0 925.3 953.0 968.3 982.8 43945.0 44425.6 44525.3 44573.6 44763.6 41855.6 42090.4 42151.0 42162.2 42163.6 7689.8 7831.7 7837.5 7840.4 7842.3 7690.3 7748.6 7753.2 7791.8 7793.4 8359.7 8560.9 8562.5 8563.0 8570.0 8432.7 8503.6 8509.5 8515.2 8516.0 8119.6 8277.4 8306.5 8361.9 8366.2 41432.4 41526.8 41581.0 41970.6 41984.6 3694.0 3758.8 3764.3 3786.6 3787.9 33811.0 34060.5 34139.5 34158.7 34177.3 5388.3 5391.7 5411.9 5430.1 5496.7 234791.0 235344.0 236312.0 237493.0 238644.0 53444.0 53807.7 53921.5 53996.5 54023.7 56155.4 56221.0 56339.4 56394.7 56483.4 15445.7 15656.3 15716.0 15748.1 15764.4 12413.5 12508.6 12512.2 12531.3 12538.9 14866.7 15195.5 15250.2 15357.2 15370.5 6062.3 6081.5 6122.2 6187.2 6254.3 1034.5 1081.9 1085.1 1089.3 1098.3 25479.5 25489.2 25605.9 25752.9 25763.7 1167.2 1191.9 1197.8 1205.7 1210.8 13497.2 13652.7 13695.7 13734.7 13950.0 294404.0 295754.0 295949.0 296519.0 296910.0 58850.0 59375.0 59612.4 63639.0 64567.7 1501.1 1519.2 1526.4 1533.6 1533.8 30227.4 30253.4 30565.8 30868.5 30949.7 41857.0 42306.2 42373.0 42428.9 42451.0 227558.0 228690.0 229322.0 229747.0 230267.0 35093.5 35202.3 35265.6 35335.3 35479.8 44056.6 45425.8 45920.8 45986.8 46061.5 33693.0 33702.8 33937.3 34099.8 34399.0 34131.8 34349.8 34553.3 34555.0 34708.0 38683.0 39569.2 40003.4 40086.2 40189.2 33187.0 33353.7 33390.7 33570.0 33637.5 25009.6 25107.1 25366.9 25408.7 25481.7 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#2] jquery.html Cycles:180 Average:38333.36 Median:22335.33 stddev:94329.82 (422.3%) stddev-sans-first:94551.90 04:15:02 INFO - PID 3785 | Values: 604.1 613.6 615.5 619.7 637.0 23223.7 23729.6 24420.0 24467.4 24518.8 25943.4 26217.9 26367.0 26383.3 26415.3 6509.2 6589.8 6623.9 6624.8 6640.3 6396.4 6464.9 6581.1 6637.0 6646.4 6595.7 6602.5 6608.5 6634.0 6637.2 6500.3 6616.0 6745.3 6795.3 6805.4 6314.1 6339.9 6352.7 6355.4 6369.9 29847.7 30413.2 30426.8 30456.5 30458.4 2336.3 2337.3 2342.9 2362.7 2364.2 19829.1 20675.5 20697.5 20710.4 20714.2 2392.9 2408.2 2455.0 2460.3 2461.6 136115.0 140740.0 152395.0 159697.0 160140.0 16086.0 16248.5 16342.7 16462.5 16662.0 25529.5 25556.7 25581.2 25681.2 25685.4 10783.4 10799.8 10947.6 10967.8 11007.9 10024.2 10087.0 10149.7 10257.3 10269.5 9314.2 9901.4 9950.3 9981.5 10111.5 2853.0 2907.8 2940.7 2971.9 3106.2 1023.3 1053.1 1053.6 1057.8 1060.8 20476.5 20824.4 20936.9 21100.5 21447.0 1126.6 1130.5 1132.2 1133.5 1147.3 11609.8 11618.0 11646.4 11656.0 11760.0 537348.0 557757.0 563042.0 570535.6 573672.0 131904.3 132034.3 133538.0 134331.3 134842.3 1196.3 1206.6 1232.6 1236.1 1237.5 18743.7 18925.4 18960.6 19130.4 19402.7 59273.4 59815.4 59819.0 60414.7 61201.0 74519.6 75616.6 75728.2 75995.6 76116.0 15156.5 15224.5 15503.6 15580.4 15605.7 23266.7 23857.5 23886.0 23893.5 24198.9 19105.4 19302.6 19388.9 19642.0 19683.0 17042.7 17065.5 17352.1 17540.0 18043.0 19447.0 19738.4 20111.7 20151.8 20231.2 15288.3 15301.5 15315.3 15355.9 15472.0 18943.1 18985.4 19036.7 19065.7 19283.0 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#3] mootools.html Cycles:180 Average:10422.50 Median:2704.60 stddev:7687.08 (284.2%) stddev-sans-first:7678.78 04:15:02 INFO - PID 3785 | Values: 1403.6 1470.4 1495.6 1504.4 1520.6 16563.6 17332.9 17345.7 17359.7 17439.6 16658.1 16698.9 16718.6 16771.0 16807.7 2831.8 2868.7 2905.8 2911.4 2921.2 2781.7 2802.5 2805.3 2812.8 2815.7 2640.6 2776.9 2792.5 2916.9 2926.9 2794.6 2823.4 2825.6 2827.4 2833.4 2698.3 2710.9 2729.8 2743.7 2835.0 16442.1 16636.8 16644.3 16645.4 16661.7 8374.4 8638.4 8663.8 8667.5 8670.3 5758.6 5992.3 6033.3 6039.9 6109.4 1920.6 1932.1 1937.4 1961.9 1966.6 30138.2 30258.5 30343.8 30349.8 30424.2 7274.8 7315.9 7332.3 7540.9 7626.6 19254.9 19726.0 19774.7 20036.4 20048.4 8293.0 8466.2 8515.9 8517.4 8528.0 7738.7 7787.8 7814.6 7866.0 7925.8 5551.1 5722.9 5795.2 5809.0 5828.2 1670.1 1684.5 1715.4 1717.7 1719.6 995.9 1018.5 1022.8 1022.9 1040.7 8255.0 8930.6 8963.0 9029.1 9069.8 774.9 801.6 803.5 806.1 806.3 5206.4 5289.2 5320.8 5368.7 5386.3 23502.5 24910.3 25302.7 25341.0 25352.2 24098.4 24297.8 24602.9 24661.3 24788.1 12436.5 12480.6 12524.8 12593.8 12696.0 9232.4 9452.2 9733.6 9795.7 9894.6 20791.8 20943.7 21360.1 21596.8 21614.8 21625.4 21698.5 21783.9 21931.0 22268.3 12294.3 12365.7 12459.3 12475.1 12542.6 15529.6 15781.8 15872.0 15907.8 15909.1 12484.6 12555.4 12575.1 12703.2 12994.6 12413.1 12547.6 12582.9 12617.2 12698.7 11202.3 11292.0 11361.4 11380.1 11384.1 7655.0 7706.7 7735.6 7777.9 7815.9 8044.2 8093.9 8198.9 8315.3 8321.0 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#4] prototype.html Cycles:180 Average:5551.40 Median:6155.05 stddev:1542.21 (25.1%) stddev-sans-first:1500.09 04:15:02 INFO - PID 3785 | Values: 547.1 561.8 574.1 585.9 587.5 6120.9 6180.8 6199.6 6229.6 6230.8 6029.1 6036.4 6058.8 6141.7 6145.8 4832.5 5004.0 5016.2 5050.2 5068.3 4901.8 4922.9 4938.9 4977.7 4981.3 4851.9 4880.5 4893.3 4905.3 4943.6 4906.1 4917.3 4920.7 4962.6 4967.9 4515.8 4516.2 4528.7 4534.1 4549.2 6054.3 6058.5 6109.1 6146.9 6164.4 5765.4 5776.2 5776.4 5785.8 5792.2 6522.5 6563.9 6565.5 6581.8 6583.0 4768.7 4987.9 4996.3 4997.6 5001.7 6669.6 6750.5 6785.2 6788.5 6794.0 5128.7 5141.7 5142.6 5151.9 5177.6 5149.2 5162.6 5182.7 5197.5 5241.2 5669.3 5709.0 5806.9 5838.6 5884.0 6559.7 6577.3 6619.6 6653.6 6666.4 1790.0 1806.1 1809.0 1818.8 1826.4 1212.6 1259.1 1283.7 1286.1 1289.6 6099.0 6107.6 6158.6 6165.4 6181.8 6488.7 6549.6 6584.0 6595.6 6629.9 5922.5 5990.3 6122.2 6151.5 6161.9 3477.9 3529.5 3529.6 3531.5 3536.5 6854.6 6886.9 6906.7 6914.7 6924.6 6818.7 6865.8 6878.4 6882.5 6899.9 6873.6 6881.9 6887.4 6888.6 6901.3 6366.3 6495.7 6516.8 6602.9 6650.0 6618.4 6636.4 6642.9 6665.9 6682.3 6824.6 6857.9 6899.7 6941.9 6973.5 5047.8 5114.4 5124.3 5129.9 5137.8 6387.8 6398.5 6533.0 6650.6 6714.3 6439.5 6449.2 6453.8 6499.8 6525.5 6389.5 6391.0 6457.4 6461.5 6479.7 6216.7 6280.5 6303.4 6307.7 6411.2 6462.3 6477.6 6478.9 6527.6 6574.4 6319.1 6324.8 6327.0 6364.0 6393.3 04:15:02 INFO - PID 3785 | 04:15:02 INFO - PID 3785 | [#5] yui.html Cycles:180 Average:28841.42 Median:17727.47 stddev:43800.09 (247.1%) stddev-sans-first:43873.00 04:15:02 INFO - PID 3785 | Values: 977.7 989.0 989.5 1004.4 1012.1 19079.8 19445.0 19477.1 19481.6 19504.8 17214.4 17353.4 17370.4 17496.5 17800.4 1019.3 1050.2 1051.3 1051.4 1051.5 1068.4 1068.8 1069.2 1069.6 1072.0 1079.7 1115.1 1116.5 1118.9 1126.5 1098.4 1103.2 1105.6 1107.2 1108.4 788.2 804.4 823.3 827.4 828.8 21585.6 21788.8 21800.1 21822.8 21832.8 21904.0 22108.8 22209.2 22210.9 22459.2 18940.1 18946.5 19230.7 19279.9 19420.8 4004.8 4031.9 4035.3 4036.6 4037.8 130027.0 160378.0 163060.0 163370.0 163940.0 18466.6 18503.5 18592.7 18879.9 19093.0 33744.3 34973.8 35085.3 35500.0 35658.3 9578.2 9678.2 9684.9 9703.7 9711.5 4205.5 4265.5 4345.0 4357.0 4376.3 5970.7 6095.4 6097.0 6111.1 6114.1 1243.4 1254.7 1284.5 1287.8 1296.5 719.9 737.1 739.0 742.8 760.0 13209.4 13321.9 13554.7 13802.9 13904.0 734.2 740.6 751.6 752.8 754.3 5696.5 5766.5 5859.4 5880.3 6002.0 155295.0 155966.0 157616.0 159552.2 164087.0 137316.0 138088.3 138136.0 141385.0 144563.3 117663.0 119424.0 119544.0 119925.4 121543.0 11004.9 11073.0 11176.6 11185.6 11238.4 57465.7 57588.4 58124.4 58188.1 58456.4 74205.6 75368.1 75428.6 75865.6 76506.2 15775.9 16354.1 16412.3 16535.2 16643.1 20056.8 20116.8 20250.8 20514.7 20551.7 16681.4 16980.7 16982.2 17140.4 17142.8 17334.7 17455.1 17539.1 17634.9 17654.6 16867.7 16904.6 16947.3 17057.5 17156.4 12646.4 12664.4 12679.6 12771.6 12872.3 12538.8 12586.2 12632.5 12708.6 12715.4 04:15:02 INFO - PID 3785 | -------- Summary: end -------- 04:15:02 INFO - PID 3785 | 04:15:03 INFO - TEST-INFO | 3785: exit 0 04:15:03 INFO - TEST-OK | dromaeo_css | took 1109630ms 04:15:03 INFO - TEST-START | kraken 04:15:03 INFO - Initialising browser for kraken test... 04:15:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54857/getInfo.html -profile /tmp/tmp4xQ0Ar/profile 04:15:03 INFO - TEST-INFO | started process 4202 (/builds/slave/test/build/application/firefox/firefox http://localhost:54857/getInfo.html) 04:15:08 INFO - TEST-INFO | 4202: exit 0 04:15:08 INFO - Browser initialized. 04:15:08 INFO - Running cycle 1/1 for kraken test... 04:15:08 INFO - Using env: {'DISPLAY': ':0', 04:15:08 INFO - 'HOME': '/home/cltbld', 04:15:08 INFO - 'JSGC_DISABLE_POISONING': '1', 04:15:08 INFO - 'LANG': 'en_US.UTF-8', 04:15:08 INFO - 'LANGUAGE': 'en_US:en', 04:15:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:15:08 INFO - 'LOGNAME': 'cltbld', 04:15:08 INFO - 'MAIL': '/var/mail/cltbld', 04:15:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:08 INFO - 'MOZ_CRASHREPORTER': '1', 04:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:15:08 INFO - 'MOZ_NO_REMOTE': '1', 04:15:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:08 INFO - 'NO_EM_RESTART': '1', 04:15:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:08 INFO - 'PWD': '/builds/slave/test', 04:15:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:08 INFO - 'RUST_BACKTRACE': 'full', 04:15:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:15:08 INFO - 'SHELL': '/bin/bash', 04:15:08 INFO - 'SHLVL': '1', 04:15:08 INFO - 'TERM': 'linux', 04:15:08 INFO - 'TMOUT': '86400', 04:15:08 INFO - 'USER': 'cltbld', 04:15:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006', 04:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:08 INFO - '_': '/tools/buildbot/bin/python'} 04:15:08 INFO - TEST-INFO | started process 4440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xQ0Ar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:09 INFO - PID 4440 | 04:15:09 INFO - PID 4440 | (/builds/slave/test/build/application/firefox/firefox:4490): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:15:09 INFO - PID 4440 | 04:15:19 INFO - PID 4440 | RSS: Main: 147005440 04:15:19 INFO - PID 4440 | 04:15:22 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54857/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:23 INFO - PID 4440 | RSS: Main: 152141824 04:15:23 INFO - PID 4440 | 04:15:25 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54857/tests/kraken/driver.html?testName=audio-dft) 04:15:26 INFO - PID 4440 | RSS: Main: 152809472 04:15:26 INFO - PID 4440 | 04:15:29 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54857/tests/kraken/driver.html?testName=audio-fft) 04:15:29 INFO - PID 4440 | RSS: Main: 149155840 04:15:29 INFO - PID 4440 | 04:15:32 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54857/tests/kraken/driver.html?testName=audio-oscillator) 04:15:32 INFO - PID 4440 | RSS: Main: 150159360 04:15:32 INFO - PID 4440 | 04:15:34 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:35 INFO - PID 4440 | RSS: Main: 149975040 04:15:35 INFO - PID 4440 | 04:15:38 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54857/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:39 INFO - PID 4440 | RSS: Main: 152915968 04:15:39 INFO - PID 4440 | 04:15:42 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54857/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:43 INFO - PID 4440 | RSS: Main: 153092096 04:15:43 INFO - PID 4440 | 04:15:46 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54857/tests/kraken/driver.html?testName=json-parse-financial) 04:15:46 INFO - PID 4440 | RSS: Main: 153137152 04:15:46 INFO - PID 4440 | 04:15:48 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:48 INFO - PID 4440 | RSS: Main: 153239552 04:15:48 INFO - PID 4440 | 04:15:50 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:51 INFO - PID 4440 | RSS: Main: 153452544 04:15:51 INFO - PID 4440 | 04:15:53 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:53 INFO - PID 4440 | RSS: Main: 149864448 04:15:53 INFO - PID 4440 | 04:15:56 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:15:57 INFO - PID 4440 | RSS: Main: 150089728 04:15:57 INFO - PID 4440 | 04:16:00 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:00 INFO - PID 4440 | RSS: Main: 150106112 04:16:00 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | Cycle 1(1): loaded http://localhost:54857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54857/tests/kraken/driver.html?testName=ai-astar) 04:16:02 INFO - PID 4440 | RSS: Main: 151478272 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | __start_tp_report 04:16:02 INFO - PID 4440 | _x_x_mozilla_page_load 04:16:02 INFO - PID 4440 | _x_x_mozilla_page_load_details 04:16:02 INFO - PID 4440 | |i|pagename|runs| 04:16:02 INFO - PID 4440 | |0;ai-astar;105;105;104;107;105;109;107;106;105;107 04:16:02 INFO - PID 4440 | |1;audio-beat-detection;119;115;110;111;123;111;111;111;137;109 04:16:02 INFO - PID 4440 | |2;audio-dft;164;162;163;164;164;162;162;163;168;167 04:16:02 INFO - PID 4440 | |3;audio-fft;72;72;72;73;74;74;74;73;74;74 04:16:02 INFO - PID 4440 | |4;audio-oscillator;78;79;77;78;78;78;79;78;77;77 04:16:02 INFO - PID 4440 | |5;imaging-gaussian-blur;113;113;110;113;114;114;113;113;114;111 04:16:02 INFO - PID 4440 | |6;imaging-darkroom;151;148;151;149;150;149;150;149;150;150 04:16:02 INFO - PID 4440 | |7;imaging-desaturate;94;98;99;98;94;94;93;95;94;94 04:16:02 INFO - PID 4440 | |8;json-parse-financial;45;45;46;45;45;46;44;45;45;44 04:16:02 INFO - PID 4440 | |9;json-stringify-tinderbox;37;37;37;37;38;36;38;37;37;37 04:16:02 INFO - PID 4440 | |10;stanford-crypto-aes;71;72;73;72;70;70;76;73;71;70 04:16:02 INFO - PID 4440 | |11;stanford-crypto-ccm;105;108;103;105;110;115;102;109;106;111 04:16:02 INFO - PID 4440 | |12;stanford-crypto-pbkdf2;167;155;155;154;154;167;152;150;155;153 04:16:02 INFO - PID 4440 | |13;stanford-crypto-sha256-iterative;75;63;60;59;64;61;63;59;60;59 04:16:02 INFO - PID 4440 | __end_tp_report 04:16:02 INFO - PID 4440 | __start_cc_report 04:16:02 INFO - PID 4440 | _x_x_mozilla_cycle_collect,725 04:16:02 INFO - PID 4440 | __end_cc_report 04:16:02 INFO - PID 4440 | __startTimestamp1505906162784__endTimestamp 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | ------- Summary: start ------- 04:16:02 INFO - PID 4440 | Number of tests: 14 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.50 stddev:1.49 (1.4%) stddev-sans-first:1.54 04:16:02 INFO - PID 4440 | Values: 105.0 105.0 104.0 107.0 105.0 109.0 107.0 106.0 105.0 107.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.00 stddev:8.72 (7.7%) stddev-sans-first:9.17 04:16:02 INFO - PID 4440 | Values: 119.0 115.0 110.0 111.0 123.0 111.0 111.0 111.0 137.0 109.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.08 (1.3%) stddev-sans-first:2.20 04:16:02 INFO - PID 4440 | Values: 164.0 162.0 163.0 164.0 164.0 162.0 162.0 163.0 168.0 167.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#3] audio-fft Cycles:10 Average:73.20 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 04:16:02 INFO - PID 4440 | Values: 72.0 72.0 72.0 73.0 74.0 74.0 74.0 73.0 74.0 74.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 04:16:02 INFO - PID 4440 | Values: 78.0 79.0 77.0 78.0 78.0 78.0 79.0 78.0 77.0 77.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:1.32 (1.2%) stddev-sans-first:1.39 04:16:02 INFO - PID 4440 | Values: 113.0 113.0 110.0 113.0 114.0 114.0 113.0 113.0 114.0 111.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 04:16:02 INFO - PID 4440 | Values: 151.0 148.0 151.0 149.0 150.0 149.0 150.0 149.0 150.0 150.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:2.16 (2.3%) stddev-sans-first:2.24 04:16:02 INFO - PID 4440 | Values: 94.0 98.0 99.0 98.0 94.0 94.0 93.0 95.0 94.0 94.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:0.67 (1.5%) stddev-sans-first:0.71 04:16:02 INFO - PID 4440 | Values: 45.0 45.0 46.0 45.0 45.0 46.0 44.0 45.0 45.0 44.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#9] json-stringify-tinderbox Cycles:10 Average:37.10 Median:37.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 04:16:02 INFO - PID 4440 | Values: 37.0 37.0 37.0 37.0 38.0 36.0 38.0 37.0 37.0 37.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:72.00 stddev:1.87 (2.6%) stddev-sans-first:1.96 04:16:02 INFO - PID 4440 | Values: 71.0 72.0 73.0 72.0 70.0 70.0 76.0 73.0 71.0 70.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#11] stanford-crypto-ccm Cycles:10 Average:107.40 Median:108.50 stddev:3.98 (3.7%) stddev-sans-first:4.12 04:16:02 INFO - PID 4440 | Values: 105.0 108.0 103.0 105.0 110.0 115.0 102.0 109.0 106.0 111.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:155.00 stddev:5.90 (3.8%) stddev-sans-first:4.80 04:16:02 INFO - PID 4440 | Values: 167.0 155.0 155.0 154.0 154.0 167.0 152.0 150.0 155.0 153.0 04:16:02 INFO - PID 4440 | 04:16:02 INFO - PID 4440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:4.83 (7.8%) stddev-sans-first:1.96 04:16:02 INFO - PID 4440 | Values: 75.0 63.0 60.0 59.0 64.0 61.0 63.0 59.0 60.0 59.0 04:16:02 INFO - PID 4440 | -------- Summary: end -------- 04:16:02 INFO - PID 4440 | 04:16:03 INFO - PID 4440 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:16:03 INFO - TEST-INFO | 4440: exit 0 04:16:03 INFO - TEST-OK | kraken | took 60138ms 04:16:03 INFO - SUITE-END | took 1169s 04:16:03 INFO - Completed test suite (00:19:30) 04:16:03 INFO - javascript benchmark 04:16:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9038.415859871018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3879.9806000969998, 3884.6309600587942, 3906.1015966327745, 3935.468711723918, 3941.783201923893, 6148.8462788430315, 6238.625682459045, 6329.145565348676, 6378.553501254914, 6395.13665655137, 6319.747210111602, 6320.968395158029, 6373.904391434132, 6438.227412710481, 6453.612783232998, 5677.602567820254, 5712.2574065371655, 5726.828195154152, 5741.224934633834, 5753.108268218432, 154.55556163085288, 5678.914816277738, 5767.509761670263, 5795.855103622401, 5817.447342502476, 5674.971625141848, 5694.2312787773535, 5769.249997500298, 5778.59549831512, 5788.334341550712, 5684.403137670568, 5716.885662286731, 5761.971190144022, 5787.421257874221, 5789.218455508537, 5665.915011274793, 5679.772809087632, 5756.769729210827, 5781.739821708034, 5783.826485205451, 6313.305536390993, 6318.399752023551, 6342.460890824285, 6409.583377080475, 6417.93582064178, 6730.83172920676, 6819.045333653293, 6853.725850965955, 6954.061201737752, 6959.652017399109, 6863.485238607124, 6864.347886950732, 6913.343232392915, 6925.549839260432, 6929.029935808991, 6441.0, 6463.48292136628, 6478.255000674889, 6492.7402903883785, 6504.902426463559, 7018.684159212848, 7059.047028651066, 7067.363937245673, 7147.857042859114, 7173.6771845267085, 6670.599764014175, 6752.5948443093575, 6785.830354241085, 6834.4874134440115, 6855.383015528527, 6815.625140617313, 6829.180498340231, 6849.794506164823, 6860.485463590251, 6864.141982252218, 6807.931920680829, 6812.216595091529, 6871.587704737632, 6880.346367095118, 6940.236573976858, 6721.092652491949, 6803.693833777492, 6826.829329266808, 6912.274211207851, 6947.340002699735, 4927.0, 5003.099442100384, 5006.123928312531, 5011.6241281904, 5020.272060551272, 4516.16450956574, 4524.04994951064, 4528.298113792367, 4556.863294101182, 4571.954280457219, 6216.285127210429, 6243.656598887014, 6262.624242545462, 6343.5876668016435, 6426.132472116205, 6782.796516104525, 6783.864322713617, 6790.388865002174, 6800.047993280945, 6800.149981252343, 6261.655608941461, 6273.937260627426, 6282.560220784592, 6295.842603934938, 6302.275238347557, 5528.917066244009, 5543.861403464945, 5595.272614560081, 5623.3533143689, 5639.154126880919, 7108.71565137399, 7118.822029449305, 7157.713691452388, 7211.819704507325, 7227.0, 6608.471322294109, 6706.295838936841, 6864.24493305726, 6938.548994315353, 6958.47811414146, 6995.755148569776, 7082.645867706698, 7091.858162836611, 7153.6423178839805, 7159.534630249017, 6841.042254084333, 6850.8287292816085, 6897.2757860423935, 6905.102336696398, 6906.309369063053, 6879.828004299732, 6890.689918953559, 6894.965525172342, 6980.336867997532, 6984.40632546219, 6462.515311351762, 6604.603723776589, 6617.933820661924, 6700.363465470772, 6702.430293425114, 6635.834104147435, 6698.497612678971, 6703.229128650268, 6704.664766761545, 6708.094407254958, 6540.313267107075, 6543.0, 6575.375339342755, 6624.867502649824, 6627.1716035495565, 6670.7665231716655, 6674.866502669823, 6792.932070679428, 6804.829879253059, 6809.353111454404, 6350.079238510482, 6464.0, 6503.772367967098, 6506.934930650633, 6574.572652777554], "value": 6235.984668823997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.9630414783409, 925.255169588481, 952.9999999999999, 968.259281649538, 982.8083523712879, 43945.0, 44425.55574444254, 44525.33212001818, 44573.55426445731, 44763.552364476345, 41855.58144418555, 42090.36864447028, 42151.0, 42162.156756864846, 42163.57836421635, 7689.769306920802, 7831.725889593866, 7837.529748215097, 7840.372770178372, 7842.294193522582, 7690.2694244046725, 7748.612569371537, 7753.18591547885, 7791.805204869867, 7793.376529877596, 8359.707410240642, 8560.871586926201, 8562.529060901648, 8563.0, 8570.0, 8432.704855330065, 8503.617337219777, 8509.48943063412, 8515.23362897336, 8515.95742021289, 8119.634616442274, 8277.420580559363, 8306.501609903366, 8361.916380836175, 8366.205210504992, 41432.37851432231, 41526.79236603828, 41581.0, 41970.580294196974, 41984.580154198375, 3694.0, 3758.849646014156, 3764.3412402829395, 3786.5645450773236, 3787.886363409102, 33811.0, 34060.48909266363, 34139.4879076814, 34158.658413416044, 34177.316453670785, 5388.272583201296, 5391.73041347931, 5411.864703382407, 5430.076886929192, 5496.725163741837, 234791.0, 235344.0, 236312.0, 237493.0, 238644.0, 53444.0, 53807.73096134494, 53921.460785391646, 53996.46003539993, 54023.729881350344, 56155.43844561584, 56221.0, 56339.43660563342, 56394.7180264096, 56483.43516564864, 15445.691086178438, 15656.295466703798, 15716.0, 15748.055116693035, 15764.369425222863, 12413.503459861504, 12508.624741257594, 12512.249265044127, 12531.31077790712, 12538.937305313415, 14866.702665946621, 15195.544133676007, 15250.161241131622, 15357.15535645528, 15370.538883833502, 6062.272527296753, 6081.452669259699, 6122.173506576644, 6187.195664563668, 6254.312025677172, 1034.4930983818026, 1081.8809930907594, 1085.1102096280974, 1089.3355053417408, 1098.2751384086464, 25479.49041019169, 25489.23532294034, 25605.871970640026, 25752.871235644077, 25763.742362576133, 1167.229628445222, 1191.9165658403829, 1197.784398808223, 1205.6684411786828, 1210.8002179640262, 13497.19016858972, 13652.726945461036, 13695.726085478234, 13734.65663358424, 13950.0, 294404.0, 295754.0, 295949.0, 296519.0, 296910.0, 58850.0, 59375.0, 59612.403875960685, 63639.0, 64567.677161613894, 1501.1068414293477, 1519.1720512320812, 1526.3589292497177, 1533.6395946952234, 1533.7776022476678, 30227.395452090394, 30253.394932101673, 30565.847170764006, 30868.536971945887, 30949.69050309468, 41857.0, 42306.15387692291, 42373.0, 42428.93927651834, 42451.0, 227558.0, 228690.0, 229322.0, 229747.0, 230267.0, 35093.47359789554, 35202.29595408026, 35265.64734352624, 35335.29329413346, 35479.82260088683, 44056.559434405244, 45425.77287113675, 45920.77039614914, 45986.77006614945, 46061.539384607066, 33693.0, 33702.79823416771, 33937.32125357528, 34099.829500852335, 34399.0, 34131.82934085413, 34349.82825085858, 34553.30893382169, 34555.0, 34708.0, 38683.0, 39569.208615828094, 40003.399949001374, 40086.1982760349, 40189.19621607493, 33187.0, 33353.66646333506, 33390.666093338754, 33570.0, 33637.495437567966, 25009.624855626815, 25107.121250756136, 25366.873165634053, 25408.74591254064, 25481.745182547937], "value": 18666.554079919704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.1330690459195, 613.6195558753574, 615.4860691322743, 619.687058035692, 637.0, 23223.651645225294, 23729.644055339162, 24420.02319907204, 24467.388315292148, 24518.75481245187, 25943.35141621456, 26217.86891065542, 26367.0, 26383.3404164896, 26415.339616509547, 6509.1863517060365, 6589.80230593083, 6623.9006414903815, 6624.8012559623285, 6640.269570347258, 6396.424321811036, 6464.903026454607, 6581.111549940744, 6636.966815165917, 6646.401823835878, 6595.736170553172, 6602.471802255808, 6608.471322294205, 6633.966830165842, 6637.203535575738, 6500.3174666660025, 6616.0, 6745.258021617618, 6795.320467953215, 6805.387515123638, 6314.147590075327, 6339.936600634027, 6352.714127864211, 6355.396237357444, 6369.904451433232, 29847.70152298471, 30413.23966900823, 30426.84786576053, 30456.54315185252, 30458.390832183453, 2336.33414476875, 2337.2637619149914, 2342.9179978700836, 2362.7164740231283, 2364.1725396111397, 19829.10769015398, 20675.483112922146, 20697.482562935897, 20710.378688639365, 20714.171433142656, 2392.940176495584, 2408.1812183857396, 2454.987725061363, 2460.323411061954, 2461.6184491403683, 136115.0, 140740.0, 152395.0, 159697.0, 160140.0, 16086.0, 16248.512544623443, 16342.673146537003, 16462.506124816275, 16662.0, 25529.489410211692, 25556.74443255581, 25581.23256302314, 25681.22956311314, 25685.357866053124, 10783.352998820095, 10799.83800242997, 10947.56209751601, 10967.83548246777, 11007.944960275147, 10024.24818138628, 10087.0, 10149.746256343651, 10257.281990260759, 10269.486525673836, 9314.230296243692, 9901.356411833207, 9950.253730970062, 9981.500924953723, 10111.544980475895, 2852.958670085404, 2907.7819163562817, 2940.705929407085, 2971.85140742962, 3106.2079169811554, 1023.2530252915265, 1053.104860868271, 1053.6154303679102, 1057.7778666479971, 1060.7772367802847, 20476.488087797923, 20824.375268741962, 20936.895315523325, 21100.47248818792, 21447.0, 1126.5831642292405, 1130.463030060731, 1132.213111887247, 1133.4729350851894, 1147.3402793393666, 11609.825852612217, 11618.0, 11646.359450230319, 11656.009239214593, 11760.000399965927, 537348.0, 557757.0, 563042.0, 570535.6119392515, 573672.0, 131904.340478297, 132034.33982830023, 133538.0, 134331.32834335766, 134842.32578837042, 1196.3360335014152, 1206.5598597162352, 1232.5747617072095, 1236.110000799423, 1237.4678888078033, 18743.718844217074, 18925.43223703291, 18960.62078758445, 19130.434782608474, 19402.70895936534, 59273.407265928516, 59815.40184598098, 59819.0, 60414.69792651009, 61201.0, 74519.62740186264, 75616.62191689006, 75728.24271757212, 75995.62002189954, 76116.0, 15156.545303640909, 15224.543263702106, 15503.612409689847, 15580.376784928929, 15605.673517751118, 23266.65100023535, 23857.52284954326, 23886.0, 23893.522129556965, 24198.87900560486, 19105.426837194907, 19302.61394772125, 19388.903055484632, 19642.0, 19683.0, 17042.744358834378, 17065.488035358958, 17352.132393380532, 17540.0, 18043.0, 19447.0, 19738.40784776459, 20111.698324524852, 20151.79848201499, 20231.19075236974, 15288.312025959081, 15301.46444874424, 15315.310811013755, 15355.923220383827, 15472.0, 18943.052847357852, 18985.43043708691, 19036.714449282994, 19065.71401428952, 19283.0], "value": 12715.758024049972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.5859421470666, 1470.3603932289448, 1495.581237253569, 1504.3907217576877, 1520.6274462756626, 16563.58591035223, 17332.913335433306, 17345.7398139028, 17359.739603905935, 17439.564010899732, 16658.0838053907, 16698.916505417455, 16718.58203544912, 16771.0, 16807.66384672306, 2831.815931964426, 2868.7131286871354, 2905.753010994068, 2911.359500909807, 2921.1966709155045, 2781.666200055986, 2802.5095608268575, 2805.2566069991367, 2812.817166884146, 2815.6621205455376, 2640.603909413584, 2776.9028084017064, 2792.4833905727505, 2916.8541572921376, 2926.89755858545, 2794.552871540554, 2823.4353129374103, 2825.6326677531997, 2827.406244688608, 2833.39082097348, 2698.3254186453387, 2710.874986880442, 2729.8089133760645, 2743.6570428696414, 2834.9716502834913, 16442.095684737335, 16636.83363166365, 16644.251008704636, 16645.41741039058, 16661.6667666646, 8374.41379103463, 8638.395312328139, 8663.826723465558, 8667.479951202948, 8670.34972377068, 5758.596898217126, 5992.280926288873, 6033.336333003366, 6039.909401358983, 6109.3890610939, 1920.6446807340687, 1932.053293886, 1937.3606709785736, 1961.892095934723, 1966.5771859050374, 30138.24654383636, 30258.54612180819, 30343.848280758455, 30349.848250758827, 30424.239394015327, 7274.818129546804, 7315.853682926312, 7332.340089391873, 7540.886886696704, 7626.580538070349, 19254.903725481283, 19726.0, 19774.703379449318, 20036.39890803278, 20048.39854804358, 8292.958535207285, 8466.19571140753, 8515.914840851636, 8517.36119791018, 8527.957360213159, 7738.729144479917, 7787.805304867424, 7814.648340824677, 7866.0, 7925.762227133196, 5551.139573366135, 5722.856928576735, 5795.217645617788, 5809.0, 5828.242328497268, 1670.098147000606, 1684.519911825124, 1715.4339068107495, 1717.6822287876782, 1719.5615118144792, 995.9352642078242, 1018.5365658625308, 1022.8056669232822, 1022.8619136416488, 1040.698197522725, 8255.0, 8930.553472326488, 8962.955185224033, 9029.09709029105, 9069.818603627891, 774.941879359039, 801.587182600961, 803.5098589860181, 806.1132753970703, 806.3025482957318, 5206.401263854629, 5289.233061206103, 5320.802819365612, 5368.7047212403695, 5386.272853164851, 23502.529949400916, 24910.252692419257, 25302.746972530407, 25341.0, 25352.239432817045, 24098.39754006164, 24297.75702242955, 24602.876985614956, 24661.26016219516, 24788.132415365737, 12436.502539898303, 12480.563180288827, 12524.81212781809, 12593.811092833615, 12696.0, 9232.353735238468, 9452.243820494481, 9733.61065557398, 9795.706128816148, 9894.604215831287, 20791.79208207959, 20943.685844712647, 21360.145594176058, 21596.784032159478, 21614.783852161276, 21625.35123946284, 21698.457538561663, 21783.891080544498, 21931.0, 22268.331950041524, 12294.262344259372, 12365.690857728629, 12459.252444853339, 12475.064370172091, 12542.561010364594, 15529.611759706098, 15781.763273550676, 15872.0, 15907.840921590636, 15909.124998125215, 12484.56304029391, 12555.435005424595, 12575.119741617998, 12703.174293670882, 12994.610161695164, 12413.131080824256, 12547.560835370718, 12582.937085314516, 12617.179883307555, 12698.746025079632, 11202.327860328407, 11292.040176585082, 11361.37512436824, 11380.146489013192, 11384.14618903569, 7654.961725191339, 7706.691732330644, 7735.613219339123, 7777.883331749915, 7815.882761758465, 8044.235797599219, 8093.87859182101, 8198.877016844634, 8315.251627353568, 8320.958395207985], "value": 7274.163502347134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.113675845131, 561.7809054468756, 574.0843354849015, 585.9209006784083, 587.4742105815295, 6120.908186377203, 6180.794745024722, 6199.628022318653, 6229.595076320036, 6230.781922632703, 6029.125776762377, 6036.3661815509395, 6058.787942422016, 6141.692915354226, 6145.784897528587, 4832.516748325174, 5003.974980125113, 5016.2224855147515, 5050.191969284915, 5068.290439338495, 4901.779419926112, 4922.901541969159, 4938.925916111261, 4977.7262250576205, 4981.302617633534, 4851.927221091686, 4880.511948805127, 4893.314935908976, 4905.2642103684375, 4943.629227807911, 4906.1168989581865, 4917.311576379309, 4920.6801557898625, 4962.60299176065, 4967.90064198714, 4515.774211289455, 4516.164509565708, 4528.660350473728, 4534.070515544338, 4549.181147393468, 6054.273487181523, 6058.454739073504, 6109.14471973924, 6146.877062458726, 6164.445199932027, 5765.394633563457, 5776.191333213354, 5776.422357764232, 5785.82642520725, 5792.175464728597, 6522.510811689142, 6563.934360656428, 6565.54041217115, 6581.835454113638, 6583.0, 4768.713877167381, 4987.900241995176, 4996.300517927493, 4997.62517811162, 5001.674891132065, 6669.633170175687, 6750.459963202932, 6785.1518560179975, 6788.524803263774, 6794.0, 5128.717920514333, 5141.691498510101, 5142.61430392722, 5151.871203219875, 5177.559907407913, 5149.150390185578, 5162.6128040397125, 5182.740862956837, 5197.532222100029, 5241.161414173714, 5669.319681638147, 5709.0, 5806.912896306559, 5838.620489668158, 5884.0, 6559.737610495622, 6577.276499585042, 6619.60988192485, 6653.567518111307, 6666.400023997863, 1790.006546366779, 1806.121633501144, 1809.0412081596776, 1818.818118188197, 1826.4155470249393, 1212.6183464115582, 1259.106034715344, 1283.7432513497338, 1286.0740267007739, 1289.5808862119848, 6098.963176260047, 6107.572469927062, 6158.599691020159, 6165.414285642857, 6181.84545386369, 6488.740450382026, 6549.6070235786, 6583.967080164569, 6595.637239951753, 6629.906065499139, 5922.519370157461, 5990.281166260077, 6122.234720659918, 6151.507879369639, 6161.921663708833, 3477.913052173716, 3529.505869178317, 3529.6293889141784, 3531.4638132412483, 3536.469529570585, 6854.554453960476, 6886.931130688629, 6906.689198986058, 6914.723411063501, 6924.58452492852, 6818.693158807866, 6865.798485265059, 6878.38094571481, 6882.518223724392, 6899.896501552481, 6873.5565531238, 6881.93118068833, 6887.414569761526, 6888.586684798928, 6901.309869013058, 6366.331535188924, 6495.707693153725, 6516.771912983023, 6602.863639771071, 6650.004998500527, 6618.385737633512, 6636.350007495761, 6642.933570664231, 6665.933340666531, 6682.3317668232785, 6824.624645644339, 6857.937019761945, 6899.724011039502, 6941.895871562032, 6973.47698922593, 5047.848564543069, 5114.411842638145, 5124.333836601218, 5129.87175320605, 5137.768800404066, 6387.808365749035, 6398.456131228898, 6533.0, 6650.567713098633, 6714.261431242657, 6439.549231553746, 6449.226092868886, 6453.774117906039, 6499.837504062247, 6525.477961763143, 6389.520785941166, 6391.0, 6457.354264573693, 6461.547691661726, 6479.676016199265, 6216.689165541795, 6280.466160376419, 6303.401176888188, 6307.684615769285, 6411.230652321751, 6462.321456247027, 6477.611343319416, 6478.870422591616, 6527.5757075789925, 6574.3754343337305, 6319.115323854756, 6324.810255692337, 6327.0, 6364.045393190873, 6393.328700486568], "value": 5111.640555221632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.7360112769552, 988.9923455385567, 989.4904124375947, 1004.352192835621, 1012.1346248957146, 19079.809201907978, 19445.0, 19477.123529441174, 19481.610367792637, 19504.804951950475, 17214.39749608764, 17353.39263125791, 17370.392036278732, 17496.47510574685, 17800.376986805466, 1019.2915923433235, 1050.2228351020228, 1051.3271506236015, 1051.3586712105648, 1051.5110473629761, 1068.4230515521608, 1068.7648717282186, 1069.2301542889106, 1069.550788668761, 1072.0298130192189, 1079.6653037558342, 1115.1190559458018, 1116.5031560955379, 1118.9216754827166, 1126.5212284778936, 1098.4343063322394, 1103.1560855945208, 1105.6075093341829, 1107.1530279336234, 1108.384846410242, 788.2393490281848, 804.3926835239415, 823.3289868756943, 827.4332082523491, 828.7555171224443, 21585.56828863414, 21788.782112178833, 21800.127994880186, 21822.781772182392, 21832.781672183235, 21904.0, 22108.778912210993, 22209.22267720638, 22210.88894555533, 22459.213927512457, 18940.147693353832, 18946.52633684155, 19230.71153932692, 19279.93960332181, 19420.805791942043, 4004.83980640774, 4031.879043628696, 4035.25347810653, 4036.6367026967714, 4037.7981100944835, 130027.0, 160378.0, 163060.0, 163370.0, 163940.0, 18466.630667386577, 18503.53741156482, 18592.721109183374, 18879.905600472186, 19093.045347732837, 33744.325113497594, 34973.82513087469, 35085.29829403449, 35500.0, 35658.28683426317, 9578.185854202331, 9678.17735492491, 9684.903150968541, 9703.66037188695, 9711.5144242789, 4205.516365617932, 4265.4881414230495, 4345.0, 4356.956430435655, 4376.343548467692, 5970.671613061323, 6095.420935011167, 6097.0, 6111.144439778434, 6114.144019837227, 1243.384524660299, 1254.6988722706485, 1284.4862055178003, 1287.7617640736494, 1296.5138073222543, 719.9208087110413, 737.0639288104078, 738.9778306650809, 742.7697413801739, 760.0499375780274, 13209.40557674907, 13321.866781332257, 13554.728905422033, 13802.861971380158, 13904.026718129837, 734.2290594875466, 740.5926740292817, 751.6279441676296, 752.8005078654161, 754.3248792330943, 5696.515796157373, 5766.538676905838, 5859.355470898197, 5880.26496687914, 6002.0, 155295.0, 155966.0, 157616.0, 159552.20223899037, 164087.0, 137316.0, 138088.30955845155, 138136.0, 141385.0, 144563.27718361342, 117663.0, 119423.99999999827, 119544.0, 119925.40037299758, 121543.0, 11004.889951100708, 11073.0, 11176.608818691308, 11185.552577896793, 11238.438078096226, 57465.71267143638, 57588.42411575831, 58124.4187558119, 58188.12717809321, 58456.4154358468, 74205.62897185479, 75368.1157971055, 75428.62285688757, 75865.62067189849, 76506.2349376499, 15775.921120394325, 16354.100524471269, 16412.261448234618, 16535.173241338125, 16643.084630345445, 20056.799432005493, 20116.798832011493, 20250.797492024893, 20514.69227961552, 20551.69172462444, 16681.416150434678, 16980.660386792442, 16982.23579938881, 17140.40008599693, 17142.828571714123, 17334.73997890058, 17455.12724363802, 17539.123043848012, 17634.91182544079, 17654.55863603369, 16867.7469837955, 16904.57738556546, 16947.32210711558, 17057.48827535176, 17156.39952601653, 12646.367681615699, 12664.366781660696, 12679.556215532411, 12771.552995645108, 12872.292023938773, 12538.811917821058, 12586.18189817659, 12632.479823260413, 12708.618741437771, 12715.364231788559], "value": 9905.395869707534, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 107.0, 105.0, 109.0, 107.0, 106.0, 105.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 110.0, 111.0, 123.0, 111.0, 111.0, 111.0, 137.0, 109.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 164.0, 164.0, 162.0, 162.0, 163.0, 168.0, 167.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 74.0, 74.0, 74.0, 73.0, 74.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 78.0, 78.0, 78.0, 79.0, 78.0, 77.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 151.0, 149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 150.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 99.0, 98.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 46.0, 45.0, 45.0, 46.0, 44.0, 45.0, 45.0, 44.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 38.0, 36.0, 38.0, 37.0, 37.0, 37.0], "value": 37.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 73.0, 72.0, 70.0, 70.0, 76.0, 73.0, 71.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 103.0, 105.0, 110.0, 115.0, 102.0, 109.0, 106.0, 111.0], "value": 107.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 155.0, 155.0, 154.0, 154.0, 167.0, 152.0, 150.0, 155.0, 153.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 63.0, 60.0, 59.0, 64.0, 61.0, 63.0, 59.0, 60.0, 59.0], "value": 62.3, "unit": "score"}]}]} 04:16:04 INFO - Return code: 0 04:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:16:04 INFO - # TBPL SUCCESS # 04:16:04 INFO - Running post-action listener: _package_coverage_data 04:16:04 INFO - Running post-action listener: _resource_record_post_action 04:16:04 INFO - [mozharness: 2017-09-20 11:16:04.068407Z] Finished run-tests step (success) 04:16:04 INFO - Running post-run listener: _resource_record_post_run 04:16:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12353536; Write bytes: 463224832; Read time: 4456; Write time: 446976 04:16:04 INFO - TinderboxPrint: CPU usage
13.1% 04:16:04 INFO - TinderboxPrint: I/O read bytes / time
12,353,536 / 4,456 04:16:04 INFO - TinderboxPrint: I/O write bytes / time
463,224,832 / 446,976 04:16:04 INFO - TinderboxPrint: CPU idle
8,231.5 (86.9%) 04:16:04 INFO - TinderboxPrint: CPU user
1,186.1 (12.5%) 04:16:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:16:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 151076864; Read time: 264; Write time: 175668 04:16:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:16:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 9973760; Write bytes: 308838400; Read time: 3560; Write time: 271016 04:16:04 INFO - Running post-run listener: _upload_blobber_files 04:16:04 INFO - Blob upload gear active. 04:16:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:04 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 04:16:04 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'] 04:16:04 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 04:16:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:06 INFO - (blobuploader) - INFO - Done attempting. 04:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:07 INFO - (blobuploader) - INFO - Done attempting. 04:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:10 INFO - (blobuploader) - INFO - Done attempting. 04:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:11 INFO - (blobuploader) - INFO - Done attempting. 04:16:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:11 INFO - Return code: 0 04:16:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4efc964b162cf6d1d683f9043ed9c703cf704651e0b2fdb7a7ce730dfe99dc8aa4811fde026d743aa930ec90634bc2fa8ba09122231dc99e37c0cfb053ee84c7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc7b1dcb2d087822931fe005e92cf6d4829073cec7f7268ceb118935e6fd7f73761980923f1dfed9707c19f1eb51cad0a37fb10750b6e9a0288f26572c42ad9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef54ac006158c85a71a90cc675cab97ebd3bfc619346af2435ee71e39390da6854cf2a7c39680fe885d027b4a329a25b3c6f0fc6fe37dffa67700e876e5bee59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81575f38c99aa2f8e064122f8805934ce5234be193bd280ff9c34652c1336df0e57113c80dd654d6d7cf3c3a1f0befb048baed4a0d8979a83f47bb5c1b9d834"} 04:16:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:11 INFO - Contents: 04:16:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4efc964b162cf6d1d683f9043ed9c703cf704651e0b2fdb7a7ce730dfe99dc8aa4811fde026d743aa930ec90634bc2fa8ba09122231dc99e37c0cfb053ee84c7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc7b1dcb2d087822931fe005e92cf6d4829073cec7f7268ceb118935e6fd7f73761980923f1dfed9707c19f1eb51cad0a37fb10750b6e9a0288f26572c42ad9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef54ac006158c85a71a90cc675cab97ebd3bfc619346af2435ee71e39390da6854cf2a7c39680fe885d027b4a329a25b3c6f0fc6fe37dffa67700e876e5bee59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81575f38c99aa2f8e064122f8805934ce5234be193bd280ff9c34652c1336df0e57113c80dd654d6d7cf3c3a1f0befb048baed4a0d8979a83f47bb5c1b9d834"} 04:16:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:11 INFO - Copying logs to upload dir... 04:16:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.255785 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-20 04:16:11.389549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 04:16:11.393249) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 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/4efc964b162cf6d1d683f9043ed9c703cf704651e0b2fdb7a7ce730dfe99dc8aa4811fde026d743aa930ec90634bc2fa8ba09122231dc99e37c0cfb053ee84c7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc7b1dcb2d087822931fe005e92cf6d4829073cec7f7268ceb118935e6fd7f73761980923f1dfed9707c19f1eb51cad0a37fb10750b6e9a0288f26572c42ad9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef54ac006158c85a71a90cc675cab97ebd3bfc619346af2435ee71e39390da6854cf2a7c39680fe885d027b4a329a25b3c6f0fc6fe37dffa67700e876e5bee59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81575f38c99aa2f8e064122f8805934ce5234be193bd280ff9c34652c1336df0e57113c80dd654d6d7cf3c3a1f0befb048baed4a0d8979a83f47bb5c1b9d834"} build_url:https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/adKXr-mFS7q1uKnWoKqiJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4efc964b162cf6d1d683f9043ed9c703cf704651e0b2fdb7a7ce730dfe99dc8aa4811fde026d743aa930ec90634bc2fa8ba09122231dc99e37c0cfb053ee84c7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cc7b1dcb2d087822931fe005e92cf6d4829073cec7f7268ceb118935e6fd7f73761980923f1dfed9707c19f1eb51cad0a37fb10750b6e9a0288f26572c42ad9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef54ac006158c85a71a90cc675cab97ebd3bfc619346af2435ee71e39390da6854cf2a7c39680fe885d027b4a329a25b3c6f0fc6fe37dffa67700e876e5bee59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81575f38c99aa2f8e064122f8805934ce5234be193bd280ff9c34652c1336df0e57113c80dd654d6d7cf3c3a1f0befb048baed4a0d8979a83f47bb5c1b9d834"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 04:16:11.421668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:16:11.422005) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505904923.412277-176858006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:16:11.506470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 04:16:11.506975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 04:16:11.507530) ========= ========= Total master_lag: 0.23 =========