builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1506681805.64 results: success (0) revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.635922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.636394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.636663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.701874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.702130) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 03:43:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-09-29 03:43:25 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131752 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.864262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.864554) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018899 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.944841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-09-29 03:43:25.945168) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946b9c995ec331f4f96360409fd8d2fc49e46838 --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 946b9c995ec331f4f96360409fd8d2fc49e46838 --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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 03:43:26,040 truncating revision to first 12 chars 2017-09-29 03:43:26,040 Setting DEBUG logging. 2017-09-29 03:43:26,040 attempt 1/10 2017-09-29 03:43:26,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946b9c995ec3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 03:43:27,885 unpacking tar archive at: mozilla-central-946b9c995ec3/testing/mozharness/ program finished with exit code 0 elapsedTime=3.441084 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-09-29 03:43:29.413667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:29.417011) ========= script_repo_revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:29.417406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:29.417663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:29.434389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 03:43:29.434783) ========= /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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:29 INFO - MultiFileLogger online at 20170929 03:43:29 in /builds/slave/test 03:43:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:43:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:29 INFO - {'append_to_log': False, 03:43:29 INFO - 'base_work_dir': '/builds/slave/test', 03:43:29 INFO - 'blob_upload_branch': 'Firefox', 03:43:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:29 INFO - 'branch': 'Firefox', 03:43:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:29 INFO - 'code_coverage': False, 03:43:29 INFO - 'config_files': ('talos/linux_config.py',), 03:43:29 INFO - 'default_actions': ('clobber', 03:43:29 INFO - 'read-buildbot-config', 03:43:29 INFO - 'download-and-extract', 03:43:29 INFO - 'populate-webroot', 03:43:29 INFO - 'create-virtualenv', 03:43:29 INFO - 'install', 03:43:29 INFO - 'setup-mitmproxy', 03:43:29 INFO - 'run-tests'), 03:43:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:29 INFO - 'disable_ccov_upload': False, 03:43:29 INFO - 'disable_stylo': False, 03:43:29 INFO - 'download_minidump_stackwalk': True, 03:43:29 INFO - 'download_symbols': 'ondemand', 03:43:29 INFO - 'enable_stylo': False, 03:43:29 INFO - 'enable_webrender': False, 03:43:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:43:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:29 INFO - 'gecko_profile': False, 03:43:29 INFO - 'gecko_profile_interval': 0, 03:43:29 INFO - 'installer_path': 'installer.exe', 03:43:29 INFO - 'log_level': 'info', 03:43:29 INFO - 'log_name': 'talos', 03:43:29 INFO - 'log_to_console': True, 03:43:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:29 INFO - 'opt_config_files': (), 03:43:29 INFO - 'pip_index': False, 03:43:29 INFO - 'suite': 'dromaeojs-e10s', 03:43:29 INFO - 'system_bits': '32', 03:43:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:29 INFO - 'title': 'talos-linux64-ix-023', 03:43:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:29 INFO - 'use_talos_json': True, 03:43:29 INFO - 'verify': 'False', 03:43:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:29 INFO - 'work_dir': 'build'} 03:43:29 INFO - [mozharness: 2017-09-29 10:43:29.658501Z] Running clobber step. 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: clobber 03:43:29 INFO - rmtree: /builds/slave/test/build 03:43:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:30 INFO - Running post-action listener: _resource_record_post_action 03:43:30 INFO - [mozharness: 2017-09-29 10:43:30.794501Z] Finished clobber step (success) 03:43:30 INFO - [mozharness: 2017-09-29 10:43:30.794598Z] Running read-buildbot-config step. 03:43:30 INFO - Running pre-action listener: _resource_record_pre_action 03:43:30 INFO - Running main action method: read_buildbot_config 03:43:30 INFO - Using buildbot properties: 03:43:30 INFO - { 03:43:30 INFO - "project": "", 03:43:30 INFO - "product": "firefox", 03:43:30 INFO - "who": "archaeopteryx@coole-files.de", 03:43:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:43:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:43:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:43:30 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:43:30 INFO - "stage_platform": "linux64-qr", 03:43:30 INFO - "basedir": "/builds/slave/test", 03:43:30 INFO - "buildnumber": 107, 03:43:30 INFO - "platform": "ubuntu64_hw_qr", 03:43:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:43:30 INFO - "slavebuilddir": "test", 03:43:30 INFO - "taskId": "PPLIhVdvTp2hkJWRxnzVYQ", 03:43:30 INFO - "branch": "mozilla-central", 03:43:30 INFO - "script_repo_revision": "production", 03:43:30 INFO - "revision": "946b9c995ec331f4f96360409fd8d2fc49e46838", 03:43:30 INFO - "slavename": "talos-linux64-ix-023", 03:43:30 INFO - "repo_path": "mozilla-central" 03:43:30 INFO - } 03:43:30 INFO - Finding installer, test and symbols from parent task. 03:43:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPLIhVdvTp2hkJWRxnzVYQ'}, attempt #1 03:43:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPLIhVdvTp2hkJWRxnzVYQ'}, attempt #1 03:43:31 INFO - Task dependencies: ewqrVSCKSgOWNQzmAaDlXw 03:43:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw'}, attempt #1 03:43:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json 03:43:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip 03:43:32 INFO - Running post-action listener: _resource_record_post_action 03:43:32 INFO - [mozharness: 2017-09-29 10:43:32.211332Z] Finished read-buildbot-config step (success) 03:43:32 INFO - [mozharness: 2017-09-29 10:43:32.211547Z] Running download-and-extract step. 03:43:32 INFO - Running pre-action listener: _resource_record_pre_action 03:43:32 INFO - Running main action method: download_and_extract 03:43:32 INFO - mkdir: /builds/slave/test/build/tests 03:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:32 INFO - trying https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json 03:43:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:43:32 INFO - Downloaded 989 bytes. 03:43:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:43:32 INFO - Using the following test package requirements: 03:43:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:43:32 INFO - u'common': [u'target.common.tests.zip'], 03:43:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:43:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:43:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:43:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:43:32 INFO - u'mozbase': [u'target.common.tests.zip'], 03:43:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:43:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:43:32 INFO - u'web-platform': [u'target.common.tests.zip', 03:43:32 INFO - u'target.web-platform.tests.tar.gz'], 03:43:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:43:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:43:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip 03:43:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:43:32 INFO - Fetch https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip into memory 03:43:33 INFO - Content-Length response header: 55366227 03:43:33 INFO - Bytes received: 55366227 03:43:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip 03:43:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:43:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip into memory 03:43:45 INFO - Content-Length response header: 14521355 03:43:45 INFO - Bytes received: 14521355 03:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:45 INFO - trying https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:43:46 INFO - Downloaded 61628365 bytes. 03:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:46 INFO - mkdir: /builds/slave/test/properties 03:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:46 INFO - Contents: 03:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:46 INFO - Running post-action listener: _resource_record_post_action 03:43:46 INFO - Running post-action listener: find_tests_for_verification 03:43:46 INFO - Running post-action listener: set_extra_try_arguments 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.865153Z] Finished download-and-extract step (success) 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.865265Z] Running populate-webroot step. 03:43:46 INFO - Running pre-action listener: _resource_record_pre_action 03:43:46 INFO - Running main action method: populate_webroot 03:43:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['tresize', 03:43:47 INFO - 'tcanvasmark']}, 03:43:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['dromaeo_css', 03:43:47 INFO - 'kraken']}, 03:43:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'tests': ['damp', 'tps']}, 03:43:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['damp', 'tps']}, 03:43:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['dromaeo_dom']}, 03:43:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:43:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['basic_compositor_video', 03:43:47 INFO - 'glvideo']}, 03:43:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:43:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['ts_paint_webext', 03:43:47 INFO - 'tp5o_webext']}, 03:43:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:47 INFO - 'ts_paint', 03:43:47 INFO - 'tpaint', 03:43:47 INFO - 'sessionrestore', 03:43:47 INFO - 'sessionrestore_many_windows', 03:43:47 INFO - 'sessionrestore_no_auto_restore', 03:43:47 INFO - 'tabpaint', 03:43:47 INFO - 'cpstartup']}, 03:43:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['a11yr', 03:43:47 INFO - 'ts_paint', 03:43:47 INFO - 'tpaint', 03:43:47 INFO - 'sessionrestore', 03:43:47 INFO - 'sessionrestore_many_windows', 03:43:47 INFO - 'sessionrestore_no_auto_restore', 03:43:47 INFO - 'tabpaint', 03:43:47 INFO - 'cpstartup']}, 03:43:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:43:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:43:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['perf_reftest_singletons']}, 03:43:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['perf_reftest']}, 03:43:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:47 INFO - 'tsvgr_opacity', 03:43:47 INFO - 'tart', 03:43:47 INFO - 'tscrollx', 03:43:47 INFO - 'tsvg_static']}, 03:43:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['tsvgx', 03:43:47 INFO - 'tsvgr_opacity', 03:43:47 INFO - 'tart', 03:43:47 INFO - 'tscrollx', 03:43:47 INFO - 'tsvg_static']}, 03:43:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:43:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--disable-stylo'], 03:43:47 INFO - 'tests': ['tp5o']}, 03:43:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:47 INFO - 'talos_options': ['--mitmproxy', 03:43:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:47 INFO - '--firstNonBlankPaint'], 03:43:47 INFO - 'tests': ['tp6_google', 03:43:47 INFO - 'tp6_youtube', 03:43:47 INFO - 'tp6_amazon', 03:43:47 INFO - 'tp6_facebook']}, 03:43:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:47 INFO - 'talos_options': ['--disable-stylo', 03:43:47 INFO - '--mitmproxy', 03:43:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:47 INFO - '--firstNonBlankPaint'], 03:43:47 INFO - 'tests': ['tp6_google', 03:43:47 INFO - 'tp6_youtube', 03:43:47 INFO - 'tp6_amazon', 03:43:47 INFO - 'tp6_facebook']}, 03:43:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:47 INFO - 'talos_options': ['--stylo-threads=1', 03:43:47 INFO - '--mitmproxy', 03:43:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:47 INFO - '--firstNonBlankPaint'], 03:43:47 INFO - 'tests': ['tp6_google', 03:43:47 INFO - 'tp6_youtube', 03:43:47 INFO - 'tp6_amazon', 03:43:47 INFO - 'tp6_facebook']}, 03:43:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--xperf_path', 03:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:47 INFO - 'tests': ['tp5n']}, 03:43:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:47 INFO - 'talos_options': ['--disable-stylo', 03:43:47 INFO - '--xperf_path', 03:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:47 INFO - 'tests': ['tp5n']}}} 03:43:47 INFO - Running post-action listener: _resource_record_post_action 03:43:47 INFO - [mozharness: 2017-09-29 10:43:47.226270Z] Finished populate-webroot step (success) 03:43:47 INFO - [mozharness: 2017-09-29 10:43:47.226367Z] Running create-virtualenv step. 03:43:47 INFO - Running pre-action listener: _resource_record_pre_action 03:43:47 INFO - Running main action method: create_virtualenv 03:43:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:43:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:43:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:48 INFO - Installing pip...............done. 03:43:48 INFO - Return code: 0 03:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:43:48 INFO - Reading from file tmpfile_stdout 03:43:48 INFO - Output received: 03:43:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:43:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:43:48 INFO - Using env: {'DISPLAY': ':0', 03:43:48 INFO - 'HOME': '/home/cltbld', 03:43:48 INFO - 'LANG': 'en_US.UTF-8', 03:43:48 INFO - 'LANGUAGE': 'en_US:en', 03:43:48 INFO - 'LOGNAME': 'cltbld', 03:43:48 INFO - 'MAIL': '/var/mail/cltbld', 03:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:48 INFO - 'MOZ_NO_REMOTE': '1', 03:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:48 INFO - 'NO_EM_RESTART': '1', 03:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:48 INFO - 'PWD': '/builds/slave/test', 03:43:48 INFO - 'SHELL': '/bin/bash', 03:43:48 INFO - 'SHLVL': '1', 03:43:48 INFO - 'TERM': 'linux', 03:43:48 INFO - 'TMOUT': '86400', 03:43:48 INFO - 'USER': 'cltbld', 03:43:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:48 INFO - '_': '/tools/buildbot/bin/python'} 03:43:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:43:49 INFO - Downloading/unpacking pip>=1.5 03:43:49 INFO - Running setup.py egg_info for package pip 03:43:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:43:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:43:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:43:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:43:49 INFO - Installing collected packages: pip 03:43:49 INFO - Found existing installation: pip 1.1 03:43:49 INFO - Uninstalling pip: 03:43:49 INFO - Successfully uninstalled pip 03:43:49 INFO - Running setup.py install for pip 03:43:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:43:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:43:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:43:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:43:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:43:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:43:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:43:49 INFO - Successfully installed pip 03:43:49 INFO - Cleaning up... 03:43:49 INFO - Return code: 0 03:43:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43: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')]} 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43: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', '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 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:43: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 psutil>=3.1.1 03:43:49 INFO - Using env: {'DISPLAY': ':0', 03:43:49 INFO - 'HOME': '/home/cltbld', 03:43:49 INFO - 'LANG': 'en_US.UTF-8', 03:43:49 INFO - 'LANGUAGE': 'en_US:en', 03:43:49 INFO - 'LOGNAME': 'cltbld', 03:43:49 INFO - 'MAIL': '/var/mail/cltbld', 03:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:49 INFO - 'MOZ_NO_REMOTE': '1', 03:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:49 INFO - 'NO_EM_RESTART': '1', 03:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:49 INFO - 'PWD': '/builds/slave/test', 03:43:49 INFO - 'SHELL': '/bin/bash', 03:43:49 INFO - 'SHLVL': '1', 03:43:49 INFO - 'TERM': 'linux', 03:43:49 INFO - 'TMOUT': '86400', 03:43:49 INFO - 'USER': 'cltbld', 03:43:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:49 INFO - '_': '/tools/buildbot/bin/python'} 03:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:49 INFO - Downloading/unpacking psutil>=3.1.1 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:50 INFO - Installing collected packages: psutil 03:43:50 INFO - Running setup.py install for psutil 03:43:50 INFO - building 'psutil._psutil_linux' extension 03:43:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:43:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:43:51 INFO - building 'psutil._psutil_posix' extension 03:43:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:43:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:43:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:51 INFO - Successfully installed psutil 03:43:51 INFO - Cleaning up... 03:43:51 INFO - Return code: 0 03:43:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:43:51 INFO - Using env: {'DISPLAY': ':0', 03:43:51 INFO - 'HOME': '/home/cltbld', 03:43:51 INFO - 'LANG': 'en_US.UTF-8', 03:43:51 INFO - 'LANGUAGE': 'en_US:en', 03:43:51 INFO - 'LOGNAME': 'cltbld', 03:43:51 INFO - 'MAIL': '/var/mail/cltbld', 03:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:51 INFO - 'MOZ_NO_REMOTE': '1', 03:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:51 INFO - 'NO_EM_RESTART': '1', 03:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:51 INFO - 'PWD': '/builds/slave/test', 03:43:51 INFO - 'SHELL': '/bin/bash', 03:43:51 INFO - 'SHLVL': '1', 03:43:51 INFO - 'TERM': 'linux', 03:43:51 INFO - 'TMOUT': '86400', 03:43:51 INFO - 'USER': 'cltbld', 03:43:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:51 INFO - '_': '/tools/buildbot/bin/python'} 03:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:52 INFO - Installing collected packages: mozsystemmonitor 03:43:52 INFO - Running setup.py install for mozsystemmonitor 03:43:53 INFO - Successfully installed mozsystemmonitor 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:43:53 INFO - Using env: {'DISPLAY': ':0', 03:43:53 INFO - 'HOME': '/home/cltbld', 03:43:53 INFO - 'LANG': 'en_US.UTF-8', 03:43:53 INFO - 'LANGUAGE': 'en_US:en', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MAIL': '/var/mail/cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SHLVL': '1', 03:43:53 INFO - 'TERM': 'linux', 03:43:53 INFO - 'TMOUT': '86400', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - '_': '/tools/buildbot/bin/python'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:55 INFO - warning: no files found matching '*.txt' 03:43:55 INFO - no previously-included directories found matching 'build' 03:43:55 INFO - no previously-included directories found matching 'dist' 03:43:55 INFO - no previously-included directories found matching '.git*' 03:43:55 INFO - Installing collected packages: jsonschema, functools32 03:43:55 INFO - Running setup.py install for functools32 03:43:55 INFO - warning: no files found matching '*.txt' 03:43:55 INFO - no previously-included directories found matching 'build' 03:43:55 INFO - no previously-included directories found matching 'dist' 03:43:55 INFO - no previously-included directories found matching '.git*' 03:43:55 INFO - Successfully installed jsonschema functools32 03:43:55 INFO - Cleaning up... 03:43:55 INFO - Return code: 0 03:43:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:43:55 INFO - Using env: {'DISPLAY': ':0', 03:43:55 INFO - 'HOME': '/home/cltbld', 03:43:55 INFO - 'LANG': 'en_US.UTF-8', 03:43:55 INFO - 'LANGUAGE': 'en_US:en', 03:43:55 INFO - 'LOGNAME': 'cltbld', 03:43:55 INFO - 'MAIL': '/var/mail/cltbld', 03:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:55 INFO - 'MOZ_NO_REMOTE': '1', 03:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:55 INFO - 'NO_EM_RESTART': '1', 03:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:55 INFO - 'PWD': '/builds/slave/test', 03:43:55 INFO - 'SHELL': '/bin/bash', 03:43:55 INFO - 'SHLVL': '1', 03:43:55 INFO - 'TERM': 'linux', 03:43:55 INFO - 'TMOUT': '86400', 03:43:55 INFO - 'USER': 'cltbld', 03:43:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:55 INFO - '_': '/tools/buildbot/bin/python'} 03:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:43:55 INFO - Cleaning up... 03:43:55 INFO - Return code: 0 03:43:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:43:55 INFO - Using env: {'DISPLAY': ':0', 03:43:55 INFO - 'HOME': '/home/cltbld', 03:43:55 INFO - 'LANG': 'en_US.UTF-8', 03:43:55 INFO - 'LANGUAGE': 'en_US:en', 03:43:55 INFO - 'LOGNAME': 'cltbld', 03:43:55 INFO - 'MAIL': '/var/mail/cltbld', 03:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:55 INFO - 'MOZ_NO_REMOTE': '1', 03:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:55 INFO - 'NO_EM_RESTART': '1', 03:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:55 INFO - 'PWD': '/builds/slave/test', 03:43:55 INFO - 'SHELL': '/bin/bash', 03:43:55 INFO - 'SHLVL': '1', 03:43:55 INFO - 'TERM': 'linux', 03:43:55 INFO - 'TMOUT': '86400', 03:43:55 INFO - 'USER': 'cltbld', 03:43:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:55 INFO - '_': '/tools/buildbot/bin/python'} 03:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:57 INFO - Downloading docopt-0.6.1.tar.gz 03:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:57 INFO - Running setup.py install for blobuploader 03:43:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:57 INFO - Running setup.py install for requests 03:43:58 INFO - Running setup.py install for docopt 03:43:58 INFO - Successfully installed blobuploader requests docopt 03:43:58 INFO - Cleaning up... 03:43:58 INFO - Return code: 0 03:43:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:58 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 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:58 INFO - Using env: {'DISPLAY': ':0', 03:43:58 INFO - 'HOME': '/home/cltbld', 03:43:58 INFO - 'LANG': 'en_US.UTF-8', 03:43:58 INFO - 'LANGUAGE': 'en_US:en', 03:43:58 INFO - 'LOGNAME': 'cltbld', 03:43:58 INFO - 'MAIL': '/var/mail/cltbld', 03:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:58 INFO - 'MOZ_NO_REMOTE': '1', 03:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:58 INFO - 'NO_EM_RESTART': '1', 03:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:58 INFO - 'PWD': '/builds/slave/test', 03:43:58 INFO - 'SHELL': '/bin/bash', 03:43:58 INFO - 'SHLVL': '1', 03:43:58 INFO - 'TERM': 'linux', 03:43:58 INFO - 'TMOUT': '86400', 03:43:58 INFO - 'USER': 'cltbld', 03:43:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:58 INFO - '_': '/tools/buildbot/bin/python'} 03:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:58 INFO - Running setup.py (path:/tmp/pip-PiJscN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:58 INFO - Running setup.py (path:/tmp/pip-Wp93lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:58 INFO - Running setup.py (path:/tmp/pip-HI5kKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:58 INFO - Running setup.py (path:/tmp/pip-vfI9b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:58 INFO - Running setup.py (path:/tmp/pip-5yhefl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:58 INFO - Running setup.py (path:/tmp/pip-Blaqcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:58 INFO - Running setup.py (path:/tmp/pip-xCpfiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:58 INFO - Running setup.py (path:/tmp/pip-BXJK10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:59 INFO - Running setup.py (path:/tmp/pip-__tBEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:59 INFO - Running setup.py (path:/tmp/pip-hBLs12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:59 INFO - Running setup.py (path:/tmp/pip-K8aLJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:59 INFO - Running setup.py (path:/tmp/pip-14p8zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:59 INFO - Running setup.py (path:/tmp/pip-Or28CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:59 INFO - Running setup.py (path:/tmp/pip-uKP0Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:59 INFO - Running setup.py (path:/tmp/pip-fMYS4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:59 INFO - Running setup.py (path:/tmp/pip-Z4bSTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:59 INFO - Running setup.py (path:/tmp/pip-fYDlYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:59 INFO - Running setup.py install for manifestparser 03:43:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:59 INFO - Running setup.py install for mozcrash 03:43:59 INFO - Running setup.py install for mozdebug 03:43:59 INFO - Running setup.py install for mozdevice 03:44:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozfile 03:44:00 INFO - Running setup.py install for mozhttpd 03:44:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozinfo 03:44:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozInstall 03:44:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozleak 03:44:00 INFO - Running setup.py install for mozlog 03:44:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for moznetwork 03:44:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozprocess 03:44:00 INFO - Running setup.py install for mozprofile 03:44:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozrunner 03:44:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozscreenshot 03:44:01 INFO - Running setup.py install for moztest 03:44:01 INFO - Running setup.py install for mozversion 03:44:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:01 INFO - Cleaning up... 03:44:01 INFO - Return code: 0 03:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:01 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 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:01 INFO - Using env: {'DISPLAY': ':0', 03:44:01 INFO - 'HOME': '/home/cltbld', 03:44:01 INFO - 'LANG': 'en_US.UTF-8', 03:44:01 INFO - 'LANGUAGE': 'en_US:en', 03:44:01 INFO - 'LOGNAME': 'cltbld', 03:44:01 INFO - 'MAIL': '/var/mail/cltbld', 03:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:01 INFO - 'MOZ_NO_REMOTE': '1', 03:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:01 INFO - 'NO_EM_RESTART': '1', 03:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:01 INFO - 'PWD': '/builds/slave/test', 03:44:01 INFO - 'SHELL': '/bin/bash', 03:44:01 INFO - 'SHLVL': '1', 03:44:01 INFO - 'TERM': 'linux', 03:44:01 INFO - 'TMOUT': '86400', 03:44:01 INFO - 'USER': 'cltbld', 03:44:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:01 INFO - '_': '/tools/buildbot/bin/python'} 03:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:01 INFO - Running setup.py (path:/tmp/pip-2UxsEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:01 INFO - Running setup.py (path:/tmp/pip-B9zrPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:01 INFO - Running setup.py (path:/tmp/pip-oEyxs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:01 INFO - Running setup.py (path:/tmp/pip-5Aql_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:01 INFO - Running setup.py (path:/tmp/pip-BYapA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:02 INFO - Running setup.py (path:/tmp/pip-stt73i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:02 INFO - Running setup.py (path:/tmp/pip-yNqie8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:02 INFO - Running setup.py (path:/tmp/pip-VLIfTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:02 INFO - Running setup.py (path:/tmp/pip-ES7aT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:02 INFO - Running setup.py (path:/tmp/pip-BXPvQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:02 INFO - Running setup.py (path:/tmp/pip-0BC1fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:02 INFO - Running setup.py (path:/tmp/pip-WeISBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:02 INFO - Running setup.py (path:/tmp/pip-sFg0et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:02 INFO - Running setup.py (path:/tmp/pip-tEtv65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:02 INFO - Running setup.py (path:/tmp/pip-Ab3CRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:02 INFO - Running setup.py (path:/tmp/pip-sxPSqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:02 INFO - Running setup.py (path:/tmp/pip-qpHcHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:44:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:04 INFO - Downloading blessings-1.6.tar.gz 03:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:04 INFO - Installing collected packages: blessings 03:44:04 INFO - Running setup.py install for blessings 03:44:04 INFO - Successfully installed blessings 03:44:04 INFO - Cleaning up... 03:44:04 INFO - Return code: 0 03:44:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:04 INFO - Reading from file tmpfile_stdout 03:44:04 INFO - Current package versions: 03:44:04 INFO - argparse == 1.2.1 03:44:04 INFO - blessings == 1.6 03:44:04 INFO - blobuploader == 1.2.4 03:44:04 INFO - docopt == 0.6.1 03:44:04 INFO - functools32 == 3.2.3-2 03:44:04 INFO - jsonschema == 2.5.1 03:44:04 INFO - manifestparser == 1.1 03:44:04 INFO - mozInstall == 1.13 03:44:04 INFO - mozcrash == 1.0 03:44:04 INFO - mozdebug == 0.1 03:44:04 INFO - mozdevice == 0.51 03:44:04 INFO - mozfile == 1.2 03:44:04 INFO - mozhttpd == 0.7 03:44:04 INFO - mozinfo == 0.10 03:44:04 INFO - mozleak == 0.1 03:44:04 INFO - mozlog == 3.5 03:44:04 INFO - moznetwork == 0.27 03:44:04 INFO - mozprocess == 0.25 03:44:04 INFO - mozprofile == 0.28 03:44:04 INFO - mozrunner == 6.13 03:44:04 INFO - mozscreenshot == 0.1 03:44:04 INFO - mozsystemmonitor == 0.3 03:44:04 INFO - moztest == 0.8 03:44:04 INFO - mozversion == 1.4 03:44:04 INFO - psutil == 3.1.1 03:44:04 INFO - requests == 1.2.3 03:44:04 INFO - wsgiref == 0.1.2 03:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:04 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 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:04 INFO - Using env: {'DISPLAY': ':0', 03:44:04 INFO - 'HOME': '/home/cltbld', 03:44:04 INFO - 'LANG': 'en_US.UTF-8', 03:44:04 INFO - 'LANGUAGE': 'en_US:en', 03:44:04 INFO - 'LOGNAME': 'cltbld', 03:44:04 INFO - 'MAIL': '/var/mail/cltbld', 03:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:04 INFO - 'MOZ_NO_REMOTE': '1', 03:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:04 INFO - 'NO_EM_RESTART': '1', 03:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:04 INFO - 'PWD': '/builds/slave/test', 03:44:04 INFO - 'SHELL': '/bin/bash', 03:44:04 INFO - 'SHLVL': '1', 03:44:04 INFO - 'TERM': 'linux', 03:44:04 INFO - 'TMOUT': '86400', 03:44:04 INFO - 'USER': 'cltbld', 03:44:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:04 INFO - '_': '/tools/buildbot/bin/python'} 03:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:44:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:06 INFO - Installing collected packages: simplejson 03:44:06 INFO - Running setup.py install for simplejson 03:44:06 INFO - building 'simplejson._speedups' extension 03:44:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:44:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:44:07 INFO - Successfully installed simplejson 03:44:07 INFO - Cleaning up... 03:44:07 INFO - Return code: 0 03:44:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:07 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 0x1eb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2079b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:44:07 INFO - Using env: {'DISPLAY': ':0', 03:44:07 INFO - 'HOME': '/home/cltbld', 03:44:07 INFO - 'LANG': 'en_US.UTF-8', 03:44:07 INFO - 'LANGUAGE': 'en_US:en', 03:44:07 INFO - 'LOGNAME': 'cltbld', 03:44:07 INFO - 'MAIL': '/var/mail/cltbld', 03:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:07 INFO - 'MOZ_NO_REMOTE': '1', 03:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:07 INFO - 'NO_EM_RESTART': '1', 03:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:07 INFO - 'PWD': '/builds/slave/test', 03:44:07 INFO - 'SHELL': '/bin/bash', 03:44:07 INFO - 'SHLVL': '1', 03:44:07 INFO - 'TERM': 'linux', 03:44:07 INFO - 'TMOUT': '86400', 03:44:07 INFO - 'USER': 'cltbld', 03:44:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:07 INFO - '_': '/tools/buildbot/bin/python'} 03:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:07 INFO - Cleaning up... 03:44:07 INFO - Return code: 0 03:44:07 INFO - Running post-action listener: _resource_record_post_action 03:44:07 INFO - Running post-action listener: _start_resource_monitoring 03:44:07 INFO - Starting resource monitoring. 03:44:07 INFO - [mozharness: 2017-09-29 10:44:07.373625Z] Finished create-virtualenv step (success) 03:44:07 INFO - [mozharness: 2017-09-29 10:44:07.374140Z] Running install step. 03:44:07 INFO - Running pre-action listener: _resource_record_pre_action 03:44:07 INFO - Running main action method: install 03:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:07 INFO - Reading from file tmpfile_stdout 03:44:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:07 INFO - Reading from file tmpfile_stdout 03:44:07 INFO - Output received: 03:44:07 INFO - Usage: mozinstall [options] installer 03:44:07 INFO - Options: 03:44:07 INFO - -h, --help show this help message and exit 03:44:07 INFO - -d DEST, --destination=DEST 03:44:07 INFO - Directory to install application into. [default: 03:44:07 INFO - "/builds/slave/test"] 03:44:07 INFO - --app=APP Application being installed. [default: firefox] 03:44:07 INFO - mkdir: /builds/slave/test/build/application 03:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:44:25 INFO - Reading from file tmpfile_stdout 03:44:25 INFO - Output received: 03:44:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:25 INFO - Running post-action listener: _resource_record_post_action 03:44:25 INFO - [mozharness: 2017-09-29 10:44:25.535657Z] Finished install step (success) 03:44:25 INFO - [mozharness: 2017-09-29 10:44:25.535909Z] Running setup-mitmproxy step. 03:44:25 INFO - Running pre-action listener: _resource_record_pre_action 03:44:25 INFO - Running main action method: setup_mitmproxy 03:44:25 INFO - Skipping: mitmproxy is not required 03:44:25 INFO - Running post-action listener: _resource_record_post_action 03:44:25 INFO - [mozharness: 2017-09-29 10:44:25.537047Z] Finished setup-mitmproxy step (success) 03:44:25 INFO - [mozharness: 2017-09-29 10:44:25.537322Z] Running run-tests step. 03:44:25 INFO - Running pre-action listener: _resource_record_pre_action 03:44:25 INFO - Running pre-action listener: _set_gcov_prefix 03:44:25 INFO - Running main action method: run_tests 03:44:25 WARNING - Try message not found. 03:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:25 INFO - Python 2.7.3 03:44:25 INFO - Return code: 0 03:44:25 INFO - grabbing minidump binary from tooltool 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:25 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 0x221bd60>, '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 0x221ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:44:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:44:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:44:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:25 INFO - Return code: 0 03:44:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:25 INFO - ENV: RUST_BACKTRACE is now full 03:44:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:25 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/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:44:25 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/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:44:25 INFO - Using env: {'DISPLAY': ':0', 03:44:25 INFO - 'HOME': '/home/cltbld', 03:44:25 INFO - 'LANG': 'en_US.UTF-8', 03:44:25 INFO - 'LANGUAGE': 'en_US:en', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MAIL': '/var/mail/cltbld', 03:44:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:25 INFO - 'MOZ_ACCELERATED': '1', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:25 INFO - 'MOZ_WEBRENDER': '1', 03:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:25 INFO - 'RUST_BACKTRACE': 'full', 03:44:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SHLVL': '1', 03:44:25 INFO - 'TERM': 'linux', 03:44:25 INFO - 'TMOUT': '86400', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - '_': '/tools/buildbot/bin/python'} 03:44:25 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/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:44:25 INFO - mozversion application_buildid: 20170929094722 03:44:25 INFO - mozversion application_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 03:44:25 INFO - mozversion application_display_name: Nightly 03:44:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:25 INFO - mozversion application_name: Firefox 03:44:25 INFO - mozversion application_remotingname: firefox 03:44:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:25 INFO - mozversion application_vendor: Mozilla 03:44:25 INFO - mozversion application_version: 58.0a1 03:44:25 INFO - mozversion platform_buildid: 20170929094722 03:44:25 INFO - mozversion platform_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 03:44:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:25 INFO - mozversion platform_version: 58.0a1 03:44:25 INFO - using testdate: 1506681865 03:44:25 INFO - actual date: 1506681865 03:44:25 INFO - starting webserver on 'localhost:50639' 03:44:25 INFO - SUITE-START | Running 2 tests 03:44:25 INFO - TEST-START | dromaeo_css 03:44:25 INFO - Initialising browser for dromaeo_css test... 03:44:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50639/getInfo.html -profile /tmp/tmpCAlogA/profile 03:44:25 INFO - TEST-INFO | started process 17522 (/builds/slave/test/build/application/firefox/firefox http://localhost:50639/getInfo.html) 03:44:32 INFO - TEST-INFO | 17522: exit 0 03:44:32 INFO - Browser initialized. 03:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:32 INFO - Using env: {'DISPLAY': ':0', 03:44:32 INFO - 'HOME': '/home/cltbld', 03:44:32 INFO - 'JSGC_DISABLE_POISONING': '1', 03:44:32 INFO - 'LANG': 'en_US.UTF-8', 03:44:32 INFO - 'LANGUAGE': 'en_US:en', 03:44:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:44:32 INFO - 'LOGNAME': 'cltbld', 03:44:32 INFO - 'MAIL': '/var/mail/cltbld', 03:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:32 INFO - 'MOZ_ACCELERATED': '1', 03:44:32 INFO - 'MOZ_CRASHREPORTER': '1', 03:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:44:32 INFO - 'MOZ_NO_REMOTE': '1', 03:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:32 INFO - 'MOZ_WEBRENDER': '1', 03:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:32 INFO - 'NO_EM_RESTART': '1', 03:44:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:32 INFO - 'PWD': '/builds/slave/test', 03:44:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:32 INFO - 'RUST_BACKTRACE': 'full', 03:44:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:32 INFO - 'SHELL': '/bin/bash', 03:44:32 INFO - 'SHLVL': '1', 03:44:32 INFO - 'TERM': 'linux', 03:44:32 INFO - 'TMOUT': '86400', 03:44:32 INFO - 'USER': 'cltbld', 03:44:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 03:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:32 INFO - '_': '/tools/buildbot/bin/python'} 03:44:32 INFO - TEST-INFO | started process 17764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAlogA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:33 INFO - PID 17764 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:44:33 INFO - PID 17764 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:44:33 INFO - PID 17764 | 03:44:33 INFO - PID 17764 | (/builds/slave/test/build/application/firefox/firefox:17823): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:44:33 INFO - PID 17764 | 03:44:44 INFO - PID 17764 | RSS: Main: 195010560 03:44:44 INFO - PID 17764 | 03:47:41 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50639/tests/dromaeo/cssquery-ext.html) 03:47:43 INFO - PID 17764 | RSS: Main: 190676992 03:47:43 INFO - PID 17764 | 03:50:45 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-ext.html (next: http://localhost:50639/tests/dromaeo/cssquery-jquery.html) 03:50:46 INFO - PID 17764 | RSS: Main: 188780544 03:50:46 INFO - PID 17764 | 03:53:48 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50639/tests/dromaeo/cssquery-mootools.html) 03:53:48 INFO - PID 17764 | RSS: Main: 190214144 03:53:48 INFO - PID 17764 | 03:56:50 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50639/tests/dromaeo/cssquery-prototype.html) 03:56:51 INFO - PID 17764 | RSS: Main: 189693952 03:56:51 INFO - PID 17764 | 03:59:55 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50639/tests/dromaeo/cssquery-yui.html) 03:59:55 INFO - PID 17764 | RSS: Main: 193318912 03:59:55 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-yui.html (next: http://localhost:50639/tests/dromaeo/cssquery-dojo.html) 04:02:57 INFO - PID 17764 | RSS: Main: 193773568 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | __start_tp_report 04:02:57 INFO - PID 17764 | _x_x_mozilla_page_load 04:02:57 INFO - PID 17764 | _x_x_mozilla_page_load_details 04:02:57 INFO - PID 17764 | |i|pagename|runs| 04:02:57 INFO - PID 17764 | |0;dojo.html;3192.696693814088;3195.057458049875;3205.27881226724;3205.6634053424377;3223.597050368704;6209.410106039931;6299.685015749212;6325.146105275787;6370.2355717313985;6404.455621272185;6273.717682704278;6276.717547710353;6290.21372328459;6315.273743519497;6324.9367506324925;5734.397888221739;5759.424057594249;5762.3949485303965;5803.245578074844;5896.587238893279;5846.766129354821;5892.3812999635065;5893.7347819348015;5917.319508256563;5957.553183511254;5815.912761308584;5823.3012038555435;5894.58737888348;5894.9978503654265;5900.262467191601;5606.682429629034;5656.151577263402;5761.798337058225;5785.82642520725;5810.4770570648425;5703.372629010805;5735.053716136832;5770.884582308372;5820.563457740686;5829.038208695561;6211.751529938842;6285.120083188357;6333;6367.586106903036;6382.234131904155;6565.441937435276;6722.126123603949;6775.762848300285;6780.220274668427;6835.521513494057;6750.797476075725;6782.898256526156;6793.864122717568;6795.18457785064;6796.932030679729;6139.2632884053755;6186.1648677428875;6212.502999760009;6218.595791273598;6218.9378106219265;6896.827579310558;7030.683619237147;7031.226565077837;7117.71529138839;7124.750633727898;6619.404253617101;6650;6688.264290927994;6732.225794033651;6769.153855768029;6649.800505984828;6740.764073257413;6751.729930802713;6843.555168914005;6855.4172895304455;6555.672216389162;6673.833154171185;6698.062271282024;6717.832054198684;6834.931650683429;6612.537122401482;6654.234763002317;6699;6737.124173857367;6847.041414202015;5308.734563271898;5358.5981051421295;5361.785528578891;5374.8656283592445;5393;4664.95335046652;4670.322803193518;4688.062387522509;4688.835890743808;4690.788914498856;5783.421657834183;5800.071988481823;5809.186713860063;5829.650220986754;5878.412158784173;6579.276279609239;6679.265280819106;6755.831104222434;6787.796366109024;6848.486363522756;5756.453136951983;5759.913601295984;5791.391903850119;5847.1229315603;5853.970730146407;5732.942670573324;5791.942080579224;5821.922944255326;5844;5846.619969702041;6501.609903405811;6549.508786841006;6569.934300657028;6609.074729537869;6611.107500487469;6511.902321465087;6660.766873159416;6701.698423570853;6716.194056713226;6758.797236082925;6382.87234255303;6419.807405777834;6424.775132870327;6432.3246059164985;6448.419642232222;6442.613443193423;6619.437347825488;6672.599644021374;6711.395974362331;6736.93263067363;6821.693023813841;6899.206591242071;6903.75836845708;6913.481488888253;6914.654267286515;6534.379233972765;6560;6574;6634.867302654016;6642.933570664425;6382.68086595659;6439.356064393523;6439.645819479973;6446.161998940295;6492.610443373413;6394.392532709385;6412.326705695835;6428.8071357859335;6470.676466176767;6471.676416179078;6164.599301045418;6555.770548030987;6590.242122155822;6619.238787539494;6653.135092437952;6338.651374174465;6433.260175079926;6433.806985790434;6435.356464353527;6453.967730161319 04:02:57 INFO - PID 17764 | |1;ext.html;878.2271600991127;901.2834796336915;902.4044130873625;902.7201567514076;905.6739573753449;39180.60819391809;42325.78837105814;42513.7874310628;42629;42948.3557746634;38462.42306365407;38533.22933541328;38672.61327386725;38681;38867.41698874519;7043.964780176092;7135.286471352849;7147.714091436336;7172.390346820526;7176.641167941608;7142.178649455302;7795.805104872366;8003.439759216857;8004.839903201932;8010.759677209664;7974.960125199366;7986.760397188064;8037.437379383446;8047;8054.315383192436;7849.921500785004;7871.763847084597;7877.606119693993;7924.207579242087;7934.365250779982;7672;7824.804379890491;7851.097123830718;7926.24700653437;7928.603569821544;38437.80781096104;38587;38820.611793882264;38947.221055579015;38953.22093558141;3534.540509733744;3564.8752293669854;3570.982145089284;3631.8184090795617;3632.8001959892194;31142.532862007087;31285.217869553217;31542.369152617048;31546.526802097986;31592.36815263705;5084.618653600995;5114.360704911886;5141.331626888481;5158.664686795346;5200.115980283361;185219;186797;187222;188205;188253;49734;50119.498805011484;50179.24731129036;50300;50369;44609.77695111569;44808;45491.772541137085;52000.73999630053;53263;16075.919620401823;16647.83352166463;16745.16274186286;16787.07671078078;16810.915945420194;13714.17714937107;13722.725545489035;13729.931350343184;13818.792718109236;13820.308984550733;14173.291335433187;14277.64305892361;14363.56909292723;14511.637209069857;14693.559193224006;5740.971295143498;5774.624649397776;5796.739146738407;5801.88396232073;5919.200907877467;977.0034564743921;986.9753256168509;1002.6290272599185;1008.1884083312857;1015.6546774096843;23096.538069238857;23187.188448404224;23248.883755581115;23326.950287237116;23566.821658916986;1109.983350249747;1122.3826895207603;1122.4275619434147;1128.8588926384202;1129.4296380327883;12158.696032599079;12288.569900053455;12359.32023738685;12368.381580920917;12389.62831115068;221450;221988;223211;223260;224626;53623.46376536263;53689;53920.460795392326;53973.46026539685;54009;1401.9579412617638;1458.7228426599124;1463.9707205855823;1472.8527147285185;1473.786300986351;22948.196813111463;23309.76690233076;23447.413814654086;23559;23601.881990589936;37991;38109.237815244094;38203.80898095492;38352.616473836024;38362.42456363213;183924;184653;185558;185887;186417;33072;34336.11151386598;34520.48219276763;34592.48111278282;34832.47751283783;43181.784091079346;43325.78337108294;43334.34998475089;43947.78026109849;44153.55846441623;31963.520547192275;32032.67967320297;32193.195170120933;32292;32381.838090809397;31842;31869.68130318667;31905.361892762478;31938.52092218665;32075.679243208204;34644.48033279453;35885;35971.64028359787;36079.81960090183;36497;31450.37099258048;31455;31668.366632666755;31785.682143178274;31996.52005219877;22998.655020174378;23278.65082023737;23657.114934906203;24149.275521734377;24321.39196520101 04:02:57 INFO - PID 17764 | |2;jquery.html;577.2005772005771;577.3384696548909;580.6545105662129;583.8978178818709;604.2084868821844;22328.999999999978;22871.542569148627;23020.539589208205;23121.884390578045;23161.884190579065;20898.477538061557;21020;21449;24849.75150248497;25282.115125970595;6404.775832845851;6618.172728408949;6644.667766611674;6647.6343801090925;6655.567388119781;6537.477001839865;6637.966810165943;6658.966705166492;6667.633280169589;6669.333066693341;6369.904451433232;6531.93468065318;6582.2101347838325;6609.966950165266;6618.7021584028835;6567.113439685653;6588.934110658928;6601.570897891622;6621.205455345389;6621.867562648744;5920.97039514804;6144.5698801083945;6163.383661633846;6166.4758495527485;6171.6297022178815;27994.86002569974;28629.713702863122;28684.71315286841;28686.713132868612;28883.56674649882;2094.225136699431;2098.045389347843;2098.527831237959;2099.895005249731;2101.684747287919;18662.160202790907;18888.055597220085;18999.05004749757;19025.90487047556;19061.142248598848;2422.0553983946097;2425.7210420801657;2454.3864033991504;2462.150558057467;2466.0628960994886;120515.39742301233;124578;126492;139569.3021534896;147040.2647986764;14650.324153156022;14663.340149693076;14810.925945370203;14893.659570638694;15012.849871501363;23209.3037208884;23278.767212328;23396.532069358516;23540;23676.289711308687;10105.949470252748;10291.691249262534;10375.325603835727;10376.533056012497;10450.634227802142;9236.491992940453;9304.534773261445;9512.524373781283;9537.427754334762;9627.90372096284;9082.228010619172;9207.677731279373;9313.578469597818;9427.811443771223;9450.952745236367;2476.640887071401;2543.974560254411;2580.63871058052;2629.737026297355;2757.1177223288355;908.1554154636252;924.0943875002536;943.6414162618161;953.1564565359567;961.4135377419768;18762.530936726416;19042;19212.903935480514;19243.903780481007;19485.415437536896;987.4420952162005;993.7316924430363;1001.4992503748126;1004.2066767253933;1008.7074748323051;10319.587216511256;10462.372257664565;10600.310979786289;10608.257421980386;10776.622818201482;471067;475798;476450;479946;480390;114993;118196;118594;118788;118814.40592796981;1035.3322107240788;1127.3968426891574;1136.539701420926;1191.7795207886568;1196.1148749925167;19617.411477655693;19777.703334449707;19864.90067549711;20070.297539586045;20289;53247.73376133094;53454;54731.17903231534;55030.17454738262;55971.440285596625;69272;70038;70548.29451705623;70866.64566677134;71216;14225.146491210147;14468.710625787215;14535.41858325655;14562.19907905033;14716.411343546139;22183.556328873008;22456.775432246122;22490;22576;22676.319710408054;16447.91776041112;17117.914410427868;17922;17962.10189490494;17970.550736231176;16038.919805401365;16355.509334719978;16637.66724665524;16855.325786968384;16989;18422.81577184211;18441.815581844545;18457.261709531467;18470;18529.258829647202;14241.857581424054;14282.35729392159;14283.642908926944;14352.282385880873;14403.70366667005;15757.44848930282;15768.92115539415;16586.83413165853;16736.414225502536;17129.743053853952 04:02:57 INFO - PID 17764 | |3;mootools.html;1310.8295921530203;1379.5102738527828;1380.4478208716512;1389.6803735140918;1394.6722520207752;14971.850281497182;15458.381664733397;15480.767788483168;15529.611759706013;15539.533813985585;15080.622984425394;15120.924395378008;15241;15244.542663720078;15269.236538173103;2767.377340098482;2868.9713102868914;2873.382222822093;2873.9856300718466;2875.453663803881;2737.5209338365808;2829.5614179802164;2833.3908209734905;2835.362043540197;2838.8722507487214;2669.8131130820852;2778.9722102779015;2843.289177705574;2859.8570071496447;2865.3266482376625;2786.2894961784614;2802.985985070072;2819.4361127774528;2842.559403292483;2842.9289267768368;2752.6696796384363;2762.8066035377533;2777.250142461524;2779.8749056292313;2790.4558611070847;14987.175705336202;15225.847741522553;15406;15413.845861541466;15437.845621543753;8195.508269503789;8432.747017589481;8464.873026904601;8477.364197685136;8519.892413986205;5676.290463692038;5914.585978981473;5930.347661757203;6076.815021070893;6092.1775560299675;1902.2391043582538;1915.79884112169;1915.9712604310946;1925.1144473542188;1963.1558429875147;27205.183844484698;27529.86235068832;27615.44769104627;27770;27814.860925695444;6978.267281935425;7066.201475069574;7191.748288809971;7221.783346499508;7295.379892709073;17830.821691783174;17861.7320740189;17886.105694715214;17893.821061789215;17902;7792.454528182972;8233.3824963128;8244;8255.545944972964;8257.463264887763;7449.925500744923;7517.210692877169;7547.773566793005;7581.734639287599;7611.4291428143115;5140.897182056338;5327.334083239595;5354.973225133849;5365.517103460707;5374.059539580558;1551.6655676118528;1556.5952852258267;1567.4984005118254;1568.215892053973;1575.4249698859833;857.691231156783;877.1097336203758;882.4131952251809;893.5666201892077;904.516083895113;7572.053493313336;7594.962025189839;7608.8478230436185;7660.463767536219;7697.692092316244;684.5618803965466;704.5878161275712;712.4407340237889;713.1869668577825;724.8876424154159;4442.222611043055;4550.385697930737;4582.289745089516;4637.350770892078;5425.891482170335;21441.67837482439;22473.662895056586;23034.65448018281;23087.07651693947;23148.884255578614;21484.402226404247;22229.333120006424;22297.55404891893;22416.55166896653;22420.103195871983;8922.286217102615;10158;11315.15136364776;11329.206955513035;11336.546538138547;7959.602019898866;8886.511241881759;8911.910880891368;8991.865122023044;9021.548922553977;18567.814321856607;18918;19101.140448679565;19282.32511862078;19323.903380483007;19925.202991880164;20137.798622013594;20174.89912550428;20184.192632294544;20415.59168816645;10435.582576696846;11218.66344009681;11219.55121795119;11224.719382015515;11241.88758112441;14342.354594043085;14361.281935902955;14456.060356076821;14482;14515.709685806436;10848;11060.668179954615;11080.337949307668;11300;11359.659210223706;10661.946690266499;10746.83879741789;10782.245242832927;10876.945615271872;11163.609273675707;9411.29415293842;9463.479508627091;9475.431474111576;9498.810023799624;9569.043095690375;7239.203687594466;7275.054242948383;7311.524750891175;7372.225916278713;7383.040204773345;7745.535267883945;7767.72812951544;7821.960890195513;7873.566953817595;7935.444518883623 04:02:57 INFO - PID 17764 | |4;prototype.html;482.5849769198491;512.5054322578711;519.4364114935295;520.5731300333726;524.6878107526021;6241.164511182048;6265.843353916149;6272.3100458949475;6275.905861412082;6304.8108556743255;6086.665233412161;6164.352742961992;6234.968825155879;6236.594621349609;6250.312465628777;5085.440601533837;5122.871928201787;5145.459726728695;5166.380034395859;5221.086309895753;5134.460881607433;5150.459201783815;5182.974085129569;5202.115640341132;5221.503957124067;4785;4991.850244492671;5135.486451354872;5163.173892177252;5181.663191892515;4940.110780059588;4968.925466118011;4972.502749725017;4990.2764099205415;5010.72441015744;4436.9556304436865;4482.391674701864;4493.123840851035;4501.257292546726;4501.617362524189;5914.674692891889;6076.817695469143;6136.171616831715;6167.907481387782;6218.533609979269;5710.2862142232225;5741.841986907184;5755.884882302331;5780.566457515703;5798.217240672498;6608.471322294253;6623.801285961429;6628.536002479828;6628.701708423133;6670.132882725215;4806.423229212482;4843.588294994895;4906.509349065101;4909.68087074339;4930.704157750546;6687.531872768908;6737.427318677869;6846.801809683286;6857.451403887677;6886.519398329333;4995.500449954975;5022.723750193702;5035.748212589356;5036.143855544567;5038.64729468941;5058.114829904752;5101.464346243665;5108.489151084862;5110.872228194251;5126.2054381570915;5646.520045796071;5652.689102099342;5713.971430142823;5714.51418632896;5742.368339482654;6506.31683673217;6532.256452290049;6562.179727534059;6585.5719378240265;6680.99785032249;1754.9298028078733;1760.4366602687273;1760.7887053553657;1770.4246120011048;1788.937387191442;894.6823877523516;1207.5169932027084;1233.3894722112611;1239.7892358299111;1251.6870782304425;5638.6052976292085;5667.319921609351;5696.09180924395;5758.596898217168;5804.158397032406;6581.440577550866;6724.4284235840505;6734.8989765153565;6735.595864248161;6762.357576030269;5688.544916406678;5690.7439165237665;5731.856703582361;5759.596828222068;5780.682062486603;3493.615702272748;3562.750607457453;3569.7322700797545;3610.332088563624;3622.3298689741955;6399;6444.806655800334;6459.935400645933;6475.611463312216;6500.447461965691;6758.560693555001;6795.247924590549;6826.590404575642;6862.553933994274;6904.654767261717;6374.745010199633;6398.168238129107;6406.327335629878;6419.325970773095;6440.194975628046;6683.7660681875905;6704.530682852153;6780.830479237861;6827.487938404739;6833.2483426824;6042.697865106639;6666.799996000128;6671.499637527108;6730.889278419395;6825.35159159879;6394.200724909387;6414.518911081781;6438.67806609677;6503.512236582181;6543.378379053982;4961.355023846877;4981.651284410056;5029.245613157909;5044.419891712353;5058.671186372874;6399.488040956805;6505.837354066186;6657.300983396867;6748.628825414649;6761.729530818712;6323.494120470259;6394.552381333262;6471.2234531856475;6475.902861457176;6567.978729784161;6413.16628838248;6433.420992110732;6459.386358295955;6518;6530.444912182327;6263.3736626337;6348.269948955744;6363.140975968185;6379.681015949277;6453.903191452038;6488.437067358462;6498.570314530795;6519.837004074936;6537.673116344259;6609.1408116944485;6287.182666253358;6330.9050364245495;6371.617702937839;6373.3945275198785;6381.617102973836 04:02:57 INFO - PID 17764 | |5;yui.html;849.2781136034372;865.5499140446967;883.0771843423622;894.0389081737134;894.3918135667748;19160.137793799277;19588.092454357422;19611.705824412646;19651.115699793507;19750.802491975075;18101.547461313472;18135.546611334725;18153.727694084566;18180.636387272247;18257.269709211614;960.1214888377126;969.181042019496;973.8880028796673;975.7219192530131;980.5391466010964;941.2846236860001;981.4994352880011;984.4290311619244;989.5497548615399;997.1524204426253;1024.933379330341;1030.3663247103052;1035.9689209323733;1036.383351905615;1038.776663017451;1015.8984101589818;1033.225081189108;1033.7829055898271;1035.1460045462447;1035.79801938622;715.8103102677794;737.1117803047368;740.4002757766173;742.224375527575;762.523422860712;18219.99790011549;18373.540661483436;18421.355252566096;18581.16384762689;18644.25422983079;21316.14735410582;21679.45801354979;22647.886760566256;22662.206822761123;22767;16209.837901620951;16520.256588453547;16627;16799;16915.407960721317;3702.6667599916136;3718.535183102112;3761;3766.453864189677;3773.0755964788805;135163;138721;139890.3005484966;141613;144526.27736861247;14638.341274642667;15769.921150394175;15781.28984195714;15843.524694259191;16130.193490325437;31129.688703113134;31187.908423205077;31630.367392652017;32001.359972800412;32399.352012959607;7888.723894663659;8052.033755949206;8108.1891810819625;8121.431499794958;8128.837423251502;3815.561210460777;3930.390789427643;3932.2135572885536;3942.3495123304906;3949.0324870406935;5056.469070747592;5477.808276710296;5501.477359650827;5516.3380394352935;5574.996500629925;960.4381436859516;979.118793086228;993.1756641987133;993.562832353762;994.2791476179711;503.97228152451964;510.35440168187273;514.1824499046534;515.2991930973873;517.3558919145612;11190;11660.242084264495;12512.81230781539;12603.93698031504;12991.090623656442;679.751890559942;687.0758829374483;694.1669996004814;699.6851416862432;701.0185739963989;5571.359293681278;5683.090705487102;5697.658140511582;5714.314282286152;5797.246357973437;124943;126131;126288.36855815846;126489.36755316165;127621;113247.43376283065;115221.42389288;115735;116351;117397.41301293438;95875.52062239645;96905.030949691;97218;98341.5082924595;99925.00074999302;10405.427701476492;10419.687409377731;10470.947645261725;10543.525541350504;10688.412137332522;47398.526014739415;47607.52392476031;47624;48551;49437.25844112413;61630.38369616426;62576;62608.37391626208;62669.37330626635;62997.68501157648;15272.083674979536;15536.92231538835;15564.766528501856;15587.688246235239;15849.128297943262;17637.294508220042;17686.11569421498;17691.73462398091;17806.287748489915;17897;16196.352145914032;16283.837161628233;16332.346706131622;16504.25730842091;16542.83457165413;15704.29330680145;15824.525264242091;16073.276702548646;16101.355945762507;16310.592235194215;14679.48621798232;14765.335559900044;14777.630559236106;14783.852161478679;14970.550883473514;10257.281990260908;10261.538230779783;10372.636957706443;10689.412082335546;10696.572137114428;10996.450177491253;11003.61487347971;11032.896710328903;11128.38793866345;11153.219274650697 04:02:57 INFO - PID 17764 | __end_tp_report 04:02:57 INFO - PID 17764 | __start_cc_report 04:02:57 INFO - PID 17764 | _x_x_mozilla_cycle_collect,282 04:02:57 INFO - PID 17764 | __end_cc_report 04:02:57 INFO - PID 17764 | __startTimestamp1506682977925__endTimestamp 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | ------- Summary: start ------- 04:02:57 INFO - PID 17764 | Number of tests: 6 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#0] dojo.html Cycles:165 Average:6200.03 Median:6424.78 stddev:731.87 (11.4%) stddev-sans-first:695.05 04:02:57 INFO - PID 17764 | Values: 3192.7 3195.1 3205.3 3205.7 3223.6 6209.4 6299.7 6325.1 6370.2 6404.5 6273.7 6276.7 6290.2 6315.3 6324.9 5734.4 5759.4 5762.4 5803.2 5896.6 5846.8 5892.4 5893.7 5917.3 5957.6 5815.9 5823.3 5894.6 5895.0 5900.3 5606.7 5656.2 5761.8 5785.8 5810.5 5703.4 5735.1 5770.9 5820.6 5829.0 6211.8 6285.1 6333.0 6367.6 6382.2 6565.4 6722.1 6775.8 6780.2 6835.5 6750.8 6782.9 6793.9 6795.2 6796.9 6139.3 6186.2 6212.5 6218.6 6218.9 6896.8 7030.7 7031.2 7117.7 7124.8 6619.4 6650.0 6688.3 6732.2 6769.2 6649.8 6740.8 6751.7 6843.6 6855.4 6555.7 6673.8 6698.1 6717.8 6834.9 6612.5 6654.2 6699.0 6737.1 6847.0 5308.7 5358.6 5361.8 5374.9 5393.0 4665.0 4670.3 4688.1 4688.8 4690.8 5783.4 5800.1 5809.2 5829.7 5878.4 6579.3 6679.3 6755.8 6787.8 6848.5 5756.5 5759.9 5791.4 5847.1 5854.0 5732.9 5791.9 5821.9 5844.0 5846.6 6501.6 6549.5 6569.9 6609.1 6611.1 6511.9 6660.8 6701.7 6716.2 6758.8 6382.9 6419.8 6424.8 6432.3 6448.4 6442.6 6619.4 6672.6 6711.4 6736.9 6821.7 6899.2 6903.8 6913.5 6914.7 6534.4 6560.0 6574.0 6634.9 6642.9 6382.7 6439.4 6439.6 6446.2 6492.6 6394.4 6412.3 6428.8 6470.7 6471.7 6164.6 6555.8 6590.2 6619.2 6653.1 6338.7 6433.3 6433.8 6435.4 6454.0 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#1] ext.html Cycles:180 Average:36968.09 Median:3567.93 stddev:51526.44 (1444.2%) stddev-sans-first:51599.73 04:02:57 INFO - PID 17764 | Values: 878.2 901.3 902.4 902.7 905.7 39180.6 42325.8 42513.8 42629.0 42948.4 38462.4 38533.2 38672.6 38681.0 38867.4 7044.0 7135.3 7147.7 7172.4 7176.6 7142.2 7795.8 8003.4 8004.8 8010.8 7975.0 7986.8 8037.4 8047.0 8054.3 7849.9 7871.8 7877.6 7924.2 7934.4 7672.0 7824.8 7851.1 7926.2 7928.6 38437.8 38587.0 38820.6 38947.2 38953.2 3534.5 3564.9 3571.0 3631.8 3632.8 31142.5 31285.2 31542.4 31546.5 31592.4 5084.6 5114.4 5141.3 5158.7 5200.1 185219.0 186797.0 187222.0 188205.0 188253.0 49734.0 50119.5 50179.2 50300.0 50369.0 44609.8 44808.0 45491.8 52000.7 53263.0 16075.9 16647.8 16745.2 16787.1 16810.9 13714.2 13722.7 13729.9 13818.8 13820.3 14173.3 14277.6 14363.6 14511.6 14693.6 5741.0 5774.6 5796.7 5801.9 5919.2 977.0 987.0 1002.6 1008.2 1015.7 23096.5 23187.2 23248.9 23327.0 23566.8 1110.0 1122.4 1122.4 1128.9 1129.4 12158.7 12288.6 12359.3 12368.4 12389.6 221450.0 221988.0 223211.0 223260.0 224626.0 53623.5 53689.0 53920.5 53973.5 54009.0 1402.0 1458.7 1464.0 1472.9 1473.8 22948.2 23309.8 23447.4 23559.0 23601.9 37991.0 38109.2 38203.8 38352.6 38362.4 183924.0 184653.0 185558.0 185887.0 186417.0 33072.0 34336.1 34520.5 34592.5 34832.5 43181.8 43325.8 43334.3 43947.8 44153.6 31963.5 32032.7 32193.2 32292.0 32381.8 31842.0 31869.7 31905.4 31938.5 32075.7 34644.5 35885.0 35971.6 36079.8 36497.0 31450.4 31455.0 31668.4 31785.7 31996.5 22998.7 23278.7 23657.1 24149.3 24321.4 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#2] jquery.html Cycles:180 Average:34017.64 Median:22626.16 stddev:80390.39 (355.3%) stddev-sans-first:80576.70 04:02:57 INFO - PID 17764 | Values: 577.2 577.3 580.7 583.9 604.2 22329.0 22871.5 23020.5 23121.9 23161.9 20898.5 21020.0 21449.0 24849.8 25282.1 6404.8 6618.2 6644.7 6647.6 6655.6 6537.5 6638.0 6659.0 6667.6 6669.3 6369.9 6531.9 6582.2 6610.0 6618.7 6567.1 6588.9 6601.6 6621.2 6621.9 5921.0 6144.6 6163.4 6166.5 6171.6 27994.9 28629.7 28684.7 28686.7 28883.6 2094.2 2098.0 2098.5 2099.9 2101.7 18662.2 18888.1 18999.1 19025.9 19061.1 2422.1 2425.7 2454.4 2462.2 2466.1 120515.4 124578.0 126492.0 139569.3 147040.3 14650.3 14663.3 14810.9 14893.7 15012.8 23209.3 23278.8 23396.5 23540.0 23676.3 10105.9 10291.7 10375.3 10376.5 10450.6 9236.5 9304.5 9512.5 9537.4 9627.9 9082.2 9207.7 9313.6 9427.8 9451.0 2476.6 2544.0 2580.6 2629.7 2757.1 908.2 924.1 943.6 953.2 961.4 18762.5 19042.0 19212.9 19243.9 19485.4 987.4 993.7 1001.5 1004.2 1008.7 10319.6 10462.4 10600.3 10608.3 10776.6 471067.0 475798.0 476450.0 479946.0 480390.0 114993.0 118196.0 118594.0 118788.0 118814.4 1035.3 1127.4 1136.5 1191.8 1196.1 19617.4 19777.7 19864.9 20070.3 20289.0 53247.7 53454.0 54731.2 55030.2 55971.4 69272.0 70038.0 70548.3 70866.6 71216.0 14225.1 14468.7 14535.4 14562.2 14716.4 22183.6 22456.8 22490.0 22576.0 22676.3 16447.9 17117.9 17922.0 17962.1 17970.6 16038.9 16355.5 16637.7 16855.3 16989.0 18422.8 18441.8 18457.3 18470.0 18529.3 14241.9 14282.4 14283.6 14352.3 14403.7 15757.4 15768.9 16586.8 16736.4 17129.7 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#3] mootools.html Cycles:180 Average:9505.87 Median:15297.37 stddev:6909.67 (45.2%) stddev-sans-first:6901.62 04:02:57 INFO - PID 17764 | Values: 1310.8 1379.5 1380.4 1389.7 1394.7 14971.9 15458.4 15480.8 15529.6 15539.5 15080.6 15120.9 15241.0 15244.5 15269.2 2767.4 2869.0 2873.4 2874.0 2875.5 2737.5 2829.6 2833.4 2835.4 2838.9 2669.8 2779.0 2843.3 2859.9 2865.3 2786.3 2803.0 2819.4 2842.6 2842.9 2752.7 2762.8 2777.3 2779.9 2790.5 14987.2 15225.8 15406.0 15413.8 15437.8 8195.5 8432.7 8464.9 8477.4 8519.9 5676.3 5914.6 5930.3 6076.8 6092.2 1902.2 1915.8 1916.0 1925.1 1963.2 27205.2 27529.9 27615.4 27770.0 27814.9 6978.3 7066.2 7191.7 7221.8 7295.4 17830.8 17861.7 17886.1 17893.8 17902.0 7792.5 8233.4 8244.0 8255.5 8257.5 7449.9 7517.2 7547.8 7581.7 7611.4 5140.9 5327.3 5355.0 5365.5 5374.1 1551.7 1556.6 1567.5 1568.2 1575.4 857.7 877.1 882.4 893.6 904.5 7572.1 7595.0 7608.8 7660.5 7697.7 684.6 704.6 712.4 713.2 724.9 4442.2 4550.4 4582.3 4637.4 5425.9 21441.7 22473.7 23034.7 23087.1 23148.9 21484.4 22229.3 22297.6 22416.6 22420.1 8922.3 10158.0 11315.2 11329.2 11336.5 7959.6 8886.5 8911.9 8991.9 9021.5 18567.8 18918.0 19101.1 19282.3 19323.9 19925.2 20137.8 20174.9 20184.2 20415.6 10435.6 11218.7 11219.6 11224.7 11241.9 14342.4 14361.3 14456.1 14482.0 14515.7 10848.0 11060.7 11080.3 11300.0 11359.7 10661.9 10746.8 10782.2 10876.9 11163.6 9411.3 9463.5 9475.4 9498.8 9569.0 7239.2 7275.1 7311.5 7372.2 7383.0 7745.5 7767.7 7822.0 7873.6 7935.4 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#4] prototype.html Cycles:180 Average:5509.29 Median:6193.22 stddev:1534.74 (24.8%) stddev-sans-first:1491.94 04:02:57 INFO - PID 17764 | Values: 482.6 512.5 519.4 520.6 524.7 6241.2 6265.8 6272.3 6275.9 6304.8 6086.7 6164.4 6235.0 6236.6 6250.3 5085.4 5122.9 5145.5 5166.4 5221.1 5134.5 5150.5 5183.0 5202.1 5221.5 4785.0 4991.9 5135.5 5163.2 5181.7 4940.1 4968.9 4972.5 4990.3 5010.7 4437.0 4482.4 4493.1 4501.3 4501.6 5914.7 6076.8 6136.2 6167.9 6218.5 5710.3 5741.8 5755.9 5780.6 5798.2 6608.5 6623.8 6628.5 6628.7 6670.1 4806.4 4843.6 4906.5 4909.7 4930.7 6687.5 6737.4 6846.8 6857.5 6886.5 4995.5 5022.7 5035.7 5036.1 5038.6 5058.1 5101.5 5108.5 5110.9 5126.2 5646.5 5652.7 5714.0 5714.5 5742.4 6506.3 6532.3 6562.2 6585.6 6681.0 1754.9 1760.4 1760.8 1770.4 1788.9 894.7 1207.5 1233.4 1239.8 1251.7 5638.6 5667.3 5696.1 5758.6 5804.2 6581.4 6724.4 6734.9 6735.6 6762.4 5688.5 5690.7 5731.9 5759.6 5780.7 3493.6 3562.8 3569.7 3610.3 3622.3 6399.0 6444.8 6459.9 6475.6 6500.4 6758.6 6795.2 6826.6 6862.6 6904.7 6374.7 6398.2 6406.3 6419.3 6440.2 6683.8 6704.5 6780.8 6827.5 6833.2 6042.7 6666.8 6671.5 6730.9 6825.4 6394.2 6414.5 6438.7 6503.5 6543.4 4961.4 4981.7 5029.2 5044.4 5058.7 6399.5 6505.8 6657.3 6748.6 6761.7 6323.5 6394.6 6471.2 6475.9 6568.0 6413.2 6433.4 6459.4 6518.0 6530.4 6263.4 6348.3 6363.1 6379.7 6453.9 6488.4 6498.6 6519.8 6537.7 6609.1 6287.2 6330.9 6371.6 6373.4 6381.6 04:02:57 INFO - PID 17764 | 04:02:57 INFO - PID 17764 | [#5] yui.html Cycles:180 Average:24771.84 Median:19374.12 stddev:36468.90 (188.2%) stddev-sans-first:36526.96 04:02:57 INFO - PID 17764 | Values: 849.3 865.5 883.1 894.0 894.4 19160.1 19588.1 19611.7 19651.1 19750.8 18101.5 18135.5 18153.7 18180.6 18257.3 960.1 969.2 973.9 975.7 980.5 941.3 981.5 984.4 989.5 997.2 1024.9 1030.4 1036.0 1036.4 1038.8 1015.9 1033.2 1033.8 1035.1 1035.8 715.8 737.1 740.4 742.2 762.5 18220.0 18373.5 18421.4 18581.2 18644.3 21316.1 21679.5 22647.9 22662.2 22767.0 16209.8 16520.3 16627.0 16799.0 16915.4 3702.7 3718.5 3761.0 3766.5 3773.1 135163.0 138721.0 139890.3 141613.0 144526.3 14638.3 15769.9 15781.3 15843.5 16130.2 31129.7 31187.9 31630.4 32001.4 32399.4 7888.7 8052.0 8108.2 8121.4 8128.8 3815.6 3930.4 3932.2 3942.3 3949.0 5056.5 5477.8 5501.5 5516.3 5575.0 960.4 979.1 993.2 993.6 994.3 504.0 510.4 514.2 515.3 517.4 11190.0 11660.2 12512.8 12603.9 12991.1 679.8 687.1 694.2 699.7 701.0 5571.4 5683.1 5697.7 5714.3 5797.2 124943.0 126131.0 126288.4 126489.4 127621.0 113247.4 115221.4 115735.0 116351.0 117397.4 95875.5 96905.0 97218.0 98341.5 99925.0 10405.4 10419.7 10470.9 10543.5 10688.4 47398.5 47607.5 47624.0 48551.0 49437.3 61630.4 62576.0 62608.4 62669.4 62997.7 15272.1 15536.9 15564.8 15587.7 15849.1 17637.3 17686.1 17691.7 17806.3 17897.0 16196.4 16283.8 16332.3 16504.3 16542.8 15704.3 15824.5 16073.3 16101.4 16310.6 14679.5 14765.3 14777.6 14783.9 14970.6 10257.3 10261.5 10372.6 10689.4 10696.6 10996.5 11003.6 11032.9 11128.4 11153.2 04:02:57 INFO - PID 17764 | -------- Summary: end -------- 04:02:57 INFO - PID 17764 | 04:02:58 INFO - TEST-INFO | 17764: exit 0 04:02:58 INFO - TEST-OK | dromaeo_css | took 1112689ms 04:02:58 INFO - TEST-START | kraken 04:02:58 INFO - Initialising browser for kraken test... 04:02:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50639/getInfo.html -profile /tmp/tmpBEuQaw/profile 04:02:58 INFO - TEST-INFO | started process 18139 (/builds/slave/test/build/application/firefox/firefox http://localhost:50639/getInfo.html) 04:03:04 INFO - TEST-INFO | 18139: exit 0 04:03:04 INFO - Browser initialized. 04:03:04 INFO - Running cycle 1/1 for kraken test... 04:03:04 INFO - Using env: {'DISPLAY': ':0', 04:03:04 INFO - 'HOME': '/home/cltbld', 04:03:04 INFO - 'JSGC_DISABLE_POISONING': '1', 04:03:04 INFO - 'LANG': 'en_US.UTF-8', 04:03:04 INFO - 'LANGUAGE': 'en_US:en', 04:03:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:03:04 INFO - 'LOGNAME': 'cltbld', 04:03:04 INFO - 'MAIL': '/var/mail/cltbld', 04:03:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:04 INFO - 'MOZ_ACCELERATED': '1', 04:03:04 INFO - 'MOZ_CRASHREPORTER': '1', 04:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:03:04 INFO - 'MOZ_NO_REMOTE': '1', 04:03:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:04 INFO - 'MOZ_WEBRENDER': '1', 04:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:04 INFO - 'NO_EM_RESTART': '1', 04:03:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:04 INFO - 'PWD': '/builds/slave/test', 04:03:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:04 INFO - 'RUST_BACKTRACE': 'full', 04:03:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:03:04 INFO - 'SHELL': '/bin/bash', 04:03:04 INFO - 'SHLVL': '1', 04:03:04 INFO - 'TERM': 'linux', 04:03:04 INFO - 'TMOUT': '86400', 04:03:04 INFO - 'USER': 'cltbld', 04:03:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460', 04:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:04 INFO - '_': '/tools/buildbot/bin/python'} 04:03:04 INFO - TEST-INFO | started process 18387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBEuQaw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:05 INFO - PID 18387 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:03:05 INFO - PID 18387 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:03:05 INFO - PID 18387 | 04:03:05 INFO - PID 18387 | (/builds/slave/test/build/application/firefox/firefox:18447): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:03:05 INFO - PID 18387 | 04:03:15 INFO - PID 18387 | RSS: Main: 198905856 04:03:15 INFO - PID 18387 | 04:03:18 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:19 INFO - PID 18387 | RSS: Main: 196141056 04:03:19 INFO - PID 18387 | 04:03:22 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-dft) 04:03:22 INFO - PID 18387 | RSS: Main: 196587520 04:03:22 INFO - PID 18387 | 04:03:25 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-fft) 04:03:26 INFO - PID 18387 | RSS: Main: 192802816 04:03:26 INFO - PID 18387 | 04:03:28 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-oscillator) 04:03:29 INFO - PID 18387 | RSS: Main: 193380352 04:03:29 INFO - PID 18387 | 04:03:31 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:31 INFO - PID 18387 | RSS: Main: 193171456 04:03:31 INFO - PID 18387 | 04:03:35 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:35 INFO - PID 18387 | RSS: Main: 195334144 04:03:35 INFO - PID 18387 | 04:03:39 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:40 INFO - PID 18387 | RSS: Main: 194666496 04:03:40 INFO - PID 18387 | 04:03:43 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50639/tests/kraken/driver.html?testName=json-parse-financial) 04:03:43 INFO - PID 18387 | RSS: Main: 195579904 04:03:43 INFO - PID 18387 | 04:03:45 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:46 INFO - PID 18387 | RSS: Main: 195616768 04:03:46 INFO - PID 18387 | 04:03:47 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:48 INFO - PID 18387 | RSS: Main: 192880640 04:03:48 INFO - PID 18387 | 04:03:50 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:51 INFO - PID 18387 | RSS: Main: 192540672 04:03:51 INFO - PID 18387 | 04:03:53 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:54 INFO - PID 18387 | RSS: Main: 192839680 04:03:54 INFO - PID 18387 | 04:03:57 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:58 INFO - PID 18387 | RSS: Main: 193232896 04:03:58 INFO - PID 18387 | 04:03:59 INFO - PID 18387 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50639/tests/kraken/driver.html?testName=ai-astar) 04:04:00 INFO - PID 18387 | RSS: Main: 194404352 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | __start_tp_report 04:04:00 INFO - PID 18387 | _x_x_mozilla_page_load 04:04:00 INFO - PID 18387 | _x_x_mozilla_page_load_details 04:04:00 INFO - PID 18387 | |i|pagename|runs| 04:04:00 INFO - PID 18387 | |0;ai-astar;108;113;107;123;108;111;116;117;114;106 04:04:00 INFO - PID 18387 | |1;audio-beat-detection;122;124;117;119;129;144;134;122;124;129 04:04:00 INFO - PID 18387 | |2;audio-dft;166;171;174;164;168;169;173;167;167;166 04:04:00 INFO - PID 18387 | |3;audio-fft;76;82;77;78;73;74;74;83;79;78 04:04:00 INFO - PID 18387 | |4;audio-oscillator;80;87;86;80;81;85;81;79;87;81 04:04:00 INFO - PID 18387 | |5;imaging-gaussian-blur;130;123;122;113;112;111;112;112;119;113 04:04:00 INFO - PID 18387 | |6;imaging-darkroom;148;151;157;149;149;153;152;150;149;149 04:04:00 INFO - PID 18387 | |7;imaging-desaturate;95;95;99;103;95;94;96;95;95;95 04:04:00 INFO - PID 18387 | |8;json-parse-financial;55;63;52;53;63;58;52;52;51;55 04:04:00 INFO - PID 18387 | |9;json-stringify-tinderbox;44;43;44;42;47;46;37;44;45;37 04:04:00 INFO - PID 18387 | |10;stanford-crypto-aes;79;80;80;75;79;76;86;80;79;75 04:04:00 INFO - PID 18387 | |11;stanford-crypto-ccm;127;112;115;122;125;114;116;115;113;111 04:04:00 INFO - PID 18387 | |12;stanford-crypto-pbkdf2;181;172;162;162;160;165;162;170;160;162 04:04:00 INFO - PID 18387 | |13;stanford-crypto-sha256-iterative;64;64;62;65;68;71;63;63;65;65 04:04:00 INFO - PID 18387 | __end_tp_report 04:04:00 INFO - PID 18387 | __start_cc_report 04:04:00 INFO - PID 18387 | _x_x_mozilla_cycle_collect,755 04:04:00 INFO - PID 18387 | __end_cc_report 04:04:00 INFO - PID 18387 | __startTimestamp1506683040071__endTimestamp 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | ------- Summary: start ------- 04:04:00 INFO - PID 18387 | Number of tests: 14 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:5.38 (4.7%) stddev-sans-first:5.47 04:04:00 INFO - PID 18387 | Values: 108.0 113.0 107.0 123.0 108.0 111.0 116.0 117.0 114.0 106.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:126.50 stddev:7.99 (6.3%) stddev-sans-first:8.31 04:04:00 INFO - PID 18387 | Values: 122.0 124.0 117.0 119.0 129.0 144.0 134.0 122.0 124.0 129.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#2] audio-dft Cycles:10 Average:168.50 Median:168.50 stddev:3.24 (1.9%) stddev-sans-first:3.31 04:04:00 INFO - PID 18387 | Values: 166.0 171.0 174.0 164.0 168.0 169.0 173.0 167.0 167.0 166.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#3] audio-fft Cycles:10 Average:77.40 Median:78.00 stddev:3.34 (4.3%) stddev-sans-first:3.50 04:04:00 INFO - PID 18387 | Values: 76.0 82.0 77.0 78.0 73.0 74.0 74.0 83.0 79.0 78.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:83.00 stddev:3.16 (3.8%) stddev-sans-first:3.20 04:04:00 INFO - PID 18387 | Values: 80.0 87.0 86.0 80.0 81.0 85.0 81.0 79.0 87.0 81.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:116.00 stddev:6.46 (5.6%) stddev-sans-first:4.74 04:04:00 INFO - PID 18387 | Values: 130.0 123.0 122.0 113.0 112.0 111.0 112.0 112.0 119.0 113.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.50 stddev:2.71 (1.8%) stddev-sans-first:2.69 04:04:00 INFO - PID 18387 | Values: 148.0 151.0 157.0 149.0 149.0 153.0 152.0 150.0 149.0 149.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.00 stddev:2.74 (2.9%) stddev-sans-first:2.87 04:04:00 INFO - PID 18387 | Values: 95.0 95.0 99.0 103.0 95.0 94.0 96.0 95.0 95.0 95.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:4.50 (8.2%) stddev-sans-first:4.77 04:04:00 INFO - PID 18387 | Values: 55.0 63.0 52.0 53.0 63.0 58.0 52.0 52.0 51.0 55.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#9] json-stringify-tinderbox Cycles:10 Average:42.90 Median:44.00 stddev:3.41 (7.8%) stddev-sans-first:3.60 04:04:00 INFO - PID 18387 | Values: 44.0 43.0 44.0 42.0 47.0 46.0 37.0 44.0 45.0 37.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.50 stddev:3.21 (4.0%) stddev-sans-first:3.41 04:04:00 INFO - PID 18387 | Values: 79.0 80.0 80.0 75.0 79.0 76.0 86.0 80.0 79.0 75.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:115.50 stddev:5.62 (4.9%) stddev-sans-first:4.65 04:04:00 INFO - PID 18387 | Values: 127.0 112.0 115.0 122.0 125.0 114.0 116.0 115.0 113.0 111.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:163.50 stddev:6.77 (4.1%) stddev-sans-first:4.31 04:04:00 INFO - PID 18387 | Values: 181.0 172.0 162.0 162.0 160.0 165.0 162.0 170.0 160.0 162.0 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.67 (4.1%) stddev-sans-first:2.80 04:04:00 INFO - PID 18387 | Values: 64.0 64.0 62.0 65.0 68.0 71.0 63.0 63.0 65.0 65.0 04:04:00 INFO - PID 18387 | -------- Summary: end -------- 04:04:00 INFO - PID 18387 | 04:04:00 INFO - PID 18387 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:04:00 INFO - TEST-INFO | 18387: exit 0 04:04:00 INFO - TEST-OK | kraken | took 62387ms 04:04:00 INFO - SUITE-END | took 1175s 04:04:01 INFO - Completed test suite (00:19:35) 04:04:01 INFO - javascript benchmark 04:04:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8483.992391684229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3192.696693814088, 3195.057458049875, 3205.27881226724, 3205.6634053424377, 3223.597050368704, 6209.410106039931, 6299.685015749212, 6325.146105275787, 6370.2355717313985, 6404.455621272185, 6273.717682704278, 6276.717547710353, 6290.21372328459, 6315.273743519497, 6324.9367506324925, 5734.397888221739, 5759.424057594249, 5762.3949485303965, 5803.245578074844, 5896.587238893279, 5846.766129354821, 5892.3812999635065, 5893.7347819348015, 5917.319508256563, 5957.553183511254, 5815.912761308584, 5823.3012038555435, 5894.58737888348, 5894.9978503654265, 5900.262467191601, 5606.682429629034, 5656.151577263402, 5761.798337058225, 5785.82642520725, 5810.4770570648425, 5703.372629010805, 5735.053716136832, 5770.884582308372, 5820.563457740686, 5829.038208695561, 6211.751529938842, 6285.120083188357, 6333.0, 6367.586106903036, 6382.234131904155, 6565.441937435276, 6722.126123603949, 6775.762848300285, 6780.220274668427, 6835.521513494057, 6750.797476075725, 6782.898256526156, 6793.864122717568, 6795.18457785064, 6796.932030679729, 6139.2632884053755, 6186.1648677428875, 6212.502999760009, 6218.595791273598, 6218.9378106219265, 6896.827579310558, 7030.683619237147, 7031.226565077837, 7117.71529138839, 7124.750633727898, 6619.404253617101, 6650.0, 6688.264290927994, 6732.225794033651, 6769.153855768029, 6649.800505984828, 6740.764073257413, 6751.729930802713, 6843.555168914005, 6855.4172895304455, 6555.672216389162, 6673.833154171185, 6698.062271282024, 6717.832054198684, 6834.931650683429, 6612.537122401482, 6654.234763002317, 6699.0, 6737.124173857367, 6847.041414202015, 5308.734563271898, 5358.5981051421295, 5361.785528578891, 5374.8656283592445, 5393.0, 4664.95335046652, 4670.322803193518, 4688.062387522509, 4688.835890743808, 4690.788914498856, 5783.421657834183, 5800.071988481823, 5809.186713860063, 5829.650220986754, 5878.412158784173, 6579.276279609239, 6679.265280819106, 6755.831104222434, 6787.796366109024, 6848.486363522756, 5756.453136951983, 5759.913601295984, 5791.391903850119, 5847.1229315603, 5853.970730146407, 5732.942670573324, 5791.942080579224, 5821.922944255326, 5844.0, 5846.619969702041, 6501.609903405811, 6549.508786841006, 6569.934300657028, 6609.074729537869, 6611.107500487469, 6511.902321465087, 6660.766873159416, 6701.698423570853, 6716.194056713226, 6758.797236082925, 6382.87234255303, 6419.807405777834, 6424.775132870327, 6432.3246059164985, 6448.419642232222, 6442.613443193423, 6619.437347825488, 6672.599644021374, 6711.395974362331, 6736.93263067363, 6821.693023813841, 6899.206591242071, 6903.75836845708, 6913.481488888253, 6914.654267286515, 6534.379233972765, 6560.0, 6574.0, 6634.867302654016, 6642.933570664425, 6382.68086595659, 6439.356064393523, 6439.645819479973, 6446.161998940295, 6492.610443373413, 6394.392532709385, 6412.326705695835, 6428.8071357859335, 6470.676466176767, 6471.676416179078, 6164.599301045418, 6555.770548030987, 6590.242122155822, 6619.238787539494, 6653.135092437952, 6338.651374174465, 6433.260175079926, 6433.806985790434, 6435.356464353527, 6453.967730161319], "value": 6145.518654948519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.2271600991127, 901.2834796336915, 902.4044130873625, 902.7201567514076, 905.6739573753449, 39180.60819391809, 42325.78837105814, 42513.7874310628, 42629.0, 42948.3557746634, 38462.42306365407, 38533.22933541328, 38672.61327386725, 38681.0, 38867.41698874519, 7043.964780176092, 7135.286471352849, 7147.714091436336, 7172.390346820526, 7176.641167941608, 7142.178649455302, 7795.805104872366, 8003.439759216857, 8004.839903201932, 8010.759677209664, 7974.960125199366, 7986.760397188064, 8037.437379383446, 8047.0, 8054.315383192436, 7849.921500785004, 7871.763847084597, 7877.606119693993, 7924.207579242087, 7934.365250779982, 7672.0, 7824.804379890491, 7851.097123830718, 7926.24700653437, 7928.603569821544, 38437.80781096104, 38587.0, 38820.611793882264, 38947.221055579015, 38953.22093558141, 3534.540509733744, 3564.8752293669854, 3570.982145089284, 3631.8184090795617, 3632.8001959892194, 31142.532862007087, 31285.217869553217, 31542.369152617048, 31546.526802097986, 31592.36815263705, 5084.618653600995, 5114.360704911886, 5141.331626888481, 5158.664686795346, 5200.115980283361, 185219.0, 186797.0, 187222.0, 188205.0, 188253.0, 49734.0, 50119.498805011484, 50179.24731129036, 50300.0, 50369.0, 44609.77695111569, 44808.0, 45491.772541137085, 52000.73999630053, 53263.0, 16075.919620401823, 16647.83352166463, 16745.16274186286, 16787.07671078078, 16810.915945420194, 13714.17714937107, 13722.725545489035, 13729.931350343184, 13818.792718109236, 13820.308984550733, 14173.291335433187, 14277.64305892361, 14363.56909292723, 14511.637209069857, 14693.559193224006, 5740.971295143498, 5774.624649397776, 5796.739146738407, 5801.88396232073, 5919.200907877467, 977.0034564743921, 986.9753256168509, 1002.6290272599185, 1008.1884083312857, 1015.6546774096843, 23096.538069238857, 23187.188448404224, 23248.883755581115, 23326.950287237116, 23566.821658916986, 1109.983350249747, 1122.3826895207603, 1122.4275619434147, 1128.8588926384202, 1129.4296380327883, 12158.696032599079, 12288.569900053455, 12359.32023738685, 12368.381580920917, 12389.62831115068, 221450.0, 221988.0, 223211.0, 223260.0, 224626.0, 53623.46376536263, 53689.0, 53920.460795392326, 53973.46026539685, 54009.0, 1401.9579412617638, 1458.7228426599124, 1463.9707205855823, 1472.8527147285185, 1473.786300986351, 22948.196813111463, 23309.76690233076, 23447.413814654086, 23559.0, 23601.881990589936, 37991.0, 38109.237815244094, 38203.80898095492, 38352.616473836024, 38362.42456363213, 183924.0, 184653.0, 185558.0, 185887.0, 186417.0, 33072.0, 34336.11151386598, 34520.48219276763, 34592.48111278282, 34832.47751283783, 43181.784091079346, 43325.78337108294, 43334.34998475089, 43947.78026109849, 44153.55846441623, 31963.520547192275, 32032.67967320297, 32193.195170120933, 32292.0, 32381.838090809397, 31842.0, 31869.68130318667, 31905.361892762478, 31938.52092218665, 32075.679243208204, 34644.48033279453, 35885.0, 35971.64028359787, 36079.81960090183, 36497.0, 31450.37099258048, 31455.0, 31668.366632666755, 31785.682143178274, 31996.52005219877, 22998.655020174378, 23278.65082023737, 23657.114934906203, 24149.275521734377, 24321.39196520101], "value": 17194.6845126441, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2005772005771, 577.3384696548909, 580.6545105662129, 583.8978178818709, 604.2084868821844, 22328.999999999978, 22871.542569148627, 23020.539589208205, 23121.884390578045, 23161.884190579065, 20898.477538061557, 21020.0, 21449.0, 24849.75150248497, 25282.115125970595, 6404.775832845851, 6618.172728408949, 6644.667766611674, 6647.6343801090925, 6655.567388119781, 6537.477001839865, 6637.966810165943, 6658.966705166492, 6667.633280169589, 6669.333066693341, 6369.904451433232, 6531.93468065318, 6582.2101347838325, 6609.966950165266, 6618.7021584028835, 6567.113439685653, 6588.934110658928, 6601.570897891622, 6621.205455345389, 6621.867562648744, 5920.97039514804, 6144.5698801083945, 6163.383661633846, 6166.4758495527485, 6171.6297022178815, 27994.86002569974, 28629.713702863122, 28684.71315286841, 28686.713132868612, 28883.56674649882, 2094.225136699431, 2098.045389347843, 2098.527831237959, 2099.895005249731, 2101.684747287919, 18662.160202790907, 18888.055597220085, 18999.05004749757, 19025.90487047556, 19061.142248598848, 2422.0553983946097, 2425.7210420801657, 2454.3864033991504, 2462.150558057467, 2466.0628960994886, 120515.39742301233, 124578.0, 126492.0, 139569.3021534896, 147040.2647986764, 14650.324153156022, 14663.340149693076, 14810.925945370203, 14893.659570638694, 15012.849871501363, 23209.3037208884, 23278.767212328, 23396.532069358516, 23540.0, 23676.289711308687, 10105.949470252748, 10291.691249262534, 10375.325603835727, 10376.533056012497, 10450.634227802142, 9236.491992940453, 9304.534773261445, 9512.524373781283, 9537.427754334762, 9627.90372096284, 9082.228010619172, 9207.677731279373, 9313.578469597818, 9427.811443771223, 9450.952745236367, 2476.640887071401, 2543.974560254411, 2580.63871058052, 2629.737026297355, 2757.1177223288355, 908.1554154636252, 924.0943875002536, 943.6414162618161, 953.1564565359567, 961.4135377419768, 18762.530936726416, 19042.0, 19212.903935480514, 19243.903780481007, 19485.415437536896, 987.4420952162005, 993.7316924430363, 1001.4992503748126, 1004.2066767253933, 1008.7074748323051, 10319.587216511256, 10462.372257664565, 10600.310979786289, 10608.257421980386, 10776.622818201482, 471067.0, 475798.0, 476450.0, 479946.0, 480390.0, 114993.0, 118196.0, 118594.0, 118788.0, 118814.40592796981, 1035.3322107240788, 1127.3968426891574, 1136.539701420926, 1191.7795207886568, 1196.1148749925167, 19617.411477655693, 19777.703334449707, 19864.90067549711, 20070.297539586045, 20289.0, 53247.73376133094, 53454.0, 54731.17903231534, 55030.17454738262, 55971.440285596625, 69272.0, 70038.0, 70548.29451705623, 70866.64566677134, 71216.0, 14225.146491210147, 14468.710625787215, 14535.41858325655, 14562.19907905033, 14716.411343546139, 22183.556328873008, 22456.775432246122, 22490.0, 22576.0, 22676.319710408054, 16447.91776041112, 17117.914410427868, 17922.0, 17962.10189490494, 17970.550736231176, 16038.919805401365, 16355.509334719978, 16637.66724665524, 16855.325786968384, 16989.0, 18422.81577184211, 18441.815581844545, 18457.261709531467, 18470.0, 18529.258829647202, 14241.857581424054, 14282.35729392159, 14283.642908926944, 14352.282385880873, 14403.70366667005, 15757.44848930282, 15768.92115539415, 16586.83413165853, 16736.414225502536, 17129.743053853952], "value": 11809.465273921804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.8295921530203, 1379.5102738527828, 1380.4478208716512, 1389.6803735140918, 1394.6722520207752, 14971.850281497182, 15458.381664733397, 15480.767788483168, 15529.611759706013, 15539.533813985585, 15080.622984425394, 15120.924395378008, 15241.0, 15244.542663720078, 15269.236538173103, 2767.377340098482, 2868.9713102868914, 2873.382222822093, 2873.9856300718466, 2875.453663803881, 2737.5209338365808, 2829.5614179802164, 2833.3908209734905, 2835.362043540197, 2838.8722507487214, 2669.8131130820852, 2778.9722102779015, 2843.289177705574, 2859.8570071496447, 2865.3266482376625, 2786.2894961784614, 2802.985985070072, 2819.4361127774528, 2842.559403292483, 2842.9289267768368, 2752.6696796384363, 2762.8066035377533, 2777.250142461524, 2779.8749056292313, 2790.4558611070847, 14987.175705336202, 15225.847741522553, 15406.0, 15413.845861541466, 15437.845621543753, 8195.508269503789, 8432.747017589481, 8464.873026904601, 8477.364197685136, 8519.892413986205, 5676.290463692038, 5914.585978981473, 5930.347661757203, 6076.815021070893, 6092.1775560299675, 1902.2391043582538, 1915.79884112169, 1915.9712604310946, 1925.1144473542188, 1963.1558429875147, 27205.183844484698, 27529.86235068832, 27615.44769104627, 27770.0, 27814.860925695444, 6978.267281935425, 7066.201475069574, 7191.748288809971, 7221.783346499508, 7295.379892709073, 17830.821691783174, 17861.7320740189, 17886.105694715214, 17893.821061789215, 17902.0, 7792.454528182972, 8233.3824963128, 8244.0, 8255.545944972964, 8257.463264887763, 7449.925500744923, 7517.210692877169, 7547.773566793005, 7581.734639287599, 7611.4291428143115, 5140.897182056338, 5327.334083239595, 5354.973225133849, 5365.517103460707, 5374.059539580558, 1551.6655676118528, 1556.5952852258267, 1567.4984005118254, 1568.215892053973, 1575.4249698859833, 857.691231156783, 877.1097336203758, 882.4131952251809, 893.5666201892077, 904.516083895113, 7572.053493313336, 7594.962025189839, 7608.8478230436185, 7660.463767536219, 7697.692092316244, 684.5618803965466, 704.5878161275712, 712.4407340237889, 713.1869668577825, 724.8876424154159, 4442.222611043055, 4550.385697930737, 4582.289745089516, 4637.350770892078, 5425.891482170335, 21441.67837482439, 22473.662895056586, 23034.65448018281, 23087.07651693947, 23148.884255578614, 21484.402226404247, 22229.333120006424, 22297.55404891893, 22416.55166896653, 22420.103195871983, 8922.286217102615, 10158.0, 11315.15136364776, 11329.206955513035, 11336.546538138547, 7959.602019898866, 8886.511241881759, 8911.910880891368, 8991.865122023044, 9021.548922553977, 18567.814321856607, 18918.0, 19101.140448679565, 19282.32511862078, 19323.903380483007, 19925.202991880164, 20137.798622013594, 20174.89912550428, 20184.192632294544, 20415.59168816645, 10435.582576696846, 11218.66344009681, 11219.55121795119, 11224.719382015515, 11241.88758112441, 14342.354594043085, 14361.281935902955, 14456.060356076821, 14482.0, 14515.709685806436, 10848.0, 11060.668179954615, 11080.337949307668, 11300.0, 11359.659210223706, 10661.946690266499, 10746.83879741789, 10782.245242832927, 10876.945615271872, 11163.609273675707, 9411.29415293842, 9463.479508627091, 9475.431474111576, 9498.810023799624, 9569.043095690375, 7239.203687594466, 7275.054242948383, 7311.524750891175, 7372.225916278713, 7383.040204773345, 7745.535267883945, 7767.72812951544, 7821.960890195513, 7873.566953817595, 7935.444518883623], "value": 6727.287466630167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.5849769198491, 512.5054322578711, 519.4364114935295, 520.5731300333726, 524.6878107526021, 6241.164511182048, 6265.843353916149, 6272.3100458949475, 6275.905861412082, 6304.8108556743255, 6086.665233412161, 6164.352742961992, 6234.968825155879, 6236.594621349609, 6250.312465628777, 5085.440601533837, 5122.871928201787, 5145.459726728695, 5166.380034395859, 5221.086309895753, 5134.460881607433, 5150.459201783815, 5182.974085129569, 5202.115640341132, 5221.503957124067, 4785.0, 4991.850244492671, 5135.486451354872, 5163.173892177252, 5181.663191892515, 4940.110780059588, 4968.925466118011, 4972.502749725017, 4990.2764099205415, 5010.72441015744, 4436.9556304436865, 4482.391674701864, 4493.123840851035, 4501.257292546726, 4501.617362524189, 5914.674692891889, 6076.817695469143, 6136.171616831715, 6167.907481387782, 6218.533609979269, 5710.2862142232225, 5741.841986907184, 5755.884882302331, 5780.566457515703, 5798.217240672498, 6608.471322294253, 6623.801285961429, 6628.536002479828, 6628.701708423133, 6670.132882725215, 4806.423229212482, 4843.588294994895, 4906.509349065101, 4909.68087074339, 4930.704157750546, 6687.531872768908, 6737.427318677869, 6846.801809683286, 6857.451403887677, 6886.519398329333, 4995.500449954975, 5022.723750193702, 5035.748212589356, 5036.143855544567, 5038.64729468941, 5058.114829904752, 5101.464346243665, 5108.489151084862, 5110.872228194251, 5126.2054381570915, 5646.520045796071, 5652.689102099342, 5713.971430142823, 5714.51418632896, 5742.368339482654, 6506.31683673217, 6532.256452290049, 6562.179727534059, 6585.5719378240265, 6680.99785032249, 1754.9298028078733, 1760.4366602687273, 1760.7887053553657, 1770.4246120011048, 1788.937387191442, 894.6823877523516, 1207.5169932027084, 1233.3894722112611, 1239.7892358299111, 1251.6870782304425, 5638.6052976292085, 5667.319921609351, 5696.09180924395, 5758.596898217168, 5804.158397032406, 6581.440577550866, 6724.4284235840505, 6734.8989765153565, 6735.595864248161, 6762.357576030269, 5688.544916406678, 5690.7439165237665, 5731.856703582361, 5759.596828222068, 5780.682062486603, 3493.615702272748, 3562.750607457453, 3569.7322700797545, 3610.332088563624, 3622.3298689741955, 6399.0, 6444.806655800334, 6459.935400645933, 6475.611463312216, 6500.447461965691, 6758.560693555001, 6795.247924590549, 6826.590404575642, 6862.553933994274, 6904.654767261717, 6374.745010199633, 6398.168238129107, 6406.327335629878, 6419.325970773095, 6440.194975628046, 6683.7660681875905, 6704.530682852153, 6780.830479237861, 6827.487938404739, 6833.2483426824, 6042.697865106639, 6666.799996000128, 6671.499637527108, 6730.889278419395, 6825.35159159879, 6394.200724909387, 6414.518911081781, 6438.67806609677, 6503.512236582181, 6543.378379053982, 4961.355023846877, 4981.651284410056, 5029.245613157909, 5044.419891712353, 5058.671186372874, 6399.488040956805, 6505.837354066186, 6657.300983396867, 6748.628825414649, 6761.729530818712, 6323.494120470259, 6394.552381333262, 6471.2234531856475, 6475.902861457176, 6567.978729784161, 6413.16628838248, 6433.420992110732, 6459.386358295955, 6518.0, 6530.444912182327, 6263.3736626337, 6348.269948955744, 6363.140975968185, 6379.681015949277, 6453.903191452038, 6488.437067358462, 6498.570314530795, 6519.837004074936, 6537.673116344259, 6609.1408116944485, 6287.182666253358, 6330.9050364245495, 6371.617702937839, 6373.3945275198785, 6381.617102973836], "value": 5053.271363905797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.2781136034372, 865.5499140446967, 883.0771843423622, 894.0389081737134, 894.3918135667748, 19160.137793799277, 19588.092454357422, 19611.705824412646, 19651.115699793507, 19750.802491975075, 18101.547461313472, 18135.546611334725, 18153.727694084566, 18180.636387272247, 18257.269709211614, 960.1214888377126, 969.181042019496, 973.8880028796673, 975.7219192530131, 980.5391466010964, 941.2846236860001, 981.4994352880011, 984.4290311619244, 989.5497548615399, 997.1524204426253, 1024.933379330341, 1030.3663247103052, 1035.9689209323733, 1036.383351905615, 1038.776663017451, 1015.8984101589818, 1033.225081189108, 1033.7829055898271, 1035.1460045462447, 1035.79801938622, 715.8103102677794, 737.1117803047368, 740.4002757766173, 742.224375527575, 762.523422860712, 18219.99790011549, 18373.540661483436, 18421.355252566096, 18581.16384762689, 18644.25422983079, 21316.14735410582, 21679.45801354979, 22647.886760566256, 22662.206822761123, 22767.0, 16209.837901620951, 16520.256588453547, 16627.0, 16799.0, 16915.407960721317, 3702.6667599916136, 3718.535183102112, 3761.0, 3766.453864189677, 3773.0755964788805, 135163.0, 138721.0, 139890.3005484966, 141613.0, 144526.27736861247, 14638.341274642667, 15769.921150394175, 15781.28984195714, 15843.524694259191, 16130.193490325437, 31129.688703113134, 31187.908423205077, 31630.367392652017, 32001.359972800412, 32399.352012959607, 7888.723894663659, 8052.033755949206, 8108.1891810819625, 8121.431499794958, 8128.837423251502, 3815.561210460777, 3930.390789427643, 3932.2135572885536, 3942.3495123304906, 3949.0324870406935, 5056.469070747592, 5477.808276710296, 5501.477359650827, 5516.3380394352935, 5574.996500629925, 960.4381436859516, 979.118793086228, 993.1756641987133, 993.562832353762, 994.2791476179711, 503.97228152451964, 510.35440168187273, 514.1824499046534, 515.2991930973873, 517.3558919145612, 11190.0, 11660.242084264495, 12512.81230781539, 12603.93698031504, 12991.090623656442, 679.751890559942, 687.0758829374483, 694.1669996004814, 699.6851416862432, 701.0185739963989, 5571.359293681278, 5683.090705487102, 5697.658140511582, 5714.314282286152, 5797.246357973437, 124943.0, 126131.0, 126288.36855815846, 126489.36755316165, 127621.0, 113247.43376283065, 115221.42389288, 115735.0, 116351.0, 117397.41301293438, 95875.52062239645, 96905.030949691, 97218.0, 98341.5082924595, 99925.00074999302, 10405.427701476492, 10419.687409377731, 10470.947645261725, 10543.525541350504, 10688.412137332522, 47398.526014739415, 47607.52392476031, 47624.0, 48551.0, 49437.25844112413, 61630.38369616426, 62576.0, 62608.37391626208, 62669.37330626635, 62997.68501157648, 15272.083674979536, 15536.92231538835, 15564.766528501856, 15587.688246235239, 15849.128297943262, 17637.294508220042, 17686.11569421498, 17691.73462398091, 17806.287748489915, 17897.0, 16196.352145914032, 16283.837161628233, 16332.346706131622, 16504.25730842091, 16542.83457165413, 15704.29330680145, 15824.525264242091, 16073.276702548646, 16101.355945762507, 16310.592235194215, 14679.48621798232, 14765.335559900044, 14777.630559236106, 14783.852161478679, 14970.550883473514, 10257.281990260908, 10261.538230779783, 10372.636957706443, 10689.412082335546, 10696.572137114428, 10996.450177491253, 11003.61487347971, 11032.896710328903, 11128.38793866345, 11153.219274650697], "value": 8789.831785514905, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 107.0, 123.0, 108.0, 111.0, 116.0, 117.0, 114.0, 106.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 117.0, 119.0, 129.0, 144.0, 134.0, 122.0, 124.0, 129.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 174.0, 164.0, 168.0, 169.0, 173.0, 167.0, 167.0, 166.0], "value": 168.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 77.0, 78.0, 73.0, 74.0, 74.0, 83.0, 79.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 86.0, 80.0, 81.0, 85.0, 81.0, 79.0, 87.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 122.0, 113.0, 112.0, 111.0, 112.0, 112.0, 119.0, 113.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 157.0, 149.0, 149.0, 153.0, 152.0, 150.0, 149.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 103.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 52.0, 53.0, 63.0, 58.0, 52.0, 52.0, 51.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 44.0, 42.0, 47.0, 46.0, 37.0, 44.0, 45.0, 37.0], "value": 42.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 75.0, 79.0, 76.0, 86.0, 80.0, 79.0, 75.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 112.0, 115.0, 122.0, 125.0, 114.0, 116.0, 115.0, 113.0, 111.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 172.0, 162.0, 162.0, 160.0, 165.0, 162.0, 170.0, 160.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 65.0, 68.0, 71.0, 63.0, 63.0, 65.0, 65.0], "value": 65.0, "unit": "score"}]}]} 04:04:01 INFO - Return code: 0 04:04:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:04:01 INFO - # TBPL SUCCESS # 04:04:01 INFO - Running post-action listener: _package_coverage_data 04:04:01 INFO - Running post-action listener: _resource_record_post_action 04:04:01 INFO - [mozharness: 2017-09-29 11:04:01.372239Z] Finished run-tests step (success) 04:04:01 INFO - Running post-run listener: _resource_record_post_run 04:04:01 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 3383296; Write bytes: 345227264; Read time: 1096; Write time: 211760 04:04:01 INFO - TinderboxPrint: CPU usage
13.2% 04:04:01 INFO - TinderboxPrint: I/O read bytes / time
3,383,296 / 1,096 04:04:01 INFO - TinderboxPrint: I/O write bytes / time
345,227,264 / 211,760 04:04:01 INFO - TinderboxPrint: CPU idle
8,249.7 (86.8%) 04:04:01 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 04:04:01 INFO - TinderboxPrint: Swap in / out
0 / 0 04:04:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13254656; Read time: 0; Write time: 2844 04:04:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:04:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 3379200; Write bytes: 331972608; Read time: 1080; Write time: 208916 04:04:02 INFO - Running post-run listener: _upload_blobber_files 04:04:02 INFO - Blob upload gear active. 04:04:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:04:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:03 INFO - (blobuploader) - INFO - Done attempting. 04:04:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:04:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:04 INFO - (blobuploader) - INFO - Done attempting. 04:04:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:04:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:05 INFO - (blobuploader) - INFO - Done attempting. 04:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:09 INFO - (blobuploader) - INFO - Done attempting. 04:04:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:09 INFO - Return code: 0 04:04:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e722a66927ac9b36ac8ae1d4cd80e4cb8610c7f77d926ef1e5ccc696aa254f7a2f1957da0ba2ff4750019200ed1cdfe40e28b5bdeb8714bb0c1a72d6cb0d4b5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7e4e421526168ae450e3454d52bd199083a22962c0963a81a51e845b3358139f9069ce4df2e5b6d1de2903305d0fd6236a1ce55f113545dc815d05185302ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25795c4a89958f12e4997ddcde9e3a5d0da40bfae745d6172084e50dfa7ae31459a767b5f0e2d271f2dbbf00f1cf27ef2550125a895c52164a074cdae69e3a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37dab62888831f79630e5e464ff4e594a8e4bb2a23a1ad9bd7077356999ebe26e77e30e81ddc6a2d3bfd212810b879e1b7a019cf17ed9d29f87fe97ec17d417b"} 04:04:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:09 INFO - Contents: 04:04:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e722a66927ac9b36ac8ae1d4cd80e4cb8610c7f77d926ef1e5ccc696aa254f7a2f1957da0ba2ff4750019200ed1cdfe40e28b5bdeb8714bb0c1a72d6cb0d4b5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7e4e421526168ae450e3454d52bd199083a22962c0963a81a51e845b3358139f9069ce4df2e5b6d1de2903305d0fd6236a1ce55f113545dc815d05185302ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25795c4a89958f12e4997ddcde9e3a5d0da40bfae745d6172084e50dfa7ae31459a767b5f0e2d271f2dbbf00f1cf27ef2550125a895c52164a074cdae69e3a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37dab62888831f79630e5e464ff4e594a8e4bb2a23a1ad9bd7077356999ebe26e77e30e81ddc6a2d3bfd212810b879e1b7a019cf17ed9d29f87fe97ec17d417b"} 04:04:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:09 INFO - Copying logs to upload dir... 04:04:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.686944 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 04:04:09.218005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:09.227315) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 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/2e722a66927ac9b36ac8ae1d4cd80e4cb8610c7f77d926ef1e5ccc696aa254f7a2f1957da0ba2ff4750019200ed1cdfe40e28b5bdeb8714bb0c1a72d6cb0d4b5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7e4e421526168ae450e3454d52bd199083a22962c0963a81a51e845b3358139f9069ce4df2e5b6d1de2903305d0fd6236a1ce55f113545dc815d05185302ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25795c4a89958f12e4997ddcde9e3a5d0da40bfae745d6172084e50dfa7ae31459a767b5f0e2d271f2dbbf00f1cf27ef2550125a895c52164a074cdae69e3a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37dab62888831f79630e5e464ff4e594a8e4bb2a23a1ad9bd7077356999ebe26e77e30e81ddc6a2d3bfd212810b879e1b7a019cf17ed9d29f87fe97ec17d417b"} build_url:https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e722a66927ac9b36ac8ae1d4cd80e4cb8610c7f77d926ef1e5ccc696aa254f7a2f1957da0ba2ff4750019200ed1cdfe40e28b5bdeb8714bb0c1a72d6cb0d4b5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7e4e421526168ae450e3454d52bd199083a22962c0963a81a51e845b3358139f9069ce4df2e5b6d1de2903305d0fd6236a1ce55f113545dc815d05185302ea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25795c4a89958f12e4997ddcde9e3a5d0da40bfae745d6172084e50dfa7ae31459a767b5f0e2d271f2dbbf00f1cf27ef2550125a895c52164a074cdae69e3a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37dab62888831f79630e5e464ff4e594a8e4bb2a23a1ad9bd7077356999ebe26e77e30e81ddc6a2d3bfd212810b879e1b7a019cf17ed9d29f87fe97ec17d417b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:09.255566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:09.257925) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506677111.913213-2119136460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:09.339690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:04:09.340006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:04:09.340315) ========= ========= Total master_lag: 0.31 =========