builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1503623178.72 results: success (0) revision: 3199bacd6b3827d711155a9e81c081434cf7cd8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:18.723546) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:18.723972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:18.724265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:18.738790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:18.739137) ========= 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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 18:06:18-- 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% 46.1M=0s 2017-08-24 18:06:19 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.358733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:19.113704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:19.114070) ========= 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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:19.163184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 18:06:19.163518) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3199bacd6b3827d711155a9e81c081434cf7cd8f --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 3199bacd6b3827d711155a9e81c081434cf7cd8f --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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 18:06:19,383 truncating revision to first 12 chars 2017-08-24 18:06:19,383 Setting DEBUG logging. 2017-08-24 18:06:19,383 attempt 1/10 2017-08-24 18:06:19,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3199bacd6b38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 18:06:20,216 unpacking tar archive at: mozilla-central-3199bacd6b38/testing/mozharness/ program finished with exit code 0 elapsedTime=1.168570 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 18:06:20.350026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:20.350386) ========= script_repo_revision: 3199bacd6b3827d711155a9e81c081434cf7cd8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:20.350787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:20.351077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 18:06:20.362702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-24 18:06:20.362986) ========= /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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:20 INFO - MultiFileLogger online at 20170824 18:06:20 in /builds/slave/test 18:06:20 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 18:06:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:20 INFO - {'append_to_log': False, 18:06:20 INFO - 'base_work_dir': '/builds/slave/test', 18:06:20 INFO - 'blob_upload_branch': 'Firefox', 18:06:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:20 INFO - 'branch': 'Firefox', 18:06:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:20 INFO - 'code_coverage': False, 18:06:20 INFO - 'config_files': ('talos/linux_config.py',), 18:06:20 INFO - 'default_actions': ('clobber', 18:06:20 INFO - 'read-buildbot-config', 18:06:20 INFO - 'download-and-extract', 18:06:20 INFO - 'populate-webroot', 18:06:20 INFO - 'create-virtualenv', 18:06:20 INFO - 'install', 18:06:20 INFO - 'setup-mitmproxy', 18:06:20 INFO - 'run-tests'), 18:06:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:20 INFO - 'disable_ccov_upload': False, 18:06:20 INFO - 'download_minidump_stackwalk': True, 18:06:20 INFO - 'download_symbols': 'ondemand', 18:06:20 INFO - 'enable_stylo': False, 18:06:20 INFO - 'enable_webrender': False, 18:06:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:06:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:20 INFO - 'gecko_profile': False, 18:06:20 INFO - 'gecko_profile_interval': 0, 18:06:20 INFO - 'installer_path': 'installer.exe', 18:06:20 INFO - 'log_level': 'info', 18:06:20 INFO - 'log_name': 'talos', 18:06:20 INFO - 'log_to_console': True, 18:06:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:20 INFO - 'opt_config_files': (), 18:06:20 INFO - 'pip_index': False, 18:06:20 INFO - 'suite': 'dromaeojs-e10s', 18:06:20 INFO - 'system_bits': '32', 18:06:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:20 INFO - 'title': 'talos-linux64-ix-047', 18:06:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:20 INFO - 'use_talos_json': True, 18:06:20 INFO - 'verify': 'False', 18:06:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:20 INFO - 'work_dir': 'build'} 18:06:20 INFO - [mozharness: 2017-08-25 01:06:20.722880Z] Running clobber step. 18:06:20 INFO - Running pre-action listener: _resource_record_pre_action 18:06:20 INFO - Running main action method: clobber 18:06:20 INFO - rmtree: /builds/slave/test/build 18:06:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:21 INFO - Running post-action listener: _resource_record_post_action 18:06:21 INFO - [mozharness: 2017-08-25 01:06:21.755752Z] Finished clobber step (success) 18:06:21 INFO - [mozharness: 2017-08-25 01:06:21.755850Z] Running read-buildbot-config step. 18:06:21 INFO - Running pre-action listener: _resource_record_pre_action 18:06:21 INFO - Running main action method: read_buildbot_config 18:06:21 INFO - Using buildbot properties: 18:06:21 INFO - { 18:06:21 INFO - "project": "", 18:06:21 INFO - "product": "firefox", 18:06:21 INFO - "who": "ryanvm@gmail.com", 18:06:21 INFO - "installer_path": "public/build/target.tar.bz2", 18:06:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:06:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:06:21 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:06:21 INFO - "stage_platform": "linux64-stylosequential", 18:06:21 INFO - "basedir": "/builds/slave/test", 18:06:21 INFO - "buildnumber": 209, 18:06:21 INFO - "platform": "ubuntu64_hw_styloseq", 18:06:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:06:21 INFO - "slavebuilddir": "test", 18:06:21 INFO - "taskId": "RLrC0MEfTpyw8SWHi3JDhw", 18:06:21 INFO - "branch": "mozilla-central", 18:06:21 INFO - "script_repo_revision": "production", 18:06:21 INFO - "revision": "3199bacd6b3827d711155a9e81c081434cf7cd8f", 18:06:21 INFO - "slavename": "talos-linux64-ix-047", 18:06:21 INFO - "repo_path": "mozilla-central" 18:06:21 INFO - } 18:06:21 INFO - Finding installer, test and symbols from parent task. 18:06:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLrC0MEfTpyw8SWHi3JDhw'}, attempt #1 18:06:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLrC0MEfTpyw8SWHi3JDhw'}, attempt #1 18:06:22 INFO - Task dependencies: Amqe4HB8QW2hqpHBtZHK2w 18:06:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w'}, attempt #1 18:06:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 18:06:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.test_packages.json 18:06:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.crashreporter-symbols.zip 18:06:23 INFO - Running post-action listener: _resource_record_post_action 18:06:23 INFO - [mozharness: 2017-08-25 01:06:23.119303Z] Finished read-buildbot-config step (success) 18:06:23 INFO - [mozharness: 2017-08-25 01:06:23.119521Z] Running download-and-extract step. 18:06:23 INFO - Running pre-action listener: _resource_record_pre_action 18:06:23 INFO - Running main action method: download_and_extract 18:06:23 INFO - mkdir: /builds/slave/test/build/tests 18:06:23 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')]} 18:06:23 INFO - trying https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.test_packages.json 18:06:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:06:23 INFO - Downloaded 989 bytes. 18:06:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:06:23 INFO - Using the following test package requirements: 18:06:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:06:23 INFO - u'common': [u'target.common.tests.zip'], 18:06:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:06:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:06:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:06:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:06:23 INFO - u'mozbase': [u'target.common.tests.zip'], 18:06:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:06:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:06:23 INFO - u'web-platform': [u'target.common.tests.zip', 18:06:23 INFO - u'target.web-platform.tests.tar.gz'], 18:06:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:06:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:06:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip 18:06:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:06:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip into memory 18:06:24 INFO - Content-Length response header: 54980109 18:06:24 INFO - Bytes received: 54980109 18:06:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:06:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip 18:06:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:06:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.common.tests.zip into memory 18:06:36 INFO - Content-Length response header: 54980109 18:06:36 INFO - Bytes received: 54980109 18:06:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.talos.tests.zip 18:06:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:06:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.talos.tests.zip into memory 18:06:49 INFO - Content-Length response header: 14496555 18:06:49 INFO - Bytes received: 14496555 18:06: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')]} 18:06:49 INFO - trying https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 18:06:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:06:50 INFO - Downloaded 61070188 bytes. 18:06:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 18:06:50 INFO - mkdir: /builds/slave/test/properties 18:06:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:06:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:06:50 INFO - Contents: 18:06:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 18:06:50 INFO - Running post-action listener: _resource_record_post_action 18:06:50 INFO - Running post-action listener: find_tests_for_verification 18:06:50 INFO - Running post-action listener: set_extra_try_arguments 18:06:50 INFO - [mozharness: 2017-08-25 01:06:50.786413Z] Finished download-and-extract step (success) 18:06:50 INFO - [mozharness: 2017-08-25 01:06:50.786511Z] Running populate-webroot step. 18:06:50 INFO - Running pre-action listener: _resource_record_pre_action 18:06:50 INFO - Running main action method: populate_webroot 18:06:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:06:50 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:06:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:06:50 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:06:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:50 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'tests': ['damp', 'tps']}, 18:06:50 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['damp', 'tps']}, 18:06:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:06:50 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:06:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:06:50 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:06:50 INFO - 'other-e10s': {'tests': ['a11yr', 18:06:50 INFO - 'ts_paint', 18:06:50 INFO - 'tpaint', 18:06:50 INFO - 'sessionrestore', 18:06:50 INFO - 'sessionrestore_many_windows', 18:06:50 INFO - 'sessionrestore_no_auto_restore', 18:06:50 INFO - 'tabpaint']}, 18:06:50 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['a11yr', 18:06:50 INFO - 'ts_paint', 18:06:50 INFO - 'tpaint', 18:06:50 INFO - 'sessionrestore', 18:06:50 INFO - 'sessionrestore_many_windows', 18:06:50 INFO - 'sessionrestore_no_auto_restore', 18:06:50 INFO - 'tabpaint']}, 18:06:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:06:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:06:50 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['bloom_basic_singleton']}, 18:06:50 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['bloom_basic']}, 18:06:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:06:50 INFO - 'tsvgr_opacity', 18:06:50 INFO - 'tart', 18:06:50 INFO - 'tscrollx', 18:06:50 INFO - 'tsvg_static']}, 18:06:50 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['tsvgx', 18:06:50 INFO - 'tsvgr_opacity', 18:06:50 INFO - 'tart', 18:06:50 INFO - 'tscrollx', 18:06:50 INFO - 'tsvg_static']}, 18:06:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:06:50 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--stylo'], 18:06:50 INFO - 'tests': ['tp5o']}, 18:06:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:50 INFO - 'talos_options': ['--mitmproxy', 18:06:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:50 INFO - '--firstNonBlankPaint'], 18:06:50 INFO - 'tests': ['tp6_google', 18:06:50 INFO - 'tp6_youtube', 18:06:50 INFO - 'tp6_amazon', 18:06:50 INFO - 'tp6_facebook']}, 18:06:50 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:50 INFO - 'talos_options': ['--stylo', 18:06:50 INFO - '--mitmproxy', 18:06:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:50 INFO - '--firstNonBlankPaint'], 18:06:50 INFO - 'tests': ['tp6_google', 18:06:50 INFO - 'tp6_youtube', 18:06:50 INFO - 'tp6_amazon', 18:06:50 INFO - 'tp6_facebook']}, 18:06:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:50 INFO - 'talos_options': ['--stylo', 18:06:50 INFO - '--stylo-threads=1', 18:06:50 INFO - '--mitmproxy', 18:06:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:50 INFO - '--firstNonBlankPaint'], 18:06:50 INFO - 'tests': ['tp6_google', 18:06:50 INFO - 'tp6_youtube', 18:06:50 INFO - 'tp6_amazon', 18:06:50 INFO - 'tp6_facebook']}, 18:06:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--xperf_path', 18:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:50 INFO - 'tests': ['tp5n']}, 18:06:50 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:06:50 INFO - 'talos_options': ['--stylo', 18:06:50 INFO - '--xperf_path', 18:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:50 INFO - 'tests': ['tp5n']}}} 18:06:50 INFO - Running post-action listener: _resource_record_post_action 18:06:50 INFO - [mozharness: 2017-08-25 01:06:50.800724Z] Finished populate-webroot step (success) 18:06:50 INFO - [mozharness: 2017-08-25 01:06:50.800814Z] Running create-virtualenv step. 18:06:50 INFO - Running pre-action listener: _resource_record_pre_action 18:06:50 INFO - Running main action method: create_virtualenv 18:06:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:06:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:06:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:06:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:06:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:06:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:51 INFO - Installing pip...............done. 18:06:51 INFO - Return code: 0 18:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:06:52 INFO - Reading from file tmpfile_stdout 18:06:52 INFO - Output received: 18:06:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:06:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:06:52 INFO - Using env: {'DISPLAY': ':0', 18:06:52 INFO - 'HOME': '/home/cltbld', 18:06:52 INFO - 'LANG': 'en_US.UTF-8', 18:06:52 INFO - 'LANGUAGE': 'en_US:en', 18:06:52 INFO - 'LOGNAME': 'cltbld', 18:06:52 INFO - 'MAIL': '/var/mail/cltbld', 18:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:52 INFO - 'MOZ_NO_REMOTE': '1', 18:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:52 INFO - 'NO_EM_RESTART': '1', 18:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:52 INFO - 'PWD': '/builds/slave/test', 18:06:52 INFO - 'SHELL': '/bin/bash', 18:06:52 INFO - 'SHLVL': '1', 18:06:52 INFO - 'TERM': 'linux', 18:06:52 INFO - 'TMOUT': '86400', 18:06:52 INFO - 'USER': 'cltbld', 18:06:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:52 INFO - '_': '/tools/buildbot/bin/python'} 18:06:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:06:53 INFO - Downloading/unpacking pip>=1.5 18:06:53 INFO - Running setup.py egg_info for package pip 18:06:53 INFO - warning: no files found matching 'pip/cacert.pem' 18:06:53 INFO - warning: no files found matching '*.html' under directory 'docs' 18:06:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:06:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:06:53 INFO - Installing collected packages: pip 18:06:53 INFO - Found existing installation: pip 1.1 18:06:53 INFO - Uninstalling pip: 18:06:53 INFO - Successfully uninstalled pip 18:06:53 INFO - Running setup.py install for pip 18:06:53 INFO - warning: no files found matching 'pip/cacert.pem' 18:06:53 INFO - warning: no files found matching '*.html' under directory 'docs' 18:06:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:06:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:06:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:06:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:06:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:06:53 INFO - Successfully installed pip 18:06:53 INFO - Cleaning up... 18:06:53 INFO - Return code: 0 18:06:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06: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')]} 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06: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', '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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:06: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 psutil>=3.1.1 18:06:53 INFO - Using env: {'DISPLAY': ':0', 18:06:53 INFO - 'HOME': '/home/cltbld', 18:06:53 INFO - 'LANG': 'en_US.UTF-8', 18:06:53 INFO - 'LANGUAGE': 'en_US:en', 18:06:53 INFO - 'LOGNAME': 'cltbld', 18:06:53 INFO - 'MAIL': '/var/mail/cltbld', 18:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:53 INFO - 'MOZ_NO_REMOTE': '1', 18:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:53 INFO - 'NO_EM_RESTART': '1', 18:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:53 INFO - 'PWD': '/builds/slave/test', 18:06:53 INFO - 'SHELL': '/bin/bash', 18:06:53 INFO - 'SHLVL': '1', 18:06:53 INFO - 'TERM': 'linux', 18:06:53 INFO - 'TMOUT': '86400', 18:06:53 INFO - 'USER': 'cltbld', 18:06:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:53 INFO - '_': '/tools/buildbot/bin/python'} 18:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:53 INFO - Downloading/unpacking psutil>=3.1.1 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:54 INFO - Installing collected packages: psutil 18:06:54 INFO - Running setup.py install for psutil 18:06:54 INFO - building 'psutil._psutil_linux' extension 18:06:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:06:54 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 18:06:54 INFO - building 'psutil._psutil_posix' extension 18:06:54 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 18:06:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:55 INFO - Successfully installed psutil 18:06:55 INFO - Cleaning up... 18:06:55 INFO - Return code: 0 18:06:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:06:55 INFO - Using env: {'DISPLAY': ':0', 18:06:55 INFO - 'HOME': '/home/cltbld', 18:06:55 INFO - 'LANG': 'en_US.UTF-8', 18:06:55 INFO - 'LANGUAGE': 'en_US:en', 18:06:55 INFO - 'LOGNAME': 'cltbld', 18:06:55 INFO - 'MAIL': '/var/mail/cltbld', 18:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:55 INFO - 'MOZ_NO_REMOTE': '1', 18:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:55 INFO - 'NO_EM_RESTART': '1', 18:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:55 INFO - 'PWD': '/builds/slave/test', 18:06:55 INFO - 'SHELL': '/bin/bash', 18:06:55 INFO - 'SHLVL': '1', 18:06:55 INFO - 'TERM': 'linux', 18:06:55 INFO - 'TMOUT': '86400', 18:06:55 INFO - 'USER': 'cltbld', 18:06:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:55 INFO - '_': '/tools/buildbot/bin/python'} 18:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:06: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 18:06: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 18:06: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 18:06: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 18:06:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:06:56 INFO - Installing collected packages: mozsystemmonitor 18:06:56 INFO - Running setup.py install for mozsystemmonitor 18:06:56 INFO - Successfully installed mozsystemmonitor 18:06:56 INFO - Cleaning up... 18:06:56 INFO - Return code: 0 18:06:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:06:56 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')]} 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:56 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')]} 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:56 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06:56 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 18:06:56 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 18:06:56 INFO - Using env: {'DISPLAY': ':0', 18:06:56 INFO - 'HOME': '/home/cltbld', 18:06:56 INFO - 'LANG': 'en_US.UTF-8', 18:06:56 INFO - 'LANGUAGE': 'en_US:en', 18:06:56 INFO - 'LOGNAME': 'cltbld', 18:06:56 INFO - 'MAIL': '/var/mail/cltbld', 18:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:56 INFO - 'MOZ_NO_REMOTE': '1', 18:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:56 INFO - 'NO_EM_RESTART': '1', 18:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:56 INFO - 'PWD': '/builds/slave/test', 18:06:56 INFO - 'SHELL': '/bin/bash', 18:06:56 INFO - 'SHLVL': '1', 18:06:56 INFO - 'TERM': 'linux', 18:06:56 INFO - 'TMOUT': '86400', 18:06:56 INFO - 'USER': 'cltbld', 18:06:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:56 INFO - '_': '/tools/buildbot/bin/python'} 18:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:58 INFO - warning: no files found matching '*.txt' 18:06:58 INFO - no previously-included directories found matching 'build' 18:06:58 INFO - no previously-included directories found matching 'dist' 18:06:58 INFO - no previously-included directories found matching '.git*' 18:06:58 INFO - Installing collected packages: jsonschema, functools32 18:06:58 INFO - Running setup.py install for functools32 18:06:58 INFO - warning: no files found matching '*.txt' 18:06:58 INFO - no previously-included directories found matching 'build' 18:06:58 INFO - no previously-included directories found matching 'dist' 18:06:58 INFO - no previously-included directories found matching '.git*' 18:06:58 INFO - Successfully installed jsonschema functools32 18:06:58 INFO - Cleaning up... 18:06:58 INFO - Return code: 0 18:06:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06: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')]} 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:58 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06:58 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 18:06:58 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 18:06:58 INFO - Using env: {'DISPLAY': ':0', 18:06:58 INFO - 'HOME': '/home/cltbld', 18:06:58 INFO - 'LANG': 'en_US.UTF-8', 18:06:58 INFO - 'LANGUAGE': 'en_US:en', 18:06:58 INFO - 'LOGNAME': 'cltbld', 18:06:58 INFO - 'MAIL': '/var/mail/cltbld', 18:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:58 INFO - 'MOZ_NO_REMOTE': '1', 18:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:58 INFO - 'NO_EM_RESTART': '1', 18:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:58 INFO - 'PWD': '/builds/slave/test', 18:06:58 INFO - 'SHELL': '/bin/bash', 18:06:58 INFO - 'SHLVL': '1', 18:06:58 INFO - 'TERM': 'linux', 18:06:58 INFO - 'TMOUT': '86400', 18:06:58 INFO - 'USER': 'cltbld', 18:06:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:58 INFO - '_': '/tools/buildbot/bin/python'} 18:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:06:58 INFO - Cleaning up... 18:06:58 INFO - Return code: 0 18:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06: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')]} 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:58 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:06:58 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 18:06:58 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 18:06:58 INFO - Using env: {'DISPLAY': ':0', 18:06:58 INFO - 'HOME': '/home/cltbld', 18:06:58 INFO - 'LANG': 'en_US.UTF-8', 18:06:58 INFO - 'LANGUAGE': 'en_US:en', 18:06:58 INFO - 'LOGNAME': 'cltbld', 18:06:58 INFO - 'MAIL': '/var/mail/cltbld', 18:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:58 INFO - 'MOZ_NO_REMOTE': '1', 18:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:58 INFO - 'NO_EM_RESTART': '1', 18:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:58 INFO - 'PWD': '/builds/slave/test', 18:06:58 INFO - 'SHELL': '/bin/bash', 18:06:58 INFO - 'SHLVL': '1', 18:06:58 INFO - 'TERM': 'linux', 18:06:58 INFO - 'TMOUT': '86400', 18:06:58 INFO - 'USER': 'cltbld', 18:06:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:58 INFO - '_': '/tools/buildbot/bin/python'} 18:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:06:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:07:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:00 INFO - Downloading docopt-0.6.1.tar.gz 18:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:07:00 INFO - Installing collected packages: blobuploader, requests, docopt 18:07:00 INFO - Running setup.py install for blobuploader 18:07:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:07:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:07:00 INFO - Running setup.py install for requests 18:07:00 INFO - Running setup.py install for docopt 18:07:00 INFO - Successfully installed blobuploader requests docopt 18:07:00 INFO - Cleaning up... 18:07:01 INFO - Return code: 0 18:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07: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')]} 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07: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')]} 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:01 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:07:01 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 18:07:01 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 18:07:01 INFO - Using env: {'DISPLAY': ':0', 18:07:01 INFO - 'HOME': '/home/cltbld', 18:07:01 INFO - 'LANG': 'en_US.UTF-8', 18:07:01 INFO - 'LANGUAGE': 'en_US:en', 18:07:01 INFO - 'LOGNAME': 'cltbld', 18:07:01 INFO - 'MAIL': '/var/mail/cltbld', 18:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:01 INFO - 'MOZ_NO_REMOTE': '1', 18:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:01 INFO - 'NO_EM_RESTART': '1', 18:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:01 INFO - 'PWD': '/builds/slave/test', 18:07:01 INFO - 'SHELL': '/bin/bash', 18:07:01 INFO - 'SHLVL': '1', 18:07:01 INFO - 'TERM': 'linux', 18:07:01 INFO - 'TMOUT': '86400', 18:07:01 INFO - 'USER': 'cltbld', 18:07:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:01 INFO - '_': '/tools/buildbot/bin/python'} 18:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:01 INFO - Running setup.py (path:/tmp/pip-IfhqEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:01 INFO - Running setup.py (path:/tmp/pip-IQqUHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:01 INFO - Running setup.py (path:/tmp/pip-yhlSKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:01 INFO - Running setup.py (path:/tmp/pip-7D0sep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:01 INFO - Running setup.py (path:/tmp/pip-pqFVaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:01 INFO - Running setup.py (path:/tmp/pip-FeD9rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:01 INFO - Running setup.py (path:/tmp/pip-fFT7Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:01 INFO - Running setup.py (path:/tmp/pip-PYnaf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:01 INFO - Running setup.py (path:/tmp/pip-IGwde0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:01 INFO - Running setup.py (path:/tmp/pip-Ceg0I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:01 INFO - Running setup.py (path:/tmp/pip-RAp5FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:02 INFO - Running setup.py (path:/tmp/pip-G7X08k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:02 INFO - Running setup.py (path:/tmp/pip-V6y6nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:02 INFO - Running setup.py (path:/tmp/pip-80YsJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:02 INFO - Running setup.py (path:/tmp/pip-GNAdDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:02 INFO - Running setup.py (path:/tmp/pip-xFBGZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:02 INFO - Running setup.py (path:/tmp/pip-wAcaUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:07:02 INFO - Running setup.py install for manifestparser 18:07:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:07:02 INFO - Running setup.py install for mozcrash 18:07:02 INFO - Running setup.py install for mozdebug 18:07:02 INFO - Running setup.py install for mozdevice 18:07:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:07:02 INFO - Running setup.py install for mozfile 18:07:02 INFO - Running setup.py install for mozhttpd 18:07:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozinfo 18:07:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozInstall 18:07:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozleak 18:07:03 INFO - Running setup.py install for mozlog 18:07:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for moznetwork 18:07:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozprocess 18:07:03 INFO - Running setup.py install for mozprofile 18:07:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozrunner 18:07:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozscreenshot 18:07:03 INFO - Running setup.py install for moztest 18:07:04 INFO - Running setup.py install for mozversion 18:07:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:07:04 INFO - Cleaning up... 18:07:04 INFO - Return code: 0 18:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07: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')]} 18:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07: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')]} 18:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:04 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:07:04 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 18:07:04 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 18:07:04 INFO - Using env: {'DISPLAY': ':0', 18:07:04 INFO - 'HOME': '/home/cltbld', 18:07:04 INFO - 'LANG': 'en_US.UTF-8', 18:07:04 INFO - 'LANGUAGE': 'en_US:en', 18:07:04 INFO - 'LOGNAME': 'cltbld', 18:07:04 INFO - 'MAIL': '/var/mail/cltbld', 18:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:04 INFO - 'MOZ_NO_REMOTE': '1', 18:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:04 INFO - 'NO_EM_RESTART': '1', 18:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:04 INFO - 'PWD': '/builds/slave/test', 18:07:04 INFO - 'SHELL': '/bin/bash', 18:07:04 INFO - 'SHLVL': '1', 18:07:04 INFO - 'TERM': 'linux', 18:07:04 INFO - 'TMOUT': '86400', 18:07:04 INFO - 'USER': 'cltbld', 18:07:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:04 INFO - '_': '/tools/buildbot/bin/python'} 18:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:04 INFO - Running setup.py (path:/tmp/pip-_WZMU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:04 INFO - Running setup.py (path:/tmp/pip-OLhgkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:04 INFO - Running setup.py (path:/tmp/pip-X5zrJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:04 INFO - Running setup.py (path:/tmp/pip-ABvky3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:04 INFO - Running setup.py (path:/tmp/pip-xnd0k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:04 INFO - Running setup.py (path:/tmp/pip-nggR4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:04 INFO - Running setup.py (path:/tmp/pip-VviJMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:04 INFO - Running setup.py (path:/tmp/pip-sxIb6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:04 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)) 18:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:04 INFO - Running setup.py (path:/tmp/pip-cPQF8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:05 INFO - Running setup.py (path:/tmp/pip-H2RE_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:05 INFO - Running setup.py (path:/tmp/pip-qBsBab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:05 INFO - Running setup.py (path:/tmp/pip-6fp7fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:05 INFO - Running setup.py (path:/tmp/pip-kXmTzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:05 INFO - Running setup.py (path:/tmp/pip-EOgqKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:05 INFO - Running setup.py (path:/tmp/pip-NKjZVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:05 INFO - Running setup.py (path:/tmp/pip-tbjPwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:05 INFO - Running setup.py (path:/tmp/pip-yRz_j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:05 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)) 18:07:05 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)) 18:07:05 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)) 18:07:05 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)) 18:07:05 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)) 18:07:05 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)) 18:07:05 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)) 18:07:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:06 INFO - Downloading blessings-1.6.tar.gz 18:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:07:06 INFO - Installing collected packages: blessings 18:07:06 INFO - Running setup.py install for blessings 18:07:06 INFO - Successfully installed blessings 18:07:06 INFO - Cleaning up... 18:07:06 INFO - Return code: 0 18:07:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:07 INFO - Reading from file tmpfile_stdout 18:07:07 INFO - Current package versions: 18:07:07 INFO - argparse == 1.2.1 18:07:07 INFO - blessings == 1.6 18:07:07 INFO - blobuploader == 1.2.4 18:07:07 INFO - docopt == 0.6.1 18:07:07 INFO - functools32 == 3.2.3-2 18:07:07 INFO - jsonschema == 2.5.1 18:07:07 INFO - manifestparser == 1.1 18:07:07 INFO - mozInstall == 1.13 18:07:07 INFO - mozcrash == 1.0 18:07:07 INFO - mozdebug == 0.1 18:07:07 INFO - mozdevice == 0.51 18:07:07 INFO - mozfile == 1.2 18:07:07 INFO - mozhttpd == 0.7 18:07:07 INFO - mozinfo == 0.10 18:07:07 INFO - mozleak == 0.1 18:07:07 INFO - mozlog == 3.5 18:07:07 INFO - moznetwork == 0.27 18:07:07 INFO - mozprocess == 0.25 18:07:07 INFO - mozprofile == 0.28 18:07:07 INFO - mozrunner == 6.13 18:07:07 INFO - mozscreenshot == 0.1 18:07:07 INFO - mozsystemmonitor == 0.3 18:07:07 INFO - moztest == 0.8 18:07:07 INFO - mozversion == 1.4 18:07:07 INFO - psutil == 3.1.1 18:07:07 INFO - requests == 1.2.3 18:07:07 INFO - wsgiref == 0.1.2 18:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07: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')]} 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07: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')]} 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:07 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:07:07 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 18:07:07 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 18:07:07 INFO - Using env: {'DISPLAY': ':0', 18:07:07 INFO - 'HOME': '/home/cltbld', 18:07:07 INFO - 'LANG': 'en_US.UTF-8', 18:07:07 INFO - 'LANGUAGE': 'en_US:en', 18:07:07 INFO - 'LOGNAME': 'cltbld', 18:07:07 INFO - 'MAIL': '/var/mail/cltbld', 18:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:07 INFO - 'MOZ_NO_REMOTE': '1', 18:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:07 INFO - 'NO_EM_RESTART': '1', 18:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:07 INFO - 'PWD': '/builds/slave/test', 18:07:07 INFO - 'SHELL': '/bin/bash', 18:07:07 INFO - 'SHLVL': '1', 18:07:07 INFO - 'TERM': 'linux', 18:07:07 INFO - 'TMOUT': '86400', 18:07:07 INFO - 'USER': 'cltbld', 18:07:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:07 INFO - '_': '/tools/buildbot/bin/python'} 18:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 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)) 18:07:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:07:08 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)) 18:07:08 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)) 18:07:08 INFO - Installing collected packages: simplejson 18:07:08 INFO - Running setup.py install for simplejson 18:07:08 INFO - building 'simplejson._speedups' extension 18:07:08 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 18:07:09 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 18:07:09 INFO - Successfully installed simplejson 18:07:09 INFO - Cleaning up... 18:07:09 INFO - Return code: 0 18:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:09 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', '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 18:07:09 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 18:07:09 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 18:07:09 INFO - Using env: {'DISPLAY': ':0', 18:07:09 INFO - 'HOME': '/home/cltbld', 18:07:09 INFO - 'LANG': 'en_US.UTF-8', 18:07:09 INFO - 'LANGUAGE': 'en_US:en', 18:07:09 INFO - 'LOGNAME': 'cltbld', 18:07:09 INFO - 'MAIL': '/var/mail/cltbld', 18:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:09 INFO - 'MOZ_NO_REMOTE': '1', 18:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:09 INFO - 'NO_EM_RESTART': '1', 18:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:09 INFO - 'PWD': '/builds/slave/test', 18:07:09 INFO - 'SHELL': '/bin/bash', 18:07:09 INFO - 'SHLVL': '1', 18:07:09 INFO - 'TERM': 'linux', 18:07:09 INFO - 'TMOUT': '86400', 18:07:09 INFO - 'USER': 'cltbld', 18:07:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:09 INFO - '_': '/tools/buildbot/bin/python'} 18:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:07:09 INFO - Cleaning up... 18:07:09 INFO - Return code: 0 18:07:09 INFO - Running post-action listener: _resource_record_post_action 18:07:09 INFO - Running post-action listener: _start_resource_monitoring 18:07:09 INFO - Starting resource monitoring. 18:07:09 INFO - [mozharness: 2017-08-25 01:07:09.859991Z] Finished create-virtualenv step (success) 18:07:09 INFO - [mozharness: 2017-08-25 01:07:09.860507Z] Running install step. 18:07:09 INFO - Running pre-action listener: _resource_record_pre_action 18:07:09 INFO - Running main action method: install 18:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:10 INFO - Reading from file tmpfile_stdout 18:07:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:07:10 INFO - Reading from file tmpfile_stdout 18:07:10 INFO - Output received: 18:07:10 INFO - Usage: mozinstall [options] installer 18:07:10 INFO - Options: 18:07:10 INFO - -h, --help show this help message and exit 18:07:10 INFO - -d DEST, --destination=DEST 18:07:10 INFO - Directory to install application into. [default: 18:07:10 INFO - "/builds/slave/test"] 18:07:10 INFO - --app=APP Application being installed. [default: firefox] 18:07:10 INFO - mkdir: /builds/slave/test/build/application 18:07:10 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'] 18:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:07:27 INFO - Reading from file tmpfile_stdout 18:07:27 INFO - Output received: 18:07:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:27 INFO - Running post-action listener: _resource_record_post_action 18:07:27 INFO - [mozharness: 2017-08-25 01:07:27.867632Z] Finished install step (success) 18:07:27 INFO - [mozharness: 2017-08-25 01:07:27.867883Z] Running setup-mitmproxy step. 18:07:27 INFO - Running pre-action listener: _resource_record_pre_action 18:07:27 INFO - Running main action method: setup_mitmproxy 18:07:27 INFO - Skipping: mitmproxy is not required 18:07:27 INFO - Running post-action listener: _resource_record_post_action 18:07:27 INFO - [mozharness: 2017-08-25 01:07:27.869007Z] Finished setup-mitmproxy step (success) 18:07:27 INFO - [mozharness: 2017-08-25 01:07:27.869226Z] Running run-tests step. 18:07:27 INFO - Running pre-action listener: _resource_record_pre_action 18:07:27 INFO - Running pre-action listener: _set_gcov_prefix 18:07:27 INFO - Running main action method: run_tests 18:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:27 INFO - Python 2.7.3 18:07:27 INFO - Return code: 0 18:07:27 INFO - grabbing minidump binary from tooltool 18:07:27 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')]} 18:07:27 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 0xd3a130>, '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 0xd3b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3b4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:27 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 18:07:27 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 18:07:27 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 18:07:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:27 INFO - Return code: 0 18:07:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:27 INFO - ENV: RUST_BACKTRACE is now full 18:07:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:27 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/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:07:27 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/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:07:28 INFO - Using env: {'DISPLAY': ':0', 18:07:28 INFO - 'HOME': '/home/cltbld', 18:07:28 INFO - 'LANG': 'en_US.UTF-8', 18:07:28 INFO - 'LANGUAGE': 'en_US:en', 18:07:28 INFO - 'LOGNAME': 'cltbld', 18:07:28 INFO - 'MAIL': '/var/mail/cltbld', 18:07:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:28 INFO - 'MOZ_NO_REMOTE': '1', 18:07:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:28 INFO - 'NO_EM_RESTART': '1', 18:07:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:28 INFO - 'PWD': '/builds/slave/test', 18:07:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:28 INFO - 'RUST_BACKTRACE': 'full', 18:07:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:07:28 INFO - 'SHELL': '/bin/bash', 18:07:28 INFO - 'SHLVL': '1', 18:07:28 INFO - 'STYLO_FORCE_ENABLED': '1', 18:07:28 INFO - 'TERM': 'linux', 18:07:28 INFO - 'TMOUT': '86400', 18:07:28 INFO - 'USER': 'cltbld', 18:07:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941', 18:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:28 INFO - '_': '/tools/buildbot/bin/python'} 18:07:28 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/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:07:28 INFO - mozversion application_buildid: 20170825001342 18:07:28 INFO - mozversion application_changeset: 3199bacd6b3827d711155a9e81c081434cf7cd8f 18:07:28 INFO - mozversion application_display_name: Nightly 18:07:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:28 INFO - mozversion application_name: Firefox 18:07:28 INFO - mozversion application_remotingname: firefox 18:07:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:07:28 INFO - mozversion application_vendor: Mozilla 18:07:28 INFO - mozversion application_version: 57.0a1 18:07:28 INFO - mozversion platform_buildid: 20170825001342 18:07:28 INFO - mozversion platform_changeset: 3199bacd6b3827d711155a9e81c081434cf7cd8f 18:07:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:07:28 INFO - mozversion platform_version: 57.0a1 18:07:28 INFO - using testdate: 1503623248 18:07:28 INFO - actual date: 1503623248 18:07:28 INFO - starting webserver on 'localhost:57719' 18:07:28 INFO - SUITE-START | Running 2 tests 18:07:28 INFO - TEST-START | dromaeo_css 18:07:28 INFO - Initialising browser for dromaeo_css test... 18:07:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57719/getInfo.html -profile /tmp/tmp8R1Tt5/profile 18:07:28 INFO - TEST-INFO | started process 16481 (/builds/slave/test/build/application/firefox/firefox http://localhost:57719/getInfo.html) 18:07:33 INFO - TEST-INFO | 16481: exit 0 18:07:34 INFO - Browser initialized. 18:07:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:34 INFO - TEST-INFO | started process 16670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8R1Tt5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:35 INFO - PID 16670 | 18:07:35 INFO - PID 16670 | (/builds/slave/test/build/application/firefox/firefox:16719): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:07:35 INFO - PID 16670 | 18:07:35 INFO - PID 16670 | 18:07:35 INFO - PID 16670 | (/builds/slave/test/build/application/firefox/firefox:16783): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:07:35 INFO - PID 16670 | 18:07:35 INFO - PID 16670 | __metrics Screen width/height:1600/1200 18:07:35 INFO - PID 16670 | colorDepth:24 18:07:35 INFO - PID 16670 | Browser inner width/height: 1024/768 18:07:35 INFO - PID 16670 | __metrics 18:07:45 INFO - PID 16670 | RSS: Main: 174653440 18:07:45 INFO - PID 16670 | 18:10:43 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57719/tests/dromaeo/cssquery-ext.html) 18:10:44 INFO - PID 16670 | RSS: Main: 178487296 18:10:44 INFO - PID 16670 | 18:13:46 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-ext.html (next: http://localhost:57719/tests/dromaeo/cssquery-jquery.html) 18:13:46 INFO - PID 16670 | RSS: Main: 174964736 18:13:46 INFO - PID 16670 | 18:16:48 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57719/tests/dromaeo/cssquery-mootools.html) 18:16:49 INFO - PID 16670 | RSS: Main: 177434624 18:16:49 INFO - PID 16670 | 18:19:51 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57719/tests/dromaeo/cssquery-prototype.html) 18:19:51 INFO - PID 16670 | RSS: Main: 173854720 18:19:51 INFO - PID 16670 | 18:22:55 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57719/tests/dromaeo/cssquery-yui.html) 18:22:55 INFO - PID 16670 | RSS: Main: 179265536 18:22:55 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-yui.html (next: http://localhost:57719/tests/dromaeo/cssquery-dojo.html) 18:25:57 INFO - PID 16670 | RSS: Main: 179822592 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | __start_tp_report 18:25:57 INFO - PID 16670 | _x_x_mozilla_page_load 18:25:57 INFO - PID 16670 | _x_x_mozilla_page_load_details 18:25:57 INFO - PID 16670 | |i|pagename|runs| 18:25:57 INFO - PID 16670 | |0;dojo.html;3250.9837450812743;3283.228441316291;3287.8684852605898;3293.489509126085;3332.3668502984447;6251.249850017993;6252.7498900044;6315.305316415191;6346.174997250357;6374.394432528914;6117.877642447148;6244.188255526775;6250.187475628173;6270.122182894398;6291.0248911418685;5673.319201695802;5687.943120568803;5711.971440142794;5747.396523365028;5802.97098514509;5716.914246286309;5744.3394009689;5766.596338256324;5768.884622307552;5830.912536311958;84.11865704239663;5662.886742265132;5780.566457515703;5862.50168735658;5877.617954832944;5684.943150568482;5685.061964775807;5716.1997320375185;5782.56630752691;5796.420357964212;5696.601237913348;5703.116017017369;5762.4525670061275;5794.913076303858;5801.419858014207;6183.845403864894;6196.2874269459135;6224.190855188842;6296.024116261987;6320.494360451153;6702.296258892844;6712.228093769181;6749.2238392584495;6800.1159849219775;6815.556988795713;6636.469082473391;6684.131062961784;6740;6776.186857577122;6861.759838405682;6287.96856015717;6293.433590976788;6297.338779428185;6298;6323.177986861679;6880.139982502187;6890.276520965226;6977.476689248225;6991.021257023919;6991.056207412036;6558;6569.967150164219;6610.239822420387;6674.098996635489;6693.732250710014;6543.672816359163;6571.507136964747;6681.966590167018;6759.391654751096;6760.763373281911;6722.865542689216;6730;6737.326267373223;6750.628715420601;6755.256921738604;6693.698783554752;6722.798316050526;6738.528303018742;6788.253292137861;6824.658767061627;4839.637027222902;4865.635077369211;4894.828680996148;4906.0433215522635;4909.582685471703;4324.437823083042;4341.978290108529;4345.760983145894;4356.891077723082;4367.017421080295;5828.358880523139;5842.5618078644275;5868.295804503487;5873.177755114288;5874;6664.100346453264;6726.663666816639;6757.898631520531;6827.1807383113355;6836.179658440919;5704.629199102045;5776.191333213354;5777.971110144506;5803.332616749043;5860.062390017577;5699.287589051369;5711.914321285184;5731.426857314235;5776.826695199066;5778.27771528559;6470.579412338183;6547.083408322838;6554.3117972613145;6561.245456772533;6563.737450502022;6674.399304062657;6692.330766923269;6796.286389929184;6822.215445223665;6835.453163746888;6409.134766806422;6430.453411459891;6502.154719886385;6507.707153178024;6539.11721917535;6659.733610655713;6678.699458524476;6679.6994135265;6689.531732778659;6704.06143139951;6758.7296508139125;6761.152763593675;6762;6845.965770171118;6857.040014398088;6518.250401203923;6537.8692426152165;6611.504137189634;6613.470922326299;6619.470442364695;6414.262359828679;6501.934980650133;6503.447206987459;6505.447037001908;6599.274079851117;6356.11014457967;6366.936330636634;6373.649449280334;6374.235091789015;6378.52161087911;6448.645324507197;6499.545031847725;6533.314002029719;6588.8023359299295;6618.172728408949;6275.058741188858;6320.399562041599;6418.454431373386;6430.067640192239;6443.7422503101225 18:25:57 INFO - PID 16670 | |1;ext.html;795.9482633628813;848.872669099635;878.9428687135336;879.1252703559957;1079.7462596289865;26995.190144295677;27936.16191514255;27972.440551188964;38000.61999380006;38570.614293857056;38460.42309365362;38771;39015.609843901555;39016;39091.21817563647;7573;7654.158042615308;7667.731629392944;7719.035120609924;7737.3036426721865;7086.326798954117;7601.581912994783;7671.079470463552;7682.692692292301;7702.614869256543;7664.463487555873;7694.384449244075;7717.151113377524;7718;7718.6912523498995;7587.430942679293;7605.543667379975;7667.386609071289;7681.846363072736;7688.769336919901;7589.43079269057;7623.199564045751;7655.50239234448;7657.885131723028;7662.731804386875;35555;35621.82189089038;35640.82179589086;35663.64336356655;35777.10557236064;3433.4678124890684;3476.930461390758;3486.4247399179103;3488.6162522122545;3488.89533314001;29660.406791864258;29783.851080744673;29867;29893.551596726065;29907.25231869199;4909.2881532177635;5093.617978651616;5107.387113546398;5138.2806407103035;5141.357330333708;187298;188288;188407;188482.99999999863;188878;44255.55744442579;44297.55702442999;44320.3351949721;44444.333335;44592.3311150333;46992.295115573295;47002.52997469981;47339.76330118327;47369.76315118402;47406;15392.461263855936;15682.843171568367;15686.843131568767;15758.842411575737;15785.052896826228;11248.606298779667;13003.739925201444;13018.609441716764;13032.152910060815;13034.869651303556;11818.763624727457;13536.120152190273;13562.796558051637;13729.244891530861;13741.519046833313;5553.444655534414;5634.23937768396;5664.830055098354;5677.290338707661;5689.800856969986;974.6929717139078;991.2912267728609;998.2513115163628;1004.1565085328359;1007.0131271353968;21398.465038373855;21533.24633637815;21704.89147554252;21717.13131474755;22107.668384974237;1086.983695244572;1089.3355053417408;1095.9945200273949;1096.7696783675358;1106.756513567014;11537.942310288396;11713.824292635618;11774.940255377058;11776.234544754563;14894;228633;229257;230290;230431;230977;51680.74159629253;52154.478455214965;53829;55379.72310138423;55665.443345566026;1443.1196969848384;1467.6477645365035;1471.5953112893826;1476.7046590681907;1477.128494188434;26019.21942341733;26627.60058599161;27300.72699272982;27531;27605.861970690017;36871.815640921624;36969;36977.26045479129;36995.63004369922;37131.443028355134;146995.2650236742;149620;149627;149976;150294;32515.18712032218;33953.66046339505;34253.828730856185;34302;34393.312133756684;42696;42718.359224611035;42808.357874631285;43151;43216.78391608022;30938.690613093582;31588.36823263568;31973.68026319707;33213.16967075843;33563.83218083894;32306.676933230367;32568.51147232746;32657;33283;33484.330313394086;35444;35713;36194;36461.635383646884;36657.63342366542;31708.841455793496;32060.19849503781;32063;32150;32172;22494.550108997402;23117.884410578514;23288.6506702403;23486.530269394858;23812.642810358204 18:25:57 INFO - PID 16670 | |2;jquery.html;562.8817948230871;566.8384510414533;571.8913406452772;575.2665351676615;577.5206578539812;21395.251166209186;21855.781442185573;22136.557268854634;22177.223797167102;22298.55402891941;25022.874885625548;25419.36451588711;25428.872855635742;25442.491150177033;25586.360340991483;6489.123968264283;6649.933500665004;6665.533412661116;6666.3000384959605;6667.133272674546;6584.473242140617;6636.933630663704;6811.761588344409;7140.143182818043;7220.458465615074;7182.6408679566075;7186.71253149876;7191.640417979106;7196.280371962815;7204;7206.963965180167;7210.4952653314285;7218.3503484686635;7221.42228621709;7224.096987876515;6916.3429474199875;6997.615131167784;7024.4029257513175;7044.049053377779;7057.4354051676255;29877.701222987926;30685.232869178228;31434.685653143406;31505.21236969071;31660;2013.597280543897;2041.8570700050855;2043.1316690406518;2043.2031507712004;2044.499097721053;20482.283120090724;21047.05288262032;21223.893880530497;21228.5754284915;21233.0445129968;2489.9004039838383;2515.597504399287;2556.782673472757;2571.6014017827265;2588.197658725801;136085;140083.29958350246;140249.2987535066;140267.29866350602;140868;19778;21241.575168496853;21577.892110539346;22309.776902231093;22446.438839029153;43183;43330.100290973336;43365.783171083945;43375.13249734988;43385;11348.092152627934;11406.258593191416;11428.25716328436;11455.770884582262;11506.194566380273;8532.786680333042;9426.670066547638;9546.90453095474;9562.713118606453;9689.70930872075;9578.760530986641;10952.780944381067;10988.011079002928;11331.263467874562;11660.30038197711;3631.388137065964;3635.4183330666965;3851.691864650821;4016.5581786003518;4470.798814053375;949.3070058857073;963.4853033582344;973.5862258540234;975.6975337645353;988.8862780780158;19063.714044289347;19323;19528.8047119527;19628.901855490632;19906.104225309897;1011.5549158370294;1026.1226651213256;1030.108955753268;1030.2324768047852;1034.2605037398296;10608.734781630366;10680.465976701134;10769.192310576738;10770.623028193975;11037.83443248352;472874;479020;481385.18614814105;483328;492183;104951;104971.47514262379;105141;105722.47138764257;106297;1116.6817457024708;1130.6890605083668;1142.2118738070706;1148.1675785055768;1151.3782557419067;16967.830321696623;17019.48941531756;17309.826901730823;17658.02880841566;17746.11269436549;52852.678683033235;55067;56440.43559564352;57163.714181428826;57309.42690573208;69350.30649693438;69426;69841.65079174572;69928.30071699218;70092;15060.54818355451;17336.30654773795;19419.61160776805;19581.70627440618;20210.898945505178;21869.56260874742;22273.44316392103;22353.552928941655;22355;22553.323400298017;17839.910800445916;17986.82013179904;18082.367117150836;18200.72698909491;18251;16180.514584562481;16477.752833707742;16864.072476013447;16919.91540042341;16923.91538042302;17575.736363954296;18074.186661599997;18466;18537.629247414705;18616.627667446846;19366.61266774685;19405.8059419404;19431.611367772282;19534.90232548885;19571.804281956996;17218.741718873975;17913.462596122135;17948.55128621795;18070.457886263433;18073.909630451762 18:25:57 INFO - PID 16670 | |3;mootools.html;1291.6899944013437;1351.89860760443;1366.9521566745166;1374.6082366525543;1379.4757991963052;14313;15069.321880515376;15077.396904123822;15095.471658491968;15109.09345439273;14439.927800360983;15517.689646207069;15535.378584856593;15553.377864885419;15562.84437155628;2674.8796304166312;2742.8217165884253;2746.958795618057;2750.931226719328;2759.0619189475574;2587.6636037315125;2637.7230390808977;2669.8798554065015;2689.8520581368016;2763.1434255380796;2719.524083285427;2748;2750.22993561803;2752.325680208352;2754.1462146734475;2619.1487766475875;2640.1419538650016;2657.255968328871;2657.9867100664374;2659.268701107201;2599.8830052647486;2609.0346571768378;2630.644862943497;2632.0261503243923;2634.4204275059647;14303.49937752184;14666.413343466249;14669.559913202622;14688.192149431778;14738.115713057143;7768.495047821873;7972.561509116997;7999.040115186157;8058.798530036737;8082.5958702065245;5297.788088476456;5463.508284254436;5500.7524661390335;5580.274564306655;5594.0769772987405;1776.9111544422856;1785.1431312969717;1811.184966764961;1817.5274428648647;1821.317006122704;24898.87550562254;24934.875325623256;25141.120060797784;25153.874230628913;25209.117680881263;6998.125234345707;7108.850256815426;7144.3212894774915;7299.562026278334;7362.6318684066655;16966.49100526986;17103.315867365167;17182.65634687299;17191.742123868153;17198.1400929953;7682.7311044113185;7796.610169491502;7801.531908085533;7801.80495487606;7803.063632364153;7149.320814522612;7206.783796486114;7227.494075414776;7324.121105467378;7339.119305683245;5066.36670416198;5191.792328306826;5191.896162076738;5193.454687257859;5221.13851214553;1336.3318340829585;1375.1199232491213;1439.4386189386148;1472.3080152328603;1499.8526127512462;902.7743064233941;918.7106061590578;922.0594993106994;927.9304052196112;936.3866667332908;7712.537247765152;7935.444518883623;8116.35069194463;8327.750167494985;8427.904372431667;992.8212921674168;997.7356000659831;1000.8598796168542;1005.1456262177092;1014.4015031131668;4638.512956139624;5652.660840349592;5689.516391106802;5862.032764593794;5924.9703751480965;20422.489437763878;21273.468163296042;21275.574488510145;21277.574448510943;21280.467988300417;20074.498137546678;20074.799252007586;20369.694454583194;20378.184872605227;20416.0812763426;10485.213608979357;10609.84085238722;10825.621103261348;10832.187585931088;10888.61889833852;8302.211289927447;8841.204291613785;8844.601992910206;8888.64445422176;8969;17540.91229543844;17944.102794859944;17965.640687186446;18320;18447.07764611791;18086.366977155736;18089.547761305545;18191;18276;18331.450056497793;12000.339981300764;12049.277043377426;12158.939205303917;12227.938860305641;12232.938835306122;13518.662033449242;13659.658508536968;13669.179849209078;13676.521321753691;13805.930970345486;11061.391623460788;11246.212765106364;11297.71755706114;11332.830007549728;11338.659840204808;10971.177161713063;10977.506012229309;11058.115350771757;11111.611093611686;11340.206185567262;9500.47747373901;9730.172935300296;9745.902540974499;9749.171320437843;9760.365576237522;7151.499395042505;7219.530730502501;7247.601381924045;7252.347288744038;7321.084864391951;6552.737890484518;6637.402633762985;6663.13379260693;6682.665866706548;6743.561668491532 18:25:57 INFO - PID 16670 | |4;prototype.html;496.33986797559226;498.25858624108747;524.2293828072732;530.2682298428169;530.522529723249;6352.904706429395;6361.745530178793;6370.9362906370925;6386.552941294111;6420.1974753155855;6001.729922153502;6154.507639388849;6194.380561943814;6252.968735156329;6283.863486414618;4947.77735001924;4963.627727920402;5000.7749651265685;5016.147254966664;5065.898682026375;4754.405699287589;4963.627727920402;5003.599712023048;5037.4710655381205;5040.521150490697;4944.579710724593;4956.454789973118;4964.950350496485;5034.471380505049;5051.1413059779925;4940.184869496528;4948.604111671076;4953.85138445849;4981.90036199274;5011.674241174312;4449.7330160190495;4462.107578484283;4469.240229161018;4474.709143905636;4477.171723231213;6121.173641558422;6179.907301390483;6201.116480836387;6220.626762394271;6239.844003899939;5654.264945557051;5674.489295963342;5681.488666020036;5712.428757124296;5784.219130417382;6539.280679125292;6562.212534495891;6568.934310656928;6592.1100651411925;6662.46889148752;4791.904161916742;4805.663603547753;4826.517348265181;4864.635152363587;4881.778026502491;6945.756898508578;6981.720731170798;7032.191298000693;7104.396126329269;7107.751228707022;4969.304297398367;4979.576735977483;4986.950130498722;5007.349044624249;5024.874378140576;5048.570871475966;5085.949140508547;5103.489651034867;5104.540591346722;5109.6678715883345;5689.175069614883;5712.371639119693;5720.8283751487525;5739.483446489752;5744.167095771089;6616.4376028037195;6639.302873198341;6659.267480577133;6708.83227919306;6713.4964877634375;1634.730269505542;1663.7670726098356;1687.5949772054864;1756.4028230401725;1768.9203985820668;1200.6578125234266;1209.6975756060986;1224.253205544617;1228.8218208359738;1233.3771445420005;5758.395368486249;5775.48020678141;5780.364159942403;5786.71066446676;5815.82552523425;6640.568363056386;6757.628330441775;6795.966020169867;6880.931190688029;6922.5154239203775;5709.172170035322;5784.566157538202;5795;5832.1834943108;5845.941540584625;3573.213892943548;3573.2312505310038;3613.259281847215;3638.6179451157777;3647.1429214135187;6446.161998940108;6545.41820725494;6558.80323590293;6590.340965903371;6639.535232533676;6996.19543752475;7017.245773511147;7037.331453511908;7058.258882817333;7058.647067646597;6550.83622909412;6555.213374395008;6634.805734967752;6636.270010298863;6658.667066646648;6809.455243580601;6823.727050918106;6838.316168383122;6856.965715171392;6885.345892140239;6665.666716664245;6769.695363708546;6783.93216067833;6792.558483698544;6818.659067046727;6492.383223593751;6497.610143391412;6510;6525.804225873231;6529.804105876831;4909.140900342497;4929.014197160654;4957.529034741694;4990.675606085593;5000.2499625056535;6523.858324793047;6737.494687898329;6800.659967001531;6827.317268273332;6876.621785801629;6399.64801935898;6536.182977127859;6545.410913017851;6573.5069869759;6585.374389432996;6550.541462097607;6565.244996825235;6622.801315960529;6626.5030122741955;6691.0595927180575;6281.371862813682;6407.8718425630295;6424.421802037839;6464.644444555406;6488.351164883474;6585;6644.46844252449;6672.866542669217;6703.162104736908;6723.2940541244425;6453.064305675557;6454.838629034124;6460.773872914426;6463.61032378041;6464.095026696173 18:25:57 INFO - PID 16670 | |5;yui.html;867.4200222823495;869.5826003518312;887.4054383563013;894.0924961164416;895.2524641923995;18583.5354116147;19713.21147154114;19743.111559979818;19758.90120549399;21494.462638434008;19961.401157965283;20136.798632013677;20684.379468615927;20852.270170544034;20865.791342086573;901.0583939782942;910.3036177324352;912.726182145357;913.8309412758628;914.0813482450128;912.6896855069275;955.7515046088032;959.3716115944068;959.3811991265665;963.4123184857267;1006.124671535765;1007.2395341517145;1007.4861820471575;1008.4151192308481;1012.0385633648064;1011.2466212671533;1012.357153207711;1012.4583347908871;1012.5645972231937;1020.2042406922612;738.6860584251725;741.5031928607846;742.2911119880555;743.4052757793744;747.2527472527472;18864.905675471673;19221;19329.51676208092;19429.514262143417;19770.604587908307;20650.380488585368;20715.171393144257;21117.68323475149;21307.041183146797;21361.67957480639;16050.518484445485;16338.428155014517;16515.256813443422;16530;16841.578960525963;3656.177360093984;3705.0366904604725;3707.295613833363;3708.8145592720525;3713.721470889694;120315;125057;127230.36384818109;129256.12231633066;131171;15293.541193764206;15502.689946201239;15824.68350632981;15877.12675802842;15949.760753588705;29343.85328073346;29495.705042949296;29576.408471830444;29610;29670.55494167589;7499.362554182846;7825.413094017971;8558.914410855936;8736.956315218384;8768.605412756313;4270;4361.80371883266;4368.170047690992;4377.146456440963;4381.1237752449;5056.570191533688;5126.512981266774;5143.27994080829;5185.377754669464;5205.427402985669;1074.9301295415773;1083.669480808361;1100.6092837042734;1103.5475455063386;1109.173665619119;668.6255696809802;671.771597656799;677.9830504237335;690.3407246080081;702.2977022977022;11158.721031974266;11241.381724005258;11604.071674266039;13634.454621815215;13795.310234488436;639.66097968077;695.6382681005848;700.1423256510734;707.1478867964091;719.7444907058024;5435.755391007414;5700.25896633435;5845.035569131046;6083.330833608299;6346.555741098079;104176.95823041673;110248;113579;121041.78958210482;122423.38788306179;99425.50287248663;101539;103121.48439257756;103820;107426;88305;90004;91414.54292728627;94222.99999999863;98908.50545747225;11540.653780386601;11622.476988535367;12126.454309556268;12578.30819304947;12906.225626462443;40043.1991360177;40569.391459128725;40688.59311406848;41378.586214137475;42023.57976420319;52895.73552132369;53218.46781532135;54259.45740542544;54867.725661371434;56123.43876561346;18136.727949080512;18242.543936401697;18747;18750.156242968827;19084.713729293795;20857.68713469269;21050.578988420453;21150.894245528674;21986.340409787732;22139.225127120473;18266;18299.26802927868;18303.54241143982;18553.628927421647;19238.326658566883;19116.139773710496;19526.31657891967;19699.507512312306;19859.349103885754;19935.501612459804;17210.741838872178;17518;17795.555111122325;18020.18909149118;18251.0874456274;13633;13680.589582312547;13686.589402317946;14036.929815350857;14090.718185636435;13683.863161368658;13949.497670427676;13979.316928828955;14053.859461405664;14057.929710351384 18:25:57 INFO - PID 16670 | __end_tp_report 18:25:57 INFO - PID 16670 | __start_cc_report 18:25:57 INFO - PID 16670 | _x_x_mozilla_cycle_collect,387 18:25:57 INFO - PID 16670 | __end_cc_report 18:25:57 INFO - PID 16670 | __startTimestamp1503624357959__endTimestamp 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | ------- Summary: start ------- 18:25:57 INFO - PID 16670 | Number of tests: 6 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#0] dojo.html Cycles:165 Average:6128.14 Median:6414.26 stddev:898.74 (14.0%) stddev-sans-first:872.70 18:25:57 INFO - PID 16670 | Values: 3251.0 3283.2 3287.9 3293.5 3332.4 6251.2 6252.7 6315.3 6346.2 6374.4 6117.9 6244.2 6250.2 6270.1 6291.0 5673.3 5687.9 5712.0 5747.4 5803.0 5716.9 5744.3 5766.6 5768.9 5830.9 84.1 5662.9 5780.6 5862.5 5877.6 5684.9 5685.1 5716.2 5782.6 5796.4 5696.6 5703.1 5762.5 5794.9 5801.4 6183.8 6196.3 6224.2 6296.0 6320.5 6702.3 6712.2 6749.2 6800.1 6815.6 6636.5 6684.1 6740.0 6776.2 6861.8 6288.0 6293.4 6297.3 6298.0 6323.2 6880.1 6890.3 6977.5 6991.0 6991.1 6558.0 6570.0 6610.2 6674.1 6693.7 6543.7 6571.5 6682.0 6759.4 6760.8 6722.9 6730.0 6737.3 6750.6 6755.3 6693.7 6722.8 6738.5 6788.3 6824.7 4839.6 4865.6 4894.8 4906.0 4909.6 4324.4 4342.0 4345.8 4356.9 4367.0 5828.4 5842.6 5868.3 5873.2 5874.0 6664.1 6726.7 6757.9 6827.2 6836.2 5704.6 5776.2 5778.0 5803.3 5860.1 5699.3 5711.9 5731.4 5776.8 5778.3 6470.6 6547.1 6554.3 6561.2 6563.7 6674.4 6692.3 6796.3 6822.2 6835.5 6409.1 6430.5 6502.2 6507.7 6539.1 6659.7 6678.7 6679.7 6689.5 6704.1 6758.7 6761.2 6762.0 6846.0 6857.0 6518.3 6537.9 6611.5 6613.5 6619.5 6414.3 6501.9 6503.4 6505.4 6599.3 6356.1 6366.9 6373.6 6374.2 6378.5 6448.6 6499.5 6533.3 6588.8 6618.2 6275.1 6320.4 6418.5 6430.1 6443.7 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#1] ext.html Cycles:180 Average:35523.87 Median:18913.39 stddev:49757.08 (263.1%) stddev-sans-first:49828.33 18:25:57 INFO - PID 16670 | Values: 795.9 848.9 878.9 879.1 1079.7 26995.2 27936.2 27972.4 38000.6 38570.6 38460.4 38771.0 39015.6 39016.0 39091.2 7573.0 7654.2 7667.7 7719.0 7737.3 7086.3 7601.6 7671.1 7682.7 7702.6 7664.5 7694.4 7717.2 7718.0 7718.7 7587.4 7605.5 7667.4 7681.8 7688.8 7589.4 7623.2 7655.5 7657.9 7662.7 35555.0 35621.8 35640.8 35663.6 35777.1 3433.5 3476.9 3486.4 3488.6 3488.9 29660.4 29783.9 29867.0 29893.6 29907.3 4909.3 5093.6 5107.4 5138.3 5141.4 187298.0 188288.0 188407.0 188483.0 188878.0 44255.6 44297.6 44320.3 44444.3 44592.3 46992.3 47002.5 47339.8 47369.8 47406.0 15392.5 15682.8 15686.8 15758.8 15785.1 11248.6 13003.7 13018.6 13032.2 13034.9 11818.8 13536.1 13562.8 13729.2 13741.5 5553.4 5634.2 5664.8 5677.3 5689.8 974.7 991.3 998.3 1004.2 1007.0 21398.5 21533.2 21704.9 21717.1 22107.7 1087.0 1089.3 1096.0 1096.8 1106.8 11537.9 11713.8 11774.9 11776.2 14894.0 228633.0 229257.0 230290.0 230431.0 230977.0 51680.7 52154.5 53829.0 55379.7 55665.4 1443.1 1467.6 1471.6 1476.7 1477.1 26019.2 26627.6 27300.7 27531.0 27605.9 36871.8 36969.0 36977.3 36995.6 37131.4 146995.3 149620.0 149627.0 149976.0 150294.0 32515.2 33953.7 34253.8 34302.0 34393.3 42696.0 42718.4 42808.4 43151.0 43216.8 30938.7 31588.4 31973.7 33213.2 33563.8 32306.7 32568.5 32657.0 33283.0 33484.3 35444.0 35713.0 36194.0 36461.6 36657.6 31708.8 32060.2 32063.0 32150.0 32172.0 22494.6 23117.9 23288.7 23486.5 23812.6 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#2] jquery.html Cycles:180 Average:35381.48 Median:22156.89 stddev:80911.33 (365.2%) stddev-sans-first:81096.07 18:25:57 INFO - PID 16670 | Values: 562.9 566.8 571.9 575.3 577.5 21395.3 21855.8 22136.6 22177.2 22298.6 25022.9 25419.4 25428.9 25442.5 25586.4 6489.1 6649.9 6665.5 6666.3 6667.1 6584.5 6636.9 6811.8 7140.1 7220.5 7182.6 7186.7 7191.6 7196.3 7204.0 7207.0 7210.5 7218.4 7221.4 7224.1 6916.3 6997.6 7024.4 7044.0 7057.4 29877.7 30685.2 31434.7 31505.2 31660.0 2013.6 2041.9 2043.1 2043.2 2044.5 20482.3 21047.1 21223.9 21228.6 21233.0 2489.9 2515.6 2556.8 2571.6 2588.2 136085.0 140083.3 140249.3 140267.3 140868.0 19778.0 21241.6 21577.9 22309.8 22446.4 43183.0 43330.1 43365.8 43375.1 43385.0 11348.1 11406.3 11428.3 11455.8 11506.2 8532.8 9426.7 9546.9 9562.7 9689.7 9578.8 10952.8 10988.0 11331.3 11660.3 3631.4 3635.4 3851.7 4016.6 4470.8 949.3 963.5 973.6 975.7 988.9 19063.7 19323.0 19528.8 19628.9 19906.1 1011.6 1026.1 1030.1 1030.2 1034.3 10608.7 10680.5 10769.2 10770.6 11037.8 472874.0 479020.0 481385.2 483328.0 492183.0 104951.0 104971.5 105141.0 105722.5 106297.0 1116.7 1130.7 1142.2 1148.2 1151.4 16967.8 17019.5 17309.8 17658.0 17746.1 52852.7 55067.0 56440.4 57163.7 57309.4 69350.3 69426.0 69841.7 69928.3 70092.0 15060.5 17336.3 19419.6 19581.7 20210.9 21869.6 22273.4 22353.6 22355.0 22553.3 17839.9 17986.8 18082.4 18200.7 18251.0 16180.5 16477.8 16864.1 16919.9 16923.9 17575.7 18074.2 18466.0 18537.6 18616.6 19366.6 19405.8 19431.6 19534.9 19571.8 17218.7 17913.5 17948.6 18070.5 18073.9 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#3] mootools.html Cycles:180 Average:9175.87 Median:2614.09 stddev:6405.23 (245.0%) stddev-sans-first:6395.81 18:25:57 INFO - PID 16670 | Values: 1291.7 1351.9 1367.0 1374.6 1379.5 14313.0 15069.3 15077.4 15095.5 15109.1 14439.9 15517.7 15535.4 15553.4 15562.8 2674.9 2742.8 2747.0 2750.9 2759.1 2587.7 2637.7 2669.9 2689.9 2763.1 2719.5 2748.0 2750.2 2752.3 2754.1 2619.1 2640.1 2657.3 2658.0 2659.3 2599.9 2609.0 2630.6 2632.0 2634.4 14303.5 14666.4 14669.6 14688.2 14738.1 7768.5 7972.6 7999.0 8058.8 8082.6 5297.8 5463.5 5500.8 5580.3 5594.1 1776.9 1785.1 1811.2 1817.5 1821.3 24898.9 24934.9 25141.1 25153.9 25209.1 6998.1 7108.9 7144.3 7299.6 7362.6 16966.5 17103.3 17182.7 17191.7 17198.1 7682.7 7796.6 7801.5 7801.8 7803.1 7149.3 7206.8 7227.5 7324.1 7339.1 5066.4 5191.8 5191.9 5193.5 5221.1 1336.3 1375.1 1439.4 1472.3 1499.9 902.8 918.7 922.1 927.9 936.4 7712.5 7935.4 8116.4 8327.8 8427.9 992.8 997.7 1000.9 1005.1 1014.4 4638.5 5652.7 5689.5 5862.0 5925.0 20422.5 21273.5 21275.6 21277.6 21280.5 20074.5 20074.8 20369.7 20378.2 20416.1 10485.2 10609.8 10825.6 10832.2 10888.6 8302.2 8841.2 8844.6 8888.6 8969.0 17540.9 17944.1 17965.6 18320.0 18447.1 18086.4 18089.5 18191.0 18276.0 18331.5 12000.3 12049.3 12158.9 12227.9 12232.9 13518.7 13659.7 13669.2 13676.5 13805.9 11061.4 11246.2 11297.7 11332.8 11338.7 10971.2 10977.5 11058.1 11111.6 11340.2 9500.5 9730.2 9745.9 9749.2 9760.4 7151.5 7219.5 7247.6 7252.3 7321.1 6552.7 6637.4 6663.1 6682.7 6743.6 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#4] prototype.html Cycles:180 Average:5552.41 Median:6210.87 stddev:1577.82 (25.4%) stddev-sans-first:1535.93 18:25:57 INFO - PID 16670 | Values: 496.3 498.3 524.2 530.3 530.5 6352.9 6361.7 6370.9 6386.6 6420.2 6001.7 6154.5 6194.4 6253.0 6283.9 4947.8 4963.6 5000.8 5016.1 5065.9 4754.4 4963.6 5003.6 5037.5 5040.5 4944.6 4956.5 4965.0 5034.5 5051.1 4940.2 4948.6 4953.9 4981.9 5011.7 4449.7 4462.1 4469.2 4474.7 4477.2 6121.2 6179.9 6201.1 6220.6 6239.8 5654.3 5674.5 5681.5 5712.4 5784.2 6539.3 6562.2 6568.9 6592.1 6662.5 4791.9 4805.7 4826.5 4864.6 4881.8 6945.8 6981.7 7032.2 7104.4 7107.8 4969.3 4979.6 4987.0 5007.3 5024.9 5048.6 5085.9 5103.5 5104.5 5109.7 5689.2 5712.4 5720.8 5739.5 5744.2 6616.4 6639.3 6659.3 6708.8 6713.5 1634.7 1663.8 1687.6 1756.4 1768.9 1200.7 1209.7 1224.3 1228.8 1233.4 5758.4 5775.5 5780.4 5786.7 5815.8 6640.6 6757.6 6796.0 6880.9 6922.5 5709.2 5784.6 5795.0 5832.2 5845.9 3573.2 3573.2 3613.3 3638.6 3647.1 6446.2 6545.4 6558.8 6590.3 6639.5 6996.2 7017.2 7037.3 7058.3 7058.6 6550.8 6555.2 6634.8 6636.3 6658.7 6809.5 6823.7 6838.3 6857.0 6885.3 6665.7 6769.7 6783.9 6792.6 6818.7 6492.4 6497.6 6510.0 6525.8 6529.8 4909.1 4929.0 4957.5 4990.7 5000.2 6523.9 6737.5 6800.7 6827.3 6876.6 6399.6 6536.2 6545.4 6573.5 6585.4 6550.5 6565.2 6622.8 6626.5 6691.1 6281.4 6407.9 6424.4 6464.6 6488.4 6585.0 6644.5 6672.9 6703.2 6723.3 6453.1 6454.8 6460.8 6463.6 6464.1 18:25:57 INFO - PID 16670 | 18:25:57 INFO - PID 16670 | [#5] yui.html Cycles:180 Average:23823.26 Median:20667.38 stddev:32701.49 (158.2%) stddev-sans-first:32747.79 18:25:57 INFO - PID 16670 | Values: 867.4 869.6 887.4 894.1 895.3 18583.5 19713.2 19743.1 19758.9 21494.5 19961.4 20136.8 20684.4 20852.3 20865.8 901.1 910.3 912.7 913.8 914.1 912.7 955.8 959.4 959.4 963.4 1006.1 1007.2 1007.5 1008.4 1012.0 1011.2 1012.4 1012.5 1012.6 1020.2 738.7 741.5 742.3 743.4 747.3 18864.9 19221.0 19329.5 19429.5 19770.6 20650.4 20715.2 21117.7 21307.0 21361.7 16050.5 16338.4 16515.3 16530.0 16841.6 3656.2 3705.0 3707.3 3708.8 3713.7 120315.0 125057.0 127230.4 129256.1 131171.0 15293.5 15502.7 15824.7 15877.1 15949.8 29343.9 29495.7 29576.4 29610.0 29670.6 7499.4 7825.4 8558.9 8737.0 8768.6 4270.0 4361.8 4368.2 4377.1 4381.1 5056.6 5126.5 5143.3 5185.4 5205.4 1074.9 1083.7 1100.6 1103.5 1109.2 668.6 671.8 678.0 690.3 702.3 11158.7 11241.4 11604.1 13634.5 13795.3 639.7 695.6 700.1 707.1 719.7 5435.8 5700.3 5845.0 6083.3 6346.6 104177.0 110248.0 113579.0 121041.8 122423.4 99425.5 101539.0 103121.5 103820.0 107426.0 88305.0 90004.0 91414.5 94223.0 98908.5 11540.7 11622.5 12126.5 12578.3 12906.2 40043.2 40569.4 40688.6 41378.6 42023.6 52895.7 53218.5 54259.5 54867.7 56123.4 18136.7 18242.5 18747.0 18750.2 19084.7 20857.7 21050.6 21150.9 21986.3 22139.2 18266.0 18299.3 18303.5 18553.6 19238.3 19116.1 19526.3 19699.5 19859.3 19935.5 17210.7 17518.0 17795.6 18020.2 18251.1 13633.0 13680.6 13686.6 14036.9 14090.7 13683.9 13949.5 13979.3 14053.9 14057.9 18:25:57 INFO - PID 16670 | -------- Summary: end -------- 18:25:57 INFO - PID 16670 | 18:25:58 INFO - TEST-INFO | 16670: exit 0 18:25:58 INFO - TEST-OK | dromaeo_css | took 1110463ms 18:25:58 INFO - TEST-START | kraken 18:25:58 INFO - Initialising browser for kraken test... 18:25:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57719/getInfo.html -profile /tmp/tmphJraU2/profile 18:25:58 INFO - TEST-INFO | started process 17096 (/builds/slave/test/build/application/firefox/firefox http://localhost:57719/getInfo.html) 18:26:04 INFO - TEST-INFO | 17096: exit 0 18:26:04 INFO - Browser initialized. 18:26:04 INFO - Running cycle 1/1 for kraken test... 18:26:04 INFO - TEST-INFO | started process 17284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphJraU2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:05 INFO - PID 17284 | 18:26:05 INFO - PID 17284 | (/builds/slave/test/build/application/firefox/firefox:17334): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:26:05 INFO - PID 17284 | 18:26:05 INFO - PID 17284 | 18:26:05 INFO - PID 17284 | (/builds/slave/test/build/application/firefox/firefox:17394): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:26:05 INFO - PID 17284 | 18:26:06 INFO - PID 17284 | __metrics Screen width/height:1600/1200 18:26:06 INFO - PID 17284 | colorDepth:24 18:26:06 INFO - PID 17284 | Browser inner width/height: 1024/768 18:26:06 INFO - PID 17284 | __metrics 18:26:15 INFO - PID 17284 | RSS: Main: 175104000 18:26:15 INFO - PID 17284 | 18:26:18 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:19 INFO - PID 17284 | RSS: Main: 179322880 18:26:19 INFO - PID 17284 | 18:26:22 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-dft) 18:26:22 INFO - PID 17284 | RSS: Main: 179494912 18:26:22 INFO - PID 17284 | 18:26:25 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-fft) 18:26:26 INFO - PID 17284 | RSS: Main: 174202880 18:26:26 INFO - PID 17284 | 18:26:28 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator) 18:26:29 INFO - PID 17284 | RSS: Main: 174530560 18:26:29 INFO - PID 17284 | 18:26:31 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:32 INFO - PID 17284 | RSS: Main: 175341568 18:26:32 INFO - PID 17284 | 18:26:35 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:35 INFO - PID 17284 | RSS: Main: 176017408 18:26:35 INFO - PID 17284 | 18:26:39 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:39 INFO - PID 17284 | RSS: Main: 175992832 18:26:39 INFO - PID 17284 | 18:26:42 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial) 18:26:43 INFO - PID 17284 | RSS: Main: 176197632 18:26:43 INFO - PID 17284 | 18:26:45 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:45 INFO - PID 17284 | RSS: Main: 176603136 18:26:45 INFO - PID 17284 | 18:26:47 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:48 INFO - PID 17284 | RSS: Main: 176537600 18:26:48 INFO - PID 17284 | 18:26:50 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:51 INFO - PID 17284 | RSS: Main: 176619520 18:26:51 INFO - PID 17284 | 18:26:53 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:54 INFO - PID 17284 | RSS: Main: 176947200 18:26:54 INFO - PID 17284 | 18:26:57 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:58 INFO - PID 17284 | RSS: Main: 176996352 18:26:58 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57719/tests/kraken/driver.html?testName=ai-astar) 18:27:00 INFO - PID 17284 | RSS: Main: 178331648 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | __start_tp_report 18:27:00 INFO - PID 17284 | _x_x_mozilla_page_load 18:27:00 INFO - PID 17284 | _x_x_mozilla_page_load_details 18:27:00 INFO - PID 17284 | |i|pagename|runs| 18:27:00 INFO - PID 17284 | |0;ai-astar;99;107;100;106;106;112;109;100;108;108 18:27:00 INFO - PID 17284 | |1;audio-beat-detection;152;121;149;179;118;154;146;120;167;119 18:27:00 INFO - PID 17284 | |2;audio-dft;161;170;162;173;165;164;170;169;163;164 18:27:00 INFO - PID 17284 | |3;audio-fft;74;82;74;175;77;75;73;75;149;76 18:27:00 INFO - PID 17284 | |4;audio-oscillator;79;80;138;79;79;79;133;79;84;127 18:27:00 INFO - PID 17284 | |5;imaging-gaussian-blur;115;114;113;114;114;114;114;114;116;115 18:27:00 INFO - PID 17284 | |6;imaging-darkroom;149;148;148;149;147;147;147;154;148;148 18:27:00 INFO - PID 17284 | |7;imaging-desaturate;101;93;94;94;95;95;93;94;103;94 18:27:00 INFO - PID 17284 | |8;json-parse-financial;55;58;53;60;59;59;53;53;55;53 18:27:00 INFO - PID 17284 | |9;json-stringify-tinderbox;55;55;62;55;56;54;55;62;56;55 18:27:00 INFO - PID 17284 | |10;stanford-crypto-aes;76;76;82;76;75;74;77;75;75;76 18:27:00 INFO - PID 17284 | |11;stanford-crypto-ccm;123;128;119;129;137;123;115;116;119;166 18:27:00 INFO - PID 17284 | |12;stanford-crypto-pbkdf2;175;178;175;174;169;173;176;183;170;176 18:27:00 INFO - PID 17284 | |13;stanford-crypto-sha256-iterative;64;65;69;72;66;72;65;68;66;71 18:27:00 INFO - PID 17284 | __end_tp_report 18:27:00 INFO - PID 17284 | __start_cc_report 18:27:00 INFO - PID 17284 | _x_x_mozilla_cycle_collect,947 18:27:00 INFO - PID 17284 | __end_cc_report 18:27:00 INFO - PID 17284 | __startTimestamp1503624420267__endTimestamp 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | ------- Summary: start ------- 18:27:00 INFO - PID 17284 | Number of tests: 14 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#0] ai-astar Cycles:10 Average:105.50 Median:108.00 stddev:4.38 (4.1%) stddev-sans-first:3.96 18:27:00 INFO - PID 17284 | Values: 99.0 107.0 100.0 106.0 106.0 112.0 109.0 100.0 108.0 108.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:150.50 stddev:21.94 (14.6%) stddev-sans-first:23.00 18:27:00 INFO - PID 17284 | Values: 152.0 121.0 149.0 179.0 118.0 154.0 146.0 120.0 167.0 119.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#2] audio-dft Cycles:10 Average:166.10 Median:167.00 stddev:4.07 (2.4%) stddev-sans-first:3.87 18:27:00 INFO - PID 17284 | Values: 161.0 170.0 162.0 173.0 165.0 164.0 170.0 169.0 163.0 164.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:36.96 (49.3%) stddev-sans-first:38.56 18:27:00 INFO - PID 17284 | Values: 74.0 82.0 74.0 175.0 77.0 75.0 73.0 75.0 149.0 76.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:25.69 (32.5%) stddev-sans-first:26.52 18:27:00 INFO - PID 17284 | Values: 79.0 80.0 138.0 79.0 79.0 79.0 133.0 79.0 84.0 127.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 18:27:00 INFO - PID 17284 | Values: 115.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 116.0 115.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:2.07 (1.4%) stddev-sans-first:2.19 18:27:00 INFO - PID 17284 | Values: 149.0 148.0 148.0 149.0 147.0 147.0 147.0 154.0 148.0 148.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:3.47 (3.7%) stddev-sans-first:3.08 18:27:00 INFO - PID 17284 | Values: 101.0 93.0 94.0 94.0 95.0 95.0 93.0 94.0 103.0 94.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:2.90 (5.1%) stddev-sans-first:3.06 18:27:00 INFO - PID 17284 | Values: 55.0 58.0 53.0 60.0 59.0 59.0 53.0 53.0 55.0 53.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:55.50 stddev:2.95 (5.3%) stddev-sans-first:3.08 18:27:00 INFO - PID 17284 | Values: 55.0 55.0 62.0 55.0 56.0 54.0 55.0 62.0 56.0 55.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.20 (2.9%) stddev-sans-first:2.33 18:27:00 INFO - PID 17284 | Values: 76.0 76.0 82.0 76.0 75.0 74.0 77.0 75.0 75.0 76.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:125.50 stddev:15.09 (12.0%) stddev-sans-first:15.91 18:27:00 INFO - PID 17284 | Values: 123.0 128.0 119.0 129.0 137.0 123.0 115.0 116.0 119.0 166.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.50 stddev:3.96 (2.3%) stddev-sans-first:4.20 18:27:00 INFO - PID 17284 | Values: 175.0 178.0 175.0 174.0 169.0 173.0 176.0 183.0 170.0 176.0 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:3.05 (4.4%) stddev-sans-first:2.91 18:27:00 INFO - PID 17284 | Values: 64.0 65.0 69.0 72.0 66.0 72.0 65.0 68.0 66.0 71.0 18:27:00 INFO - PID 17284 | -------- Summary: end -------- 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:27:00 INFO - PID 17284 | 18:27:00 INFO - PID 17284 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:27:01 INFO - TEST-INFO | 17284: exit 0 18:27:01 INFO - TEST-OK | kraken | took 62360ms 18:27:01 INFO - SUITE-END | took 1172s 18:27:01 INFO - Completed test suite (00:19:33) 18:27:01 INFO - javascript benchmark 18:27:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8570.553850019836, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.9837450812743, 3283.228441316291, 3287.8684852605898, 3293.489509126085, 3332.3668502984447, 6251.249850017993, 6252.7498900044, 6315.305316415191, 6346.174997250357, 6374.394432528914, 6117.877642447148, 6244.188255526775, 6250.187475628173, 6270.122182894398, 6291.0248911418685, 5673.319201695802, 5687.943120568803, 5711.971440142794, 5747.396523365028, 5802.97098514509, 5716.914246286309, 5744.3394009689, 5766.596338256324, 5768.884622307552, 5830.912536311958, 84.11865704239663, 5662.886742265132, 5780.566457515703, 5862.50168735658, 5877.617954832944, 5684.943150568482, 5685.061964775807, 5716.1997320375185, 5782.56630752691, 5796.420357964212, 5696.601237913348, 5703.116017017369, 5762.4525670061275, 5794.913076303858, 5801.419858014207, 6183.845403864894, 6196.2874269459135, 6224.190855188842, 6296.024116261987, 6320.494360451153, 6702.296258892844, 6712.228093769181, 6749.2238392584495, 6800.1159849219775, 6815.556988795713, 6636.469082473391, 6684.131062961784, 6740.0, 6776.186857577122, 6861.759838405682, 6287.96856015717, 6293.433590976788, 6297.338779428185, 6298.0, 6323.177986861679, 6880.139982502187, 6890.276520965226, 6977.476689248225, 6991.021257023919, 6991.056207412036, 6558.0, 6569.967150164219, 6610.239822420387, 6674.098996635489, 6693.732250710014, 6543.672816359163, 6571.507136964747, 6681.966590167018, 6759.391654751096, 6760.763373281911, 6722.865542689216, 6730.0, 6737.326267373223, 6750.628715420601, 6755.256921738604, 6693.698783554752, 6722.798316050526, 6738.528303018742, 6788.253292137861, 6824.658767061627, 4839.637027222902, 4865.635077369211, 4894.828680996148, 4906.0433215522635, 4909.582685471703, 4324.437823083042, 4341.978290108529, 4345.760983145894, 4356.891077723082, 4367.017421080295, 5828.358880523139, 5842.5618078644275, 5868.295804503487, 5873.177755114288, 5874.0, 6664.100346453264, 6726.663666816639, 6757.898631520531, 6827.1807383113355, 6836.179658440919, 5704.629199102045, 5776.191333213354, 5777.971110144506, 5803.332616749043, 5860.062390017577, 5699.287589051369, 5711.914321285184, 5731.426857314235, 5776.826695199066, 5778.27771528559, 6470.579412338183, 6547.083408322838, 6554.3117972613145, 6561.245456772533, 6563.737450502022, 6674.399304062657, 6692.330766923269, 6796.286389929184, 6822.215445223665, 6835.453163746888, 6409.134766806422, 6430.453411459891, 6502.154719886385, 6507.707153178024, 6539.11721917535, 6659.733610655713, 6678.699458524476, 6679.6994135265, 6689.531732778659, 6704.06143139951, 6758.7296508139125, 6761.152763593675, 6762.0, 6845.965770171118, 6857.040014398088, 6518.250401203923, 6537.8692426152165, 6611.504137189634, 6613.470922326299, 6619.470442364695, 6414.262359828679, 6501.934980650133, 6503.447206987459, 6505.447037001908, 6599.274079851117, 6356.11014457967, 6366.936330636634, 6373.649449280334, 6374.235091789015, 6378.52161087911, 6448.645324507197, 6499.545031847725, 6533.314002029719, 6588.8023359299295, 6618.172728408949, 6275.058741188858, 6320.399562041599, 6418.454431373386, 6430.067640192239, 6443.7422503101225], "value": 6063.568455359407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.9482633628813, 848.872669099635, 878.9428687135336, 879.1252703559957, 1079.7462596289865, 26995.190144295677, 27936.16191514255, 27972.440551188964, 38000.61999380006, 38570.614293857056, 38460.42309365362, 38771.0, 39015.609843901555, 39016.0, 39091.21817563647, 7573.0, 7654.158042615308, 7667.731629392944, 7719.035120609924, 7737.3036426721865, 7086.326798954117, 7601.581912994783, 7671.079470463552, 7682.692692292301, 7702.614869256543, 7664.463487555873, 7694.384449244075, 7717.151113377524, 7718.0, 7718.6912523498995, 7587.430942679293, 7605.543667379975, 7667.386609071289, 7681.846363072736, 7688.769336919901, 7589.43079269057, 7623.199564045751, 7655.50239234448, 7657.885131723028, 7662.731804386875, 35555.0, 35621.82189089038, 35640.82179589086, 35663.64336356655, 35777.10557236064, 3433.4678124890684, 3476.930461390758, 3486.4247399179103, 3488.6162522122545, 3488.89533314001, 29660.406791864258, 29783.851080744673, 29867.0, 29893.551596726065, 29907.25231869199, 4909.2881532177635, 5093.617978651616, 5107.387113546398, 5138.2806407103035, 5141.357330333708, 187298.0, 188288.0, 188407.0, 188482.99999999863, 188878.0, 44255.55744442579, 44297.55702442999, 44320.3351949721, 44444.333335, 44592.3311150333, 46992.295115573295, 47002.52997469981, 47339.76330118327, 47369.76315118402, 47406.0, 15392.461263855936, 15682.843171568367, 15686.843131568767, 15758.842411575737, 15785.052896826228, 11248.606298779667, 13003.739925201444, 13018.609441716764, 13032.152910060815, 13034.869651303556, 11818.763624727457, 13536.120152190273, 13562.796558051637, 13729.244891530861, 13741.519046833313, 5553.444655534414, 5634.23937768396, 5664.830055098354, 5677.290338707661, 5689.800856969986, 974.6929717139078, 991.2912267728609, 998.2513115163628, 1004.1565085328359, 1007.0131271353968, 21398.465038373855, 21533.24633637815, 21704.89147554252, 21717.13131474755, 22107.668384974237, 1086.983695244572, 1089.3355053417408, 1095.9945200273949, 1096.7696783675358, 1106.756513567014, 11537.942310288396, 11713.824292635618, 11774.940255377058, 11776.234544754563, 14894.0, 228633.0, 229257.0, 230290.0, 230431.0, 230977.0, 51680.74159629253, 52154.478455214965, 53829.0, 55379.72310138423, 55665.443345566026, 1443.1196969848384, 1467.6477645365035, 1471.5953112893826, 1476.7046590681907, 1477.128494188434, 26019.21942341733, 26627.60058599161, 27300.72699272982, 27531.0, 27605.861970690017, 36871.815640921624, 36969.0, 36977.26045479129, 36995.63004369922, 37131.443028355134, 146995.2650236742, 149620.0, 149627.0, 149976.0, 150294.0, 32515.18712032218, 33953.66046339505, 34253.828730856185, 34302.0, 34393.312133756684, 42696.0, 42718.359224611035, 42808.357874631285, 43151.0, 43216.78391608022, 30938.690613093582, 31588.36823263568, 31973.68026319707, 33213.16967075843, 33563.83218083894, 32306.676933230367, 32568.51147232746, 32657.0, 33283.0, 33484.330313394086, 35444.0, 35713.0, 36194.0, 36461.635383646884, 36657.63342366542, 31708.841455793496, 32060.19849503781, 32063.0, 32150.0, 32172.0, 22494.550108997402, 23117.884410578514, 23288.6506702403, 23486.530269394858, 23812.642810358204], "value": 16701.398052885408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8817948230871, 566.8384510414533, 571.8913406452772, 575.2665351676615, 577.5206578539812, 21395.251166209186, 21855.781442185573, 22136.557268854634, 22177.223797167102, 22298.55402891941, 25022.874885625548, 25419.36451588711, 25428.872855635742, 25442.491150177033, 25586.360340991483, 6489.123968264283, 6649.933500665004, 6665.533412661116, 6666.3000384959605, 6667.133272674546, 6584.473242140617, 6636.933630663704, 6811.761588344409, 7140.143182818043, 7220.458465615074, 7182.6408679566075, 7186.71253149876, 7191.640417979106, 7196.280371962815, 7204.0, 7206.963965180167, 7210.4952653314285, 7218.3503484686635, 7221.42228621709, 7224.096987876515, 6916.3429474199875, 6997.615131167784, 7024.4029257513175, 7044.049053377779, 7057.4354051676255, 29877.701222987926, 30685.232869178228, 31434.685653143406, 31505.21236969071, 31660.0, 2013.597280543897, 2041.8570700050855, 2043.1316690406518, 2043.2031507712004, 2044.499097721053, 20482.283120090724, 21047.05288262032, 21223.893880530497, 21228.5754284915, 21233.0445129968, 2489.9004039838383, 2515.597504399287, 2556.782673472757, 2571.6014017827265, 2588.197658725801, 136085.0, 140083.29958350246, 140249.2987535066, 140267.29866350602, 140868.0, 19778.0, 21241.575168496853, 21577.892110539346, 22309.776902231093, 22446.438839029153, 43183.0, 43330.100290973336, 43365.783171083945, 43375.13249734988, 43385.0, 11348.092152627934, 11406.258593191416, 11428.25716328436, 11455.770884582262, 11506.194566380273, 8532.786680333042, 9426.670066547638, 9546.90453095474, 9562.713118606453, 9689.70930872075, 9578.760530986641, 10952.780944381067, 10988.011079002928, 11331.263467874562, 11660.30038197711, 3631.388137065964, 3635.4183330666965, 3851.691864650821, 4016.5581786003518, 4470.798814053375, 949.3070058857073, 963.4853033582344, 973.5862258540234, 975.6975337645353, 988.8862780780158, 19063.714044289347, 19323.0, 19528.8047119527, 19628.901855490632, 19906.104225309897, 1011.5549158370294, 1026.1226651213256, 1030.108955753268, 1030.2324768047852, 1034.2605037398296, 10608.734781630366, 10680.465976701134, 10769.192310576738, 10770.623028193975, 11037.83443248352, 472874.0, 479020.0, 481385.18614814105, 483328.0, 492183.0, 104951.0, 104971.47514262379, 105141.0, 105722.47138764257, 106297.0, 1116.6817457024708, 1130.6890605083668, 1142.2118738070706, 1148.1675785055768, 1151.3782557419067, 16967.830321696623, 17019.48941531756, 17309.826901730823, 17658.02880841566, 17746.11269436549, 52852.678683033235, 55067.0, 56440.43559564352, 57163.714181428826, 57309.42690573208, 69350.30649693438, 69426.0, 69841.65079174572, 69928.30071699218, 70092.0, 15060.54818355451, 17336.30654773795, 19419.61160776805, 19581.70627440618, 20210.898945505178, 21869.56260874742, 22273.44316392103, 22353.552928941655, 22355.0, 22553.323400298017, 17839.910800445916, 17986.82013179904, 18082.367117150836, 18200.72698909491, 18251.0, 16180.514584562481, 16477.752833707742, 16864.072476013447, 16919.91540042341, 16923.91538042302, 17575.736363954296, 18074.186661599997, 18466.0, 18537.629247414705, 18616.627667446846, 19366.61266774685, 19405.8059419404, 19431.611367772282, 19534.90232548885, 19571.804281956996, 17218.741718873975, 17913.462596122135, 17948.55128621795, 18070.457886263433, 18073.909630451762], "value": 12776.043328016363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.6899944013437, 1351.89860760443, 1366.9521566745166, 1374.6082366525543, 1379.4757991963052, 14313.0, 15069.321880515376, 15077.396904123822, 15095.471658491968, 15109.09345439273, 14439.927800360983, 15517.689646207069, 15535.378584856593, 15553.377864885419, 15562.84437155628, 2674.8796304166312, 2742.8217165884253, 2746.958795618057, 2750.931226719328, 2759.0619189475574, 2587.6636037315125, 2637.7230390808977, 2669.8798554065015, 2689.8520581368016, 2763.1434255380796, 2719.524083285427, 2748.0, 2750.22993561803, 2752.325680208352, 2754.1462146734475, 2619.1487766475875, 2640.1419538650016, 2657.255968328871, 2657.9867100664374, 2659.268701107201, 2599.8830052647486, 2609.0346571768378, 2630.644862943497, 2632.0261503243923, 2634.4204275059647, 14303.49937752184, 14666.413343466249, 14669.559913202622, 14688.192149431778, 14738.115713057143, 7768.495047821873, 7972.561509116997, 7999.040115186157, 8058.798530036737, 8082.5958702065245, 5297.788088476456, 5463.508284254436, 5500.7524661390335, 5580.274564306655, 5594.0769772987405, 1776.9111544422856, 1785.1431312969717, 1811.184966764961, 1817.5274428648647, 1821.317006122704, 24898.87550562254, 24934.875325623256, 25141.120060797784, 25153.874230628913, 25209.117680881263, 6998.125234345707, 7108.850256815426, 7144.3212894774915, 7299.562026278334, 7362.6318684066655, 16966.49100526986, 17103.315867365167, 17182.65634687299, 17191.742123868153, 17198.1400929953, 7682.7311044113185, 7796.610169491502, 7801.531908085533, 7801.80495487606, 7803.063632364153, 7149.320814522612, 7206.783796486114, 7227.494075414776, 7324.121105467378, 7339.119305683245, 5066.36670416198, 5191.792328306826, 5191.896162076738, 5193.454687257859, 5221.13851214553, 1336.3318340829585, 1375.1199232491213, 1439.4386189386148, 1472.3080152328603, 1499.8526127512462, 902.7743064233941, 918.7106061590578, 922.0594993106994, 927.9304052196112, 936.3866667332908, 7712.537247765152, 7935.444518883623, 8116.35069194463, 8327.750167494985, 8427.904372431667, 992.8212921674168, 997.7356000659831, 1000.8598796168542, 1005.1456262177092, 1014.4015031131668, 4638.512956139624, 5652.660840349592, 5689.516391106802, 5862.032764593794, 5924.9703751480965, 20422.489437763878, 21273.468163296042, 21275.574488510145, 21277.574448510943, 21280.467988300417, 20074.498137546678, 20074.799252007586, 20369.694454583194, 20378.184872605227, 20416.0812763426, 10485.213608979357, 10609.84085238722, 10825.621103261348, 10832.187585931088, 10888.61889833852, 8302.211289927447, 8841.204291613785, 8844.601992910206, 8888.64445422176, 8969.0, 17540.91229543844, 17944.102794859944, 17965.640687186446, 18320.0, 18447.07764611791, 18086.366977155736, 18089.547761305545, 18191.0, 18276.0, 18331.450056497793, 12000.339981300764, 12049.277043377426, 12158.939205303917, 12227.938860305641, 12232.938835306122, 13518.662033449242, 13659.658508536968, 13669.179849209078, 13676.521321753691, 13805.930970345486, 11061.391623460788, 11246.212765106364, 11297.71755706114, 11332.830007549728, 11338.659840204808, 10971.177161713063, 10977.506012229309, 11058.115350771757, 11111.611093611686, 11340.206185567262, 9500.47747373901, 9730.172935300296, 9745.902540974499, 9749.171320437843, 9760.365576237522, 7151.499395042505, 7219.530730502501, 7247.601381924045, 7252.347288744038, 7321.084864391951, 6552.737890484518, 6637.402633762985, 6663.13379260693, 6682.665866706548, 6743.561668491532], "value": 6611.06112544816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.33986797559226, 498.25858624108747, 524.2293828072732, 530.2682298428169, 530.522529723249, 6352.904706429395, 6361.745530178793, 6370.9362906370925, 6386.552941294111, 6420.1974753155855, 6001.729922153502, 6154.507639388849, 6194.380561943814, 6252.968735156329, 6283.863486414618, 4947.77735001924, 4963.627727920402, 5000.7749651265685, 5016.147254966664, 5065.898682026375, 4754.405699287589, 4963.627727920402, 5003.599712023048, 5037.4710655381205, 5040.521150490697, 4944.579710724593, 4956.454789973118, 4964.950350496485, 5034.471380505049, 5051.1413059779925, 4940.184869496528, 4948.604111671076, 4953.85138445849, 4981.90036199274, 5011.674241174312, 4449.7330160190495, 4462.107578484283, 4469.240229161018, 4474.709143905636, 4477.171723231213, 6121.173641558422, 6179.907301390483, 6201.116480836387, 6220.626762394271, 6239.844003899939, 5654.264945557051, 5674.489295963342, 5681.488666020036, 5712.428757124296, 5784.219130417382, 6539.280679125292, 6562.212534495891, 6568.934310656928, 6592.1100651411925, 6662.46889148752, 4791.904161916742, 4805.663603547753, 4826.517348265181, 4864.635152363587, 4881.778026502491, 6945.756898508578, 6981.720731170798, 7032.191298000693, 7104.396126329269, 7107.751228707022, 4969.304297398367, 4979.576735977483, 4986.950130498722, 5007.349044624249, 5024.874378140576, 5048.570871475966, 5085.949140508547, 5103.489651034867, 5104.540591346722, 5109.6678715883345, 5689.175069614883, 5712.371639119693, 5720.8283751487525, 5739.483446489752, 5744.167095771089, 6616.4376028037195, 6639.302873198341, 6659.267480577133, 6708.83227919306, 6713.4964877634375, 1634.730269505542, 1663.7670726098356, 1687.5949772054864, 1756.4028230401725, 1768.9203985820668, 1200.6578125234266, 1209.6975756060986, 1224.253205544617, 1228.8218208359738, 1233.3771445420005, 5758.395368486249, 5775.48020678141, 5780.364159942403, 5786.71066446676, 5815.82552523425, 6640.568363056386, 6757.628330441775, 6795.966020169867, 6880.931190688029, 6922.5154239203775, 5709.172170035322, 5784.566157538202, 5795.0, 5832.1834943108, 5845.941540584625, 3573.213892943548, 3573.2312505310038, 3613.259281847215, 3638.6179451157777, 3647.1429214135187, 6446.161998940108, 6545.41820725494, 6558.80323590293, 6590.340965903371, 6639.535232533676, 6996.19543752475, 7017.245773511147, 7037.331453511908, 7058.258882817333, 7058.647067646597, 6550.83622909412, 6555.213374395008, 6634.805734967752, 6636.270010298863, 6658.667066646648, 6809.455243580601, 6823.727050918106, 6838.316168383122, 6856.965715171392, 6885.345892140239, 6665.666716664245, 6769.695363708546, 6783.93216067833, 6792.558483698544, 6818.659067046727, 6492.383223593751, 6497.610143391412, 6510.0, 6525.804225873231, 6529.804105876831, 4909.140900342497, 4929.014197160654, 4957.529034741694, 4990.675606085593, 5000.2499625056535, 6523.858324793047, 6737.494687898329, 6800.659967001531, 6827.317268273332, 6876.621785801629, 6399.64801935898, 6536.182977127859, 6545.410913017851, 6573.5069869759, 6585.374389432996, 6550.541462097607, 6565.244996825235, 6622.801315960529, 6626.5030122741955, 6691.0595927180575, 6281.371862813682, 6407.8718425630295, 6424.421802037839, 6464.644444555406, 6488.351164883474, 6585.0, 6644.46844252449, 6672.866542669217, 6703.162104736908, 6723.2940541244425, 6453.064305675557, 6454.838629034124, 6460.773872914426, 6463.61032378041, 6464.095026696173], "value": 5085.57230676829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.4200222823495, 869.5826003518312, 887.4054383563013, 894.0924961164416, 895.2524641923995, 18583.5354116147, 19713.21147154114, 19743.111559979818, 19758.90120549399, 21494.462638434008, 19961.401157965283, 20136.798632013677, 20684.379468615927, 20852.270170544034, 20865.791342086573, 901.0583939782942, 910.3036177324352, 912.726182145357, 913.8309412758628, 914.0813482450128, 912.6896855069275, 955.7515046088032, 959.3716115944068, 959.3811991265665, 963.4123184857267, 1006.124671535765, 1007.2395341517145, 1007.4861820471575, 1008.4151192308481, 1012.0385633648064, 1011.2466212671533, 1012.357153207711, 1012.4583347908871, 1012.5645972231937, 1020.2042406922612, 738.6860584251725, 741.5031928607846, 742.2911119880555, 743.4052757793744, 747.2527472527472, 18864.905675471673, 19221.0, 19329.51676208092, 19429.514262143417, 19770.604587908307, 20650.380488585368, 20715.171393144257, 21117.68323475149, 21307.041183146797, 21361.67957480639, 16050.518484445485, 16338.428155014517, 16515.256813443422, 16530.0, 16841.578960525963, 3656.177360093984, 3705.0366904604725, 3707.295613833363, 3708.8145592720525, 3713.721470889694, 120315.0, 125057.0, 127230.36384818109, 129256.12231633066, 131171.0, 15293.541193764206, 15502.689946201239, 15824.68350632981, 15877.12675802842, 15949.760753588705, 29343.85328073346, 29495.705042949296, 29576.408471830444, 29610.0, 29670.55494167589, 7499.362554182846, 7825.413094017971, 8558.914410855936, 8736.956315218384, 8768.605412756313, 4270.0, 4361.80371883266, 4368.170047690992, 4377.146456440963, 4381.1237752449, 5056.570191533688, 5126.512981266774, 5143.27994080829, 5185.377754669464, 5205.427402985669, 1074.9301295415773, 1083.669480808361, 1100.6092837042734, 1103.5475455063386, 1109.173665619119, 668.6255696809802, 671.771597656799, 677.9830504237335, 690.3407246080081, 702.2977022977022, 11158.721031974266, 11241.381724005258, 11604.071674266039, 13634.454621815215, 13795.310234488436, 639.66097968077, 695.6382681005848, 700.1423256510734, 707.1478867964091, 719.7444907058024, 5435.755391007414, 5700.25896633435, 5845.035569131046, 6083.330833608299, 6346.555741098079, 104176.95823041673, 110248.0, 113579.0, 121041.78958210482, 122423.38788306179, 99425.50287248663, 101539.0, 103121.48439257756, 103820.0, 107426.0, 88305.0, 90004.0, 91414.54292728627, 94222.99999999863, 98908.50545747225, 11540.653780386601, 11622.476988535367, 12126.454309556268, 12578.30819304947, 12906.225626462443, 40043.1991360177, 40569.391459128725, 40688.59311406848, 41378.586214137475, 42023.57976420319, 52895.73552132369, 53218.46781532135, 54259.45740542544, 54867.725661371434, 56123.43876561346, 18136.727949080512, 18242.543936401697, 18747.0, 18750.156242968827, 19084.713729293795, 20857.68713469269, 21050.578988420453, 21150.894245528674, 21986.340409787732, 22139.225127120473, 18266.0, 18299.26802927868, 18303.54241143982, 18553.628927421647, 19238.326658566883, 19116.139773710496, 19526.31657891967, 19699.507512312306, 19859.349103885754, 19935.501612459804, 17210.741838872178, 17518.0, 17795.555111122325, 18020.18909149118, 18251.0874456274, 13633.0, 13680.589582312547, 13686.589402317946, 14036.929815350857, 14090.718185636435, 13683.863161368658, 13949.497670427676, 13979.316928828955, 14053.859461405664, 14057.929710351384], "value": 9110.422078194902, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 100.0, 106.0, 106.0, 112.0, 109.0, 100.0, 108.0, 108.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 149.0, 179.0, 118.0, 154.0, 146.0, 120.0, 167.0, 119.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 170.0, 162.0, 173.0, 165.0, 164.0, 170.0, 169.0, 163.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 175.0, 77.0, 75.0, 73.0, 75.0, 149.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 138.0, 79.0, 79.0, 79.0, 133.0, 79.0, 84.0, 127.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0, 154.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 94.0, 94.0, 95.0, 95.0, 93.0, 94.0, 103.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 53.0, 60.0, 59.0, 59.0, 53.0, 53.0, 55.0, 53.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 62.0, 55.0, 56.0, 54.0, 55.0, 62.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 76.0, 75.0, 74.0, 77.0, 75.0, 75.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 119.0, 129.0, 137.0, 123.0, 115.0, 116.0, 119.0, 166.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 175.0, 174.0, 169.0, 173.0, 176.0, 183.0, 170.0, 176.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 69.0, 72.0, 66.0, 72.0, 65.0, 68.0, 66.0, 71.0], "value": 67.8, "unit": "score"}]}]} 18:27:01 INFO - Return code: 0 18:27:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:27:01 INFO - # TBPL SUCCESS # 18:27:01 INFO - Running post-action listener: _package_coverage_data 18:27:01 INFO - Running post-action listener: _resource_record_post_action 18:27:01 INFO - [mozharness: 2017-08-25 01:27:01.544933Z] Finished run-tests step (success) 18:27:01 INFO - Running post-run listener: _resource_record_post_run 18:27:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 429912064; Read time: 192; Write time: 264640 18:27:01 INFO - TinderboxPrint: CPU usage
13.1% 18:27:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 18:27:01 INFO - TinderboxPrint: I/O write bytes / time
429,912,064 / 264,640 18:27:01 INFO - TinderboxPrint: CPU idle
8,247.2 (86.8%) 18:27:01 INFO - TinderboxPrint: CPU user
1,196.8 (12.6%) 18:27:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:27:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105705472; Read time: 0; Write time: 80092 18:27:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:27:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324206592; Read time: 192; Write time: 184548 18:27:02 INFO - Running post-run listener: _upload_blobber_files 18:27:02 INFO - Blob upload gear active. 18:27:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:27: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 18:27: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'] 18:27: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 18:27:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:06 INFO - (blobuploader) - INFO - Done attempting. 18:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:07 INFO - (blobuploader) - INFO - Done attempting. 18:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:08 INFO - (blobuploader) - INFO - Done attempting. 18:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:09 INFO - (blobuploader) - INFO - Done attempting. 18:27:09 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:09 INFO - Return code: 0 18:27:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a23eee77d31d4c65a339813da13718ae8555ba9a6ef12c6f4566d203ef61783f4f8767a218e9ef415cea4167b99c9e4288f893c3377f6e7f67b59f47f1bd814", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15722fb7f1231159350df0554f7d0799dee42bbd08529c3a6412594fde3db50654fe025131b287e82de0ed0a046908e4e5ccbd8b8d8107e8f02280897156dd4e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ccaf310225bcec92466e29d5c0c79cfef6f878ccd0adf7eb350323e6447d49fbb66a17dc2222325b67f40f54c6a6c2daba7347f128b83ef3702a2082676b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde334e34a5899bb253f9c2c77a85d072494d46f032aa328eb3d9816dfac16629141c636973f677d18f5199323b1900b97db146a32f5c406dd0b43133ba3477"} 18:27:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:09 INFO - Contents: 18:27:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a23eee77d31d4c65a339813da13718ae8555ba9a6ef12c6f4566d203ef61783f4f8767a218e9ef415cea4167b99c9e4288f893c3377f6e7f67b59f47f1bd814", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15722fb7f1231159350df0554f7d0799dee42bbd08529c3a6412594fde3db50654fe025131b287e82de0ed0a046908e4e5ccbd8b8d8107e8f02280897156dd4e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ccaf310225bcec92466e29d5c0c79cfef6f878ccd0adf7eb350323e6447d49fbb66a17dc2222325b67f40f54c6a6c2daba7347f128b83ef3702a2082676b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde334e34a5899bb253f9c2c77a85d072494d46f032aa328eb3d9816dfac16629141c636973f677d18f5199323b1900b97db146a32f5c406dd0b43133ba3477"} 18:27:09 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:09 INFO - Copying logs to upload dir... 18:27:09 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.744221 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-24 18:27:09.117746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 18:27:09.123574) ========= 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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 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/6a23eee77d31d4c65a339813da13718ae8555ba9a6ef12c6f4566d203ef61783f4f8767a218e9ef415cea4167b99c9e4288f893c3377f6e7f67b59f47f1bd814", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15722fb7f1231159350df0554f7d0799dee42bbd08529c3a6412594fde3db50654fe025131b287e82de0ed0a046908e4e5ccbd8b8d8107e8f02280897156dd4e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ccaf310225bcec92466e29d5c0c79cfef6f878ccd0adf7eb350323e6447d49fbb66a17dc2222325b67f40f54c6a6c2daba7347f128b83ef3702a2082676b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde334e34a5899bb253f9c2c77a85d072494d46f032aa328eb3d9816dfac16629141c636973f677d18f5199323b1900b97db146a32f5c406dd0b43133ba3477"} build_url:https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/Amqe4HB8QW2hqpHBtZHK2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a23eee77d31d4c65a339813da13718ae8555ba9a6ef12c6f4566d203ef61783f4f8767a218e9ef415cea4167b99c9e4288f893c3377f6e7f67b59f47f1bd814", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15722fb7f1231159350df0554f7d0799dee42bbd08529c3a6412594fde3db50654fe025131b287e82de0ed0a046908e4e5ccbd8b8d8107e8f02280897156dd4e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ccaf310225bcec92466e29d5c0c79cfef6f878ccd0adf7eb350323e6447d49fbb66a17dc2222325b67f40f54c6a6c2daba7347f128b83ef3702a2082676b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde334e34a5899bb253f9c2c77a85d072494d46f032aa328eb3d9816dfac16629141c636973f677d18f5199323b1900b97db146a32f5c406dd0b43133ba3477"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 18:27:09.150230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:27:09.150521) ========= 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=03627c79f6bb3d1578c4a402000001ba-1503623177.828057-67269941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 18:27:09.233464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 18:27:09.233818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 18:27:09.234090) ========= ========= Total master_lag: 0.17 =========