builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1506054925.96 results: success (0) revision: 97282b0c985aa1778ced171514d1ae61945c634c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:25.956435) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:25.956790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:25.957084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:25.977797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:25.978087) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 21:35:26-- 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% 41.4M=0s 2017-09-21 21:35:26 (41.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:26.104471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:26.104747) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:26.156384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 21:35:26.156673) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97282b0c985aa1778ced171514d1ae61945c634c --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 97282b0c985aa1778ced171514d1ae61945c634c --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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 21:35:26,250 truncating revision to first 12 chars 2017-09-21 21:35:26,250 Setting DEBUG logging. 2017-09-21 21:35:26,251 attempt 1/10 2017-09-21 21:35:26,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97282b0c985a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 21:35:26,893 unpacking tar archive at: mozilla-central-97282b0c985a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 21:35:27.175422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:27.175716) ========= script_repo_revision: 97282b0c985aa1778ced171514d1ae61945c634c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:27.180135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:27.180405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 21:35:27.193856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-21 21:35:27.194207) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:35:27 INFO - MultiFileLogger online at 20170921 21:35:27 in /builds/slave/test 21:35:27 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 21:35:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:35:27 INFO - {'append_to_log': False, 21:35:27 INFO - 'base_work_dir': '/builds/slave/test', 21:35:27 INFO - 'blob_upload_branch': 'Firefox', 21:35:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:35:27 INFO - 'branch': 'Firefox', 21:35:27 INFO - 'buildbot_json_path': 'buildprops.json', 21:35:27 INFO - 'code_coverage': False, 21:35:27 INFO - 'config_files': ('talos/linux_config.py',), 21:35:27 INFO - 'default_actions': ('clobber', 21:35:27 INFO - 'read-buildbot-config', 21:35:27 INFO - 'download-and-extract', 21:35:27 INFO - 'populate-webroot', 21:35:27 INFO - 'create-virtualenv', 21:35:27 INFO - 'install', 21:35:27 INFO - 'setup-mitmproxy', 21:35:27 INFO - 'run-tests'), 21:35:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:35:27 INFO - 'disable_ccov_upload': False, 21:35:27 INFO - 'disable_stylo': False, 21:35:27 INFO - 'download_minidump_stackwalk': True, 21:35:27 INFO - 'download_symbols': 'ondemand', 21:35:27 INFO - 'enable_stylo': False, 21:35:27 INFO - 'enable_webrender': False, 21:35:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:35:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:35:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:35:27 INFO - 'gecko_profile': False, 21:35:27 INFO - 'gecko_profile_interval': 0, 21:35:27 INFO - 'installer_path': 'installer.exe', 21:35:27 INFO - 'log_level': 'info', 21:35:27 INFO - 'log_name': 'talos', 21:35:27 INFO - 'log_to_console': True, 21:35:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:35:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:35:27 INFO - 'opt_config_files': (), 21:35:27 INFO - 'pip_index': False, 21:35:27 INFO - 'suite': 'dromaeojs-e10s', 21:35:27 INFO - 'system_bits': '32', 21:35:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:35:27 INFO - 'title': 'talos-linux64-ix-040', 21:35:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:35:27 INFO - 'use_talos_json': True, 21:35:27 INFO - 'verify': 'False', 21:35:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:35:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:35:27 INFO - 'work_dir': 'build'} 21:35:27 INFO - [mozharness: 2017-09-22 04:35:27.431285Z] Running clobber step. 21:35:27 INFO - Running pre-action listener: _resource_record_pre_action 21:35:27 INFO - Running main action method: clobber 21:35:27 INFO - rmtree: /builds/slave/test/build 21:35:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:35:28 INFO - Running post-action listener: _resource_record_post_action 21:35:28 INFO - [mozharness: 2017-09-22 04:35:28.437788Z] Finished clobber step (success) 21:35:28 INFO - [mozharness: 2017-09-22 04:35:28.437888Z] Running read-buildbot-config step. 21:35:28 INFO - Running pre-action listener: _resource_record_pre_action 21:35:28 INFO - Running main action method: read_buildbot_config 21:35:28 INFO - Using buildbot properties: 21:35:28 INFO - { 21:35:28 INFO - "project": "", 21:35:28 INFO - "product": "firefox", 21:35:28 INFO - "who": "philringnalda@gmail.com", 21:35:28 INFO - "installer_path": "public/build/target.tar.bz2", 21:35:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 21:35:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:35:28 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 21:35:28 INFO - "stage_platform": "linux64-qr", 21:35:28 INFO - "basedir": "/builds/slave/test", 21:35:28 INFO - "buildnumber": 89, 21:35:28 INFO - "platform": "ubuntu64_hw_qr", 21:35:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:35:28 INFO - "slavebuilddir": "test", 21:35:28 INFO - "taskId": "dTu811ROTGypuPp6KjqXqA", 21:35:28 INFO - "branch": "mozilla-central", 21:35:28 INFO - "script_repo_revision": "production", 21:35:28 INFO - "revision": "97282b0c985aa1778ced171514d1ae61945c634c", 21:35:28 INFO - "slavename": "talos-linux64-ix-040", 21:35:28 INFO - "repo_path": "mozilla-central" 21:35:28 INFO - } 21:35:28 INFO - Finding installer, test and symbols from parent task. 21:35:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTu811ROTGypuPp6KjqXqA'}, attempt #1 21:35:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTu811ROTGypuPp6KjqXqA'}, attempt #1 21:35:29 INFO - Task dependencies: Qc4qapSdREq4to_uIRkeSw 21:35:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw'}, attempt #1 21:35:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json 21:35:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip 21:35:29 INFO - Running post-action listener: _resource_record_post_action 21:35:29 INFO - [mozharness: 2017-09-22 04:35:29.817774Z] Finished read-buildbot-config step (success) 21:35:29 INFO - [mozharness: 2017-09-22 04:35:29.817994Z] Running download-and-extract step. 21:35:29 INFO - Running pre-action listener: _resource_record_pre_action 21:35:29 INFO - Running main action method: download_and_extract 21:35:29 INFO - mkdir: /builds/slave/test/build/tests 21:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:29 INFO - trying https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json 21:35:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:35:30 INFO - Downloaded 989 bytes. 21:35:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:35:30 INFO - Using the following test package requirements: 21:35:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:35:30 INFO - u'common': [u'target.common.tests.zip'], 21:35:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:35:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:35:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:35:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:35:30 INFO - u'mozbase': [u'target.common.tests.zip'], 21:35:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:35:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:35:30 INFO - u'web-platform': [u'target.common.tests.zip', 21:35:30 INFO - u'target.web-platform.tests.tar.gz'], 21:35:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:35:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:35:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip 21:35:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:35:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip into memory 21:35:32 INFO - Content-Length response header: 54739760 21:35:32 INFO - Bytes received: 54739760 21:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip 21:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip into memory 21:35:43 INFO - Content-Length response header: 14513414 21:35:43 INFO - Bytes received: 14513414 21:35: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')]} 21:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:35:45 INFO - Downloaded 61709000 bytes. 21:35:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:45 INFO - mkdir: /builds/slave/test/properties 21:35:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:45 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:45 INFO - Contents: 21:35:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:45 INFO - Running post-action listener: _resource_record_post_action 21:35:45 INFO - Running post-action listener: find_tests_for_verification 21:35:45 INFO - Running post-action listener: set_extra_try_arguments 21:35:45 INFO - [mozharness: 2017-09-22 04:35:45.601098Z] Finished download-and-extract step (success) 21:35:45 INFO - [mozharness: 2017-09-22 04:35:45.601197Z] Running populate-webroot step. 21:35:45 INFO - Running pre-action listener: _resource_record_pre_action 21:35:45 INFO - Running main action method: populate_webroot 21:35:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:45 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['tresize', 21:35:45 INFO - 'tcanvasmark']}, 21:35:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:45 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['dromaeo_css', 21:35:45 INFO - 'kraken']}, 21:35:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:45 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'tests': ['damp', 'tps']}, 21:35:45 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['damp', 'tps']}, 21:35:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:45 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['dromaeo_dom']}, 21:35:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:35:45 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['basic_compositor_video', 21:35:45 INFO - 'glvideo']}, 21:35:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:35:45 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['ts_paint_webext', 21:35:45 INFO - 'tp5o_webext']}, 21:35:45 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:45 INFO - 'ts_paint', 21:35:45 INFO - 'tpaint', 21:35:45 INFO - 'sessionrestore', 21:35:45 INFO - 'sessionrestore_many_windows', 21:35:45 INFO - 'sessionrestore_no_auto_restore', 21:35:45 INFO - 'tabpaint']}, 21:35:45 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['a11yr', 21:35:45 INFO - 'ts_paint', 21:35:45 INFO - 'tpaint', 21:35:45 INFO - 'sessionrestore', 21:35:45 INFO - 'sessionrestore_many_windows', 21:35:45 INFO - 'sessionrestore_no_auto_restore', 21:35:45 INFO - 'tabpaint']}, 21:35:45 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 21:35:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:35:45 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['perf_reftest_singletons']}, 21:35:45 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['perf_reftest']}, 21:35:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:45 INFO - 'tsvgr_opacity', 21:35:45 INFO - 'tart', 21:35:45 INFO - 'tscrollx', 21:35:45 INFO - 'tsvg_static']}, 21:35:45 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['tsvgx', 21:35:45 INFO - 'tsvgr_opacity', 21:35:45 INFO - 'tart', 21:35:45 INFO - 'tscrollx', 21:35:45 INFO - 'tsvg_static']}, 21:35:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:35:45 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo'], 21:35:45 INFO - 'tests': ['tp5o']}, 21:35:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:45 INFO - 'talos_options': ['--mitmproxy', 21:35:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:45 INFO - '--firstNonBlankPaint'], 21:35:45 INFO - 'tests': ['tp6_google', 21:35:45 INFO - 'tp6_youtube', 21:35:45 INFO - 'tp6_amazon', 21:35:45 INFO - 'tp6_facebook']}, 21:35:45 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo', 21:35:45 INFO - '--mitmproxy', 21:35:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:45 INFO - '--firstNonBlankPaint'], 21:35:45 INFO - 'tests': ['tp6_google', 21:35:45 INFO - 'tp6_youtube', 21:35:45 INFO - 'tp6_amazon', 21:35:45 INFO - 'tp6_facebook']}, 21:35:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:45 INFO - 'talos_options': ['--stylo-threads=1', 21:35:45 INFO - '--mitmproxy', 21:35:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:45 INFO - '--firstNonBlankPaint'], 21:35:45 INFO - 'tests': ['tp6_google', 21:35:45 INFO - 'tp6_youtube', 21:35:45 INFO - 'tp6_amazon', 21:35:45 INFO - 'tp6_facebook']}, 21:35:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--xperf_path', 21:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:45 INFO - 'tests': ['tp5n']}, 21:35:45 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:45 INFO - 'talos_options': ['--disable-stylo', 21:35:45 INFO - '--xperf_path', 21:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:45 INFO - 'tests': ['tp5n']}}} 21:35:45 INFO - Running post-action listener: _resource_record_post_action 21:35:45 INFO - [mozharness: 2017-09-22 04:35:45.616259Z] Finished populate-webroot step (success) 21:35:45 INFO - [mozharness: 2017-09-22 04:35:45.616350Z] Running create-virtualenv step. 21:35:45 INFO - Running pre-action listener: _resource_record_pre_action 21:35:45 INFO - Running main action method: create_virtualenv 21:35:45 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:35:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:35:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:35:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:46 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:46 INFO - Installing pip...............done. 21:35:46 INFO - Return code: 0 21:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:46 INFO - Reading from file tmpfile_stdout 21:35:46 INFO - Output received: 21:35:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:35:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:46 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')]} 21:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:46 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')]} 21:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:46 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35:46 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 21:35:46 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 21:35:46 INFO - Using env: {'DISPLAY': ':0', 21:35:46 INFO - 'HOME': '/home/cltbld', 21:35:46 INFO - 'LANG': 'en_US.UTF-8', 21:35:46 INFO - 'LANGUAGE': 'en_US:en', 21:35:46 INFO - 'LOGNAME': 'cltbld', 21:35:46 INFO - 'MAIL': '/var/mail/cltbld', 21:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:46 INFO - 'MOZ_NO_REMOTE': '1', 21:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:46 INFO - 'NO_EM_RESTART': '1', 21:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:46 INFO - 'PWD': '/builds/slave/test', 21:35:46 INFO - 'SHELL': '/bin/bash', 21:35:46 INFO - 'SHLVL': '1', 21:35:46 INFO - 'TERM': 'linux', 21:35:46 INFO - 'TMOUT': '86400', 21:35:46 INFO - 'USER': 'cltbld', 21:35:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:46 INFO - '_': '/tools/buildbot/bin/python'} 21:35:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:35:47 INFO - Downloading/unpacking pip>=1.5 21:35:47 INFO - Running setup.py egg_info for package pip 21:35:47 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:47 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:47 INFO - Installing collected packages: pip 21:35:47 INFO - Found existing installation: pip 1.1 21:35:47 INFO - Uninstalling pip: 21:35:47 INFO - Successfully uninstalled pip 21:35:47 INFO - Running setup.py install for pip 21:35:47 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:47 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:35:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:35:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:35:47 INFO - Successfully installed pip 21:35:47 INFO - Cleaning up... 21:35:47 INFO - Return code: 0 21:35:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35: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')]} 21:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35: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', '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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:35: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 psutil>=3.1.1 21:35:47 INFO - Using env: {'DISPLAY': ':0', 21:35:47 INFO - 'HOME': '/home/cltbld', 21:35:47 INFO - 'LANG': 'en_US.UTF-8', 21:35:47 INFO - 'LANGUAGE': 'en_US:en', 21:35:47 INFO - 'LOGNAME': 'cltbld', 21:35:47 INFO - 'MAIL': '/var/mail/cltbld', 21:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:47 INFO - 'MOZ_NO_REMOTE': '1', 21:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:47 INFO - 'NO_EM_RESTART': '1', 21:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:47 INFO - 'PWD': '/builds/slave/test', 21:35:47 INFO - 'SHELL': '/bin/bash', 21:35:47 INFO - 'SHLVL': '1', 21:35:47 INFO - 'TERM': 'linux', 21:35:47 INFO - 'TMOUT': '86400', 21:35:47 INFO - 'USER': 'cltbld', 21:35:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:47 INFO - '_': '/tools/buildbot/bin/python'} 21:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:48 INFO - Downloading/unpacking psutil>=3.1.1 21:35: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 21:35: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 21:35: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 21:35: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 21:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:49 INFO - Installing collected packages: psutil 21:35:49 INFO - Running setup.py install for psutil 21:35:49 INFO - building 'psutil._psutil_linux' extension 21:35:49 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 21:35:49 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 21:35:49 INFO - building 'psutil._psutil_posix' extension 21:35:49 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 21:35:49 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 21:35:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:49 INFO - Successfully installed psutil 21:35:49 INFO - Cleaning up... 21:35:49 INFO - Return code: 0 21:35:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:49 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')]} 21:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:49 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')]} 21:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:49 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35:49 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 21:35:49 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 21:35:49 INFO - Using env: {'DISPLAY': ':0', 21:35:49 INFO - 'HOME': '/home/cltbld', 21:35:49 INFO - 'LANG': 'en_US.UTF-8', 21:35:49 INFO - 'LANGUAGE': 'en_US:en', 21:35:49 INFO - 'LOGNAME': 'cltbld', 21:35:49 INFO - 'MAIL': '/var/mail/cltbld', 21:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:49 INFO - 'MOZ_NO_REMOTE': '1', 21:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:49 INFO - 'NO_EM_RESTART': '1', 21:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:49 INFO - 'PWD': '/builds/slave/test', 21:35:49 INFO - 'SHELL': '/bin/bash', 21:35:49 INFO - 'SHLVL': '1', 21:35:49 INFO - 'TERM': 'linux', 21:35:49 INFO - 'TMOUT': '86400', 21:35:49 INFO - 'USER': 'cltbld', 21:35:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:49 INFO - '_': '/tools/buildbot/bin/python'} 21:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:50 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 21:35:50 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 21:35:50 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 21:35:50 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 21:35:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:51 INFO - Installing collected packages: mozsystemmonitor 21:35:51 INFO - Running setup.py install for mozsystemmonitor 21:35:51 INFO - Successfully installed mozsystemmonitor 21:35:51 INFO - Cleaning up... 21:35:51 INFO - Return code: 0 21:35:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35: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', '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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35: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 jsonschema==2.5.1 21:35:52 INFO - Using env: {'DISPLAY': ':0', 21:35:52 INFO - 'HOME': '/home/cltbld', 21:35:52 INFO - 'LANG': 'en_US.UTF-8', 21:35:52 INFO - 'LANGUAGE': 'en_US:en', 21:35:52 INFO - 'LOGNAME': 'cltbld', 21:35:52 INFO - 'MAIL': '/var/mail/cltbld', 21:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:52 INFO - 'MOZ_NO_REMOTE': '1', 21:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:52 INFO - 'NO_EM_RESTART': '1', 21:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:52 INFO - 'PWD': '/builds/slave/test', 21:35:52 INFO - 'SHELL': '/bin/bash', 21:35:52 INFO - 'SHLVL': '1', 21:35:52 INFO - 'TERM': 'linux', 21:35:52 INFO - 'TMOUT': '86400', 21:35:52 INFO - 'USER': 'cltbld', 21:35:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:52 INFO - '_': '/tools/buildbot/bin/python'} 21:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:52 INFO - Downloading/unpacking jsonschema==2.5.1 21:35: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 21:35: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 21:35: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 21:35: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 21:35:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:53 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:53 INFO - warning: no files found matching '*.txt' 21:35:53 INFO - no previously-included directories found matching 'build' 21:35:53 INFO - no previously-included directories found matching 'dist' 21:35:53 INFO - no previously-included directories found matching '.git*' 21:35:53 INFO - Installing collected packages: jsonschema, functools32 21:35:53 INFO - Running setup.py install for functools32 21:35:53 INFO - warning: no files found matching '*.txt' 21:35:53 INFO - no previously-included directories found matching 'build' 21:35:53 INFO - no previously-included directories found matching 'dist' 21:35:53 INFO - no previously-included directories found matching '.git*' 21:35:53 INFO - Successfully installed jsonschema functools32 21:35:53 INFO - Cleaning up... 21:35:53 INFO - Return code: 0 21:35:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35: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')]} 21:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35: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', '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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:35: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 functools32==3.2.3-2 21:35:53 INFO - Using env: {'DISPLAY': ':0', 21:35:53 INFO - 'HOME': '/home/cltbld', 21:35:53 INFO - 'LANG': 'en_US.UTF-8', 21:35:53 INFO - 'LANGUAGE': 'en_US:en', 21:35:53 INFO - 'LOGNAME': 'cltbld', 21:35:53 INFO - 'MAIL': '/var/mail/cltbld', 21:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:53 INFO - 'MOZ_NO_REMOTE': '1', 21:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:53 INFO - 'NO_EM_RESTART': '1', 21:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:53 INFO - 'PWD': '/builds/slave/test', 21:35:53 INFO - 'SHELL': '/bin/bash', 21:35:53 INFO - 'SHLVL': '1', 21:35:53 INFO - 'TERM': 'linux', 21:35:53 INFO - 'TMOUT': '86400', 21:35:53 INFO - 'USER': 'cltbld', 21:35:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:53 INFO - '_': '/tools/buildbot/bin/python'} 21:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:54 INFO - Cleaning up... 21:35:54 INFO - Return code: 0 21:35:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:54 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')]} 21:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:54 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')]} 21:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:54 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35:54 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 21:35:54 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 21:35:54 INFO - Using env: {'DISPLAY': ':0', 21:35:54 INFO - 'HOME': '/home/cltbld', 21:35:54 INFO - 'LANG': 'en_US.UTF-8', 21:35:54 INFO - 'LANGUAGE': 'en_US:en', 21:35:54 INFO - 'LOGNAME': 'cltbld', 21:35:54 INFO - 'MAIL': '/var/mail/cltbld', 21:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:54 INFO - 'MOZ_NO_REMOTE': '1', 21:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:54 INFO - 'NO_EM_RESTART': '1', 21:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:54 INFO - 'PWD': '/builds/slave/test', 21:35:54 INFO - 'SHELL': '/bin/bash', 21:35:54 INFO - 'SHLVL': '1', 21:35:54 INFO - 'TERM': 'linux', 21:35:54 INFO - 'TMOUT': '86400', 21:35:54 INFO - 'USER': 'cltbld', 21:35:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:54 INFO - '_': '/tools/buildbot/bin/python'} 21:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:35: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 21:35: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 21:35: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 21:35: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 21:35:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35: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 21:35: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 21:35: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 21:35: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 21:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:56 INFO - Downloading docopt-0.6.1.tar.gz 21:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:56 INFO - Running setup.py install for blobuploader 21:35:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:56 INFO - Running setup.py install for requests 21:35:56 INFO - Running setup.py install for docopt 21:35:56 INFO - Successfully installed blobuploader requests docopt 21:35:56 INFO - Cleaning up... 21:35:57 INFO - Return code: 0 21:35:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:57 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:35:57 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 21:35:57 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 21:35:57 INFO - Using env: {'DISPLAY': ':0', 21:35:57 INFO - 'HOME': '/home/cltbld', 21:35:57 INFO - 'LANG': 'en_US.UTF-8', 21:35:57 INFO - 'LANGUAGE': 'en_US:en', 21:35:57 INFO - 'LOGNAME': 'cltbld', 21:35:57 INFO - 'MAIL': '/var/mail/cltbld', 21:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:57 INFO - 'MOZ_NO_REMOTE': '1', 21:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:57 INFO - 'NO_EM_RESTART': '1', 21:35:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:57 INFO - 'PWD': '/builds/slave/test', 21:35:57 INFO - 'SHELL': '/bin/bash', 21:35:57 INFO - 'SHLVL': '1', 21:35:57 INFO - 'TERM': 'linux', 21:35:57 INFO - 'TMOUT': '86400', 21:35:57 INFO - 'USER': 'cltbld', 21:35:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:57 INFO - '_': '/tools/buildbot/bin/python'} 21:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:57 INFO - Running setup.py (path:/tmp/pip-XnJi85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:57 INFO - Running setup.py (path:/tmp/pip-HtY11S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:57 INFO - Running setup.py (path:/tmp/pip-4wZgH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:57 INFO - Running setup.py (path:/tmp/pip-00mOu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:57 INFO - Running setup.py (path:/tmp/pip-lM9mhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:57 INFO - Running setup.py (path:/tmp/pip-o_BRuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:57 INFO - Running setup.py (path:/tmp/pip-p9zjtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:57 INFO - Running setup.py (path:/tmp/pip-Gncm0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:57 INFO - Running setup.py (path:/tmp/pip-Md792N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:57 INFO - Running setup.py (path:/tmp/pip-adJGiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:57 INFO - Running setup.py (path:/tmp/pip-TcM8pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:57 INFO - Running setup.py (path:/tmp/pip-JNtr7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:58 INFO - Running setup.py (path:/tmp/pip-qWqjUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:58 INFO - Running setup.py (path:/tmp/pip-vJyqHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:58 INFO - Running setup.py (path:/tmp/pip-4Gf82L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:58 INFO - Running setup.py (path:/tmp/pip-V46WTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:58 INFO - Running setup.py (path:/tmp/pip-LDkgXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:58 INFO - Running setup.py install for manifestparser 21:35:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:58 INFO - Running setup.py install for mozcrash 21:35:58 INFO - Running setup.py install for mozdebug 21:35:58 INFO - Running setup.py install for mozdevice 21:35:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:58 INFO - Running setup.py install for mozfile 21:35:58 INFO - Running setup.py install for mozhttpd 21:35:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozinfo 21:35:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozInstall 21:35:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozleak 21:35:59 INFO - Running setup.py install for mozlog 21:35:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for moznetwork 21:35:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozprocess 21:35:59 INFO - Running setup.py install for mozprofile 21:35:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozrunner 21:35:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:59 INFO - Running setup.py install for mozscreenshot 21:35:59 INFO - Running setup.py install for moztest 21:36:00 INFO - Running setup.py install for mozversion 21:36:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:36:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:36:00 INFO - Cleaning up... 21:36:00 INFO - Return code: 0 21:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:00 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:36:00 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 21:36:00 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 21:36:00 INFO - Using env: {'DISPLAY': ':0', 21:36:00 INFO - 'HOME': '/home/cltbld', 21:36:00 INFO - 'LANG': 'en_US.UTF-8', 21:36:00 INFO - 'LANGUAGE': 'en_US:en', 21:36:00 INFO - 'LOGNAME': 'cltbld', 21:36:00 INFO - 'MAIL': '/var/mail/cltbld', 21:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:00 INFO - 'MOZ_NO_REMOTE': '1', 21:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:00 INFO - 'NO_EM_RESTART': '1', 21:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:00 INFO - 'PWD': '/builds/slave/test', 21:36:00 INFO - 'SHELL': '/bin/bash', 21:36:00 INFO - 'SHLVL': '1', 21:36:00 INFO - 'TERM': 'linux', 21:36:00 INFO - 'TMOUT': '86400', 21:36:00 INFO - 'USER': 'cltbld', 21:36:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:00 INFO - '_': '/tools/buildbot/bin/python'} 21:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:36:00 INFO - Running setup.py (path:/tmp/pip-Ee7yBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:36:00 INFO - Running setup.py (path:/tmp/pip-yWFcwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:36:00 INFO - Running setup.py (path:/tmp/pip-JmtZhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:36:00 INFO - Running setup.py (path:/tmp/pip-5VjJ6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:36:00 INFO - Running setup.py (path:/tmp/pip-9gEn8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:36:00 INFO - Running setup.py (path:/tmp/pip-N9Bc3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:36:00 INFO - Running setup.py (path:/tmp/pip-MKPUP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:36:00 INFO - Running setup.py (path:/tmp/pip-qhWfOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:36:00 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)) 21:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:36:00 INFO - Running setup.py (path:/tmp/pip-JpDNFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:36:01 INFO - Running setup.py (path:/tmp/pip-Pn8XhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:36:01 INFO - Running setup.py (path:/tmp/pip-Qc5O7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:36:01 INFO - Running setup.py (path:/tmp/pip-Ip9P5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:36:01 INFO - Running setup.py (path:/tmp/pip-lQ8UpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:36:01 INFO - Running setup.py (path:/tmp/pip-w3wJpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:01 INFO - Running setup.py (path:/tmp/pip-YLqaxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:36:01 INFO - Running setup.py (path:/tmp/pip-qdHIbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:36:01 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)) 21:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:36:01 INFO - Running setup.py (path:/tmp/pip-BrCeZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:36:01 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)) 21:36:01 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)) 21:36:01 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)) 21:36:01 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)) 21:36:01 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)) 21:36:01 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)) 21:36:01 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)) 21:36:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:02 INFO - Downloading blessings-1.6.tar.gz 21:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:36:02 INFO - Installing collected packages: blessings 21:36:02 INFO - Running setup.py install for blessings 21:36:02 INFO - Successfully installed blessings 21:36:02 INFO - Cleaning up... 21:36:02 INFO - Return code: 0 21:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:03 INFO - Reading from file tmpfile_stdout 21:36:03 INFO - Current package versions: 21:36:03 INFO - argparse == 1.2.1 21:36:03 INFO - blessings == 1.6 21:36:03 INFO - blobuploader == 1.2.4 21:36:03 INFO - docopt == 0.6.1 21:36:03 INFO - functools32 == 3.2.3-2 21:36:03 INFO - jsonschema == 2.5.1 21:36:03 INFO - manifestparser == 1.1 21:36:03 INFO - mozInstall == 1.13 21:36:03 INFO - mozcrash == 1.0 21:36:03 INFO - mozdebug == 0.1 21:36:03 INFO - mozdevice == 0.51 21:36:03 INFO - mozfile == 1.2 21:36:03 INFO - mozhttpd == 0.7 21:36:03 INFO - mozinfo == 0.10 21:36:03 INFO - mozleak == 0.1 21:36:03 INFO - mozlog == 3.5 21:36:03 INFO - moznetwork == 0.27 21:36:03 INFO - mozprocess == 0.25 21:36:03 INFO - mozprofile == 0.28 21:36:03 INFO - mozrunner == 6.13 21:36:03 INFO - mozscreenshot == 0.1 21:36:03 INFO - mozsystemmonitor == 0.3 21:36:03 INFO - moztest == 0.8 21:36:03 INFO - mozversion == 1.4 21:36:03 INFO - psutil == 3.1.1 21:36:03 INFO - requests == 1.2.3 21:36:03 INFO - wsgiref == 0.1.2 21:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:03 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:36:03 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 21:36:03 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 21:36:03 INFO - Using env: {'DISPLAY': ':0', 21:36:03 INFO - 'HOME': '/home/cltbld', 21:36:03 INFO - 'LANG': 'en_US.UTF-8', 21:36:03 INFO - 'LANGUAGE': 'en_US:en', 21:36:03 INFO - 'LOGNAME': 'cltbld', 21:36:03 INFO - 'MAIL': '/var/mail/cltbld', 21:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:03 INFO - 'MOZ_NO_REMOTE': '1', 21:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:03 INFO - 'NO_EM_RESTART': '1', 21:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:03 INFO - 'PWD': '/builds/slave/test', 21:36:03 INFO - 'SHELL': '/bin/bash', 21:36:03 INFO - 'SHLVL': '1', 21:36:03 INFO - 'TERM': 'linux', 21:36:03 INFO - 'TMOUT': '86400', 21:36:03 INFO - 'USER': 'cltbld', 21:36:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:03 INFO - '_': '/tools/buildbot/bin/python'} 21:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 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)) 21:36:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:36: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 21:36: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 21:36: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 21:36: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 21:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:36:04 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)) 21:36:04 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)) 21:36:04 INFO - Installing collected packages: simplejson 21:36:04 INFO - Running setup.py install for simplejson 21:36:04 INFO - building 'simplejson._speedups' extension 21:36:04 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 21:36:05 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 21:36:05 INFO - Successfully installed simplejson 21:36:05 INFO - Cleaning up... 21:36:05 INFO - Return code: 0 21:36:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:36: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')]} 21:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36: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')]} 21:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:05 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 0xc751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', '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 21:36:05 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 21:36:05 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 21:36:05 INFO - Using env: {'DISPLAY': ':0', 21:36:05 INFO - 'HOME': '/home/cltbld', 21:36:05 INFO - 'LANG': 'en_US.UTF-8', 21:36:05 INFO - 'LANGUAGE': 'en_US:en', 21:36:05 INFO - 'LOGNAME': 'cltbld', 21:36:05 INFO - 'MAIL': '/var/mail/cltbld', 21:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:05 INFO - 'MOZ_NO_REMOTE': '1', 21:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:05 INFO - 'NO_EM_RESTART': '1', 21:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:05 INFO - 'PWD': '/builds/slave/test', 21:36:05 INFO - 'SHELL': '/bin/bash', 21:36:05 INFO - 'SHLVL': '1', 21:36:05 INFO - 'TERM': 'linux', 21:36:05 INFO - 'TMOUT': '86400', 21:36:05 INFO - 'USER': 'cltbld', 21:36:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:05 INFO - '_': '/tools/buildbot/bin/python'} 21:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:36:05 INFO - Cleaning up... 21:36:05 INFO - Return code: 0 21:36:05 INFO - Running post-action listener: _resource_record_post_action 21:36:05 INFO - Running post-action listener: _start_resource_monitoring 21:36:05 INFO - Starting resource monitoring. 21:36:05 INFO - [mozharness: 2017-09-22 04:36:05.858044Z] Finished create-virtualenv step (success) 21:36:05 INFO - [mozharness: 2017-09-22 04:36:05.858516Z] Running install step. 21:36:05 INFO - Running pre-action listener: _resource_record_pre_action 21:36:05 INFO - Running main action method: install 21:36:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:06 INFO - Reading from file tmpfile_stdout 21:36:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:36:06 INFO - Reading from file tmpfile_stdout 21:36:06 INFO - Output received: 21:36:06 INFO - Usage: mozinstall [options] installer 21:36:06 INFO - Options: 21:36:06 INFO - -h, --help show this help message and exit 21:36:06 INFO - -d DEST, --destination=DEST 21:36:06 INFO - Directory to install application into. [default: 21:36:06 INFO - "/builds/slave/test"] 21:36:06 INFO - --app=APP Application being installed. [default: firefox] 21:36:06 INFO - mkdir: /builds/slave/test/build/application 21:36:06 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'] 21:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:36:24 INFO - Reading from file tmpfile_stdout 21:36:24 INFO - Output received: 21:36:24 INFO - /builds/slave/test/build/application/firefox/firefox 21:36:24 INFO - Running post-action listener: _resource_record_post_action 21:36:24 INFO - [mozharness: 2017-09-22 04:36:24.002680Z] Finished install step (success) 21:36:24 INFO - [mozharness: 2017-09-22 04:36:24.002933Z] Running setup-mitmproxy step. 21:36:24 INFO - Running pre-action listener: _resource_record_pre_action 21:36:24 INFO - Running main action method: setup_mitmproxy 21:36:24 INFO - Skipping: mitmproxy is not required 21:36:24 INFO - Running post-action listener: _resource_record_post_action 21:36:24 INFO - [mozharness: 2017-09-22 04:36:24.004066Z] Finished setup-mitmproxy step (success) 21:36:24 INFO - [mozharness: 2017-09-22 04:36:24.004289Z] Running run-tests step. 21:36:24 INFO - Running pre-action listener: _resource_record_pre_action 21:36:24 INFO - Running pre-action listener: _set_gcov_prefix 21:36:24 INFO - Running main action method: run_tests 21:36:24 WARNING - Try message not found. 21:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:36:24 INFO - Python 2.7.3 21:36:24 INFO - Return code: 0 21:36:24 INFO - grabbing minidump binary from tooltool 21:36:24 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')]} 21:36:24 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 0xfe5090>, '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 0xfe5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:36:24 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 21:36:24 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 21:36:24 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 21:36:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:36:24 INFO - Return code: 0 21:36:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:36:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:36:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:36:24 INFO - ENV: RUST_BACKTRACE is now full 21:36:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:36:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:36:24 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/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 21:36:24 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/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 21:36:24 INFO - Using env: {'DISPLAY': ':0', 21:36:24 INFO - 'HOME': '/home/cltbld', 21:36:24 INFO - 'LANG': 'en_US.UTF-8', 21:36:24 INFO - 'LANGUAGE': 'en_US:en', 21:36:24 INFO - 'LOGNAME': 'cltbld', 21:36:24 INFO - 'MAIL': '/var/mail/cltbld', 21:36:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:36:24 INFO - 'MOZ_ACCELERATED': '1', 21:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:24 INFO - 'MOZ_NO_REMOTE': '1', 21:36:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:24 INFO - 'MOZ_WEBRENDER': '1', 21:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:24 INFO - 'NO_EM_RESTART': '1', 21:36:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:24 INFO - 'PWD': '/builds/slave/test', 21:36:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:24 INFO - 'RUST_BACKTRACE': 'full', 21:36:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:36:24 INFO - 'SHELL': '/bin/bash', 21:36:24 INFO - 'SHLVL': '1', 21:36:24 INFO - 'TERM': 'linux', 21:36:24 INFO - 'TMOUT': '86400', 21:36:24 INFO - 'USER': 'cltbld', 21:36:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:24 INFO - '_': '/tools/buildbot/bin/python'} 21:36:24 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/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 21:36:24 INFO - mozversion application_buildid: 20170922034016 21:36:24 INFO - mozversion application_changeset: 97282b0c985aa1778ced171514d1ae61945c634c 21:36:24 INFO - mozversion application_display_name: Nightly 21:36:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:36:24 INFO - mozversion application_name: Firefox 21:36:24 INFO - mozversion application_remotingname: firefox 21:36:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:36:24 INFO - mozversion application_vendor: Mozilla 21:36:24 INFO - mozversion application_version: 58.0a1 21:36:24 INFO - mozversion platform_buildid: 20170922034016 21:36:24 INFO - mozversion platform_changeset: 97282b0c985aa1778ced171514d1ae61945c634c 21:36:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:36:24 INFO - mozversion platform_version: 58.0a1 21:36:24 INFO - using testdate: 1506054984 21:36:24 INFO - actual date: 1506054984 21:36:24 INFO - starting webserver on 'localhost:46140' 21:36:24 INFO - SUITE-START | Running 2 tests 21:36:24 INFO - TEST-START | dromaeo_css 21:36:24 INFO - Initialising browser for dromaeo_css test... 21:36:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46140/getInfo.html -profile /tmp/tmp5EslFF/profile 21:36:24 INFO - TEST-INFO | started process 28331 (/builds/slave/test/build/application/firefox/firefox http://localhost:46140/getInfo.html) 21:36:31 INFO - TEST-INFO | 28331: exit 0 21:36:31 INFO - Browser initialized. 21:36:31 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:31 INFO - Using env: {'DISPLAY': ':0', 21:36:31 INFO - 'HOME': '/home/cltbld', 21:36:31 INFO - 'JSGC_DISABLE_POISONING': '1', 21:36:31 INFO - 'LANG': 'en_US.UTF-8', 21:36:31 INFO - 'LANGUAGE': 'en_US:en', 21:36:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:36:31 INFO - 'LOGNAME': 'cltbld', 21:36:31 INFO - 'MAIL': '/var/mail/cltbld', 21:36:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:36:31 INFO - 'MOZ_ACCELERATED': '1', 21:36:31 INFO - 'MOZ_CRASHREPORTER': '1', 21:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:36:31 INFO - 'MOZ_NO_REMOTE': '1', 21:36:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:31 INFO - 'MOZ_WEBRENDER': '1', 21:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:31 INFO - 'NO_EM_RESTART': '1', 21:36:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:31 INFO - 'PWD': '/builds/slave/test', 21:36:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:31 INFO - 'RUST_BACKTRACE': 'full', 21:36:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:36:31 INFO - 'SHELL': '/bin/bash', 21:36:31 INFO - 'SHLVL': '1', 21:36:31 INFO - 'TERM': 'linux', 21:36:31 INFO - 'TMOUT': '86400', 21:36:31 INFO - 'USER': 'cltbld', 21:36:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:31 INFO - '_': '/tools/buildbot/bin/python'} 21:36:31 INFO - TEST-INFO | started process 28575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EslFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:32 INFO - PID 28575 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:36:32 INFO - PID 28575 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:36:32 INFO - PID 28575 | 21:36:32 INFO - PID 28575 | (/builds/slave/test/build/application/firefox/firefox:28635): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:36:32 INFO - PID 28575 | 21:36:42 INFO - PID 28575 | RSS: Main: 185470976 21:36:42 INFO - PID 28575 | 21:39:41 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46140/tests/dromaeo/cssquery-ext.html) 21:39:42 INFO - PID 28575 | RSS: Main: 188104704 21:39:42 INFO - PID 28575 | 21:42:44 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-ext.html (next: http://localhost:46140/tests/dromaeo/cssquery-jquery.html) 21:42:44 INFO - PID 28575 | RSS: Main: 188674048 21:42:44 INFO - PID 28575 | 21:45:47 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46140/tests/dromaeo/cssquery-mootools.html) 21:45:47 INFO - PID 28575 | RSS: Main: 193150976 21:45:47 INFO - PID 28575 | 21:48:49 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46140/tests/dromaeo/cssquery-prototype.html) 21:48:50 INFO - PID 28575 | RSS: Main: 186204160 21:48:50 INFO - PID 28575 | 21:51:54 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46140/tests/dromaeo/cssquery-yui.html) 21:51:54 INFO - PID 28575 | RSS: Main: 189784064 21:51:54 INFO - PID 28575 | 21:54:56 INFO - PID 28575 | Cycle 1(1): loaded http://localhost:46140/tests/dromaeo/cssquery-yui.html (next: http://localhost:46140/tests/dromaeo/cssquery-dojo.html) 21:54:57 INFO - PID 28575 | RSS: Main: 192741376 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | __start_tp_report 21:54:57 INFO - PID 28575 | _x_x_mozilla_page_load 21:54:57 INFO - PID 28575 | _x_x_mozilla_page_load_details 21:54:57 INFO - PID 28575 | |i|pagename|runs| 21:54:57 INFO - PID 28575 | |0;dojo.html;3099.4575949208884;3109.9844500777494;3132.7963682360646;3179.6820317968204;3180.3957248122856;6132.540059495534;6175.907361389577;6176.4132407421275;6286.088517165008;6327.525435592326;6193.938060619393;6231.127642130105;6242.406971337716;6254.21822272216;6255.061740738892;5690.886182276362;5800.941990580082;5804.9419505805035;5849.85375365615;5868.559858010645;5855.648661080328;5921.911171332434;5926.3184733755525;5954;5969.85075373117;5757.222774925373;5766.942330576703;5782.855428614276;5857.17999480071;5913.497352725002;5599.0761524348845;5750.05124154514;5773.913391299134;5816.738246778863;5832.416758324176;5682.034054210794;5689.943100568983;5750.712464376765;5755.366909639936;5774.740136693817;6122.816315510542;6237.906431403532;6237.937620623781;6244.157038799749;6248.781292654735;6659;6676.232233293184;6715.2277488089;6717.63053032083;6774.5257831951785;6510.967445162792;6734.730610775563;6747.797566073025;6767.492438067165;6812.591244525295;6137.202163718688;6153.200083989098;6160.322364539897;6163.876722465526;6171.84570385735;6639.933600664028;6738.9217725163735;6758.628275444898;6774.187097548326;6786.151731033621;6461.127747754087;6478.773242936474;6561.934380656132;6668.433183179387;6669.733210671616;6727.831804204934;6761.526693131434;6769.796906092825;6824;6829.521933464709;6373.5857169283845;6644.66776661165;6703;6730.125083739083;6771.932280677229;6529.640869752209;6561.409473147344;6573.112629795012;6600.867982640416;6603.867922641521;5289.761960711778;5328.0675881720545;5342.439043900412;5362.678239305654;5365.436629153961;4648.814047438064;4685.508021657745;4697.741624210701;4700.811967521329;4717.363155973968;5742.196092547047;5778.27771528559;5796.536277097822;5848.678322692208;5865.237519122486;6587.868242635216;6654.968479885625;6711.966440167866;6768.701429673145;6883.449324054063;5801.419858014165;5822.126680997884;5830.125481177857;5838.357780644125;5864.824055278264;5765.567582431335;5795.8551036224435;5807.767689292466;5814.331351894586;5821.359650438449;6486.4162225398995;6496.090547323379;6556.967215163893;6574.868502629921;6584.9012264816065;6590.769323073861;6723.966380168068;6751.966240168767;6799;6805.6597170141295;6263.874722505616;6357.872842543031;6471.288158302677;6565.212174539086;6576.671166441563;6564.737410503526;6574.309697481695;6610.570312929644;6626.56927299724;6632.303608121078;6732.562383445061;6738.966305168639;6741.426978706865;6747.224069231905;6752.628605426748;6421.357864213542;6421.839454013687;6440.6135631862235;6514.6416947068365;6550.541462097798;6311.368863113836;6425.1968503937005;6493.448056915026;6502.252240992158;6532;6484.708188131451;6498.122753428227;6526.738930442919;6540.574862633914;6549.869002619826;6586.045023471665;6595.274519802914;6636.568623039487;6640.800775976729;6708.966455167693;6335.841603959938;6347.365263473615;6353.618782873043;6393.93606063952;6428.453581445442 21:54:57 INFO - PID 28575 | |1;ext.html;838.1702114906243;862.7239283429305;865.048446708621;870.203763556346;872.1932212703248;38956.80521597395;42446.57553424465;42515.78742106289;42554.787226063825;42588.36117458241;39575.20849583007;39783;39910.401343979865;39914;40206.19587608254;7169.068021157255;7230.060092188034;7231.566106033629;7887.526748395086;8128.796780080486;7899.921000790005;7938.1664925182895;7953.204679532058;8020.639071241808;8024.478408903403;7935.841283174333;8033;8053.677852885878;8054.677812887478;8055.798605034863;7928.524288542677;7949.562774047425;7953.681852725884;7978.640961156733;7981.880271795928;7838.490498117604;7941.841163176762;7945.086315073782;7945.64244608994;7960.442769006172;39202.80398598017;39344.213115737526;39443.80278098591;39525.60474395248;39594.20811583781;3558.608553059187;3588.9282214355567;3589.820508974567;3598.478220658016;3598.6401359864067;31572.684273157432;31574.210644733837;31616.367672646647;31683.366332673217;31707.52438713421;5175.870603234949;5217.452167522393;5218.556422704075;5269.051570717269;5353.250544923714;191488;193757.03121484444;194389;195372;197496;42291.36562951558;42547.57452425498;48678.02643947101;49044.50955490471;49421.50578494241;52505.7374713124;52742.47257527452;52845.2073218902;52878.73560632172;53086.73456632692;16222.188890555424;16244;16251.268692908847;16303.347866085223;16330.591735206477;13168.539101131415;13262.403191856389;13272.668183295495;13281.535146270027;13309.600711978655;14446.061006034784;14448.205348705711;14512;14544.563663090124;14707.191104489355;5539.612227144142;5598.916016259759;5611.186377975171;5744.827655170351;5768.884622307614;985.1330828870548;994.7910938702953;1018.2363227579316;1022.9028242316969;1038.6209033702644;23182.65226021611;23389.298321050395;23412.297631071095;23525.005617837392;23690.88154559216;1115.2472081345059;1123.887611238886;1130.350048721988;1132.4677401621225;1143.588308209044;12459.501619935283;12505.187162834387;12537.686557835945;12551.560695375618;12595.118341716176;232796;233655;233855;233998;234782;53452.465475345525;53886;53922.46077539253;53958;53973.460265397625;1398.286873694423;1453.345994302568;1457.9489717859612;1463.619458940683;1467.9577499974923;22635.20776772805;22907.198248061904;23042.884785575963;23504.41238968971;23708.288751337488;33792.49311260382;33872.15319617029;34103.82948085244;34116.829415852764;34128.65871341255;196599;196938;197481;197977;198135;30985.845070774503;34010;34677.306453870275;35000.64999349974;35191;43942;44088.11823763571;44207.77896110499;44392.55607443884;44554.55445445504;32236.19409514781;32696.83651581822;32906.670933291316;32983.83508082444;33254.33491330208;31951.680483194872;32085.67914320827;32165.517517237728;32273.35453290874;32508.187295317806;36034.63965360313;36233.27533449369;36362.27275454529;36721;36753.816230918674;31248.531272031392;31277;31339.843300783352;32036.6796332043;32652.183695406853;23276.107654247215;23436;23510;23947.52104957856;24154.275371738877 21:54:57 INFO - PID 28575 | |2;jquery.html;564.469398765161;572.2503520388292;583.3116922032001;585.5666806563145;602.5209958083324;21609.891950540245;22153.556928861413;22513;22532.549349013032;22609.434764130903;23212.535749285005;23890.88054559729;24200.515989680196;24271.27186184413;24625.261242162764;6503.317151699074;6650.401463868251;6687.665616719169;6711.5301928865;6715.6977935993;6547.77082802102;6601.009848522712;6605.504587155959;6666.366695163952;6673.699683514254;6366.395192456709;6606.6036037837885;6607.5374723769355;6641.837678406284;6664.666766661671;6609.603423794588;6648.867022659568;6651.334866513358;6653.866922661568;6666.966665166668;5938.643681379088;6164.568480206387;6185.443310102068;6187.752489900398;6193.102000209944;28327;28816.711832881614;28838.42323153546;28862.711372886213;28871.133865984055;1951.092741875035;1975.4962484566342;1983.6429442700307;1987.6919077543005;1990.1044529961575;16986.575335616708;18913.905430472758;19330.903345483184;19354.129064192144;19444.70832937507;2398;2454.981182809132;2481.702195736523;2497.7127630322566;2501.9249422517355;126038;132113;132195;135268;141062.29468852692;14434.863782641765;14693.632659183606;15038.248087595795;15089.156385795091;15223.467178648694;22839.543209135725;23028.4242893929;23037.308880733606;23052.308430747104;23080.307590772303;9551.522423878778;10221.080102790784;10225.437600931871;10243.48782560884;10249.12882404989;9283.860742088875;9362.859557106649;9389.62441502346;9442.763930901783;9455.669051583161;8785.780355491164;9089.409188402733;9128.954355228181;9226;9406.71779846592;2680.396910695078;2688.9596656050176;2741.231356330081;2752.059797842516;2841.3260186992284;938.4369378372921;938.7277689469977;950.5579905344048;957.9521023948774;963.6145541783343;18543.072846357627;18605.162767675487;18725.157367918477;18962.81037189638;19066.2373505061;984.3060642247199;1005.5575546759402;1015.5176291261739;1016.1718199667248;1019.5615885169449;10091.192704583616;10204.846927296096;10266.076053155102;10391.740206494747;10442.2168337375;479132;506841;508323;509457;510142;114312;114455.42772286086;115708;118576.40711796386;121337;1122.3602546548552;1154.318951818431;1194.1879521925175;1225.7732319520917;1230.680023193976;19439;19639.70540441923;19800.504987374854;20098.894560799297;20103.09536070851;56086.03698870683;58305.125423119534;58851.70574147102;60523;61470.385296146465;74008;74634.62682686551;76178.61910690411;76368.81864024937;78136.60931695305;14065.789013164605;14093.15441073539;14154.221517816619;14235;14393.496227631982;21664.675029874248;21784;21791.346259612237;21800.34598962034;22175.88912055494;16776.916115419346;17176.484705458857;17860.642787144443;17874.016929069025;18063.458096256607;15699.293531790869;16232.350705971628;16272.023678579322;16780.748288775434;16852.915735421244;16685.74971375406;17886;17928;18091.185896634946;18137.81862181414;14029.859701403264;14094.436222550983;14119.364628591944;14171.149731016172;14215.50245741394;17273.136343183043;17364.565885852953;17591.208395621972;17597.736033959758;17619.64760704753 21:54:57 INFO - PID 28575 | |3;mootools.html;1283.3070142123254;1337.2845527642708;1349.9527516536923;1352.3441131051432;1355.315565639352;12610;13332.133411328268;15226.619334516628;15803.446879359224;15877.682446351066;15411.229438528086;15680.059196448192;15762.605934851634;15857.286422111003;15867.444639437623;2702.189343197043;2752.4357506711176;2756.517609418354;2761.282066662662;2767.488014717284;2667.5998600209928;2754.3389586499197;2758.4207316463567;2758.5310497215523;2759.903403380872;2661.4277930244994;2677.9598306025423;2683.4901368739975;2693.663292088489;2699.1092939330074;2586.586146216606;2608.79129669626;2644.894204231838;2645.4973555024676;2656.3226377273672;2552.4001859562986;2553.336132605536;2577.4071963448323;2582.1866112174603;2587.3790290330376;14888.106713597219;14983.850161498354;15058.849411505855;15099.698006039818;15181.089134651846;7865.921340786576;8106.148854370265;8139.715109971123;8150.144234855374;8172.427930044899;5430.456954304538;5514.117741161395;5584.246126772874;5821.67980761058;5838.737256823453;1932.2657390191778;1973.15154483572;1984.2063174730079;2008.9497762555907;2042.0606521000357;26710.86644566784;26786.46427071467;26794;26809.329766755793;26849;7182.389496892718;7240.818979525554;7358.337749602561;7440.2931721486375;7544.773656790305;20308;20343.491412714506;20353.08411121503;20413.081411336527;20461.488462788253;8281.337493000545;8302.70940517079;8303.086660467343;8326.83346333082;8349.66601335952;5851.941480585139;6070.908936365958;6232.283287421914;6244.12582238487;7386.298301661333;5451.182322651554;5641.435856414326;5735.541156707453;5747.913781293284;5748.223989761413;1726.3181043487753;1749.7200447928526;1782.4741701198177;1789.9821001790076;1824.9469346984642;896.4621227263721;915.4919019943862;916.7204002779083;920.8066306075799;930.4882314726873;8092.514449133071;8450.577471126418;8557.871631925525;8567.571621418903;8622.180892815173;701.7964790210782;714.6248219684708;717.4726575966661;722.173111787001;728.4864170759602;4480.350349199348;4517.774111294422;4568.954310456919;4678.555537223959;4689.953100468952;20750.169993200405;22491;22685.88657056737;22735.317940461813;22772.772272277067;20723.585528289652;21595.2441664541;22029.339119826433;22133.225337113447;22257.220997265344;11428;11727.237729547553;11731.648050558497;11763.353015584225;11765.294082355085;8528.786780330542;8554.57227138653;8583.656653734031;8729.345299102466;8800.427972181787;18198.72701909499;18928.810711892704;19256.518587035436;19265.13306901221;19732.50668733293;19202.327918522784;19378.749738824587;19760;20108.39674809758;20174.69737953961;12413.193142445713;12418.192817466836;12497.312647804458;12526.561570344995;12552.435140418886;14097.154170749787;14258.786118208443;14315;14341;14362.712745744817;11047.502862371051;11231.943840280746;11342.829857552308;11354.602588909349;11484;11183.776324473301;11309.434528273718;11457.140714446283;11466.827997579876;11513.309201447604;9938.850917236392;10171.694849154537;10246.129079028366;10318.43248621303;10340.482975851028;7129.572225666477;7236.891446628199;7257.237990011184;7263.709451621876;7318.926810732038;7386.372158366599;7495.812604684927;7572;7600.125985511516;7662.961685191538 21:54:57 INFO - PID 28575 | |4;prototype.html;497.6632315845049;499.1886943188755;521.3639359980824;521.5540712690647;527.29605976022;6074.939250607493;6102.511799056076;6120.47975922046;6164.784232551861;6263.624182549051;6002.369751176129;6115.235595550545;6142.447179753821;6146.262448506174;6181.549284515142;5080.923786143211;5115.13042782726;5148.845534633958;5174.732190613305;5185.948140518584;5122.846314610549;5149.253358263049;5149.485051494839;5153.330067091273;5161.483851614846;4693.741844198567;4894.804207831682;4902.6027582139095;4909.877253068684;4962.87592810179;4886.902261954759;4908.7300198489065;4928.926066108976;4962.305277261186;4969.180085285923;4400.9559904401185;4406.933895991563;4412.271975124101;4431.91418102567;4445.644348452149;5918.763249470016;5957.612755170943;5965.850853728648;5977.402259774031;5992.880142397127;5605.467480589378;5628.943710562883;5644.745986430579;5662.971685141548;5690.345610254791;6388.64862432566;6419.775307864249;6426.935730642727;6510.511711621647;6526.445252153572;4581.839635612738;4768.094062128184;4795.448523419782;4800.423949126127;4832.009438065188;6520.11978382917;6549.377809108127;6626.469882409492;6628.834279143011;6675.699593518303;4932.580730637864;4952.752362381866;4961.131801934647;4974.179260422062;4986.975065124651;4928.728919909439;4987.950120498748;5001.549860512571;5011.523905228997;5052.090623687772;5603.411641777555;5622.381538030813;5631.521320687705;5639.154126881001;5667.376588575254;6450.6774661266745;6453.774117905851;6499.610023398611;6516.283208847023;6517.869642607121;1726.9481915542553;1729.8097209306966;1737.54823745827;1752.6845167869906;1754.631527379239;1047.601911273711;1200.5317926008863;1216.7809794237123;1244.3031902134833;1245.6325384011739;5505.256790333334;5542.224088627595;5568.192612071308;5575;5645.887082258332;6426.35736426363;6483.286838447767;6488.442773734269;6488.86444872155;6517.576357536745;5610.699613158586;5651.9826431241945;5657.886842263131;5660.377358490563;5661.320641523043;3437.8796742113905;3460.3598334308235;3473.3053389322235;3480.4257297545623;3510.227749895019;6244.406781355764;6313.305536390993;6320.525960552977;6338.30278669346;6380.7128679209545;6670.266270710218;6680.532362734659;6709.463242940651;6714;6755.662216889136;6285.402886725754;6364.64994425311;6376.649284289316;6389.712462939179;6395.968020159869;5991.7902873399225;6389.55273130895;6530.8367290818105;6604.400601672004;6614.90077648826;6243.344448832807;6327.936720632735;6381.202349706286;6404.583702059351;6427;6257.996161842432;6367.586106903036;6369.522285828489;6436.16329877113;6459.386358295955;4884.9511504884495;4929.605631549396;4936.086823937583;4946.901061978812;5007.874803129951;6286.811395658137;6354.459870911024;6430.421262086435;6602.966985165043;6659.900101498578;6222.937770622417;6285.528585356025;6339.524535659936;6399.872002560016;6416;6348.301686814354;6407.430179606026;6434.002729576923;6460.321666224979;6472.35276472349;6278.277998030285;6314.305426403183;6316.936830631635;6321.778737744341;6324.778632747832;6449.419552240321;6453.064305675744;6507;6512.674366281762;6522.739090436329;6162.630242185483;6252;6266.717997690206;6295.716692748746;6319.842003949938 21:54:57 INFO - PID 28575 | |5;yui.html;884.5533005832056;893.6425429828068;906.9682561110362;916.2166347772652;917.522888098189;19212.71180932287;19923.501912452197;20050.097745601448;20090.497737556532;20184.798152018477;17380.913095434506;17525.298988040497;17598;17613.11934403278;17989.910050449762;920.6087412849546;950.239808153478;950.4819873169139;955.4983633592385;955.8040601676639;945.4043952310069;948.5020364308758;948.5020364308758;951.2295041016764;951.4814426137737;992.3648864726581;999.5252255178805;1015.9187265018818;1016.5323950982557;1022.371241686365;982.5382070426924;983.1692220074061;984.17329443268;992.354969269973;1002.0230275481457;729.1942403644003;730.2040775554618;730.5434103685196;731.1701219116288;731.9231480694557;19886.70169947452;20014.099365528586;20389.08249128793;20465.2837150699;20502.487437814023;21060.473488162766;21690.89154554217;21810.454738631503;21929.342119736433;22007.11971521153;17097.40159094438;17206.139693015426;17218.225179866935;17242.56893577658;17319.653606927917;3771.4719939208535;3790.090378309186;3793.3740932746064;3803.866864659751;3807.3717836556934;97687.51156244174;106810;125124;138452;139035;12965.546205882749;13168.868311316955;13230.4046317914;13421.39603717835;13555.728885422237;29493.26266843346;29499.55750663742;29621.851890740407;29877.402451951275;29903.401931961238;9221.769455763526;9418.717438476857;9514.571844267024;9590.952045239728;9667.081627245401;4348.195583817004;4363.38912552243;4384.780760962003;4387.517373088957;4388.341748737651;5410.431904649955;5429.56563474921;5603.299587551556;5613.943860561424;5622.550195984311;1078.3637653784306;1080.994674952302;1094.2449709700281;1095.0910744082391;1095.1457862866816;593.2910172344094;622.1973653986397;631.1637080867777;635.7615894039735;636.2428709835374;10675.893241067646;10902.236843420884;10954.890451095547;10992.230543861853;11684.70788230301;628.2461046743925;633.8098570428945;638.2596188421409;644.9064885591563;645.880512105262;5234.345706786652;5240.187770895517;5293.523582877559;5357.866053348697;5389.110796718576;121955;122600.38699806444;123409;124240;124558.37720811338;107707;109754.45122774335;110057;111531;115074;93035.53482232546;94314;95340.52329738307;95643.52178239064;97008.02991970131;9839.655612053544;9869.753256168653;9875.703728888146;9899.95050024774;10180.389176649425;45506.08987820159;45651.31523027224;46327.53672463232;46436.53563464322;46539.76730116328;55900;56049.71975140098;56594;56943.430565693816;56964.43035569591;14633;15405.614859628598;15407;15548.222588870738;15682.451114210948;15716.92141539285;16067.357305707641;16119.355225790838;16161.515154545383;16293.837061629707;13122.081454298108;13185.868141318848;13252.337383130998;13329.800052999019;13395.531156409479;14735.92632036833;14985.475508357154;15010.949233553547;15059.322330494935;15379.84620153784;14974.925125374739;15099.47151849724;15150.924245379143;15234.695306094038;15310.31103600363;10339.741506462398;10399.896001039893;10471.94764026175;10769.676909692722;10914.727131821768;10606.893931060591;10761.192910531585;10776.906059137871;10895.891041089488;11126.443677815914 21:54:57 INFO - PID 28575 | __end_tp_report 21:54:57 INFO - PID 28575 | __start_cc_report 21:54:57 INFO - PID 28575 | _x_x_mozilla_cycle_collect,299 21:54:57 INFO - PID 28575 | __end_cc_report 21:54:57 INFO - PID 28575 | __startTimestamp1506056097135__endTimestamp 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | ------- Summary: start ------- 21:54:57 INFO - PID 28575 | Number of tests: 6 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#0] dojo.html Cycles:165 Average:6164.64 Median:6393.94 stddev:719.76 (11.3%) stddev-sans-first:680.62 21:54:57 INFO - PID 28575 | Values: 3099.5 3110.0 3132.8 3179.7 3180.4 6132.5 6175.9 6176.4 6286.1 6327.5 6193.9 6231.1 6242.4 6254.2 6255.1 5690.9 5800.9 5804.9 5849.9 5868.6 5855.6 5921.9 5926.3 5954.0 5969.9 5757.2 5766.9 5782.9 5857.2 5913.5 5599.1 5750.1 5773.9 5816.7 5832.4 5682.0 5689.9 5750.7 5755.4 5774.7 6122.8 6237.9 6237.9 6244.2 6248.8 6659.0 6676.2 6715.2 6717.6 6774.5 6511.0 6734.7 6747.8 6767.5 6812.6 6137.2 6153.2 6160.3 6163.9 6171.8 6639.9 6738.9 6758.6 6774.2 6786.2 6461.1 6478.8 6561.9 6668.4 6669.7 6727.8 6761.5 6769.8 6824.0 6829.5 6373.6 6644.7 6703.0 6730.1 6771.9 6529.6 6561.4 6573.1 6600.9 6603.9 5289.8 5328.1 5342.4 5362.7 5365.4 4648.8 4685.5 4697.7 4700.8 4717.4 5742.2 5778.3 5796.5 5848.7 5865.2 6587.9 6655.0 6712.0 6768.7 6883.4 5801.4 5822.1 5830.1 5838.4 5864.8 5765.6 5795.9 5807.8 5814.3 5821.4 6486.4 6496.1 6557.0 6574.9 6584.9 6590.8 6724.0 6752.0 6799.0 6805.7 6263.9 6357.9 6471.3 6565.2 6576.7 6564.7 6574.3 6610.6 6626.6 6632.3 6732.6 6739.0 6741.4 6747.2 6752.6 6421.4 6421.8 6440.6 6514.6 6550.5 6311.4 6425.2 6493.4 6502.3 6532.0 6484.7 6498.1 6526.7 6540.6 6549.9 6586.0 6595.3 6636.6 6640.8 6709.0 6335.8 6347.4 6353.6 6393.9 6428.5 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#1] ext.html Cycles:180 Average:37835.87 Median:34838.98 stddev:54221.75 (155.6%) stddev-sans-first:54302.69 21:54:57 INFO - PID 28575 | Values: 838.2 862.7 865.0 870.2 872.2 38956.8 42446.6 42515.8 42554.8 42588.4 39575.2 39783.0 39910.4 39914.0 40206.2 7169.1 7230.1 7231.6 7887.5 8128.8 7899.9 7938.2 7953.2 8020.6 8024.5 7935.8 8033.0 8053.7 8054.7 8055.8 7928.5 7949.6 7953.7 7978.6 7981.9 7838.5 7941.8 7945.1 7945.6 7960.4 39202.8 39344.2 39443.8 39525.6 39594.2 3558.6 3588.9 3589.8 3598.5 3598.6 31572.7 31574.2 31616.4 31683.4 31707.5 5175.9 5217.5 5218.6 5269.1 5353.3 191488.0 193757.0 194389.0 195372.0 197496.0 42291.4 42547.6 48678.0 49044.5 49421.5 52505.7 52742.5 52845.2 52878.7 53086.7 16222.2 16244.0 16251.3 16303.3 16330.6 13168.5 13262.4 13272.7 13281.5 13309.6 14446.1 14448.2 14512.0 14544.6 14707.2 5539.6 5598.9 5611.2 5744.8 5768.9 985.1 994.8 1018.2 1022.9 1038.6 23182.7 23389.3 23412.3 23525.0 23690.9 1115.2 1123.9 1130.4 1132.5 1143.6 12459.5 12505.2 12537.7 12551.6 12595.1 232796.0 233655.0 233855.0 233998.0 234782.0 53452.5 53886.0 53922.5 53958.0 53973.5 1398.3 1453.3 1457.9 1463.6 1468.0 22635.2 22907.2 23042.9 23504.4 23708.3 33792.5 33872.2 34103.8 34116.8 34128.7 196599.0 196938.0 197481.0 197977.0 198135.0 30985.8 34010.0 34677.3 35000.6 35191.0 43942.0 44088.1 44207.8 44392.6 44554.6 32236.2 32696.8 32906.7 32983.8 33254.3 31951.7 32085.7 32165.5 32273.4 32508.2 36034.6 36233.3 36362.3 36721.0 36753.8 31248.5 31277.0 31339.8 32036.7 32652.2 23276.1 23436.0 23510.0 23947.5 24154.3 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#2] jquery.html Cycles:180 Average:35000.57 Median:22522.77 stddev:84560.21 (375.4%) stddev-sans-first:84757.90 21:54:57 INFO - PID 28575 | Values: 564.5 572.3 583.3 585.6 602.5 21609.9 22153.6 22513.0 22532.5 22609.4 23212.5 23890.9 24200.5 24271.3 24625.3 6503.3 6650.4 6687.7 6711.5 6715.7 6547.8 6601.0 6605.5 6666.4 6673.7 6366.4 6606.6 6607.5 6641.8 6664.7 6609.6 6648.9 6651.3 6653.9 6667.0 5938.6 6164.6 6185.4 6187.8 6193.1 28327.0 28816.7 28838.4 28862.7 28871.1 1951.1 1975.5 1983.6 1987.7 1990.1 16986.6 18913.9 19330.9 19354.1 19444.7 2398.0 2455.0 2481.7 2497.7 2501.9 126038.0 132113.0 132195.0 135268.0 141062.3 14434.9 14693.6 15038.2 15089.2 15223.5 22839.5 23028.4 23037.3 23052.3 23080.3 9551.5 10221.1 10225.4 10243.5 10249.1 9283.9 9362.9 9389.6 9442.8 9455.7 8785.8 9089.4 9129.0 9226.0 9406.7 2680.4 2689.0 2741.2 2752.1 2841.3 938.4 938.7 950.6 958.0 963.6 18543.1 18605.2 18725.2 18962.8 19066.2 984.3 1005.6 1015.5 1016.2 1019.6 10091.2 10204.8 10266.1 10391.7 10442.2 479132.0 506841.0 508323.0 509457.0 510142.0 114312.0 114455.4 115708.0 118576.4 121337.0 1122.4 1154.3 1194.2 1225.8 1230.7 19439.0 19639.7 19800.5 20098.9 20103.1 56086.0 58305.1 58851.7 60523.0 61470.4 74008.0 74634.6 76178.6 76368.8 78136.6 14065.8 14093.2 14154.2 14235.0 14393.5 21664.7 21784.0 21791.3 21800.3 22175.9 16776.9 17176.5 17860.6 17874.0 18063.5 15699.3 16232.4 16272.0 16780.7 16852.9 16685.7 17886.0 17928.0 18091.2 18137.8 14029.9 14094.4 14119.4 14171.1 14215.5 17273.1 17364.6 17591.2 17597.7 17619.6 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#3] mootools.html Cycles:180 Average:9573.17 Median:2626.84 stddev:6927.92 (263.7%) stddev-sans-first:6919.36 21:54:57 INFO - PID 28575 | Values: 1283.3 1337.3 1350.0 1352.3 1355.3 12610.0 13332.1 15226.6 15803.4 15877.7 15411.2 15680.1 15762.6 15857.3 15867.4 2702.2 2752.4 2756.5 2761.3 2767.5 2667.6 2754.3 2758.4 2758.5 2759.9 2661.4 2678.0 2683.5 2693.7 2699.1 2586.6 2608.8 2644.9 2645.5 2656.3 2552.4 2553.3 2577.4 2582.2 2587.4 14888.1 14983.9 15058.8 15099.7 15181.1 7865.9 8106.1 8139.7 8150.1 8172.4 5430.5 5514.1 5584.2 5821.7 5838.7 1932.3 1973.2 1984.2 2008.9 2042.1 26710.9 26786.5 26794.0 26809.3 26849.0 7182.4 7240.8 7358.3 7440.3 7544.8 20308.0 20343.5 20353.1 20413.1 20461.5 8281.3 8302.7 8303.1 8326.8 8349.7 5851.9 6070.9 6232.3 6244.1 7386.3 5451.2 5641.4 5735.5 5747.9 5748.2 1726.3 1749.7 1782.5 1790.0 1824.9 896.5 915.5 916.7 920.8 930.5 8092.5 8450.6 8557.9 8567.6 8622.2 701.8 714.6 717.5 722.2 728.5 4480.4 4517.8 4569.0 4678.6 4690.0 20750.2 22491.0 22685.9 22735.3 22772.8 20723.6 21595.2 22029.3 22133.2 22257.2 11428.0 11727.2 11731.6 11763.4 11765.3 8528.8 8554.6 8583.7 8729.3 8800.4 18198.7 18928.8 19256.5 19265.1 19732.5 19202.3 19378.7 19760.0 20108.4 20174.7 12413.2 12418.2 12497.3 12526.6 12552.4 14097.2 14258.8 14315.0 14341.0 14362.7 11047.5 11231.9 11342.8 11354.6 11484.0 11183.8 11309.4 11457.1 11466.8 11513.3 9938.9 10171.7 10246.1 10318.4 10340.5 7129.6 7236.9 7257.2 7263.7 7318.9 7386.4 7495.8 7572.0 7600.1 7663.0 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#4] prototype.html Cycles:180 Average:5407.22 Median:5997.62 stddev:1496.10 (24.9%) stddev-sans-first:1454.21 21:54:57 INFO - PID 28575 | Values: 497.7 499.2 521.4 521.6 527.3 6074.9 6102.5 6120.5 6164.8 6263.6 6002.4 6115.2 6142.4 6146.3 6181.5 5080.9 5115.1 5148.8 5174.7 5185.9 5122.8 5149.3 5149.5 5153.3 5161.5 4693.7 4894.8 4902.6 4909.9 4962.9 4886.9 4908.7 4928.9 4962.3 4969.2 4401.0 4406.9 4412.3 4431.9 4445.6 5918.8 5957.6 5965.9 5977.4 5992.9 5605.5 5628.9 5644.7 5663.0 5690.3 6388.6 6419.8 6426.9 6510.5 6526.4 4581.8 4768.1 4795.4 4800.4 4832.0 6520.1 6549.4 6626.5 6628.8 6675.7 4932.6 4952.8 4961.1 4974.2 4987.0 4928.7 4988.0 5001.5 5011.5 5052.1 5603.4 5622.4 5631.5 5639.2 5667.4 6450.7 6453.8 6499.6 6516.3 6517.9 1726.9 1729.8 1737.5 1752.7 1754.6 1047.6 1200.5 1216.8 1244.3 1245.6 5505.3 5542.2 5568.2 5575.0 5645.9 6426.4 6483.3 6488.4 6488.9 6517.6 5610.7 5652.0 5657.9 5660.4 5661.3 3437.9 3460.4 3473.3 3480.4 3510.2 6244.4 6313.3 6320.5 6338.3 6380.7 6670.3 6680.5 6709.5 6714.0 6755.7 6285.4 6364.6 6376.6 6389.7 6396.0 5991.8 6389.6 6530.8 6604.4 6614.9 6243.3 6327.9 6381.2 6404.6 6427.0 6258.0 6367.6 6369.5 6436.2 6459.4 4885.0 4929.6 4936.1 4946.9 5007.9 6286.8 6354.5 6430.4 6603.0 6659.9 6222.9 6285.5 6339.5 6399.9 6416.0 6348.3 6407.4 6434.0 6460.3 6472.4 6278.3 6314.3 6316.9 6321.8 6324.8 6449.4 6453.1 6507.0 6512.7 6522.7 6162.6 6252.0 6266.7 6295.7 6319.8 21:54:57 INFO - PID 28575 | 21:54:57 INFO - PID 28575 | [#5] yui.html Cycles:180 Average:23513.54 Median:21750.67 stddev:34122.57 (156.9%) stddev-sans-first:34175.99 21:54:57 INFO - PID 28575 | Values: 884.6 893.6 907.0 916.2 917.5 19212.7 19923.5 20050.1 20090.5 20184.8 17380.9 17525.3 17598.0 17613.1 17989.9 920.6 950.2 950.5 955.5 955.8 945.4 948.5 948.5 951.2 951.5 992.4 999.5 1015.9 1016.5 1022.4 982.5 983.2 984.2 992.4 1002.0 729.2 730.2 730.5 731.2 731.9 19886.7 20014.1 20389.1 20465.3 20502.5 21060.5 21690.9 21810.5 21929.3 22007.1 17097.4 17206.1 17218.2 17242.6 17319.7 3771.5 3790.1 3793.4 3803.9 3807.4 97687.5 106810.0 125124.0 138452.0 139035.0 12965.5 13168.9 13230.4 13421.4 13555.7 29493.3 29499.6 29621.9 29877.4 29903.4 9221.8 9418.7 9514.6 9591.0 9667.1 4348.2 4363.4 4384.8 4387.5 4388.3 5410.4 5429.6 5603.3 5613.9 5622.6 1078.4 1081.0 1094.2 1095.1 1095.1 593.3 622.2 631.2 635.8 636.2 10675.9 10902.2 10954.9 10992.2 11684.7 628.2 633.8 638.3 644.9 645.9 5234.3 5240.2 5293.5 5357.9 5389.1 121955.0 122600.4 123409.0 124240.0 124558.4 107707.0 109754.5 110057.0 111531.0 115074.0 93035.5 94314.0 95340.5 95643.5 97008.0 9839.7 9869.8 9875.7 9900.0 10180.4 45506.1 45651.3 46327.5 46436.5 46539.8 55900.0 56049.7 56594.0 56943.4 56964.4 14633.0 15405.6 15407.0 15548.2 15682.5 15716.9 16067.4 16119.4 16161.5 16293.8 13122.1 13185.9 13252.3 13329.8 13395.5 14735.9 14985.5 15010.9 15059.3 15379.8 14974.9 15099.5 15150.9 15234.7 15310.3 10339.7 10399.9 10471.9 10769.7 10914.7 10606.9 10761.2 10776.9 10895.9 11126.4 21:54:57 INFO - PID 28575 | -------- Summary: end -------- 21:54:57 INFO - PID 28575 | 21:54:57 INFO - TEST-INFO | 28575: exit 0 21:54:57 INFO - TEST-OK | dromaeo_css | took 1113600ms 21:54:57 INFO - TEST-START | kraken 21:54:57 INFO - Initialising browser for kraken test... 21:54:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46140/getInfo.html -profile /tmp/tmp0CO8bF/profile 21:54:57 INFO - TEST-INFO | started process 28955 (/builds/slave/test/build/application/firefox/firefox http://localhost:46140/getInfo.html) 21:55:03 INFO - TEST-INFO | 28955: exit 0 21:55:03 INFO - Browser initialized. 21:55:03 INFO - Running cycle 1/1 for kraken test... 21:55:03 INFO - Using env: {'DISPLAY': ':0', 21:55:03 INFO - 'HOME': '/home/cltbld', 21:55:03 INFO - 'JSGC_DISABLE_POISONING': '1', 21:55:03 INFO - 'LANG': 'en_US.UTF-8', 21:55:03 INFO - 'LANGUAGE': 'en_US:en', 21:55:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:55:03 INFO - 'LOGNAME': 'cltbld', 21:55:03 INFO - 'MAIL': '/var/mail/cltbld', 21:55:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:55:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:55:03 INFO - 'MOZ_ACCELERATED': '1', 21:55:03 INFO - 'MOZ_CRASHREPORTER': '1', 21:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:55:03 INFO - 'MOZ_NO_REMOTE': '1', 21:55:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:55:03 INFO - 'MOZ_WEBRENDER': '1', 21:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:03 INFO - 'NO_EM_RESTART': '1', 21:55:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:03 INFO - 'PWD': '/builds/slave/test', 21:55:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:55:03 INFO - 'RUST_BACKTRACE': 'full', 21:55:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:55:03 INFO - 'SHELL': '/bin/bash', 21:55:03 INFO - 'SHLVL': '1', 21:55:03 INFO - 'TERM': 'linux', 21:55:03 INFO - 'TMOUT': '86400', 21:55:03 INFO - 'USER': 'cltbld', 21:55:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752', 21:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:03 INFO - '_': '/tools/buildbot/bin/python'} 21:55:03 INFO - TEST-INFO | started process 29200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0CO8bF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:04 INFO - PID 29200 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:55:04 INFO - PID 29200 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:55:05 INFO - PID 29200 | 21:55:05 INFO - PID 29200 | (/builds/slave/test/build/application/firefox/firefox:29259): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:55:05 INFO - PID 29200 | 21:55:15 INFO - PID 29200 | RSS: Main: 189014016 21:55:15 INFO - PID 29200 | 21:55:18 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46140/tests/kraken/driver.html?testName=audio-beat-detection) 21:55:19 INFO - PID 29200 | RSS: Main: 186949632 21:55:19 INFO - PID 29200 | 21:55:21 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46140/tests/kraken/driver.html?testName=audio-dft) 21:55:22 INFO - PID 29200 | RSS: Main: 185962496 21:55:22 INFO - PID 29200 | 21:55:25 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46140/tests/kraken/driver.html?testName=audio-fft) 21:55:26 INFO - PID 29200 | RSS: Main: 184500224 21:55:26 INFO - PID 29200 | 21:55:28 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46140/tests/kraken/driver.html?testName=audio-oscillator) 21:55:28 INFO - PID 29200 | RSS: Main: 184418304 21:55:28 INFO - PID 29200 | 21:55:30 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:55:31 INFO - PID 29200 | RSS: Main: 184717312 21:55:31 INFO - PID 29200 | 21:55:34 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46140/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:35 INFO - PID 29200 | RSS: Main: 187817984 21:55:35 INFO - PID 29200 | 21:55:39 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46140/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:39 INFO - PID 29200 | RSS: Main: 187703296 21:55:39 INFO - PID 29200 | 21:55:42 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46140/tests/kraken/driver.html?testName=json-parse-financial) 21:55:43 INFO - PID 29200 | RSS: Main: 187756544 21:55:43 INFO - PID 29200 | 21:55:45 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:45 INFO - PID 29200 | RSS: Main: 187543552 21:55:45 INFO - PID 29200 | 21:55:47 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:47 INFO - PID 29200 | RSS: Main: 184258560 21:55:47 INFO - PID 29200 | 21:55:50 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:50 INFO - PID 29200 | RSS: Main: 184438784 21:55:50 INFO - PID 29200 | 21:55:53 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:54 INFO - PID 29200 | RSS: Main: 184815616 21:55:54 INFO - PID 29200 | 21:55:57 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:57 INFO - PID 29200 | RSS: Main: 184635392 21:55:57 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | Cycle 1(1): loaded http://localhost:46140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46140/tests/kraken/driver.html?testName=ai-astar) 21:55:59 INFO - PID 29200 | RSS: Main: 186425344 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | __start_tp_report 21:55:59 INFO - PID 29200 | _x_x_mozilla_page_load 21:55:59 INFO - PID 29200 | _x_x_mozilla_page_load_details 21:55:59 INFO - PID 29200 | |i|pagename|runs| 21:55:59 INFO - PID 29200 | |0;ai-astar;111;112;108;109;114;108;111;107;116;108 21:55:59 INFO - PID 29200 | |1;audio-beat-detection;126;127;120;121;117;125;118;119;137;123 21:55:59 INFO - PID 29200 | |2;audio-dft;164;167;164;168;172;175;174;162;162;166 21:55:59 INFO - PID 29200 | |3;audio-fft;79;76;75;79;75;75;87;75;75;78 21:55:59 INFO - PID 29200 | |4;audio-oscillator;80;85;79;80;80;79;82;79;84;89 21:55:59 INFO - PID 29200 | |5;imaging-gaussian-blur;125;115;115;117;114;111;114;114;117;115 21:55:59 INFO - PID 29200 | |6;imaging-darkroom;149;152;150;151;147;151;151;148;149;156 21:55:59 INFO - PID 29200 | |7;imaging-desaturate;97;100;101;94;103;100;94;94;101;95 21:55:59 INFO - PID 29200 | |8;json-parse-financial;52;52;55;54;54;55;53;53;55;53 21:55:59 INFO - PID 29200 | |9;json-stringify-tinderbox;49;38;38;39;45;52;38;39;39;38 21:55:59 INFO - PID 29200 | |10;stanford-crypto-aes;81;79;74;74;76;77;72;74;73;82 21:55:59 INFO - PID 29200 | |11;stanford-crypto-ccm;116;120;119;121;115;113;118;115;120;114 21:55:59 INFO - PID 29200 | |12;stanford-crypto-pbkdf2;168;171;171;171;163;178;166;171;172;173 21:55:59 INFO - PID 29200 | |13;stanford-crypto-sha256-iterative;63;66;64;64;73;65;64;67;69;64 21:55:59 INFO - PID 29200 | __end_tp_report 21:55:59 INFO - PID 29200 | __start_cc_report 21:55:59 INFO - PID 29200 | _x_x_mozilla_cycle_collect,767 21:55:59 INFO - PID 29200 | __end_cc_report 21:55:59 INFO - PID 29200 | __startTimestamp1506056159650__endTimestamp 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | ------- Summary: start ------- 21:55:59 INFO - PID 29200 | Number of tests: 14 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.95 (2.7%) stddev-sans-first:3.12 21:55:59 INFO - PID 29200 | Values: 111.0 112.0 108.0 109.0 114.0 108.0 111.0 107.0 116.0 108.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:124.00 stddev:5.91 (4.8%) stddev-sans-first:6.18 21:55:59 INFO - PID 29200 | Values: 126.0 127.0 120.0 121.0 117.0 125.0 118.0 119.0 137.0 123.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#2] audio-dft Cycles:10 Average:167.40 Median:167.50 stddev:4.79 (2.9%) stddev-sans-first:4.92 21:55:59 INFO - PID 29200 | Values: 164.0 167.0 164.0 168.0 172.0 175.0 174.0 162.0 162.0 166.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#3] audio-fft Cycles:10 Average:77.40 Median:77.00 stddev:3.78 (4.9%) stddev-sans-first:3.96 21:55:59 INFO - PID 29200 | Values: 79.0 76.0 75.0 79.0 75.0 75.0 87.0 75.0 75.0 78.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:81.00 stddev:3.33 (4.1%) stddev-sans-first:3.48 21:55:59 INFO - PID 29200 | Values: 80.0 85.0 79.0 80.0 80.0 79.0 82.0 79.0 84.0 89.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:3.68 (3.2%) stddev-sans-first:1.80 21:55:59 INFO - PID 29200 | Values: 125.0 115.0 115.0 117.0 114.0 111.0 114.0 114.0 117.0 115.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:2.50 (1.7%) stddev-sans-first:2.60 21:55:59 INFO - PID 29200 | Values: 149.0 152.0 150.0 151.0 147.0 151.0 151.0 148.0 149.0 156.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:94.00 stddev:3.48 (3.7%) stddev-sans-first:3.67 21:55:59 INFO - PID 29200 | Values: 97.0 100.0 101.0 94.0 103.0 100.0 94.0 94.0 101.0 95.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.17 (2.2%) stddev-sans-first:1.09 21:55:59 INFO - PID 29200 | Values: 52.0 52.0 55.0 54.0 54.0 55.0 53.0 53.0 55.0 53.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#9] json-stringify-tinderbox Cycles:10 Average:41.50 Median:39.00 stddev:5.23 (13.4%) stddev-sans-first:4.80 21:55:59 INFO - PID 29200 | Values: 49.0 38.0 38.0 39.0 45.0 52.0 38.0 39.0 39.0 38.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.50 stddev:3.46 (4.5%) stddev-sans-first:3.20 21:55:59 INFO - PID 29200 | Values: 81.0 79.0 74.0 74.0 76.0 77.0 72.0 74.0 73.0 82.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.50 stddev:2.85 (2.4%) stddev-sans-first:2.99 21:55:59 INFO - PID 29200 | Values: 116.0 120.0 119.0 121.0 115.0 113.0 118.0 115.0 120.0 114.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:4.06 (2.4%) stddev-sans-first:4.21 21:55:59 INFO - PID 29200 | Values: 168.0 171.0 171.0 171.0 163.0 178.0 166.0 171.0 172.0 173.0 21:55:59 INFO - PID 29200 | 21:55:59 INFO - PID 29200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:3.07 (4.7%) stddev-sans-first:3.07 21:55:59 INFO - PID 29200 | Values: 63.0 66.0 64.0 64.0 73.0 65.0 64.0 67.0 69.0 64.0 21:55:59 INFO - PID 29200 | -------- Summary: end -------- 21:55:59 INFO - PID 29200 | 21:56:00 INFO - PID 29200 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:56:00 INFO - TEST-INFO | 29200: exit 0 21:56:00 INFO - TEST-OK | kraken | took 62519ms 21:56:00 INFO - SUITE-END | took 1176s 21:56:00 INFO - Completed test suite (00:19:36) 21:56:00 INFO - javascript benchmark 21:56:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8443.967428700422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.4575949208884, 3109.9844500777494, 3132.7963682360646, 3179.6820317968204, 3180.3957248122856, 6132.540059495534, 6175.907361389577, 6176.4132407421275, 6286.088517165008, 6327.525435592326, 6193.938060619393, 6231.127642130105, 6242.406971337716, 6254.21822272216, 6255.061740738892, 5690.886182276362, 5800.941990580082, 5804.9419505805035, 5849.85375365615, 5868.559858010645, 5855.648661080328, 5921.911171332434, 5926.3184733755525, 5954.0, 5969.85075373117, 5757.222774925373, 5766.942330576703, 5782.855428614276, 5857.17999480071, 5913.497352725002, 5599.0761524348845, 5750.05124154514, 5773.913391299134, 5816.738246778863, 5832.416758324176, 5682.034054210794, 5689.943100568983, 5750.712464376765, 5755.366909639936, 5774.740136693817, 6122.816315510542, 6237.906431403532, 6237.937620623781, 6244.157038799749, 6248.781292654735, 6659.0, 6676.232233293184, 6715.2277488089, 6717.63053032083, 6774.5257831951785, 6510.967445162792, 6734.730610775563, 6747.797566073025, 6767.492438067165, 6812.591244525295, 6137.202163718688, 6153.200083989098, 6160.322364539897, 6163.876722465526, 6171.84570385735, 6639.933600664028, 6738.9217725163735, 6758.628275444898, 6774.187097548326, 6786.151731033621, 6461.127747754087, 6478.773242936474, 6561.934380656132, 6668.433183179387, 6669.733210671616, 6727.831804204934, 6761.526693131434, 6769.796906092825, 6824.0, 6829.521933464709, 6373.5857169283845, 6644.66776661165, 6703.0, 6730.125083739083, 6771.932280677229, 6529.640869752209, 6561.409473147344, 6573.112629795012, 6600.867982640416, 6603.867922641521, 5289.761960711778, 5328.0675881720545, 5342.439043900412, 5362.678239305654, 5365.436629153961, 4648.814047438064, 4685.508021657745, 4697.741624210701, 4700.811967521329, 4717.363155973968, 5742.196092547047, 5778.27771528559, 5796.536277097822, 5848.678322692208, 5865.237519122486, 6587.868242635216, 6654.968479885625, 6711.966440167866, 6768.701429673145, 6883.449324054063, 5801.419858014165, 5822.126680997884, 5830.125481177857, 5838.357780644125, 5864.824055278264, 5765.567582431335, 5795.8551036224435, 5807.767689292466, 5814.331351894586, 5821.359650438449, 6486.4162225398995, 6496.090547323379, 6556.967215163893, 6574.868502629921, 6584.9012264816065, 6590.769323073861, 6723.966380168068, 6751.966240168767, 6799.0, 6805.6597170141295, 6263.874722505616, 6357.872842543031, 6471.288158302677, 6565.212174539086, 6576.671166441563, 6564.737410503526, 6574.309697481695, 6610.570312929644, 6626.56927299724, 6632.303608121078, 6732.562383445061, 6738.966305168639, 6741.426978706865, 6747.224069231905, 6752.628605426748, 6421.357864213542, 6421.839454013687, 6440.6135631862235, 6514.6416947068365, 6550.541462097798, 6311.368863113836, 6425.1968503937005, 6493.448056915026, 6502.252240992158, 6532.0, 6484.708188131451, 6498.122753428227, 6526.738930442919, 6540.574862633914, 6549.869002619826, 6586.045023471665, 6595.274519802914, 6636.568623039487, 6640.800775976729, 6708.966455167693, 6335.841603959938, 6347.365263473615, 6353.618782873043, 6393.93606063952, 6428.453581445442], "value": 6110.714103359733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.1702114906243, 862.7239283429305, 865.048446708621, 870.203763556346, 872.1932212703248, 38956.80521597395, 42446.57553424465, 42515.78742106289, 42554.787226063825, 42588.36117458241, 39575.20849583007, 39783.0, 39910.401343979865, 39914.0, 40206.19587608254, 7169.068021157255, 7230.060092188034, 7231.566106033629, 7887.526748395086, 8128.796780080486, 7899.921000790005, 7938.1664925182895, 7953.204679532058, 8020.639071241808, 8024.478408903403, 7935.841283174333, 8033.0, 8053.677852885878, 8054.677812887478, 8055.798605034863, 7928.524288542677, 7949.562774047425, 7953.681852725884, 7978.640961156733, 7981.880271795928, 7838.490498117604, 7941.841163176762, 7945.086315073782, 7945.64244608994, 7960.442769006172, 39202.80398598017, 39344.213115737526, 39443.80278098591, 39525.60474395248, 39594.20811583781, 3558.608553059187, 3588.9282214355567, 3589.820508974567, 3598.478220658016, 3598.6401359864067, 31572.684273157432, 31574.210644733837, 31616.367672646647, 31683.366332673217, 31707.52438713421, 5175.870603234949, 5217.452167522393, 5218.556422704075, 5269.051570717269, 5353.250544923714, 191488.0, 193757.03121484444, 194389.0, 195372.0, 197496.0, 42291.36562951558, 42547.57452425498, 48678.02643947101, 49044.50955490471, 49421.50578494241, 52505.7374713124, 52742.47257527452, 52845.2073218902, 52878.73560632172, 53086.73456632692, 16222.188890555424, 16244.0, 16251.268692908847, 16303.347866085223, 16330.591735206477, 13168.539101131415, 13262.403191856389, 13272.668183295495, 13281.535146270027, 13309.600711978655, 14446.061006034784, 14448.205348705711, 14512.0, 14544.563663090124, 14707.191104489355, 5539.612227144142, 5598.916016259759, 5611.186377975171, 5744.827655170351, 5768.884622307614, 985.1330828870548, 994.7910938702953, 1018.2363227579316, 1022.9028242316969, 1038.6209033702644, 23182.65226021611, 23389.298321050395, 23412.297631071095, 23525.005617837392, 23690.88154559216, 1115.2472081345059, 1123.887611238886, 1130.350048721988, 1132.4677401621225, 1143.588308209044, 12459.501619935283, 12505.187162834387, 12537.686557835945, 12551.560695375618, 12595.118341716176, 232796.0, 233655.0, 233855.0, 233998.0, 234782.0, 53452.465475345525, 53886.0, 53922.46077539253, 53958.0, 53973.460265397625, 1398.286873694423, 1453.345994302568, 1457.9489717859612, 1463.619458940683, 1467.9577499974923, 22635.20776772805, 22907.198248061904, 23042.884785575963, 23504.41238968971, 23708.288751337488, 33792.49311260382, 33872.15319617029, 34103.82948085244, 34116.829415852764, 34128.65871341255, 196599.0, 196938.0, 197481.0, 197977.0, 198135.0, 30985.845070774503, 34010.0, 34677.306453870275, 35000.64999349974, 35191.0, 43942.0, 44088.11823763571, 44207.77896110499, 44392.55607443884, 44554.55445445504, 32236.19409514781, 32696.83651581822, 32906.670933291316, 32983.83508082444, 33254.33491330208, 31951.680483194872, 32085.67914320827, 32165.517517237728, 32273.35453290874, 32508.187295317806, 36034.63965360313, 36233.27533449369, 36362.27275454529, 36721.0, 36753.816230918674, 31248.531272031392, 31277.0, 31339.843300783352, 32036.6796332043, 32652.183695406853, 23276.107654247215, 23436.0, 23510.0, 23947.52104957856, 24154.275371738877], "value": 17283.004671269482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.469398765161, 572.2503520388292, 583.3116922032001, 585.5666806563145, 602.5209958083324, 21609.891950540245, 22153.556928861413, 22513.0, 22532.549349013032, 22609.434764130903, 23212.535749285005, 23890.88054559729, 24200.515989680196, 24271.27186184413, 24625.261242162764, 6503.317151699074, 6650.401463868251, 6687.665616719169, 6711.5301928865, 6715.6977935993, 6547.77082802102, 6601.009848522712, 6605.504587155959, 6666.366695163952, 6673.699683514254, 6366.395192456709, 6606.6036037837885, 6607.5374723769355, 6641.837678406284, 6664.666766661671, 6609.603423794588, 6648.867022659568, 6651.334866513358, 6653.866922661568, 6666.966665166668, 5938.643681379088, 6164.568480206387, 6185.443310102068, 6187.752489900398, 6193.102000209944, 28327.0, 28816.711832881614, 28838.42323153546, 28862.711372886213, 28871.133865984055, 1951.092741875035, 1975.4962484566342, 1983.6429442700307, 1987.6919077543005, 1990.1044529961575, 16986.575335616708, 18913.905430472758, 19330.903345483184, 19354.129064192144, 19444.70832937507, 2398.0, 2454.981182809132, 2481.702195736523, 2497.7127630322566, 2501.9249422517355, 126038.0, 132113.0, 132195.0, 135268.0, 141062.29468852692, 14434.863782641765, 14693.632659183606, 15038.248087595795, 15089.156385795091, 15223.467178648694, 22839.543209135725, 23028.4242893929, 23037.308880733606, 23052.308430747104, 23080.307590772303, 9551.522423878778, 10221.080102790784, 10225.437600931871, 10243.48782560884, 10249.12882404989, 9283.860742088875, 9362.859557106649, 9389.62441502346, 9442.763930901783, 9455.669051583161, 8785.780355491164, 9089.409188402733, 9128.954355228181, 9226.0, 9406.71779846592, 2680.396910695078, 2688.9596656050176, 2741.231356330081, 2752.059797842516, 2841.3260186992284, 938.4369378372921, 938.7277689469977, 950.5579905344048, 957.9521023948774, 963.6145541783343, 18543.072846357627, 18605.162767675487, 18725.157367918477, 18962.81037189638, 19066.2373505061, 984.3060642247199, 1005.5575546759402, 1015.5176291261739, 1016.1718199667248, 1019.5615885169449, 10091.192704583616, 10204.846927296096, 10266.076053155102, 10391.740206494747, 10442.2168337375, 479132.0, 506841.0, 508323.0, 509457.0, 510142.0, 114312.0, 114455.42772286086, 115708.0, 118576.40711796386, 121337.0, 1122.3602546548552, 1154.318951818431, 1194.1879521925175, 1225.7732319520917, 1230.680023193976, 19439.0, 19639.70540441923, 19800.504987374854, 20098.894560799297, 20103.09536070851, 56086.03698870683, 58305.125423119534, 58851.70574147102, 60523.0, 61470.385296146465, 74008.0, 74634.62682686551, 76178.61910690411, 76368.81864024937, 78136.60931695305, 14065.789013164605, 14093.15441073539, 14154.221517816619, 14235.0, 14393.496227631982, 21664.675029874248, 21784.0, 21791.346259612237, 21800.34598962034, 22175.88912055494, 16776.916115419346, 17176.484705458857, 17860.642787144443, 17874.016929069025, 18063.458096256607, 15699.293531790869, 16232.350705971628, 16272.023678579322, 16780.748288775434, 16852.915735421244, 16685.74971375406, 17886.0, 17928.0, 18091.185896634946, 18137.81862181414, 14029.859701403264, 14094.436222550983, 14119.364628591944, 14171.149731016172, 14215.50245741394, 17273.136343183043, 17364.565885852953, 17591.208395621972, 17597.736033959758, 17619.64760704753], "value": 11864.839179858172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.3070142123254, 1337.2845527642708, 1349.9527516536923, 1352.3441131051432, 1355.315565639352, 12610.0, 13332.133411328268, 15226.619334516628, 15803.446879359224, 15877.682446351066, 15411.229438528086, 15680.059196448192, 15762.605934851634, 15857.286422111003, 15867.444639437623, 2702.189343197043, 2752.4357506711176, 2756.517609418354, 2761.282066662662, 2767.488014717284, 2667.5998600209928, 2754.3389586499197, 2758.4207316463567, 2758.5310497215523, 2759.903403380872, 2661.4277930244994, 2677.9598306025423, 2683.4901368739975, 2693.663292088489, 2699.1092939330074, 2586.586146216606, 2608.79129669626, 2644.894204231838, 2645.4973555024676, 2656.3226377273672, 2552.4001859562986, 2553.336132605536, 2577.4071963448323, 2582.1866112174603, 2587.3790290330376, 14888.106713597219, 14983.850161498354, 15058.849411505855, 15099.698006039818, 15181.089134651846, 7865.921340786576, 8106.148854370265, 8139.715109971123, 8150.144234855374, 8172.427930044899, 5430.456954304538, 5514.117741161395, 5584.246126772874, 5821.67980761058, 5838.737256823453, 1932.2657390191778, 1973.15154483572, 1984.2063174730079, 2008.9497762555907, 2042.0606521000357, 26710.86644566784, 26786.46427071467, 26794.0, 26809.329766755793, 26849.0, 7182.389496892718, 7240.818979525554, 7358.337749602561, 7440.2931721486375, 7544.773656790305, 20308.0, 20343.491412714506, 20353.08411121503, 20413.081411336527, 20461.488462788253, 8281.337493000545, 8302.70940517079, 8303.086660467343, 8326.83346333082, 8349.66601335952, 5851.941480585139, 6070.908936365958, 6232.283287421914, 6244.12582238487, 7386.298301661333, 5451.182322651554, 5641.435856414326, 5735.541156707453, 5747.913781293284, 5748.223989761413, 1726.3181043487753, 1749.7200447928526, 1782.4741701198177, 1789.9821001790076, 1824.9469346984642, 896.4621227263721, 915.4919019943862, 916.7204002779083, 920.8066306075799, 930.4882314726873, 8092.514449133071, 8450.577471126418, 8557.871631925525, 8567.571621418903, 8622.180892815173, 701.7964790210782, 714.6248219684708, 717.4726575966661, 722.173111787001, 728.4864170759602, 4480.350349199348, 4517.774111294422, 4568.954310456919, 4678.555537223959, 4689.953100468952, 20750.169993200405, 22491.0, 22685.88657056737, 22735.317940461813, 22772.772272277067, 20723.585528289652, 21595.2441664541, 22029.339119826433, 22133.225337113447, 22257.220997265344, 11428.0, 11727.237729547553, 11731.648050558497, 11763.353015584225, 11765.294082355085, 8528.786780330542, 8554.57227138653, 8583.656653734031, 8729.345299102466, 8800.427972181787, 18198.72701909499, 18928.810711892704, 19256.518587035436, 19265.13306901221, 19732.50668733293, 19202.327918522784, 19378.749738824587, 19760.0, 20108.39674809758, 20174.69737953961, 12413.193142445713, 12418.192817466836, 12497.312647804458, 12526.561570344995, 12552.435140418886, 14097.154170749787, 14258.786118208443, 14315.0, 14341.0, 14362.712745744817, 11047.502862371051, 11231.943840280746, 11342.829857552308, 11354.602588909349, 11484.0, 11183.776324473301, 11309.434528273718, 11457.140714446283, 11466.827997579876, 11513.309201447604, 9938.850917236392, 10171.694849154537, 10246.129079028366, 10318.43248621303, 10340.482975851028, 7129.572225666477, 7236.891446628199, 7257.237990011184, 7263.709451621876, 7318.926810732038, 7386.372158366599, 7495.812604684927, 7572.0, 7600.125985511516, 7662.961685191538], "value": 6753.440327915924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.6632315845049, 499.1886943188755, 521.3639359980824, 521.5540712690647, 527.29605976022, 6074.939250607493, 6102.511799056076, 6120.47975922046, 6164.784232551861, 6263.624182549051, 6002.369751176129, 6115.235595550545, 6142.447179753821, 6146.262448506174, 6181.549284515142, 5080.923786143211, 5115.13042782726, 5148.845534633958, 5174.732190613305, 5185.948140518584, 5122.846314610549, 5149.253358263049, 5149.485051494839, 5153.330067091273, 5161.483851614846, 4693.741844198567, 4894.804207831682, 4902.6027582139095, 4909.877253068684, 4962.87592810179, 4886.902261954759, 4908.7300198489065, 4928.926066108976, 4962.305277261186, 4969.180085285923, 4400.9559904401185, 4406.933895991563, 4412.271975124101, 4431.91418102567, 4445.644348452149, 5918.763249470016, 5957.612755170943, 5965.850853728648, 5977.402259774031, 5992.880142397127, 5605.467480589378, 5628.943710562883, 5644.745986430579, 5662.971685141548, 5690.345610254791, 6388.64862432566, 6419.775307864249, 6426.935730642727, 6510.511711621647, 6526.445252153572, 4581.839635612738, 4768.094062128184, 4795.448523419782, 4800.423949126127, 4832.009438065188, 6520.11978382917, 6549.377809108127, 6626.469882409492, 6628.834279143011, 6675.699593518303, 4932.580730637864, 4952.752362381866, 4961.131801934647, 4974.179260422062, 4986.975065124651, 4928.728919909439, 4987.950120498748, 5001.549860512571, 5011.523905228997, 5052.090623687772, 5603.411641777555, 5622.381538030813, 5631.521320687705, 5639.154126881001, 5667.376588575254, 6450.6774661266745, 6453.774117905851, 6499.610023398611, 6516.283208847023, 6517.869642607121, 1726.9481915542553, 1729.8097209306966, 1737.54823745827, 1752.6845167869906, 1754.631527379239, 1047.601911273711, 1200.5317926008863, 1216.7809794237123, 1244.3031902134833, 1245.6325384011739, 5505.256790333334, 5542.224088627595, 5568.192612071308, 5575.0, 5645.887082258332, 6426.35736426363, 6483.286838447767, 6488.442773734269, 6488.86444872155, 6517.576357536745, 5610.699613158586, 5651.9826431241945, 5657.886842263131, 5660.377358490563, 5661.320641523043, 3437.8796742113905, 3460.3598334308235, 3473.3053389322235, 3480.4257297545623, 3510.227749895019, 6244.406781355764, 6313.305536390993, 6320.525960552977, 6338.30278669346, 6380.7128679209545, 6670.266270710218, 6680.532362734659, 6709.463242940651, 6714.0, 6755.662216889136, 6285.402886725754, 6364.64994425311, 6376.649284289316, 6389.712462939179, 6395.968020159869, 5991.7902873399225, 6389.55273130895, 6530.8367290818105, 6604.400601672004, 6614.90077648826, 6243.344448832807, 6327.936720632735, 6381.202349706286, 6404.583702059351, 6427.0, 6257.996161842432, 6367.586106903036, 6369.522285828489, 6436.16329877113, 6459.386358295955, 4884.9511504884495, 4929.605631549396, 4936.086823937583, 4946.901061978812, 5007.874803129951, 6286.811395658137, 6354.459870911024, 6430.421262086435, 6602.966985165043, 6659.900101498578, 6222.937770622417, 6285.528585356025, 6339.524535659936, 6399.872002560016, 6416.0, 6348.301686814354, 6407.430179606026, 6434.002729576923, 6460.321666224979, 6472.35276472349, 6278.277998030285, 6314.305426403183, 6316.936830631635, 6321.778737744341, 6324.778632747832, 6449.419552240321, 6453.064305675744, 6507.0, 6512.674366281762, 6522.739090436329, 6162.630242185483, 6252.0, 6266.717997690206, 6295.716692748746, 6319.842003949938], "value": 4967.7906724299155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.5533005832056, 893.6425429828068, 906.9682561110362, 916.2166347772652, 917.522888098189, 19212.71180932287, 19923.501912452197, 20050.097745601448, 20090.497737556532, 20184.798152018477, 17380.913095434506, 17525.298988040497, 17598.0, 17613.11934403278, 17989.910050449762, 920.6087412849546, 950.239808153478, 950.4819873169139, 955.4983633592385, 955.8040601676639, 945.4043952310069, 948.5020364308758, 948.5020364308758, 951.2295041016764, 951.4814426137737, 992.3648864726581, 999.5252255178805, 1015.9187265018818, 1016.5323950982557, 1022.371241686365, 982.5382070426924, 983.1692220074061, 984.17329443268, 992.354969269973, 1002.0230275481457, 729.1942403644003, 730.2040775554618, 730.5434103685196, 731.1701219116288, 731.9231480694557, 19886.70169947452, 20014.099365528586, 20389.08249128793, 20465.2837150699, 20502.487437814023, 21060.473488162766, 21690.89154554217, 21810.454738631503, 21929.342119736433, 22007.11971521153, 17097.40159094438, 17206.139693015426, 17218.225179866935, 17242.56893577658, 17319.653606927917, 3771.4719939208535, 3790.090378309186, 3793.3740932746064, 3803.866864659751, 3807.3717836556934, 97687.51156244174, 106810.0, 125124.0, 138452.0, 139035.0, 12965.546205882749, 13168.868311316955, 13230.4046317914, 13421.39603717835, 13555.728885422237, 29493.26266843346, 29499.55750663742, 29621.851890740407, 29877.402451951275, 29903.401931961238, 9221.769455763526, 9418.717438476857, 9514.571844267024, 9590.952045239728, 9667.081627245401, 4348.195583817004, 4363.38912552243, 4384.780760962003, 4387.517373088957, 4388.341748737651, 5410.431904649955, 5429.56563474921, 5603.299587551556, 5613.943860561424, 5622.550195984311, 1078.3637653784306, 1080.994674952302, 1094.2449709700281, 1095.0910744082391, 1095.1457862866816, 593.2910172344094, 622.1973653986397, 631.1637080867777, 635.7615894039735, 636.2428709835374, 10675.893241067646, 10902.236843420884, 10954.890451095547, 10992.230543861853, 11684.70788230301, 628.2461046743925, 633.8098570428945, 638.2596188421409, 644.9064885591563, 645.880512105262, 5234.345706786652, 5240.187770895517, 5293.523582877559, 5357.866053348697, 5389.110796718576, 121955.0, 122600.38699806444, 123409.0, 124240.0, 124558.37720811338, 107707.0, 109754.45122774335, 110057.0, 111531.0, 115074.0, 93035.53482232546, 94314.0, 95340.52329738307, 95643.52178239064, 97008.02991970131, 9839.655612053544, 9869.753256168653, 9875.703728888146, 9899.95050024774, 10180.389176649425, 45506.08987820159, 45651.31523027224, 46327.53672463232, 46436.53563464322, 46539.76730116328, 55900.0, 56049.71975140098, 56594.0, 56943.430565693816, 56964.43035569591, 14633.0, 15405.614859628598, 15407.0, 15548.222588870738, 15682.451114210948, 15716.92141539285, 16067.357305707641, 16119.355225790838, 16161.515154545383, 16293.837061629707, 13122.081454298108, 13185.868141318848, 13252.337383130998, 13329.800052999019, 13395.531156409479, 14735.92632036833, 14985.475508357154, 15010.949233553547, 15059.322330494935, 15379.84620153784, 14974.925125374739, 15099.47151849724, 15150.924245379143, 15234.695306094038, 15310.31103600363, 10339.741506462398, 10399.896001039893, 10471.94764026175, 10769.676909692722, 10914.727131821768, 10606.893931060591, 10761.192910531585, 10776.906059137871, 10895.891041089488, 11126.443677815914], "value": 8621.673459651978, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 108.0, 109.0, 114.0, 108.0, 111.0, 107.0, 116.0, 108.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 120.0, 121.0, 117.0, 125.0, 118.0, 119.0, 137.0, 123.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 168.0, 172.0, 175.0, 174.0, 162.0, 162.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 75.0, 79.0, 75.0, 75.0, 87.0, 75.0, 75.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 80.0, 80.0, 79.0, 82.0, 79.0, 84.0, 89.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 115.0, 115.0, 117.0, 114.0, 111.0, 114.0, 114.0, 117.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 150.0, 151.0, 147.0, 151.0, 151.0, 148.0, 149.0, 156.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 101.0, 94.0, 103.0, 100.0, 94.0, 94.0, 101.0, 95.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 54.0, 54.0, 55.0, 53.0, 53.0, 55.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 38.0, 38.0, 39.0, 45.0, 52.0, 38.0, 39.0, 39.0, 38.0], "value": 41.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 74.0, 74.0, 76.0, 77.0, 72.0, 74.0, 73.0, 82.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 119.0, 121.0, 115.0, 113.0, 118.0, 115.0, 120.0, 114.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 171.0, 171.0, 163.0, 178.0, 166.0, 171.0, 172.0, 173.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 64.0, 73.0, 65.0, 64.0, 67.0, 69.0, 64.0], "value": 65.9, "unit": "score"}]}]} 21:56:00 INFO - Return code: 0 21:56:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:56:00 INFO - # TBPL SUCCESS # 21:56:00 INFO - Running post-action listener: _package_coverage_data 21:56:00 INFO - Running post-action listener: _resource_record_post_action 21:56:00 INFO - [mozharness: 2017-09-22 04:56:00.938305Z] Finished run-tests step (success) 21:56:00 INFO - Running post-run listener: _resource_record_post_run 21:56:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 6901760; Write bytes: 340156416; Read time: 1588; Write time: 234772 21:56:01 INFO - TinderboxPrint: CPU usage
13.3% 21:56:01 INFO - TinderboxPrint: I/O read bytes / time
6,901,760 / 1,588 21:56:01 INFO - TinderboxPrint: I/O write bytes / time
340,156,416 / 234,772 21:56:01 INFO - TinderboxPrint: CPU idle
8,257.3 (86.7%) 21:56:01 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 21:56:01 INFO - TinderboxPrint: Swap in / out
0 / 0 21:56:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9641984; Read time: 0; Write time: 656 21:56:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:56:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6897664; Write bytes: 329392128; Read time: 1580; Write time: 234084 21:56:01 INFO - Running post-run listener: _upload_blobber_files 21:56:01 INFO - Blob upload gear active. 21:56:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:56:01 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 21:56:01 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'] 21:56:01 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 21:56:02 INFO - (blobuploader) - INFO - Open directory for files ... 21:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:03 INFO - (blobuploader) - INFO - Done attempting. 21:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:04 INFO - (blobuploader) - INFO - Done attempting. 21:56:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:56:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:11 INFO - (blobuploader) - INFO - Done attempting. 21:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:12 INFO - (blobuploader) - INFO - Done attempting. 21:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 21:56:12 INFO - Return code: 0 21:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34feae79766f7d49430cf578da5706157f7416a79f57a025cf9c51295522af2c23359dfb7718108504e7d9b54cf519372cdd8f1c07189ca4e716a78293dff042", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce7b27768ff5e93d9482beb1fa1712ee5301d50e7d6f5aca8d58e5c4524e9d43a099fc2277a753642c213baf04966c3dfd137c051d2755b777daa12fee59e081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5e844bb29a73c5171f5bf2d2bc0a9b57474a0a01cb1d5184bb8b46209a51bcb7535c3195325ed4b3c7578680e0b9b8c19dd7dd72931359cff4ee4c785b5232", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e305d363f19c5ea87bdcbf8fd29aff990c3f0ff79a7574e606fb61f9685002056c06b9fe130fcea018de6f4f5dfd1e55c4cf0c3a7eb20eec936d84965ef55c"} 21:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:56:12 INFO - Contents: 21:56:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34feae79766f7d49430cf578da5706157f7416a79f57a025cf9c51295522af2c23359dfb7718108504e7d9b54cf519372cdd8f1c07189ca4e716a78293dff042", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce7b27768ff5e93d9482beb1fa1712ee5301d50e7d6f5aca8d58e5c4524e9d43a099fc2277a753642c213baf04966c3dfd137c051d2755b777daa12fee59e081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5e844bb29a73c5171f5bf2d2bc0a9b57474a0a01cb1d5184bb8b46209a51bcb7535c3195325ed4b3c7578680e0b9b8c19dd7dd72931359cff4ee4c785b5232", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e305d363f19c5ea87bdcbf8fd29aff990c3f0ff79a7574e606fb61f9685002056c06b9fe130fcea018de6f4f5dfd1e55c4cf0c3a7eb20eec936d84965ef55c"} 21:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 21:56:12 INFO - Copying logs to upload dir... 21:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 21:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.039087 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-21 21:56:12.323804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 21:56:12.328334) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34feae79766f7d49430cf578da5706157f7416a79f57a025cf9c51295522af2c23359dfb7718108504e7d9b54cf519372cdd8f1c07189ca4e716a78293dff042", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce7b27768ff5e93d9482beb1fa1712ee5301d50e7d6f5aca8d58e5c4524e9d43a099fc2277a753642c213baf04966c3dfd137c051d2755b777daa12fee59e081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5e844bb29a73c5171f5bf2d2bc0a9b57474a0a01cb1d5184bb8b46209a51bcb7535c3195325ed4b3c7578680e0b9b8c19dd7dd72931359cff4ee4c785b5232", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e305d363f19c5ea87bdcbf8fd29aff990c3f0ff79a7574e606fb61f9685002056c06b9fe130fcea018de6f4f5dfd1e55c4cf0c3a7eb20eec936d84965ef55c"} build_url:https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34feae79766f7d49430cf578da5706157f7416a79f57a025cf9c51295522af2c23359dfb7718108504e7d9b54cf519372cdd8f1c07189ca4e716a78293dff042", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce7b27768ff5e93d9482beb1fa1712ee5301d50e7d6f5aca8d58e5c4524e9d43a099fc2277a753642c213baf04966c3dfd137c051d2755b777daa12fee59e081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5e844bb29a73c5171f5bf2d2bc0a9b57474a0a01cb1d5184bb8b46209a51bcb7535c3195325ed4b3c7578680e0b9b8c19dd7dd72931359cff4ee4c785b5232", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e305d363f19c5ea87bdcbf8fd29aff990c3f0ff79a7574e606fb61f9685002056c06b9fe130fcea018de6f4f5dfd1e55c4cf0c3a7eb20eec936d84965ef55c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 21:56:12.363202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:56:12.363574) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506053698.529099-1926554752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:56:12.446452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 21:56:12.446787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 21:56:12.447140) ========= ========= Total master_lag: 0.25 =========