builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1503580528.54 results: success (0) revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.537505) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.537933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.538202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.555140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.555451) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 06:15:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2017-08-24 06:15:28 (15.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.715102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.715427) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.765177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:28.768529) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --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 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 06:15:28,761 truncating revision to first 12 chars 2017-08-24 06:15:28,761 Setting DEBUG logging. 2017-08-24 06:15:28,761 attempt 1/10 2017-08-24 06:15:28,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/892c8916ba32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 06:15:29,229 unpacking tar archive at: mozilla-central-892c8916ba32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:29.559056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:29.562392) ========= script_repo_revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:29.562761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:29.563047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 06:15:29.574261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-24 06:15:29.574540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:29 INFO - MultiFileLogger online at 20170824 06:15:29 in /builds/slave/test 06:15:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:15:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:29 INFO - {'append_to_log': False, 06:15:29 INFO - 'base_work_dir': '/builds/slave/test', 06:15:29 INFO - 'blob_upload_branch': 'Firefox', 06:15:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:29 INFO - 'branch': 'Firefox', 06:15:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:29 INFO - 'code_coverage': False, 06:15:29 INFO - 'config_files': ('talos/linux_config.py',), 06:15:29 INFO - 'default_actions': ('clobber', 06:15:29 INFO - 'read-buildbot-config', 06:15:29 INFO - 'download-and-extract', 06:15:29 INFO - 'populate-webroot', 06:15:29 INFO - 'create-virtualenv', 06:15:29 INFO - 'install', 06:15:29 INFO - 'setup-mitmproxy', 06:15:29 INFO - 'run-tests'), 06:15:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:29 INFO - 'disable_ccov_upload': False, 06:15:29 INFO - 'download_minidump_stackwalk': True, 06:15:29 INFO - 'download_symbols': 'ondemand', 06:15:29 INFO - 'enable_stylo': False, 06:15:29 INFO - 'enable_webrender': False, 06:15:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:15:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:29 INFO - 'gecko_profile': False, 06:15:29 INFO - 'gecko_profile_interval': 0, 06:15:29 INFO - 'installer_path': 'installer.exe', 06:15:29 INFO - 'log_level': 'info', 06:15:29 INFO - 'log_name': 'talos', 06:15:29 INFO - 'log_to_console': True, 06:15:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:29 INFO - 'opt_config_files': (), 06:15:29 INFO - 'pip_index': False, 06:15:29 INFO - 'suite': 'dromaeojs-e10s', 06:15:29 INFO - 'system_bits': '32', 06:15:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:29 INFO - 'title': 'talos-linux64-ix-023', 06:15:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:29 INFO - 'use_talos_json': True, 06:15:29 INFO - 'verify': 'False', 06:15:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:29 INFO - 'work_dir': 'build'} 06:15:29 INFO - [mozharness: 2017-08-24 13:15:29.796548Z] Running clobber step. 06:15:29 INFO - Running pre-action listener: _resource_record_pre_action 06:15:29 INFO - Running main action method: clobber 06:15:29 INFO - rmtree: /builds/slave/test/build 06:15:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:30 INFO - Running post-action listener: _resource_record_post_action 06:15:30 INFO - [mozharness: 2017-08-24 13:15:30.832626Z] Finished clobber step (success) 06:15:30 INFO - [mozharness: 2017-08-24 13:15:30.832722Z] Running read-buildbot-config step. 06:15:30 INFO - Running pre-action listener: _resource_record_pre_action 06:15:30 INFO - Running main action method: read_buildbot_config 06:15:30 INFO - Using buildbot properties: 06:15:30 INFO - { 06:15:30 INFO - "project": "", 06:15:30 INFO - "product": "firefox", 06:15:30 INFO - "who": "ffxbld@noreply.mozilla.org", 06:15:30 INFO - "installer_path": "public/build/target.tar.bz2", 06:15:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:15:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:15:30 INFO - "stage_platform": "linux64-pgo", 06:15:30 INFO - "basedir": "/builds/slave/test", 06:15:30 INFO - "buildnumber": 126, 06:15:30 INFO - "platform": "ubuntu64_hw", 06:15:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:15:30 INFO - "slavebuilddir": "test", 06:15:30 INFO - "taskId": "fB-5mBxSRlmNum-_wZ4zdw", 06:15:30 INFO - "branch": "mozilla-central", 06:15:30 INFO - "script_repo_revision": "production", 06:15:30 INFO - "revision": "892c8916ba32b7733e06bfbfdd4083ffae3ca028", 06:15:30 INFO - "slavename": "talos-linux64-ix-023", 06:15:30 INFO - "repo_path": "mozilla-central" 06:15:30 INFO - } 06:15:30 INFO - Finding installer, test and symbols from parent task. 06:15:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fB-5mBxSRlmNum-_wZ4zdw'}, attempt #1 06:15:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fB-5mBxSRlmNum-_wZ4zdw'}, attempt #1 06:15:31 INFO - Task dependencies: EDGDG24-RR6m_W-GqWJdrQ 06:15:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ'}, attempt #1 06:15:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 06:15:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.test_packages.json 06:15:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.crashreporter-symbols.zip 06:15:32 INFO - Running post-action listener: _resource_record_post_action 06:15:32 INFO - [mozharness: 2017-08-24 13:15:32.224165Z] Finished read-buildbot-config step (success) 06:15:32 INFO - [mozharness: 2017-08-24 13:15:32.224381Z] Running download-and-extract step. 06:15:32 INFO - Running pre-action listener: _resource_record_pre_action 06:15:32 INFO - Running main action method: download_and_extract 06:15:32 INFO - mkdir: /builds/slave/test/build/tests 06:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:32 INFO - trying https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.test_packages.json 06:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:15:32 INFO - Downloaded 989 bytes. 06:15:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:15:32 INFO - Using the following test package requirements: 06:15:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:15:32 INFO - u'common': [u'target.common.tests.zip'], 06:15:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:15:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:15:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:15:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:15:32 INFO - u'mozbase': [u'target.common.tests.zip'], 06:15:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:15:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:15:32 INFO - u'web-platform': [u'target.common.tests.zip', 06:15:32 INFO - u'target.web-platform.tests.tar.gz'], 06:15:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:15:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip 06:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip into memory 06:15:33 INFO - Content-Length response header: 55732964 06:15:33 INFO - Bytes received: 55732964 06:15:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:15:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip 06:15:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:44 INFO - Fetch https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.common.tests.zip into memory 06:15:45 INFO - Content-Length response header: 55732964 06:15:45 INFO - Bytes received: 55732964 06:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.talos.tests.zip 06:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.talos.tests.zip into memory 06:15:59 INFO - Content-Length response header: 14496384 06:15:59 INFO - Bytes received: 14496384 06:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:59 INFO - trying https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 06:15:59 INFO - Downloading https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:16:01 INFO - Downloaded 62201071 bytes. 06:16:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 06:16:01 INFO - mkdir: /builds/slave/test/properties 06:16:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:16:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:16:01 INFO - Contents: 06:16:01 INFO - build_url:https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 06:16:01 INFO - Running post-action listener: _resource_record_post_action 06:16:01 INFO - Running post-action listener: find_tests_for_verification 06:16:01 INFO - Running post-action listener: set_extra_try_arguments 06:16:01 INFO - [mozharness: 2017-08-24 13:16:01.205709Z] Finished download-and-extract step (success) 06:16:01 INFO - [mozharness: 2017-08-24 13:16:01.205809Z] Running populate-webroot step. 06:16:01 INFO - Running pre-action listener: _resource_record_pre_action 06:16:01 INFO - Running main action method: populate_webroot 06:16:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:16:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:16:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:16:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:16:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'tests': ['damp', 'tps']}, 06:16:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['damp', 'tps']}, 06:16:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:16:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:16:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:16:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:16:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:16:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:16:01 INFO - 'ts_paint', 06:16:01 INFO - 'tpaint', 06:16:01 INFO - 'sessionrestore', 06:16:01 INFO - 'sessionrestore_many_windows', 06:16:01 INFO - 'sessionrestore_no_auto_restore', 06:16:01 INFO - 'tabpaint']}, 06:16:01 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['a11yr', 06:16:01 INFO - 'ts_paint', 06:16:01 INFO - 'tpaint', 06:16:01 INFO - 'sessionrestore', 06:16:01 INFO - 'sessionrestore_many_windows', 06:16:01 INFO - 'sessionrestore_no_auto_restore', 06:16:01 INFO - 'tabpaint']}, 06:16:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:16:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:16:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['bloom_basic_singleton']}, 06:16:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['bloom_basic']}, 06:16:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:16:01 INFO - 'tsvgr_opacity', 06:16:01 INFO - 'tart', 06:16:01 INFO - 'tscrollx', 06:16:01 INFO - 'tsvg_static']}, 06:16:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['tsvgx', 06:16:01 INFO - 'tsvgr_opacity', 06:16:01 INFO - 'tart', 06:16:01 INFO - 'tscrollx', 06:16:01 INFO - 'tsvg_static']}, 06:16:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:16:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--stylo'], 06:16:01 INFO - 'tests': ['tp5o']}, 06:16:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:16:01 INFO - 'talos_options': ['--mitmproxy', 06:16:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:16:01 INFO - '--firstNonBlankPaint'], 06:16:01 INFO - 'tests': ['tp6_google', 06:16:01 INFO - 'tp6_youtube', 06:16:01 INFO - 'tp6_amazon', 06:16:01 INFO - 'tp6_facebook']}, 06:16:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:16:01 INFO - 'talos_options': ['--stylo', 06:16:01 INFO - '--mitmproxy', 06:16:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:16:01 INFO - '--firstNonBlankPaint'], 06:16:01 INFO - 'tests': ['tp6_google', 06:16:01 INFO - 'tp6_youtube', 06:16:01 INFO - 'tp6_amazon', 06:16:01 INFO - 'tp6_facebook']}, 06:16:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:16:01 INFO - 'talos_options': ['--stylo', 06:16:01 INFO - '--stylo-threads=1', 06:16:01 INFO - '--mitmproxy', 06:16:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:16:01 INFO - '--firstNonBlankPaint'], 06:16:01 INFO - 'tests': ['tp6_google', 06:16:01 INFO - 'tp6_youtube', 06:16:01 INFO - 'tp6_amazon', 06:16:01 INFO - 'tp6_facebook']}, 06:16:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--xperf_path', 06:16:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:01 INFO - 'tests': ['tp5n']}, 06:16:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:16:01 INFO - 'talos_options': ['--stylo', 06:16:01 INFO - '--xperf_path', 06:16:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:01 INFO - 'tests': ['tp5n']}}} 06:16:01 INFO - Running post-action listener: _resource_record_post_action 06:16:01 INFO - [mozharness: 2017-08-24 13:16:01.220736Z] Finished populate-webroot step (success) 06:16:01 INFO - [mozharness: 2017-08-24 13:16:01.220825Z] Running create-virtualenv step. 06:16:01 INFO - Running pre-action listener: _resource_record_pre_action 06:16:01 INFO - Running main action method: create_virtualenv 06:16:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:16:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:16:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:16:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:16:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:16:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:16:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:16:02 INFO - Installing pip...............done. 06:16:02 INFO - Return code: 0 06:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:16:03 INFO - Reading from file tmpfile_stdout 06:16:03 INFO - Output received: 06:16:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:16:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:03 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:03 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 06:16:03 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 06:16:03 INFO - Using env: {'DISPLAY': ':0', 06:16:03 INFO - 'HOME': '/home/cltbld', 06:16:03 INFO - 'LANG': 'en_US.UTF-8', 06:16:03 INFO - 'LANGUAGE': 'en_US:en', 06:16:03 INFO - 'LOGNAME': 'cltbld', 06:16:03 INFO - 'MAIL': '/var/mail/cltbld', 06:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:03 INFO - 'MOZ_NO_REMOTE': '1', 06:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:03 INFO - 'NO_EM_RESTART': '1', 06:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:03 INFO - 'PWD': '/builds/slave/test', 06:16:03 INFO - 'SHELL': '/bin/bash', 06:16:03 INFO - 'SHLVL': '1', 06:16:03 INFO - 'TERM': 'linux', 06:16:03 INFO - 'TMOUT': '86400', 06:16:03 INFO - 'USER': 'cltbld', 06:16:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:03 INFO - '_': '/tools/buildbot/bin/python'} 06:16:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:16:04 INFO - Downloading/unpacking pip>=1.5 06:16:04 INFO - Running setup.py egg_info for package pip 06:16:04 INFO - warning: no files found matching 'pip/cacert.pem' 06:16:04 INFO - warning: no files found matching '*.html' under directory 'docs' 06:16:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:16:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:16:04 INFO - Installing collected packages: pip 06:16:04 INFO - Found existing installation: pip 1.1 06:16:04 INFO - Uninstalling pip: 06:16:04 INFO - Successfully uninstalled pip 06:16:04 INFO - Running setup.py install for pip 06:16:04 INFO - warning: no files found matching 'pip/cacert.pem' 06:16:04 INFO - warning: no files found matching '*.html' under directory 'docs' 06:16:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:16:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:16:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Successfully installed pip 06:16:04 INFO - Cleaning up... 06:16:04 INFO - Return code: 0 06:16:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:16: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')]} 06:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16: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')]} 06:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:04 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:04 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 06:16:04 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 06:16:04 INFO - Using env: {'DISPLAY': ':0', 06:16:04 INFO - 'HOME': '/home/cltbld', 06:16:04 INFO - 'LANG': 'en_US.UTF-8', 06:16:04 INFO - 'LANGUAGE': 'en_US:en', 06:16:04 INFO - 'LOGNAME': 'cltbld', 06:16:04 INFO - 'MAIL': '/var/mail/cltbld', 06:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:04 INFO - 'MOZ_NO_REMOTE': '1', 06:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:04 INFO - 'NO_EM_RESTART': '1', 06:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:04 INFO - 'PWD': '/builds/slave/test', 06:16:04 INFO - 'SHELL': '/bin/bash', 06:16:04 INFO - 'SHLVL': '1', 06:16:04 INFO - 'TERM': 'linux', 06:16:04 INFO - 'TMOUT': '86400', 06:16:04 INFO - 'USER': 'cltbld', 06:16:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:04 INFO - '_': '/tools/buildbot/bin/python'} 06:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:05 INFO - Downloading/unpacking psutil>=3.1.1 06:16: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 06:16: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 06:16: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 06:16: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 06:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:06 INFO - Installing collected packages: psutil 06:16:06 INFO - Running setup.py install for psutil 06:16:06 INFO - building 'psutil._psutil_linux' extension 06:16:06 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 06:16:07 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 06:16:08 INFO - building 'psutil._psutil_posix' extension 06:16:08 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 06:16:08 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 06:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:08 INFO - Successfully installed psutil 06:16:08 INFO - Cleaning up... 06:16:08 INFO - Return code: 0 06:16:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:16:08 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')]} 06:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:08 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')]} 06:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:08 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:08 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 06:16:08 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 06:16:08 INFO - Using env: {'DISPLAY': ':0', 06:16:08 INFO - 'HOME': '/home/cltbld', 06:16:08 INFO - 'LANG': 'en_US.UTF-8', 06:16:08 INFO - 'LANGUAGE': 'en_US:en', 06:16:08 INFO - 'LOGNAME': 'cltbld', 06:16:08 INFO - 'MAIL': '/var/mail/cltbld', 06:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:08 INFO - 'MOZ_NO_REMOTE': '1', 06:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:08 INFO - 'NO_EM_RESTART': '1', 06:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:08 INFO - 'PWD': '/builds/slave/test', 06:16:08 INFO - 'SHELL': '/bin/bash', 06:16:08 INFO - 'SHLVL': '1', 06:16:08 INFO - 'TERM': 'linux', 06:16:08 INFO - 'TMOUT': '86400', 06:16:08 INFO - 'USER': 'cltbld', 06:16:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:08 INFO - '_': '/tools/buildbot/bin/python'} 06:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:16:08 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 06:16:08 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 06:16:08 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 06:16:08 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 06:16:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:16:09 INFO - Installing collected packages: mozsystemmonitor 06:16:09 INFO - Running setup.py install for mozsystemmonitor 06:16:09 INFO - Successfully installed mozsystemmonitor 06:16:09 INFO - Cleaning up... 06:16:09 INFO - Return code: 0 06:16:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:16: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')]} 06:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16: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')]} 06:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16: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==2.5.1'] in /builds/slave/test/build 06:16: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==2.5.1 06:16:09 INFO - Using env: {'DISPLAY': ':0', 06:16:09 INFO - 'HOME': '/home/cltbld', 06:16:09 INFO - 'LANG': 'en_US.UTF-8', 06:16:09 INFO - 'LANGUAGE': 'en_US:en', 06:16:09 INFO - 'LOGNAME': 'cltbld', 06:16:09 INFO - 'MAIL': '/var/mail/cltbld', 06:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:09 INFO - 'MOZ_NO_REMOTE': '1', 06:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:09 INFO - 'NO_EM_RESTART': '1', 06:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:09 INFO - 'PWD': '/builds/slave/test', 06:16:09 INFO - 'SHELL': '/bin/bash', 06:16:09 INFO - 'SHLVL': '1', 06:16:09 INFO - 'TERM': 'linux', 06:16:09 INFO - 'TMOUT': '86400', 06:16:09 INFO - 'USER': 'cltbld', 06:16:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:09 INFO - '_': '/tools/buildbot/bin/python'} 06:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:16:10 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 06:16:10 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 06:16:10 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 06:16:10 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 06:16:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:16:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:16:11 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 06:16:11 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 06:16:11 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 06:16:11 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 06:16:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:16:11 INFO - warning: no files found matching '*.txt' 06:16:11 INFO - no previously-included directories found matching 'build' 06:16:11 INFO - no previously-included directories found matching 'dist' 06:16:11 INFO - no previously-included directories found matching '.git*' 06:16:11 INFO - Installing collected packages: jsonschema, functools32 06:16:11 INFO - Running setup.py install for functools32 06:16:11 INFO - warning: no files found matching '*.txt' 06:16:11 INFO - no previously-included directories found matching 'build' 06:16:11 INFO - no previously-included directories found matching 'dist' 06:16:11 INFO - no previously-included directories found matching '.git*' 06:16:11 INFO - Successfully installed jsonschema functools32 06:16:11 INFO - Cleaning up... 06:16:11 INFO - Return code: 0 06:16:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:16:11 INFO - Using env: {'DISPLAY': ':0', 06:16:11 INFO - 'HOME': '/home/cltbld', 06:16:11 INFO - 'LANG': 'en_US.UTF-8', 06:16:11 INFO - 'LANGUAGE': 'en_US:en', 06:16:11 INFO - 'LOGNAME': 'cltbld', 06:16:11 INFO - 'MAIL': '/var/mail/cltbld', 06:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:11 INFO - 'MOZ_NO_REMOTE': '1', 06:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:11 INFO - 'NO_EM_RESTART': '1', 06:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:11 INFO - 'PWD': '/builds/slave/test', 06:16:11 INFO - 'SHELL': '/bin/bash', 06:16:11 INFO - 'SHLVL': '1', 06:16:11 INFO - 'TERM': 'linux', 06:16:11 INFO - 'TMOUT': '86400', 06:16:11 INFO - 'USER': 'cltbld', 06:16:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:11 INFO - '_': '/tools/buildbot/bin/python'} 06:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:16:11 INFO - Cleaning up... 06:16:11 INFO - Return code: 0 06:16:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:16:11 INFO - Using env: {'DISPLAY': ':0', 06:16:11 INFO - 'HOME': '/home/cltbld', 06:16:11 INFO - 'LANG': 'en_US.UTF-8', 06:16:11 INFO - 'LANGUAGE': 'en_US:en', 06:16:11 INFO - 'LOGNAME': 'cltbld', 06:16:11 INFO - 'MAIL': '/var/mail/cltbld', 06:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:11 INFO - 'MOZ_NO_REMOTE': '1', 06:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:11 INFO - 'NO_EM_RESTART': '1', 06:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:11 INFO - 'PWD': '/builds/slave/test', 06:16:11 INFO - 'SHELL': '/bin/bash', 06:16:11 INFO - 'SHLVL': '1', 06:16:11 INFO - 'TERM': 'linux', 06:16:11 INFO - 'TMOUT': '86400', 06:16:11 INFO - 'USER': 'cltbld', 06:16:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:11 INFO - '_': '/tools/buildbot/bin/python'} 06:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:16:11 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 06:16:11 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 06:16:11 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 06:16:11 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 06:16:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:16:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:16:13 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 06:16:13 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 06:16:13 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 06:16:13 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 06:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:16:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:16:13 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 06:16:13 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 06:16:13 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 06:16:13 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 06:16:13 INFO - Downloading docopt-0.6.1.tar.gz 06:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:16:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:16:13 INFO - Running setup.py install for blobuploader 06:16:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:16:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:16:13 INFO - Running setup.py install for requests 06:16:14 INFO - Running setup.py install for docopt 06:16:14 INFO - Successfully installed blobuploader requests docopt 06:16:14 INFO - Cleaning up... 06:16:14 INFO - Return code: 0 06:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:14 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:14 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 06:16:14 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 06:16:14 INFO - Using env: {'DISPLAY': ':0', 06:16:14 INFO - 'HOME': '/home/cltbld', 06:16:14 INFO - 'LANG': 'en_US.UTF-8', 06:16:14 INFO - 'LANGUAGE': 'en_US:en', 06:16:14 INFO - 'LOGNAME': 'cltbld', 06:16:14 INFO - 'MAIL': '/var/mail/cltbld', 06:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:14 INFO - 'MOZ_NO_REMOTE': '1', 06:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:14 INFO - 'NO_EM_RESTART': '1', 06:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:14 INFO - 'PWD': '/builds/slave/test', 06:16:14 INFO - 'SHELL': '/bin/bash', 06:16:14 INFO - 'SHLVL': '1', 06:16:14 INFO - 'TERM': 'linux', 06:16:14 INFO - 'TMOUT': '86400', 06:16:14 INFO - 'USER': 'cltbld', 06:16:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:14 INFO - '_': '/tools/buildbot/bin/python'} 06:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:14 INFO - Running setup.py (path:/tmp/pip-in5se4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:14 INFO - Running setup.py (path:/tmp/pip-5NBQAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:14 INFO - Running setup.py (path:/tmp/pip-3R_jg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:14 INFO - Running setup.py (path:/tmp/pip-DLg4ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:14 INFO - Running setup.py (path:/tmp/pip-c7ViQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:14 INFO - Running setup.py (path:/tmp/pip-3X_FTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:14 INFO - Running setup.py (path:/tmp/pip-WQAVzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:14 INFO - Running setup.py (path:/tmp/pip-B3hqgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:15 INFO - Running setup.py (path:/tmp/pip-_Vl6hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:15 INFO - Running setup.py (path:/tmp/pip-E8DLCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:15 INFO - Running setup.py (path:/tmp/pip-U7C5iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:15 INFO - Running setup.py (path:/tmp/pip-3dW2Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:15 INFO - Running setup.py (path:/tmp/pip-0mIkbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:15 INFO - Running setup.py (path:/tmp/pip-BWWa8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:15 INFO - Running setup.py (path:/tmp/pip-iCInRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:15 INFO - Running setup.py (path:/tmp/pip-s8MGfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:15 INFO - Running setup.py (path:/tmp/pip-BpAODw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:16:15 INFO - Running setup.py install for manifestparser 06:16:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:16:15 INFO - Running setup.py install for mozcrash 06:16:15 INFO - Running setup.py install for mozdebug 06:16:15 INFO - Running setup.py install for mozdevice 06:16:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozfile 06:16:16 INFO - Running setup.py install for mozhttpd 06:16:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozinfo 06:16:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozInstall 06:16:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozleak 06:16:16 INFO - Running setup.py install for mozlog 06:16:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for moznetwork 06:16:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozprocess 06:16:16 INFO - Running setup.py install for mozprofile 06:16:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:16:16 INFO - Running setup.py install for mozrunner 06:16:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:16:17 INFO - Running setup.py install for mozscreenshot 06:16:17 INFO - Running setup.py install for moztest 06:16:17 INFO - Running setup.py install for mozversion 06:16:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:16:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:16:17 INFO - Cleaning up... 06:16:17 INFO - Return code: 0 06:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:17 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')]} 06:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:17 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')]} 06:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:17 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:17 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 06:16:17 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 06:16:17 INFO - Using env: {'DISPLAY': ':0', 06:16:17 INFO - 'HOME': '/home/cltbld', 06:16:17 INFO - 'LANG': 'en_US.UTF-8', 06:16:17 INFO - 'LANGUAGE': 'en_US:en', 06:16:17 INFO - 'LOGNAME': 'cltbld', 06:16:17 INFO - 'MAIL': '/var/mail/cltbld', 06:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:17 INFO - 'MOZ_NO_REMOTE': '1', 06:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:17 INFO - 'NO_EM_RESTART': '1', 06:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:17 INFO - 'PWD': '/builds/slave/test', 06:16:17 INFO - 'SHELL': '/bin/bash', 06:16:17 INFO - 'SHLVL': '1', 06:16:17 INFO - 'TERM': 'linux', 06:16:17 INFO - 'TMOUT': '86400', 06:16:17 INFO - 'USER': 'cltbld', 06:16:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:17 INFO - '_': '/tools/buildbot/bin/python'} 06:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:17 INFO - Running setup.py (path:/tmp/pip-c5631G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:17 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)) 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:17 INFO - Running setup.py (path:/tmp/pip-jZbBII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:17 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)) 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:17 INFO - Running setup.py (path:/tmp/pip-argltZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:17 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)) 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:17 INFO - Running setup.py (path:/tmp/pip-jhDQo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:17 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)) 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:17 INFO - Running setup.py (path:/tmp/pip-ce38BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:17 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)) 06:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:17 INFO - Running setup.py (path:/tmp/pip-F2smzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:18 INFO - Running setup.py (path:/tmp/pip-KE8Gre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:18 INFO - Running setup.py (path:/tmp/pip-sw_VHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:18 INFO - Running setup.py (path:/tmp/pip-ZwJa46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:18 INFO - Running setup.py (path:/tmp/pip-sYGskb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:18 INFO - Running setup.py (path:/tmp/pip-LFVLEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:18 INFO - Running setup.py (path:/tmp/pip-Gqouoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:18 INFO - Running setup.py (path:/tmp/pip-zu40UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:18 INFO - Running setup.py (path:/tmp/pip-DO7Q49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:18 INFO - Running setup.py (path:/tmp/pip-f2MeYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:18 INFO - Running setup.py (path:/tmp/pip-jLlRj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:18 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)) 06:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:18 INFO - Running setup.py (path:/tmp/pip-XlfE33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:18 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)) 06:16:18 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)) 06:16:18 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)) 06:16:18 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)) 06:16:18 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)) 06:16:18 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)) 06:16:18 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)) 06:16:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:18 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 06:16:18 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 06:16:18 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 06:16:18 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 06:16:19 INFO - Downloading blessings-1.6.tar.gz 06:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:16:20 INFO - Installing collected packages: blessings 06:16:20 INFO - Running setup.py install for blessings 06:16:20 INFO - Successfully installed blessings 06:16:20 INFO - Cleaning up... 06:16:20 INFO - Return code: 0 06:16:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:20 INFO - Reading from file tmpfile_stdout 06:16:20 INFO - Current package versions: 06:16:20 INFO - argparse == 1.2.1 06:16:20 INFO - blessings == 1.6 06:16:20 INFO - blobuploader == 1.2.4 06:16:20 INFO - docopt == 0.6.1 06:16:20 INFO - functools32 == 3.2.3-2 06:16:20 INFO - jsonschema == 2.5.1 06:16:20 INFO - manifestparser == 1.1 06:16:20 INFO - mozInstall == 1.13 06:16:20 INFO - mozcrash == 1.0 06:16:20 INFO - mozdebug == 0.1 06:16:20 INFO - mozdevice == 0.51 06:16:20 INFO - mozfile == 1.2 06:16:20 INFO - mozhttpd == 0.7 06:16:20 INFO - mozinfo == 0.10 06:16:20 INFO - mozleak == 0.1 06:16:20 INFO - mozlog == 3.5 06:16:20 INFO - moznetwork == 0.27 06:16:20 INFO - mozprocess == 0.25 06:16:20 INFO - mozprofile == 0.28 06:16:20 INFO - mozrunner == 6.13 06:16:20 INFO - mozscreenshot == 0.1 06:16:20 INFO - mozsystemmonitor == 0.3 06:16:20 INFO - moztest == 0.8 06:16:20 INFO - mozversion == 1.4 06:16:20 INFO - psutil == 3.1.1 06:16:20 INFO - requests == 1.2.3 06:16:20 INFO - wsgiref == 0.1.2 06:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:20 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')]} 06:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:20 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')]} 06:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:20 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:20 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 06:16:20 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 06:16:20 INFO - Using env: {'DISPLAY': ':0', 06:16:20 INFO - 'HOME': '/home/cltbld', 06:16:20 INFO - 'LANG': 'en_US.UTF-8', 06:16:20 INFO - 'LANGUAGE': 'en_US:en', 06:16:20 INFO - 'LOGNAME': 'cltbld', 06:16:20 INFO - 'MAIL': '/var/mail/cltbld', 06:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:20 INFO - 'MOZ_NO_REMOTE': '1', 06:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:20 INFO - 'NO_EM_RESTART': '1', 06:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:20 INFO - 'PWD': '/builds/slave/test', 06:16:20 INFO - 'SHELL': '/bin/bash', 06:16:20 INFO - 'SHLVL': '1', 06:16:20 INFO - 'TERM': 'linux', 06:16:20 INFO - 'TMOUT': '86400', 06:16:20 INFO - 'USER': 'cltbld', 06:16:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:20 INFO - '_': '/tools/buildbot/bin/python'} 06:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 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)) 06:16:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:16:20 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 06:16:20 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 06:16:20 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 06:16:20 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 06:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:16:21 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)) 06:16:21 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)) 06:16:21 INFO - Installing collected packages: simplejson 06:16:21 INFO - Running setup.py install for simplejson 06:16:21 INFO - building 'simplejson._speedups' extension 06:16:21 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 06:16:22 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 06:16:22 INFO - Successfully installed simplejson 06:16:22 INFO - Cleaning up... 06:16:22 INFO - Return code: 0 06:16:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:16:22 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')]} 06:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:22 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')]} 06:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:22 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 0x11db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1549f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', '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 06:16:22 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 06:16:22 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 06:16:22 INFO - Using env: {'DISPLAY': ':0', 06:16:22 INFO - 'HOME': '/home/cltbld', 06:16:22 INFO - 'LANG': 'en_US.UTF-8', 06:16:22 INFO - 'LANGUAGE': 'en_US:en', 06:16:22 INFO - 'LOGNAME': 'cltbld', 06:16:22 INFO - 'MAIL': '/var/mail/cltbld', 06:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:22 INFO - 'MOZ_NO_REMOTE': '1', 06:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:22 INFO - 'NO_EM_RESTART': '1', 06:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:22 INFO - 'PWD': '/builds/slave/test', 06:16:22 INFO - 'SHELL': '/bin/bash', 06:16:22 INFO - 'SHLVL': '1', 06:16:22 INFO - 'TERM': 'linux', 06:16:22 INFO - 'TMOUT': '86400', 06:16:22 INFO - 'USER': 'cltbld', 06:16:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:22 INFO - '_': '/tools/buildbot/bin/python'} 06:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:16:23 INFO - Cleaning up... 06:16:23 INFO - Return code: 0 06:16:23 INFO - Running post-action listener: _resource_record_post_action 06:16:23 INFO - Running post-action listener: _start_resource_monitoring 06:16:23 INFO - Starting resource monitoring. 06:16:23 INFO - [mozharness: 2017-08-24 13:16:23.155636Z] Finished create-virtualenv step (success) 06:16:23 INFO - [mozharness: 2017-08-24 13:16:23.156639Z] Running install step. 06:16:23 INFO - Running pre-action listener: _resource_record_pre_action 06:16:23 INFO - Running main action method: install 06:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:23 INFO - Reading from file tmpfile_stdout 06:16:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:16:23 INFO - Reading from file tmpfile_stdout 06:16:23 INFO - Output received: 06:16:23 INFO - Usage: mozinstall [options] installer 06:16:23 INFO - Options: 06:16:23 INFO - -h, --help show this help message and exit 06:16:23 INFO - -d DEST, --destination=DEST 06:16:23 INFO - Directory to install application into. [default: 06:16:23 INFO - "/builds/slave/test"] 06:16:23 INFO - --app=APP Application being installed. [default: firefox] 06:16:23 INFO - mkdir: /builds/slave/test/build/application 06:16:23 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'] 06:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:16:41 INFO - Reading from file tmpfile_stdout 06:16:41 INFO - Output received: 06:16:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:41 INFO - Running post-action listener: _resource_record_post_action 06:16:41 INFO - [mozharness: 2017-08-24 13:16:41.125613Z] Finished install step (success) 06:16:41 INFO - [mozharness: 2017-08-24 13:16:41.125897Z] Running setup-mitmproxy step. 06:16:41 INFO - Running pre-action listener: _resource_record_pre_action 06:16:41 INFO - Running main action method: setup_mitmproxy 06:16:41 INFO - Skipping: mitmproxy is not required 06:16:41 INFO - Running post-action listener: _resource_record_post_action 06:16:41 INFO - [mozharness: 2017-08-24 13:16:41.127023Z] Finished setup-mitmproxy step (success) 06:16:41 INFO - [mozharness: 2017-08-24 13:16:41.127242Z] Running run-tests step. 06:16:41 INFO - Running pre-action listener: _resource_record_pre_action 06:16:41 INFO - Running pre-action listener: _set_gcov_prefix 06:16:41 INFO - Running main action method: run_tests 06:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:41 INFO - Python 2.7.3 06:16:41 INFO - Return code: 0 06:16:41 INFO - grabbing minidump binary from tooltool 06:16:41 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')]} 06:16:41 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 0x1547130>, '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 0x1548030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15484c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:41 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 06:16:41 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 06:16:41 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 06:16:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:41 INFO - Return code: 0 06:16:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:41 INFO - ENV: RUST_BACKTRACE is now full 06:16:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:41 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/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:16:41 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/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:16:41 INFO - Using env: {'DISPLAY': ':0', 06:16:41 INFO - 'HOME': '/home/cltbld', 06:16:41 INFO - 'LANG': 'en_US.UTF-8', 06:16:41 INFO - 'LANGUAGE': 'en_US:en', 06:16:41 INFO - 'LOGNAME': 'cltbld', 06:16:41 INFO - 'MAIL': '/var/mail/cltbld', 06:16:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:41 INFO - 'MOZ_NO_REMOTE': '1', 06:16:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:41 INFO - 'NO_EM_RESTART': '1', 06:16:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:41 INFO - 'PWD': '/builds/slave/test', 06:16:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:41 INFO - 'RUST_BACKTRACE': 'full', 06:16:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:16:41 INFO - 'SHELL': '/bin/bash', 06:16:41 INFO - 'SHLVL': '1', 06:16:41 INFO - 'TERM': 'linux', 06:16:41 INFO - 'TMOUT': '86400', 06:16:41 INFO - 'USER': 'cltbld', 06:16:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464', 06:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:41 INFO - '_': '/tools/buildbot/bin/python'} 06:16:41 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/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:16:41 INFO - mozversion application_buildid: 20170824120051 06:16:41 INFO - mozversion application_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 06:16:41 INFO - mozversion application_display_name: Nightly 06:16:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:41 INFO - mozversion application_name: Firefox 06:16:41 INFO - mozversion application_remotingname: firefox 06:16:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:16:41 INFO - mozversion application_vendor: Mozilla 06:16:41 INFO - mozversion application_version: 57.0a1 06:16:41 INFO - mozversion platform_buildid: 20170824120051 06:16:41 INFO - mozversion platform_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 06:16:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:16:41 INFO - mozversion platform_version: 57.0a1 06:16:41 INFO - using testdate: 1503580601 06:16:41 INFO - actual date: 1503580601 06:16:41 INFO - starting webserver on 'localhost:40050' 06:16:41 INFO - SUITE-START | Running 2 tests 06:16:41 INFO - TEST-START | dromaeo_css 06:16:41 INFO - Initialising browser for dromaeo_css test... 06:16:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40050/getInfo.html -profile /tmp/tmp76w2uZ/profile 06:16:41 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox http://localhost:40050/getInfo.html) 06:16:49 INFO - TEST-INFO | 3311: exit 0 06:16:50 INFO - Browser initialized. 06:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:50 INFO - TEST-INFO | started process 3533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp76w2uZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:51 INFO - PID 3533 | 06:16:51 INFO - PID 3533 | (/builds/slave/test/build/application/firefox/firefox:3583): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:51 INFO - PID 3533 | 06:16:52 INFO - PID 3533 | 06:16:52 INFO - PID 3533 | (/builds/slave/test/build/application/firefox/firefox:3639): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:52 INFO - PID 3533 | 06:16:52 INFO - PID 3533 | __metrics Screen width/height:1600/1200 06:16:52 INFO - PID 3533 | colorDepth:24 06:16:52 INFO - PID 3533 | Browser inner width/height: 1024/768 06:16:52 INFO - PID 3533 | __metrics 06:17:01 INFO - PID 3533 | RSS: Main: 166289408 06:17:01 INFO - PID 3533 | 06:20:00 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40050/tests/dromaeo/cssquery-ext.html) 06:20:01 INFO - PID 3533 | RSS: Main: 170504192 06:20:01 INFO - PID 3533 | 06:23:03 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-ext.html (next: http://localhost:40050/tests/dromaeo/cssquery-jquery.html) 06:23:03 INFO - PID 3533 | RSS: Main: 166318080 06:23:03 INFO - PID 3533 | 06:26:05 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40050/tests/dromaeo/cssquery-mootools.html) 06:26:05 INFO - PID 3533 | RSS: Main: 168976384 06:26:05 INFO - PID 3533 | 06:29:07 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40050/tests/dromaeo/cssquery-prototype.html) 06:29:08 INFO - PID 3533 | RSS: Main: 165171200 06:29:08 INFO - PID 3533 | 06:32:11 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40050/tests/dromaeo/cssquery-yui.html) 06:32:11 INFO - PID 3533 | RSS: Main: 168398848 06:32:11 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-yui.html (next: http://localhost:40050/tests/dromaeo/cssquery-dojo.html) 06:35:13 INFO - PID 3533 | RSS: Main: 171106304 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | __start_tp_report 06:35:13 INFO - PID 3533 | _x_x_mozilla_page_load 06:35:13 INFO - PID 3533 | _x_x_mozilla_page_load_details 06:35:13 INFO - PID 3533 | |i|pagename|runs| 06:35:13 INFO - PID 3533 | |0;dojo.html;3558.323918455493;3819.8281077351517;3854.4411060396233;3858.7684738915686;3886.12562173511;6028.065649824273;6102.603330783501;6129.080637904311;6149.938500614992;6163.322034576193;6024.2168518092585;6094.360092190323;6099.329073801879;6103.969480152593;6114.480269177114;5476.288082549273;5533.806316778913;5559.499645031946;5573.442655734414;5608.495235428811;5509.311336082989;5575.275214222145;5578.553715702755;5614.157876318544;5619.550435965133;5320.52115309624;5455.863603409907;5524.806631767909;5584.385717571064;5621.943780562204;5516.531094856942;5531.502164805147;5583.553315734772;5583.972080139614;5604.355499117612;5480.04099282624;5495;5560.499555040065;5577.470140336662;5584.497395234408;5996.310424301218;6034.909476357858;6046.939530604725;6053.667048312341;6076.726547305382;6554.442872355856;6586.967065164691;6619.238787539398;6620.470362370998;6631.602103873783;6589.571677840925;6592.077109204715;6656.334366563354;6676.165479315086;6685.164354455693;6100.359462256488;6108.877822443571;6111.877762444727;6148.200733904653;6163.01391777318;6740.022696708949;6754.6284954327;6760.019797129388;6761.492888033319;6765.898511522331;6423.871522569522;6446.290908000116;6454.096426500294;6475.158229430144;6534.901976470357;6522.543421960512;6558.901616475757;6569.967150164314;6611.272759996396;6623.4038936495945;6499.577527460794;6519;6534.771283005072;6541.28045914949;6554.770583029666;6479.092926990225;6491.383318584822;6575;6600.471962243105;6604.900926486107;4734.26618874075;4829.66192366531;4836.709797412166;4860.538248866352;4927.310176575283;4522.796474158671;4545.340925565841;4582.495925448198;4586.97706511472;4599.816007359735;6093.238345206849;6094.177286066413;6172.012478003498;6181.041938499539;6185.567010309235;6538.901916471256;6553.311902250291;6608.801735947929;6629.171353580802;6637.369449902348;5995.790147344909;6092.908606370908;6111.113888486145;6143.539234557426;6153.230846144232;5330.466953304638;5392.325959255093;5404.108322126884;5405.081136206854;5406.756695948692;6780.86438271222;6789.422899053537;6792.252852186256;6882.518223724392;6894.103766510321;6407.455366293917;6412.807615771534;6478.870422591616;6511.804645860631;6576.934230657824;6834.419074378535;6839.897401538881;6930.237673855972;6936.687849046704;6940.861182776417;6499.122618446639;6533.640649764308;6591.901121483085;6601.24085730128;6606.306337834458;6464.09502669636;6523.869522609616;6535.901961470487;6537.803865884031;6657.600543967377;6232.8130156095385;6244.500439964882;6270.2475702915945;6327.082573026793;6344.206974128234;6342.524310676626;6408.487321014401;6410.262819775786;6413.038044293393;6420.325865784025;6324.905126423199;6339.144215530844;6341.904871427025;6418.871622567429;6436.67816609177;6211.9068213977735;6325.683715814099;6384.712687928962;6440.6135631862235;6480.287168411565;6227.221597300338;6244.2819075806865;6277.2781130170615;6282.057691346335;6283.560150789401 06:35:13 INFO - PID 3533 | |1;ext.html;905.601535324457;925.1488630459976;944.3578366710638;981.2787601113176;981.3130808434098;40677;40735.185296294134;41520;41539.376909346385;41548.169036619285;42385.57614423855;42795.35806962898;42839;42850.785746071306;42871.57128428715;7551.358134558555;7662.387009039291;7663.693452261903;7667.961660191719;7668.463207575444;7787.338076263524;7830.491018083835;7867.645955931968;7893.921060789405;7897.052353717533;7879.566623835687;7918.841623167533;7934.404919631022;7944.443888927777;7945.602719863984;7793.96103019487;7838.80402989927;7845.607719614025;7888.842223155505;7890.684372625088;7456.813579660497;7488.550686958745;7502.17476077631;7514.511556748794;7530.548167109991;38313.61686383128;38337.808310958266;38487.807560962014;38545.421818672745;38606.613933860586;3485.0590340608146;3521.418965870628;3524.700400465938;3528.2061536154415;3530.6998905093096;31486;31586.526202106987;31593.526097108563;31707.52438713421;31724.524132137805;5162.6128040397125;5289.603279754034;5324.1747529133045;5337.866553336159;5341.1187154119525;192294.9999999986;195197;202916;205616;213648.9317553418;49519;50230.748846255534;50656.493435065175;50688.74655626698;50752;52348;52351.47648523466;52357.47642523526;52365.47634523682;52396.476035239924;15293.082415055133;15307;15379;15433.38266469351;15451.072935623899;12714.809277860655;12738.681532961566;12746.91651209639;12757.55348562796;12761;13420.328983550784;13422;13441.126326788728;13467.797983030263;13482.25847578373;5308.203769434615;5354.9196762048605;5381.139017757218;5412.323459567554;5507.256520369779;997.6558087459815;1018.5721996761378;1048.224314007629;1050;1068.9198310126772;23476.178333758235;28935.276618084717;29381;29780.702192978228;30186.54720179199;1125.0665830334044;1130.0338210829786;1141.6061458796703;1148.1675785055934;1152.504423098059;12639.304838233986;12852.807207891889;12961.611151665466;13010.089293749535;13044.739105217843;274281;275556;275906;276267;276303;51289.48710512847;51492;51492.74253628783;51536.484635153916;51796.741016294676;1458.6790906000451;1466.7139907718106;1473.6536913825244;1509.728248915184;1512.4177191781023;22945.31164065081;23015.769842301364;23064.4233894154;23083.076676933408;23259.76740232576;37411;37596;37612.2477550442;37683.43474847934;37753.24493510169;235172;235208;235304;235455;235761;32654;32656.673433265365;34292.142696431794;36096.639033609325;36459.81770091133;45615.31577026413;47127;47248.763756181;47391.28913066238;47437;34478.65521344754;34508.82745586256;34547.481787772704;34661.13347166341;34821.651783481844;34769.826150870096;34777.60947053211;34907;34972.825135874155;35314.82342588271;38487;38520.422193666556;38781.224375512895;38833.223335533694;38836.805815970736;32843.34313313768;32932.34135317328;32962.17594560059;33000;33324.166895827795;24198;24919.875400623605;24947.501049978535;25572.488550229264;25658 06:35:13 INFO - PID 3533 | |2;jquery.html;577.8673799353268;578.4995978478614;580.9854753631156;586.375510081763;601.9067044608086;22363.44091397716;23226.18708345208;23450.179243726474;23478.17826376075;23516;25705.61441578373;26639.86680066597;26653.866730666366;26680.199594012163;26720.732792672068;6279.497640188785;6386.882295598251;6392.680365981706;6402.263739669927;6410.775622853201;5943.465088142067;6152.907706384408;6167.691615419233;6190.96904515479;6366.299707032223;6129.448349648531;6144.5698801083945;6156.630602163885;6161.599496032766;6164.167837341969;6119.5410344224365;6123.387661233885;6142.262928448592;6149.631022138664;6151.969240153793;5729.140628905698;5732.770689172428;5733.541316694655;5734.598578099534;5752.395998420189;29840.253993650116;30265.848670756724;30820.2294942626;31539.21151971196;31794.841025794954;2123.5646692428013;2152.860064095829;2158.84888057836;2159.017646970625;2160.1899287767087;19951.600967980557;20506.89746551258;20525.17899284027;20556.38330850062;20568.382948511568;2296.5636529059425;2408.3136306152664;2460.8646524441147;2498.912538061159;2510.8870100845506;150861;152808;153121.23439382733;153211.46788532083;153561.23219383945;14911.701765964837;15443.536693898975;15563.844361556467;15571;15604.531864044096;24052.15817446381;24053.879730601584;24069.879650601986;24077.398065048514;24104.7589524106;9876.259280553844;9924.305298629171;9925.503724813874;9956.203503719686;9978.251631127694;8375.706850260212;8701.912980870236;8922.55387230649;9018.458892466473;9155.679551215675;11558;12086.214396064228;12182.39088045612;12827.743445131046;12872.549460768829;4062.819904621631;4071.6742660587083;4100.5489396166395;4520;4548.56788605082;971.1793534463367;995.9850602240972;1007.8840933292619;1045.696747943088;1054.383185836279;20490.897545512475;20761.169553218006;20829.479263018547;21273;21381.78618213829;1034.7878684869584;1069.6149386220955;1087.8857719939451;1088.3034857691084;1098.6703988803326;11482.564679415073;11506.827397589042;11602.535898563963;11606.013488853374;11619.302841829518;582602;583876;585571;589852;595159;124748.37625811812;127733;131641.34179329043;131939;133726.3313683445;1271.0911698135692;1300.6163181861373;1322.3652646729624;1334.299492766286;1334.5529247701934;18555.628887421906;18704.064796759834;18808.15363308627;18946.621067578846;19127.23491060342;59603.403965959784;61340.38659613347;61743.382566173765;62233.37766622276;62944.68527657333;81437.59281203557;82560.58719706364;82744.58627706823;82858;83268;15165;15262;15385.38458461649;15454.536363909101;15558.455454059054;24095.397615059763;24145.879270603535;24399.878000609882;24432.14487492929;24616.261512154662;19458.8054119457;19516.21935122579;19551.413457596296;19603.215871364984;19702.802971970672;17551.297948081934;18064.277428902697;18085.186166622272;18585.721214182067;18702.251909923994;20524.38426847197;20524.794752052287;20619.072141753957;20877.37367878966;20980.580388392453;15160.620984475036;15341;15365.539033829004;15419;15430;20074.598508029467;20147;20206.89896550508;20213.49466263355;20257.49356266046 06:35:13 INFO - PID 3533 | |3;mootools.html;1428.6856891483874;1448.587152661491;1479.8298195707491;1492.7089217602559;1504.210289597961;15814.60463488412;16441.67116657666;16464.753028704577;16475.2586133624;16489.257983390748;15761.448349307777;17098.82901170991;17107.059111748847;17109;17122.31510739569;2594.390318275199;2649.244965184923;2654.2833434972545;2657.1762753546464;2659.9734002660016;2693.111273279823;2694.878730457124;2710.6747190337187;2788.762955148815;2795.7763378929635;2555.271747551948;2580.0453832082158;2586.818922675404;2593.196109206143;2595.117659995601;2716.4431291585274;2721.306066952924;2723.237493501823;2735.644366232387;2736.630554875086;2656.282803643025;2678.3973605938704;2679.1158917557354;2679.1828492309837;2683.8121331506804;15806.762898556532;16113.516594502184;16129;16133.515994520183;16161.91919040409;8147.348212143014;8408.789780255482;8414.242718155396;8420.989481262226;8445.788855278606;5227.163653815409;5358.973205133989;5395.406505284415;5508.3114610673665;5510.91733623996;2059.783722709124;2079.5736873940955;2084.4476213803205;2122.458773012872;2128.382768996989;27977.720222797714;28496.145115646563;29785.957491487912;29843.552346714816;29847.552286715716;6923.757668481579;7005.194402643761;7090.432765378758;7138.286171382924;7160.534565253241;18484.81515184858;18871.245150194114;18912;18922;18989.430317090508;8106.310963568163;8359.540225287546;8362.749117526484;8372.372072094495;8373.497590144489;7602.961985190039;7635.618219089023;7645.655945482466;7688.615569221516;7713.92286077132;5376.274202982626;5538.253350712876;5544.556435485151;5567.220589117527;5576.330840299109;1500.5423345879394;1504.6689728259764;1510.2826157575064;1531.4486784757478;1543.1358439274043;940.9247260219166;961.4904100826573;969.1907257439975;983.3706427886159;985.0986347491964;9246.352755307198;9328.160465557996;9343.299252556086;9401.76495587602;9643.855342169873;1032.2464600841429;1068.3269540189785;1081.967540973772;1084.6474895658785;1090.4711215060688;5277.340332458442;5343.465653434703;5365.54392876602;5604.271444712162;5770.596058275964;23317.766822331898;23689.526209475713;23997.28008159758;24124.63813042806;24349.26952191437;22747.31758047228;23535.646965295535;23901.7609823903;23974.760252397602;24160.51678966446;12644.30456324911;12841.293728844816;12914.806277905838;12934.67663308406;12944.805827912589;8540.316774658137;9221.907780922105;9235.815283694423;9308.581113849757;9312.348135630711;19341.903290483457;20280.492987675425;20288.188472460937;20752.273670421462;20861.791382085983;20958.161673532886;21178;21197.36407907765;21300.7869921305;21342.679859802425;11878.524859005543;11966.162368634461;12010.699732506757;12077.879221207675;12101.878981210075;14977.400903963719;15057;15061.096334219981;15065.472708455152;15084.773728393864;11823.940880295544;11876.643700688994;11955.64133076009;11986.940065299617;12232.69418264515;11194.944025279821;11241.213115081866;11396.886031139582;11454.94272528632;11540.480678369662;10208;10225.84661230097;10252.58989640406;10327.018933201334;10328.277020608486;8149.470284431493;8322.583870806557;8322.6670933162;8327.125651806715;8347.95826020866;7945.443818932619;8189.590520474072;8287.668493260202;8297.377696672653;8391.832163356821 06:35:13 INFO - PID 3533 | |4;prototype.html;525.508649412799;529.8781280305532;543.8226240189989;563.8759472915957;564.6188822544783;6038.275406951161;6098.146259523664;6104.48111910487;6173.722182501787;6201.162843016192;5851.79518716845;5934.703264836762;5977.880442391161;5992.850178745533;6055.788047418341;4874.195757699993;4897.8775530611665;4909.828156014541;4913.852584422455;4939.8024079036795;4787.40157480315;4867.829625963092;4884.829030983917;4912.336834527347;4928.408590969088;4878.58510037532;4889.095517329288;4892.899097703006;4912.852614421555;4920.212765957447;4840.249761287007;4889.266610008492;4897.412310522743;4904.8473608701925;4961.727105009223;4413.580709832593;4431.556844315575;4438.578335058164;4440.7335559866515;4444.200043992112;5949;5953.404659534055;5976.611520251213;5993.101034844764;5995.52035837132;5705.743241554099;5712.685802280873;5725.912076705413;5732.168835518868;5757.366689664133;6295.968520157416;6383.936160638381;6387.297397286295;6387.361263873622;6477.708503117324;4816.8554943351755;4846.39420072491;4847.709137451729;4891.266310053485;4897.363342765453;6655.502511934825;6789.490788190856;6789.966050169767;6820.522563420563;6853.485988550829;4927.852164435073;4992.350994370709;4996.725180115056;5027.371578552681;5050.595952323805;5060.949390506122;5069.352460450368;5081.74591270435;5093.923591146136;5101;5706.3152421709665;5721.828345149652;5731.570132240098;5750.2524671793235;5751.9424805751405;6357.8728425432155;6391.776287829996;6430.742770289229;6449.645269510128;6462.967685161544;1661.6925868714327;1663.96672066558;1700.4218565687725;1714.7225317138812;1740.747591599211;1215.617080619602;1225.6384366611871;1237.3132911234352;1239.4794186441716;1264.6142926407533;5951.345352011275;5958.433948774859;5997.750843433712;6008.459238668541;6009.849753756191;6474.1907261592305;6503.479721622353;6505.991571306455;6526.379993900572;6550.803475895731;6048.455638992512;6072.878542429126;6106.664133472613;6107.236595425572;6137.84655383619;3476.1309672581856;3499.9300014000087;3503.8248087595516;3513.7364697647777;3518.437050071976;6823.761168359084;6827.590344579341;6836.760713375107;6842.94711586522;6865.5537390070485;6753.3246675332075;6754.926508438649;6823.488238382042;6854.691538880762;6876.312368763083;6760.695768690421;6807.829804254933;6869.931300687029;6877.449804015567;6921.965390172916;6358.872822543431;6465.967670161619;6534.738610455529;6543.247526534509;6603.2406273277265;6455.3221911700475;6506.902396464152;6526.97663724247;6533.150690410216;6638.103855979381;6788.59005053199;6818.965905170442;6871.381575658214;6921.7231310747;6941.791746247621;4968.180250258667;4970.975145124251;4995.100881841304;5018.698878067327;5030.195168772979;6392.840178995376;6474.741010359533;6541.738330466728;6571.474282057519;6667.433268172065;6212.161358216583;6316.463100636313;6339.841503962438;6376.171097757262;6410.583312084699;6211.503079753699;6332.873342533031;6358.2687990879795;6410.1987251593555;6416.385662545273;6181.1655426516845;6244.65654389013;6335;6355.809325720235;6410.679466026773;6287.811365659038;6358.364163583789;6362.331955144643;6424;6441.355864413521;6207.689615519296;6212.937870621236;6256.31180570146;6263.436290733674;6314.873702526015 06:35:13 INFO - PID 3533 | |5;yui.html;946.1520822324804;947.0103741590037;968.922486201104;980.6420656460385;983.2330781990046;19774.209031638737;20195.697064544027;20223.191072357105;20236.8988155059;22591.54816903661;20064.297749578767;20404.489887752814;20513.692294615594;20543.178272869103;20556.69164962523;1044.7492601775557;1063.9521221545049;1064.3560645809291;1067.754416484209;1069.315637991686;1042.7028296935375;1078.983815242772;1080.692002779208;1082.826747720365;1085.6200329884516;1133.6315697398338;1134.1040577943456;1134.659602119365;1135.0238794636648;1135.5571327182406;1129.4522156753967;1129.5368898751472;1131.349474052419;1131.603938621476;1132.7564573616671;828.5111784047381;834.7412302186342;834.8246868157694;834.9666013359458;835.3818174550788;19204.61590768191;19558.315458959012;20777.58444831095;20797.16811327545;20919.163233470645;22058.558828823334;22058.88970555153;22125.66811497829;22144.557108857894;22615.208467703716;17412;17987.640247194984;18149.092545372812;18379.72430413545;18453.630927381513;3953.6639385652256;3996.500437445319;3997.5402828674783;3999.8200080996426;4000.299947509174;143681;144138;145632.2718386412;145796;145908;17378.304867805145;17461.563460913578;17618.119094045247;17703.645927081387;17724.91137544304;32789;33370.666293336755;33598.83200583982;33770.15574610605;33805.66194338025;8823.735287941372;8952.104789520996;8960;8996.640134394682;9013.594388252544;4165.062860856283;4200.033992181815;4214.199302132585;4220.493540775126;4221.092465120014;5486.1222204447095;5631.605787594829;5660.943390566124;5683.0338842396895;5703.771849125988;1018.9286749927583;1038.7039693687263;1052.55792567122;1054.504382940017;1054.931429457083;733.8899165125167;748.9513181643176;752.7478294771313;762.1540090499541;769.9345555627834;12288.569900053633;12418.689532761573;12929.806052909214;13569.25369104689;13901.443942242196;747.9289467500579;749.9925000750031;755.9659815308324;756.4969295418595;757.3448966643814;6182.6599537025895;6209.9068513972325;6242;6275.780347687901;6309.842253943596;131675;133691.33154334166;135088;135374.3231283857;139652.30173849268;119848.21366076921;122545;123477;125266;128032;106421.46789266005;106472.46763766132;108471.45764271128;110070.44964775124;110128;11523.53905843757;11646.70883227926;11763.882361176278;11787.410629468664;11840.940795295968;51115;51964.700882476725;52057.73971130272;52604.47395525996;52650.736746316026;81880.59059704663;82908.58545707233;83739.5813020931;84644;84896.57551712202;18519.90740046291;18589.907050464662;18748.906255468635;18787.90606046961;18810.811891880905;22596.209132680277;23171.76828231696;23212.95541700661;23328.183513576943;23409.648855267526;20860.58278834445;21441.571168576855;21549.353519394444;21659.133634654438;21955.560888782453;21560.892195538923;21710.565788684453;21891;22066.779332207116;22100.557988839813;20427;20861.687074694197;20986.790132099093;21371.572568548232;21721.239756608444;14429;14619.780703289673;15017.549473515812;15082.698346033238;15215.239238038275;14642.487512936996;15475.767863482282;15814.209289535707;15879.126648034007;16199.75700364472 06:35:13 INFO - PID 3533 | __end_tp_report 06:35:13 INFO - PID 3533 | __start_cc_report 06:35:13 INFO - PID 3533 | _x_x_mozilla_cycle_collect,336 06:35:13 INFO - PID 3533 | __end_cc_report 06:35:13 INFO - PID 3533 | __startTimestamp1503581713671__endTimestamp 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | ------- Summary: start ------- 06:35:13 INFO - PID 3533 | Number of tests: 6 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#0] dojo.html Cycles:165 Average:6080.39 Median:6282.06 stddev:684.29 (10.9%) stddev-sans-first:657.16 06:35:13 INFO - PID 3533 | Values: 3558.3 3819.8 3854.4 3858.8 3886.1 6028.1 6102.6 6129.1 6149.9 6163.3 6024.2 6094.4 6099.3 6104.0 6114.5 5476.3 5533.8 5559.5 5573.4 5608.5 5509.3 5575.3 5578.6 5614.2 5619.6 5320.5 5455.9 5524.8 5584.4 5621.9 5516.5 5531.5 5583.6 5584.0 5604.4 5480.0 5495.0 5560.5 5577.5 5584.5 5996.3 6034.9 6046.9 6053.7 6076.7 6554.4 6587.0 6619.2 6620.5 6631.6 6589.6 6592.1 6656.3 6676.2 6685.2 6100.4 6108.9 6111.9 6148.2 6163.0 6740.0 6754.6 6760.0 6761.5 6765.9 6423.9 6446.3 6454.1 6475.2 6534.9 6522.5 6558.9 6570.0 6611.3 6623.4 6499.6 6519.0 6534.8 6541.3 6554.8 6479.1 6491.4 6575.0 6600.5 6604.9 4734.3 4829.7 4836.7 4860.5 4927.3 4522.8 4545.3 4582.5 4587.0 4599.8 6093.2 6094.2 6172.0 6181.0 6185.6 6538.9 6553.3 6608.8 6629.2 6637.4 5995.8 6092.9 6111.1 6143.5 6153.2 5330.5 5392.3 5404.1 5405.1 5406.8 6780.9 6789.4 6792.3 6882.5 6894.1 6407.5 6412.8 6478.9 6511.8 6576.9 6834.4 6839.9 6930.2 6936.7 6940.9 6499.1 6533.6 6591.9 6601.2 6606.3 6464.1 6523.9 6535.9 6537.8 6657.6 6232.8 6244.5 6270.2 6327.1 6344.2 6342.5 6408.5 6410.3 6413.0 6420.3 6324.9 6339.1 6341.9 6418.9 6436.7 6211.9 6325.7 6384.7 6440.6 6480.3 6227.2 6244.3 6277.3 6282.1 6283.6 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#1] ext.html Cycles:180 Average:40834.93 Median:19422.76 stddev:62321.28 (320.9%) stddev-sans-first:62423.99 06:35:13 INFO - PID 3533 | Values: 905.6 925.1 944.4 981.3 981.3 40677.0 40735.2 41520.0 41539.4 41548.2 42385.6 42795.4 42839.0 42850.8 42871.6 7551.4 7662.4 7663.7 7668.0 7668.5 7787.3 7830.5 7867.6 7893.9 7897.1 7879.6 7918.8 7934.4 7944.4 7945.6 7794.0 7838.8 7845.6 7888.8 7890.7 7456.8 7488.6 7502.2 7514.5 7530.5 38313.6 38337.8 38487.8 38545.4 38606.6 3485.1 3521.4 3524.7 3528.2 3530.7 31486.0 31586.5 31593.5 31707.5 31724.5 5162.6 5289.6 5324.2 5337.9 5341.1 192295.0 195197.0 202916.0 205616.0 213648.9 49519.0 50230.7 50656.5 50688.7 50752.0 52348.0 52351.5 52357.5 52365.5 52396.5 15293.1 15307.0 15379.0 15433.4 15451.1 12714.8 12738.7 12746.9 12757.6 12761.0 13420.3 13422.0 13441.1 13467.8 13482.3 5308.2 5354.9 5381.1 5412.3 5507.3 997.7 1018.6 1048.2 1050.0 1068.9 23476.2 28935.3 29381.0 29780.7 30186.5 1125.1 1130.0 1141.6 1148.2 1152.5 12639.3 12852.8 12961.6 13010.1 13044.7 274281.0 275556.0 275906.0 276267.0 276303.0 51289.5 51492.0 51492.7 51536.5 51796.7 1458.7 1466.7 1473.7 1509.7 1512.4 22945.3 23015.8 23064.4 23083.1 23259.8 37411.0 37596.0 37612.2 37683.4 37753.2 235172.0 235208.0 235304.0 235455.0 235761.0 32654.0 32656.7 34292.1 36096.6 36459.8 45615.3 47127.0 47248.8 47391.3 47437.0 34478.7 34508.8 34547.5 34661.1 34821.7 34769.8 34777.6 34907.0 34972.8 35314.8 38487.0 38520.4 38781.2 38833.2 38836.8 32843.3 32932.3 32962.2 33000.0 33324.2 24198.0 24919.9 24947.5 25572.5 25658.0 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#2] jquery.html Cycles:180 Average:39282.95 Median:23338.18 stddev:98575.04 (422.4%) stddev-sans-first:98808.73 06:35:13 INFO - PID 3533 | Values: 577.9 578.5 581.0 586.4 601.9 22363.4 23226.2 23450.2 23478.2 23516.0 25705.6 26639.9 26653.9 26680.2 26720.7 6279.5 6386.9 6392.7 6402.3 6410.8 5943.5 6152.9 6167.7 6191.0 6366.3 6129.4 6144.6 6156.6 6161.6 6164.2 6119.5 6123.4 6142.3 6149.6 6152.0 5729.1 5732.8 5733.5 5734.6 5752.4 29840.3 30265.8 30820.2 31539.2 31794.8 2123.6 2152.9 2158.8 2159.0 2160.2 19951.6 20506.9 20525.2 20556.4 20568.4 2296.6 2408.3 2460.9 2498.9 2510.9 150861.0 152808.0 153121.2 153211.5 153561.2 14911.7 15443.5 15563.8 15571.0 15604.5 24052.2 24053.9 24069.9 24077.4 24104.8 9876.3 9924.3 9925.5 9956.2 9978.3 8375.7 8701.9 8922.6 9018.5 9155.7 11558.0 12086.2 12182.4 12827.7 12872.5 4062.8 4071.7 4100.5 4520.0 4548.6 971.2 996.0 1007.9 1045.7 1054.4 20490.9 20761.2 20829.5 21273.0 21381.8 1034.8 1069.6 1087.9 1088.3 1098.7 11482.6 11506.8 11602.5 11606.0 11619.3 582602.0 583876.0 585571.0 589852.0 595159.0 124748.4 127733.0 131641.3 131939.0 133726.3 1271.1 1300.6 1322.4 1334.3 1334.6 18555.6 18704.1 18808.2 18946.6 19127.2 59603.4 61340.4 61743.4 62233.4 62944.7 81437.6 82560.6 82744.6 82858.0 83268.0 15165.0 15262.0 15385.4 15454.5 15558.5 24095.4 24145.9 24399.9 24432.1 24616.3 19458.8 19516.2 19551.4 19603.2 19702.8 17551.3 18064.3 18085.2 18585.7 18702.3 20524.4 20524.8 20619.1 20877.4 20980.6 15160.6 15341.0 15365.5 15419.0 15430.0 20074.6 20147.0 20206.9 20213.5 20257.5 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#3] mootools.html Cycles:180 Average:10088.04 Median:2567.66 stddev:7384.42 (287.6%) stddev-sans-first:7376.48 06:35:13 INFO - PID 3533 | Values: 1428.7 1448.6 1479.8 1492.7 1504.2 15814.6 16441.7 16464.8 16475.3 16489.3 15761.4 17098.8 17107.1 17109.0 17122.3 2594.4 2649.2 2654.3 2657.2 2660.0 2693.1 2694.9 2710.7 2788.8 2795.8 2555.3 2580.0 2586.8 2593.2 2595.1 2716.4 2721.3 2723.2 2735.6 2736.6 2656.3 2678.4 2679.1 2679.2 2683.8 15806.8 16113.5 16129.0 16133.5 16161.9 8147.3 8408.8 8414.2 8421.0 8445.8 5227.2 5359.0 5395.4 5508.3 5510.9 2059.8 2079.6 2084.4 2122.5 2128.4 27977.7 28496.1 29786.0 29843.6 29847.6 6923.8 7005.2 7090.4 7138.3 7160.5 18484.8 18871.2 18912.0 18922.0 18989.4 8106.3 8359.5 8362.7 8372.4 8373.5 7603.0 7635.6 7645.7 7688.6 7713.9 5376.3 5538.3 5544.6 5567.2 5576.3 1500.5 1504.7 1510.3 1531.4 1543.1 940.9 961.5 969.2 983.4 985.1 9246.4 9328.2 9343.3 9401.8 9643.9 1032.2 1068.3 1082.0 1084.6 1090.5 5277.3 5343.5 5365.5 5604.3 5770.6 23317.8 23689.5 23997.3 24124.6 24349.3 22747.3 23535.6 23901.8 23974.8 24160.5 12644.3 12841.3 12914.8 12934.7 12944.8 8540.3 9221.9 9235.8 9308.6 9312.3 19341.9 20280.5 20288.2 20752.3 20861.8 20958.2 21178.0 21197.4 21300.8 21342.7 11878.5 11966.2 12010.7 12077.9 12101.9 14977.4 15057.0 15061.1 15065.5 15084.8 11823.9 11876.6 11955.6 11986.9 12232.7 11194.9 11241.2 11396.9 11454.9 11540.5 10208.0 10225.8 10252.6 10327.0 10328.3 8149.5 8322.6 8322.7 8327.1 8348.0 7945.4 8189.6 8287.7 8297.4 8391.8 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#4] prototype.html Cycles:180 Average:5476.90 Median:6052.12 stddev:1536.05 (25.4%) stddev-sans-first:1494.73 06:35:13 INFO - PID 3533 | Values: 525.5 529.9 543.8 563.9 564.6 6038.3 6098.1 6104.5 6173.7 6201.2 5851.8 5934.7 5977.9 5992.9 6055.8 4874.2 4897.9 4909.8 4913.9 4939.8 4787.4 4867.8 4884.8 4912.3 4928.4 4878.6 4889.1 4892.9 4912.9 4920.2 4840.2 4889.3 4897.4 4904.8 4961.7 4413.6 4431.6 4438.6 4440.7 4444.2 5949.0 5953.4 5976.6 5993.1 5995.5 5705.7 5712.7 5725.9 5732.2 5757.4 6296.0 6383.9 6387.3 6387.4 6477.7 4816.9 4846.4 4847.7 4891.3 4897.4 6655.5 6789.5 6790.0 6820.5 6853.5 4927.9 4992.4 4996.7 5027.4 5050.6 5060.9 5069.4 5081.7 5093.9 5101.0 5706.3 5721.8 5731.6 5750.3 5751.9 6357.9 6391.8 6430.7 6449.6 6463.0 1661.7 1664.0 1700.4 1714.7 1740.7 1215.6 1225.6 1237.3 1239.5 1264.6 5951.3 5958.4 5997.8 6008.5 6009.8 6474.2 6503.5 6506.0 6526.4 6550.8 6048.5 6072.9 6106.7 6107.2 6137.8 3476.1 3499.9 3503.8 3513.7 3518.4 6823.8 6827.6 6836.8 6842.9 6865.6 6753.3 6754.9 6823.5 6854.7 6876.3 6760.7 6807.8 6869.9 6877.4 6922.0 6358.9 6466.0 6534.7 6543.2 6603.2 6455.3 6506.9 6527.0 6533.2 6638.1 6788.6 6819.0 6871.4 6921.7 6941.8 4968.2 4971.0 4995.1 5018.7 5030.2 6392.8 6474.7 6541.7 6571.5 6667.4 6212.2 6316.5 6339.8 6376.2 6410.6 6211.5 6332.9 6358.3 6410.2 6416.4 6181.2 6244.7 6335.0 6355.8 6410.7 6287.8 6358.4 6362.3 6424.0 6441.4 6207.7 6212.9 6256.3 6263.4 6314.9 06:35:13 INFO - PID 3533 | 06:35:13 INFO - PID 3533 | [#5] yui.html Cycles:180 Average:27772.45 Median:20549.93 stddev:39211.55 (190.8%) stddev-sans-first:39269.81 06:35:13 INFO - PID 3533 | Values: 946.2 947.0 968.9 980.6 983.2 19774.2 20195.7 20223.2 20236.9 22591.5 20064.3 20404.5 20513.7 20543.2 20556.7 1044.7 1064.0 1064.4 1067.8 1069.3 1042.7 1079.0 1080.7 1082.8 1085.6 1133.6 1134.1 1134.7 1135.0 1135.6 1129.5 1129.5 1131.3 1131.6 1132.8 828.5 834.7 834.8 835.0 835.4 19204.6 19558.3 20777.6 20797.2 20919.2 22058.6 22058.9 22125.7 22144.6 22615.2 17412.0 17987.6 18149.1 18379.7 18453.6 3953.7 3996.5 3997.5 3999.8 4000.3 143681.0 144138.0 145632.3 145796.0 145908.0 17378.3 17461.6 17618.1 17703.6 17724.9 32789.0 33370.7 33598.8 33770.2 33805.7 8823.7 8952.1 8960.0 8996.6 9013.6 4165.1 4200.0 4214.2 4220.5 4221.1 5486.1 5631.6 5660.9 5683.0 5703.8 1018.9 1038.7 1052.6 1054.5 1054.9 733.9 749.0 752.7 762.2 769.9 12288.6 12418.7 12929.8 13569.3 13901.4 747.9 750.0 756.0 756.5 757.3 6182.7 6209.9 6242.0 6275.8 6309.8 131675.0 133691.3 135088.0 135374.3 139652.3 119848.2 122545.0 123477.0 125266.0 128032.0 106421.5 106472.5 108471.5 110070.4 110128.0 11523.5 11646.7 11763.9 11787.4 11840.9 51115.0 51964.7 52057.7 52604.5 52650.7 81880.6 82908.6 83739.6 84644.0 84896.6 18519.9 18589.9 18748.9 18787.9 18810.8 22596.2 23171.8 23213.0 23328.2 23409.6 20860.6 21441.6 21549.4 21659.1 21955.6 21560.9 21710.6 21891.0 22066.8 22100.6 20427.0 20861.7 20986.8 21371.6 21721.2 14429.0 14619.8 15017.5 15082.7 15215.2 14642.5 15475.8 15814.2 15879.1 16199.8 06:35:13 INFO - PID 3533 | -------- Summary: end -------- 06:35:13 INFO - PID 3533 | 06:35:14 INFO - TEST-INFO | 3533: exit 0 06:35:14 INFO - TEST-OK | dromaeo_css | took 1112765ms 06:35:14 INFO - TEST-START | kraken 06:35:14 INFO - Initialising browser for kraken test... 06:35:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40050/getInfo.html -profile /tmp/tmpkuyRGA/profile 06:35:14 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox http://localhost:40050/getInfo.html) 06:35:19 INFO - TEST-INFO | 3953: exit 0 06:35:19 INFO - Browser initialized. 06:35:19 INFO - Running cycle 1/1 for kraken test... 06:35:19 INFO - TEST-INFO | started process 4127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuyRGA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:20 INFO - PID 4127 | 06:35:20 INFO - PID 4127 | (/builds/slave/test/build/application/firefox/firefox:4177): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:35:20 INFO - PID 4127 | 06:35:21 INFO - PID 4127 | 06:35:21 INFO - PID 4127 | (/builds/slave/test/build/application/firefox/firefox:4231): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:35:21 INFO - PID 4127 | 06:35:21 INFO - PID 4127 | __metrics Screen width/height:1600/1200 06:35:21 INFO - PID 4127 | colorDepth:24 06:35:21 INFO - PID 4127 | Browser inner width/height: 1024/768 06:35:21 INFO - PID 4127 | __metrics 06:35:31 INFO - PID 4127 | RSS: Main: 165842944 06:35:31 INFO - PID 4127 | 06:35:33 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:34 INFO - PID 4127 | RSS: Main: 170115072 06:35:34 INFO - PID 4127 | 06:35:37 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-dft) 06:35:37 INFO - PID 4127 | RSS: Main: 172761088 06:35:37 INFO - PID 4127 | 06:35:40 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-fft) 06:35:41 INFO - PID 4127 | RSS: Main: 166137856 06:35:41 INFO - PID 4127 | 06:35:43 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-oscillator) 06:35:43 INFO - PID 4127 | RSS: Main: 167215104 06:35:43 INFO - PID 4127 | 06:35:45 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:46 INFO - PID 4127 | RSS: Main: 166965248 06:35:46 INFO - PID 4127 | 06:35:49 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:50 INFO - PID 4127 | RSS: Main: 167694336 06:35:50 INFO - PID 4127 | 06:35:53 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:54 INFO - PID 4127 | RSS: Main: 168472576 06:35:54 INFO - PID 4127 | 06:35:56 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40050/tests/kraken/driver.html?testName=json-parse-financial) 06:35:57 INFO - PID 4127 | RSS: Main: 168992768 06:35:57 INFO - PID 4127 | 06:35:59 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40050/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:59 INFO - PID 4127 | RSS: Main: 168714240 06:35:59 INFO - PID 4127 | 06:36:01 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:36:02 INFO - PID 4127 | RSS: Main: 168472576 06:36:02 INFO - PID 4127 | 06:36:04 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:36:04 INFO - PID 4127 | RSS: Main: 168931328 06:36:04 INFO - PID 4127 | 06:36:07 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:36:07 INFO - PID 4127 | RSS: Main: 168779776 06:36:07 INFO - PID 4127 | 06:36:10 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:36:11 INFO - PID 4127 | RSS: Main: 168951808 06:36:11 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40050/tests/kraken/driver.html?testName=ai-astar) 06:36:13 INFO - PID 4127 | RSS: Main: 170696704 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | __start_tp_report 06:36:13 INFO - PID 4127 | _x_x_mozilla_page_load 06:36:13 INFO - PID 4127 | _x_x_mozilla_page_load_details 06:36:13 INFO - PID 4127 | |i|pagename|runs| 06:36:13 INFO - PID 4127 | |0;ai-astar;95;105;99;104;105;107;107;105;107;108 06:36:13 INFO - PID 4127 | |1;audio-beat-detection;140;118;147;170;113;142;143;120;164;121 06:36:13 INFO - PID 4127 | |2;audio-dft;169;164;164;164;163;162;160;163;165;163 06:36:13 INFO - PID 4127 | |3;audio-fft;79;73;74;179;74;74;73;73;156;74 06:36:13 INFO - PID 4127 | |4;audio-oscillator;79;78;127;78;79;80;134;79;78;137 06:36:13 INFO - PID 4127 | |5;imaging-gaussian-blur;113;113;114;115;113;113;114;113;114;114 06:36:13 INFO - PID 4127 | |6;imaging-darkroom;151;150;150;150;151;151;151;151;150;155 06:36:13 INFO - PID 4127 | |7;imaging-desaturate;95;94;94;94;93;94;94;93;94;94 06:36:13 INFO - PID 4127 | |8;json-parse-financial;45;45;45;45;45;45;45;46;45;44 06:36:13 INFO - PID 4127 | |9;json-stringify-tinderbox;51;52;52;52;51;51;51;51;51;51 06:36:13 INFO - PID 4127 | |10;stanford-crypto-aes;72;74;71;73;72;73;73;73;73;73 06:36:13 INFO - PID 4127 | |11;stanford-crypto-ccm;115;120;119;116;110;123;110;117;110;147 06:36:13 INFO - PID 4127 | |12;stanford-crypto-pbkdf2;170;166;167;166;162;167;165;168;165;171 06:36:13 INFO - PID 4127 | |13;stanford-crypto-sha256-iterative;61;62;64;62;63;62;74;60;61;60 06:36:13 INFO - PID 4127 | __end_tp_report 06:36:13 INFO - PID 4127 | __start_cc_report 06:36:13 INFO - PID 4127 | _x_x_mozilla_cycle_collect,908 06:36:13 INFO - PID 4127 | __end_cc_report 06:36:13 INFO - PID 4127 | __startTimestamp1503581773283__endTimestamp 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | ------- Summary: start ------- 06:36:13 INFO - PID 4127 | Number of tests: 14 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#0] ai-astar Cycles:10 Average:104.20 Median:107.00 stddev:4.10 (3.8%) stddev-sans-first:2.68 06:36:13 INFO - PID 4127 | Values: 95.0 105.0 99.0 104.0 105.0 107.0 107.0 105.0 107.0 108.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:142.50 stddev:19.62 (13.8%) stddev-sans-first:20.79 06:36:13 INFO - PID 4127 | Values: 140.0 118.0 147.0 170.0 113.0 142.0 143.0 120.0 164.0 121.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.31 (1.4%) stddev-sans-first:1.45 06:36:13 INFO - PID 4127 | Values: 169.0 164.0 164.0 164.0 163.0 162.0 160.0 163.0 165.0 163.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.00 stddev:39.73 (53.7%) stddev-sans-first:41.82 06:36:13 INFO - PID 4127 | Values: 79.0 73.0 74.0 179.0 74.0 74.0 73.0 73.0 156.0 74.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:78.50 stddev:26.18 (33.4%) stddev-sans-first:27.13 06:36:13 INFO - PID 4127 | Values: 79.0 78.0 127.0 78.0 79.0 80.0 134.0 79.0 78.0 137.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 06:36:13 INFO - PID 4127 | Values: 113.0 113.0 114.0 115.0 113.0 113.0 114.0 113.0 114.0 114.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 06:36:13 INFO - PID 4127 | Values: 151.0 150.0 150.0 150.0 151.0 151.0 151.0 151.0 150.0 155.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 06:36:13 INFO - PID 4127 | Values: 95.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:0.47 (1.0%) stddev-sans-first:0.50 06:36:13 INFO - PID 4127 | Values: 45.0 45.0 45.0 45.0 45.0 45.0 45.0 46.0 45.0 44.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#9] json-stringify-tinderbox Cycles:10 Average:51.30 Median:51.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 06:36:13 INFO - PID 4127 | Values: 51.0 52.0 52.0 52.0 51.0 51.0 51.0 51.0 51.0 51.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 06:36:13 INFO - PID 4127 | Values: 72.0 74.0 71.0 73.0 72.0 73.0 73.0 73.0 73.0 73.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:118.00 stddev:10.91 (9.2%) stddev-sans-first:11.49 06:36:13 INFO - PID 4127 | Values: 115.0 120.0 119.0 116.0 110.0 123.0 110.0 117.0 110.0 147.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:2.58 (1.5%) stddev-sans-first:2.45 06:36:13 INFO - PID 4127 | Values: 170.0 166.0 167.0 166.0 162.0 167.0 165.0 168.0 165.0 171.0 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:4.09 (6.6%) stddev-sans-first:4.28 06:36:13 INFO - PID 4127 | Values: 61.0 62.0 64.0 62.0 63.0 62.0 74.0 60.0 61.0 60.0 06:36:13 INFO - PID 4127 | -------- Summary: end -------- 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 06:36:13 INFO - PID 4127 | 06:36:13 INFO - PID 4127 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:36:14 INFO - TEST-INFO | 4127: exit 0 06:36:14 INFO - TEST-OK | kraken | took 59810ms 06:36:14 INFO - SUITE-END | took 1172s 06:36:14 INFO - Completed test suite (00:19:32) 06:36:14 INFO - javascript benchmark 06:36:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8881.50118568702, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3558.323918455493, 3819.8281077351517, 3854.4411060396233, 3858.7684738915686, 3886.12562173511, 6028.065649824273, 6102.603330783501, 6129.080637904311, 6149.938500614992, 6163.322034576193, 6024.2168518092585, 6094.360092190323, 6099.329073801879, 6103.969480152593, 6114.480269177114, 5476.288082549273, 5533.806316778913, 5559.499645031946, 5573.442655734414, 5608.495235428811, 5509.311336082989, 5575.275214222145, 5578.553715702755, 5614.157876318544, 5619.550435965133, 5320.52115309624, 5455.863603409907, 5524.806631767909, 5584.385717571064, 5621.943780562204, 5516.531094856942, 5531.502164805147, 5583.553315734772, 5583.972080139614, 5604.355499117612, 5480.04099282624, 5495.0, 5560.499555040065, 5577.470140336662, 5584.497395234408, 5996.310424301218, 6034.909476357858, 6046.939530604725, 6053.667048312341, 6076.726547305382, 6554.442872355856, 6586.967065164691, 6619.238787539398, 6620.470362370998, 6631.602103873783, 6589.571677840925, 6592.077109204715, 6656.334366563354, 6676.165479315086, 6685.164354455693, 6100.359462256488, 6108.877822443571, 6111.877762444727, 6148.200733904653, 6163.01391777318, 6740.022696708949, 6754.6284954327, 6760.019797129388, 6761.492888033319, 6765.898511522331, 6423.871522569522, 6446.290908000116, 6454.096426500294, 6475.158229430144, 6534.901976470357, 6522.543421960512, 6558.901616475757, 6569.967150164314, 6611.272759996396, 6623.4038936495945, 6499.577527460794, 6519.0, 6534.771283005072, 6541.28045914949, 6554.770583029666, 6479.092926990225, 6491.383318584822, 6575.0, 6600.471962243105, 6604.900926486107, 4734.26618874075, 4829.66192366531, 4836.709797412166, 4860.538248866352, 4927.310176575283, 4522.796474158671, 4545.340925565841, 4582.495925448198, 4586.97706511472, 4599.816007359735, 6093.238345206849, 6094.177286066413, 6172.012478003498, 6181.041938499539, 6185.567010309235, 6538.901916471256, 6553.311902250291, 6608.801735947929, 6629.171353580802, 6637.369449902348, 5995.790147344909, 6092.908606370908, 6111.113888486145, 6143.539234557426, 6153.230846144232, 5330.466953304638, 5392.325959255093, 5404.108322126884, 5405.081136206854, 5406.756695948692, 6780.86438271222, 6789.422899053537, 6792.252852186256, 6882.518223724392, 6894.103766510321, 6407.455366293917, 6412.807615771534, 6478.870422591616, 6511.804645860631, 6576.934230657824, 6834.419074378535, 6839.897401538881, 6930.237673855972, 6936.687849046704, 6940.861182776417, 6499.122618446639, 6533.640649764308, 6591.901121483085, 6601.24085730128, 6606.306337834458, 6464.09502669636, 6523.869522609616, 6535.901961470487, 6537.803865884031, 6657.600543967377, 6232.8130156095385, 6244.500439964882, 6270.2475702915945, 6327.082573026793, 6344.206974128234, 6342.524310676626, 6408.487321014401, 6410.262819775786, 6413.038044293393, 6420.325865784025, 6324.905126423199, 6339.144215530844, 6341.904871427025, 6418.871622567429, 6436.67816609177, 6211.9068213977735, 6325.683715814099, 6384.712687928962, 6440.6135631862235, 6480.287168411565, 6227.221597300338, 6244.2819075806865, 6277.2781130170615, 6282.057691346335, 6283.560150789401], "value": 6036.433975853546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.601535324457, 925.1488630459976, 944.3578366710638, 981.2787601113176, 981.3130808434098, 40677.0, 40735.185296294134, 41520.0, 41539.376909346385, 41548.169036619285, 42385.57614423855, 42795.35806962898, 42839.0, 42850.785746071306, 42871.57128428715, 7551.358134558555, 7662.387009039291, 7663.693452261903, 7667.961660191719, 7668.463207575444, 7787.338076263524, 7830.491018083835, 7867.645955931968, 7893.921060789405, 7897.052353717533, 7879.566623835687, 7918.841623167533, 7934.404919631022, 7944.443888927777, 7945.602719863984, 7793.96103019487, 7838.80402989927, 7845.607719614025, 7888.842223155505, 7890.684372625088, 7456.813579660497, 7488.550686958745, 7502.17476077631, 7514.511556748794, 7530.548167109991, 38313.61686383128, 38337.808310958266, 38487.807560962014, 38545.421818672745, 38606.613933860586, 3485.0590340608146, 3521.418965870628, 3524.700400465938, 3528.2061536154415, 3530.6998905093096, 31486.0, 31586.526202106987, 31593.526097108563, 31707.52438713421, 31724.524132137805, 5162.6128040397125, 5289.603279754034, 5324.1747529133045, 5337.866553336159, 5341.1187154119525, 192294.9999999986, 195197.0, 202916.0, 205616.0, 213648.9317553418, 49519.0, 50230.748846255534, 50656.493435065175, 50688.74655626698, 50752.0, 52348.0, 52351.47648523466, 52357.47642523526, 52365.47634523682, 52396.476035239924, 15293.082415055133, 15307.0, 15379.0, 15433.38266469351, 15451.072935623899, 12714.809277860655, 12738.681532961566, 12746.91651209639, 12757.55348562796, 12761.0, 13420.328983550784, 13422.0, 13441.126326788728, 13467.797983030263, 13482.25847578373, 5308.203769434615, 5354.9196762048605, 5381.139017757218, 5412.323459567554, 5507.256520369779, 997.6558087459815, 1018.5721996761378, 1048.224314007629, 1050.0, 1068.9198310126772, 23476.178333758235, 28935.276618084717, 29381.0, 29780.702192978228, 30186.54720179199, 1125.0665830334044, 1130.0338210829786, 1141.6061458796703, 1148.1675785055934, 1152.504423098059, 12639.304838233986, 12852.807207891889, 12961.611151665466, 13010.089293749535, 13044.739105217843, 274281.0, 275556.0, 275906.0, 276267.0, 276303.0, 51289.48710512847, 51492.0, 51492.74253628783, 51536.484635153916, 51796.741016294676, 1458.6790906000451, 1466.7139907718106, 1473.6536913825244, 1509.728248915184, 1512.4177191781023, 22945.31164065081, 23015.769842301364, 23064.4233894154, 23083.076676933408, 23259.76740232576, 37411.0, 37596.0, 37612.2477550442, 37683.43474847934, 37753.24493510169, 235172.0, 235208.0, 235304.0, 235455.0, 235761.0, 32654.0, 32656.673433265365, 34292.142696431794, 36096.639033609325, 36459.81770091133, 45615.31577026413, 47127.0, 47248.763756181, 47391.28913066238, 47437.0, 34478.65521344754, 34508.82745586256, 34547.481787772704, 34661.13347166341, 34821.651783481844, 34769.826150870096, 34777.60947053211, 34907.0, 34972.825135874155, 35314.82342588271, 38487.0, 38520.422193666556, 38781.224375512895, 38833.223335533694, 38836.805815970736, 32843.34313313768, 32932.34135317328, 32962.17594560059, 33000.0, 33324.166895827795, 24198.0, 24919.875400623605, 24947.501049978535, 25572.488550229264, 25658.0], "value": 17750.080443691735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8673799353268, 578.4995978478614, 580.9854753631156, 586.375510081763, 601.9067044608086, 22363.44091397716, 23226.18708345208, 23450.179243726474, 23478.17826376075, 23516.0, 25705.61441578373, 26639.86680066597, 26653.866730666366, 26680.199594012163, 26720.732792672068, 6279.497640188785, 6386.882295598251, 6392.680365981706, 6402.263739669927, 6410.775622853201, 5943.465088142067, 6152.907706384408, 6167.691615419233, 6190.96904515479, 6366.299707032223, 6129.448349648531, 6144.5698801083945, 6156.630602163885, 6161.599496032766, 6164.167837341969, 6119.5410344224365, 6123.387661233885, 6142.262928448592, 6149.631022138664, 6151.969240153793, 5729.140628905698, 5732.770689172428, 5733.541316694655, 5734.598578099534, 5752.395998420189, 29840.253993650116, 30265.848670756724, 30820.2294942626, 31539.21151971196, 31794.841025794954, 2123.5646692428013, 2152.860064095829, 2158.84888057836, 2159.017646970625, 2160.1899287767087, 19951.600967980557, 20506.89746551258, 20525.17899284027, 20556.38330850062, 20568.382948511568, 2296.5636529059425, 2408.3136306152664, 2460.8646524441147, 2498.912538061159, 2510.8870100845506, 150861.0, 152808.0, 153121.23439382733, 153211.46788532083, 153561.23219383945, 14911.701765964837, 15443.536693898975, 15563.844361556467, 15571.0, 15604.531864044096, 24052.15817446381, 24053.879730601584, 24069.879650601986, 24077.398065048514, 24104.7589524106, 9876.259280553844, 9924.305298629171, 9925.503724813874, 9956.203503719686, 9978.251631127694, 8375.706850260212, 8701.912980870236, 8922.55387230649, 9018.458892466473, 9155.679551215675, 11558.0, 12086.214396064228, 12182.39088045612, 12827.743445131046, 12872.549460768829, 4062.819904621631, 4071.6742660587083, 4100.5489396166395, 4520.0, 4548.56788605082, 971.1793534463367, 995.9850602240972, 1007.8840933292619, 1045.696747943088, 1054.383185836279, 20490.897545512475, 20761.169553218006, 20829.479263018547, 21273.0, 21381.78618213829, 1034.7878684869584, 1069.6149386220955, 1087.8857719939451, 1088.3034857691084, 1098.6703988803326, 11482.564679415073, 11506.827397589042, 11602.535898563963, 11606.013488853374, 11619.302841829518, 582602.0, 583876.0, 585571.0, 589852.0, 595159.0, 124748.37625811812, 127733.0, 131641.34179329043, 131939.0, 133726.3313683445, 1271.0911698135692, 1300.6163181861373, 1322.3652646729624, 1334.299492766286, 1334.5529247701934, 18555.628887421906, 18704.064796759834, 18808.15363308627, 18946.621067578846, 19127.23491060342, 59603.403965959784, 61340.38659613347, 61743.382566173765, 62233.37766622276, 62944.68527657333, 81437.59281203557, 82560.58719706364, 82744.58627706823, 82858.0, 83268.0, 15165.0, 15262.0, 15385.38458461649, 15454.536363909101, 15558.455454059054, 24095.397615059763, 24145.879270603535, 24399.878000609882, 24432.14487492929, 24616.261512154662, 19458.8054119457, 19516.21935122579, 19551.413457596296, 19603.215871364984, 19702.802971970672, 17551.297948081934, 18064.277428902697, 18085.186166622272, 18585.721214182067, 18702.251909923994, 20524.38426847197, 20524.794752052287, 20619.072141753957, 20877.37367878966, 20980.580388392453, 15160.620984475036, 15341.0, 15365.539033829004, 15419.0, 15430.0, 20074.598508029467, 20147.0, 20206.89896550508, 20213.49466263355, 20257.49356266046], "value": 12717.215430316648, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.6856891483874, 1448.587152661491, 1479.8298195707491, 1492.7089217602559, 1504.210289597961, 15814.60463488412, 16441.67116657666, 16464.753028704577, 16475.2586133624, 16489.257983390748, 15761.448349307777, 17098.82901170991, 17107.059111748847, 17109.0, 17122.31510739569, 2594.390318275199, 2649.244965184923, 2654.2833434972545, 2657.1762753546464, 2659.9734002660016, 2693.111273279823, 2694.878730457124, 2710.6747190337187, 2788.762955148815, 2795.7763378929635, 2555.271747551948, 2580.0453832082158, 2586.818922675404, 2593.196109206143, 2595.117659995601, 2716.4431291585274, 2721.306066952924, 2723.237493501823, 2735.644366232387, 2736.630554875086, 2656.282803643025, 2678.3973605938704, 2679.1158917557354, 2679.1828492309837, 2683.8121331506804, 15806.762898556532, 16113.516594502184, 16129.0, 16133.515994520183, 16161.91919040409, 8147.348212143014, 8408.789780255482, 8414.242718155396, 8420.989481262226, 8445.788855278606, 5227.163653815409, 5358.973205133989, 5395.406505284415, 5508.3114610673665, 5510.91733623996, 2059.783722709124, 2079.5736873940955, 2084.4476213803205, 2122.458773012872, 2128.382768996989, 27977.720222797714, 28496.145115646563, 29785.957491487912, 29843.552346714816, 29847.552286715716, 6923.757668481579, 7005.194402643761, 7090.432765378758, 7138.286171382924, 7160.534565253241, 18484.81515184858, 18871.245150194114, 18912.0, 18922.0, 18989.430317090508, 8106.310963568163, 8359.540225287546, 8362.749117526484, 8372.372072094495, 8373.497590144489, 7602.961985190039, 7635.618219089023, 7645.655945482466, 7688.615569221516, 7713.92286077132, 5376.274202982626, 5538.253350712876, 5544.556435485151, 5567.220589117527, 5576.330840299109, 1500.5423345879394, 1504.6689728259764, 1510.2826157575064, 1531.4486784757478, 1543.1358439274043, 940.9247260219166, 961.4904100826573, 969.1907257439975, 983.3706427886159, 985.0986347491964, 9246.352755307198, 9328.160465557996, 9343.299252556086, 9401.76495587602, 9643.855342169873, 1032.2464600841429, 1068.3269540189785, 1081.967540973772, 1084.6474895658785, 1090.4711215060688, 5277.340332458442, 5343.465653434703, 5365.54392876602, 5604.271444712162, 5770.596058275964, 23317.766822331898, 23689.526209475713, 23997.28008159758, 24124.63813042806, 24349.26952191437, 22747.31758047228, 23535.646965295535, 23901.7609823903, 23974.760252397602, 24160.51678966446, 12644.30456324911, 12841.293728844816, 12914.806277905838, 12934.67663308406, 12944.805827912589, 8540.316774658137, 9221.907780922105, 9235.815283694423, 9308.581113849757, 9312.348135630711, 19341.903290483457, 20280.492987675425, 20288.188472460937, 20752.273670421462, 20861.791382085983, 20958.161673532886, 21178.0, 21197.36407907765, 21300.7869921305, 21342.679859802425, 11878.524859005543, 11966.162368634461, 12010.699732506757, 12077.879221207675, 12101.878981210075, 14977.400903963719, 15057.0, 15061.096334219981, 15065.472708455152, 15084.773728393864, 11823.940880295544, 11876.643700688994, 11955.64133076009, 11986.940065299617, 12232.69418264515, 11194.944025279821, 11241.213115081866, 11396.886031139582, 11454.94272528632, 11540.480678369662, 10208.0, 10225.84661230097, 10252.58989640406, 10327.018933201334, 10328.277020608486, 8149.470284431493, 8322.583870806557, 8322.6670933162, 8327.125651806715, 8347.95826020866, 7945.443818932619, 8189.590520474072, 8287.668493260202, 8297.377696672653, 8391.832163356821], "value": 7106.5647556949625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.508649412799, 529.8781280305532, 543.8226240189989, 563.8759472915957, 564.6188822544783, 6038.275406951161, 6098.146259523664, 6104.48111910487, 6173.722182501787, 6201.162843016192, 5851.79518716845, 5934.703264836762, 5977.880442391161, 5992.850178745533, 6055.788047418341, 4874.195757699993, 4897.8775530611665, 4909.828156014541, 4913.852584422455, 4939.8024079036795, 4787.40157480315, 4867.829625963092, 4884.829030983917, 4912.336834527347, 4928.408590969088, 4878.58510037532, 4889.095517329288, 4892.899097703006, 4912.852614421555, 4920.212765957447, 4840.249761287007, 4889.266610008492, 4897.412310522743, 4904.8473608701925, 4961.727105009223, 4413.580709832593, 4431.556844315575, 4438.578335058164, 4440.7335559866515, 4444.200043992112, 5949.0, 5953.404659534055, 5976.611520251213, 5993.101034844764, 5995.52035837132, 5705.743241554099, 5712.685802280873, 5725.912076705413, 5732.168835518868, 5757.366689664133, 6295.968520157416, 6383.936160638381, 6387.297397286295, 6387.361263873622, 6477.708503117324, 4816.8554943351755, 4846.39420072491, 4847.709137451729, 4891.266310053485, 4897.363342765453, 6655.502511934825, 6789.490788190856, 6789.966050169767, 6820.522563420563, 6853.485988550829, 4927.852164435073, 4992.350994370709, 4996.725180115056, 5027.371578552681, 5050.595952323805, 5060.949390506122, 5069.352460450368, 5081.74591270435, 5093.923591146136, 5101.0, 5706.3152421709665, 5721.828345149652, 5731.570132240098, 5750.2524671793235, 5751.9424805751405, 6357.8728425432155, 6391.776287829996, 6430.742770289229, 6449.645269510128, 6462.967685161544, 1661.6925868714327, 1663.96672066558, 1700.4218565687725, 1714.7225317138812, 1740.747591599211, 1215.617080619602, 1225.6384366611871, 1237.3132911234352, 1239.4794186441716, 1264.6142926407533, 5951.345352011275, 5958.433948774859, 5997.750843433712, 6008.459238668541, 6009.849753756191, 6474.1907261592305, 6503.479721622353, 6505.991571306455, 6526.379993900572, 6550.803475895731, 6048.455638992512, 6072.878542429126, 6106.664133472613, 6107.236595425572, 6137.84655383619, 3476.1309672581856, 3499.9300014000087, 3503.8248087595516, 3513.7364697647777, 3518.437050071976, 6823.761168359084, 6827.590344579341, 6836.760713375107, 6842.94711586522, 6865.5537390070485, 6753.3246675332075, 6754.926508438649, 6823.488238382042, 6854.691538880762, 6876.312368763083, 6760.695768690421, 6807.829804254933, 6869.931300687029, 6877.449804015567, 6921.965390172916, 6358.872822543431, 6465.967670161619, 6534.738610455529, 6543.247526534509, 6603.2406273277265, 6455.3221911700475, 6506.902396464152, 6526.97663724247, 6533.150690410216, 6638.103855979381, 6788.59005053199, 6818.965905170442, 6871.381575658214, 6921.7231310747, 6941.791746247621, 4968.180250258667, 4970.975145124251, 4995.100881841304, 5018.698878067327, 5030.195168772979, 6392.840178995376, 6474.741010359533, 6541.738330466728, 6571.474282057519, 6667.433268172065, 6212.161358216583, 6316.463100636313, 6339.841503962438, 6376.171097757262, 6410.583312084699, 6211.503079753699, 6332.873342533031, 6358.2687990879795, 6410.1987251593555, 6416.385662545273, 6181.1655426516845, 6244.65654389013, 6335.0, 6355.809325720235, 6410.679466026773, 6287.811365659038, 6358.364163583789, 6362.331955144643, 6424.0, 6441.355864413521, 6207.689615519296, 6212.937870621236, 6256.31180570146, 6263.436290733674, 6314.873702526015], "value": 5031.833842327158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.1520822324804, 947.0103741590037, 968.922486201104, 980.6420656460385, 983.2330781990046, 19774.209031638737, 20195.697064544027, 20223.191072357105, 20236.8988155059, 22591.54816903661, 20064.297749578767, 20404.489887752814, 20513.692294615594, 20543.178272869103, 20556.69164962523, 1044.7492601775557, 1063.9521221545049, 1064.3560645809291, 1067.754416484209, 1069.315637991686, 1042.7028296935375, 1078.983815242772, 1080.692002779208, 1082.826747720365, 1085.6200329884516, 1133.6315697398338, 1134.1040577943456, 1134.659602119365, 1135.0238794636648, 1135.5571327182406, 1129.4522156753967, 1129.5368898751472, 1131.349474052419, 1131.603938621476, 1132.7564573616671, 828.5111784047381, 834.7412302186342, 834.8246868157694, 834.9666013359458, 835.3818174550788, 19204.61590768191, 19558.315458959012, 20777.58444831095, 20797.16811327545, 20919.163233470645, 22058.558828823334, 22058.88970555153, 22125.66811497829, 22144.557108857894, 22615.208467703716, 17412.0, 17987.640247194984, 18149.092545372812, 18379.72430413545, 18453.630927381513, 3953.6639385652256, 3996.500437445319, 3997.5402828674783, 3999.8200080996426, 4000.299947509174, 143681.0, 144138.0, 145632.2718386412, 145796.0, 145908.0, 17378.304867805145, 17461.563460913578, 17618.119094045247, 17703.645927081387, 17724.91137544304, 32789.0, 33370.666293336755, 33598.83200583982, 33770.15574610605, 33805.66194338025, 8823.735287941372, 8952.104789520996, 8960.0, 8996.640134394682, 9013.594388252544, 4165.062860856283, 4200.033992181815, 4214.199302132585, 4220.493540775126, 4221.092465120014, 5486.1222204447095, 5631.605787594829, 5660.943390566124, 5683.0338842396895, 5703.771849125988, 1018.9286749927583, 1038.7039693687263, 1052.55792567122, 1054.504382940017, 1054.931429457083, 733.8899165125167, 748.9513181643176, 752.7478294771313, 762.1540090499541, 769.9345555627834, 12288.569900053633, 12418.689532761573, 12929.806052909214, 13569.25369104689, 13901.443942242196, 747.9289467500579, 749.9925000750031, 755.9659815308324, 756.4969295418595, 757.3448966643814, 6182.6599537025895, 6209.9068513972325, 6242.0, 6275.780347687901, 6309.842253943596, 131675.0, 133691.33154334166, 135088.0, 135374.3231283857, 139652.30173849268, 119848.21366076921, 122545.0, 123477.0, 125266.0, 128032.0, 106421.46789266005, 106472.46763766132, 108471.45764271128, 110070.44964775124, 110128.0, 11523.53905843757, 11646.70883227926, 11763.882361176278, 11787.410629468664, 11840.940795295968, 51115.0, 51964.700882476725, 52057.73971130272, 52604.47395525996, 52650.736746316026, 81880.59059704663, 82908.58545707233, 83739.5813020931, 84644.0, 84896.57551712202, 18519.90740046291, 18589.907050464662, 18748.906255468635, 18787.90606046961, 18810.811891880905, 22596.209132680277, 23171.76828231696, 23212.95541700661, 23328.183513576943, 23409.648855267526, 20860.58278834445, 21441.571168576855, 21549.353519394444, 21659.133634654438, 21955.560888782453, 21560.892195538923, 21710.565788684453, 21891.0, 22066.779332207116, 22100.557988839813, 20427.0, 20861.687074694197, 20986.790132099093, 21371.572568548232, 21721.239756608444, 14429.0, 14619.780703289673, 15017.549473515812, 15082.698346033238, 15215.239238038275, 14642.487512936996, 15475.767863482282, 15814.209289535707, 15879.126648034007, 16199.75700364472], "value": 10072.371794646091, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 105.0, 99.0, 104.0, 105.0, 107.0, 107.0, 105.0, 107.0, 108.0], "value": 104.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 147.0, 170.0, 113.0, 142.0, 143.0, 120.0, 164.0, 121.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 164.0, 164.0, 163.0, 162.0, 160.0, 163.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 74.0, 179.0, 74.0, 74.0, 73.0, 73.0, 156.0, 74.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 127.0, 78.0, 79.0, 80.0, 134.0, 79.0, 78.0, 137.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 150.0, 155.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 45.0, 45.0, 45.0, 45.0, 46.0, 45.0, 44.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 119.0, 116.0, 110.0, 123.0, 110.0, 117.0, 110.0, 147.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 167.0, 166.0, 162.0, 167.0, 165.0, 168.0, 165.0, 171.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 62.0, 63.0, 62.0, 74.0, 60.0, 61.0, 60.0], "value": 62.9, "unit": "score"}]}]} 06:36:14 INFO - Return code: 0 06:36:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:36:14 INFO - # TBPL SUCCESS # 06:36:14 INFO - Running post-action listener: _package_coverage_data 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - [mozharness: 2017-08-24 13:36:14.551008Z] Finished run-tests step (success) 06:36:14 INFO - Running post-run listener: _resource_record_post_run 06:36:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 5328896; Write bytes: 435601408; Read time: 3336; Write time: 427708 06:36:14 INFO - TinderboxPrint: CPU usage
13.1% 06:36:14 INFO - TinderboxPrint: I/O read bytes / time
5,328,896 / 3,336 06:36:14 INFO - TinderboxPrint: I/O write bytes / time
435,601,408 / 427,708 06:36:14 INFO - TinderboxPrint: CPU idle
8,252.5 (86.9%) 06:36:14 INFO - TinderboxPrint: CPU user
1,188.5 (12.5%) 06:36:14 INFO - TinderboxPrint: Swap in / out
0 / 0 06:36:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 12288; Write bytes: 115343360; Read time: 172; Write time: 74860 06:36:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:36:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5316608; Write bytes: 320258048; Read time: 3164; Write time: 352848 06:36:15 INFO - Running post-run listener: _upload_blobber_files 06:36:15 INFO - Blob upload gear active. 06:36:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:36:15 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 06:36:15 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'] 06:36:15 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 06:36:15 INFO - (blobuploader) - INFO - Open directory for files ... 06:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:18 INFO - (blobuploader) - INFO - Done attempting. 06:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:19 INFO - (blobuploader) - INFO - Done attempting. 06:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:20 INFO - (blobuploader) - INFO - Done attempting. 06:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:36:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:27 INFO - (blobuploader) - INFO - Done attempting. 06:36:27 INFO - (blobuploader) - INFO - Iteration through files over. 06:36:27 INFO - Return code: 0 06:36:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:36:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:36:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7deb589d9c5df2995f9497516096af10591f9b252721d1223a3eed18500c03db49d70de852f42cac117a37a9b275ecd0c743527381610e96e0d338727c6324e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af00dfc0c47c1db534dfaadf72356d849f0314c0208dd8e27497dbfbdd9ffed6e3905744fccd9d5037c156ffd2e3836fea4ace327ee4a844a0cc1e70c3be39c0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d45c3a806d98117966c2dab108b8ad386a332268b5929034806fb51e3176ac449ab4f16ab6e4bba65e79da36838d97685eacecd257d89fd4d731011bceed9f0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c969f57211538087faf551101f9eef3edb27f9eb6f84fea38b11c83908f84d5f24d912916182227e134291362571f12f1f345b4784344f97228fbffbfd653887"} 06:36:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:36:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:36:27 INFO - Contents: 06:36:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7deb589d9c5df2995f9497516096af10591f9b252721d1223a3eed18500c03db49d70de852f42cac117a37a9b275ecd0c743527381610e96e0d338727c6324e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af00dfc0c47c1db534dfaadf72356d849f0314c0208dd8e27497dbfbdd9ffed6e3905744fccd9d5037c156ffd2e3836fea4ace327ee4a844a0cc1e70c3be39c0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d45c3a806d98117966c2dab108b8ad386a332268b5929034806fb51e3176ac449ab4f16ab6e4bba65e79da36838d97685eacecd257d89fd4d731011bceed9f0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c969f57211538087faf551101f9eef3edb27f9eb6f84fea38b11c83908f84d5f24d912916182227e134291362571f12f1f345b4784344f97228fbffbfd653887"} 06:36:27 INFO - Running post-run listener: copy_logs_to_upload_dir 06:36:27 INFO - Copying logs to upload dir... 06:36:27 INFO - mkdir: /builds/slave/test/build/upload/logs 06:36:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.875689 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-24 06:36:27.351221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:36:27.358782) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 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/7deb589d9c5df2995f9497516096af10591f9b252721d1223a3eed18500c03db49d70de852f42cac117a37a9b275ecd0c743527381610e96e0d338727c6324e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af00dfc0c47c1db534dfaadf72356d849f0314c0208dd8e27497dbfbdd9ffed6e3905744fccd9d5037c156ffd2e3836fea4ace327ee4a844a0cc1e70c3be39c0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d45c3a806d98117966c2dab108b8ad386a332268b5929034806fb51e3176ac449ab4f16ab6e4bba65e79da36838d97685eacecd257d89fd4d731011bceed9f0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c969f57211538087faf551101f9eef3edb27f9eb6f84fea38b11c83908f84d5f24d912916182227e134291362571f12f1f345b4784344f97228fbffbfd653887"} build_url:https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/EDGDG24-RR6m_W-GqWJdrQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7deb589d9c5df2995f9497516096af10591f9b252721d1223a3eed18500c03db49d70de852f42cac117a37a9b275ecd0c743527381610e96e0d338727c6324e4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af00dfc0c47c1db534dfaadf72356d849f0314c0208dd8e27497dbfbdd9ffed6e3905744fccd9d5037c156ffd2e3836fea4ace327ee4a844a0cc1e70c3be39c0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d45c3a806d98117966c2dab108b8ad386a332268b5929034806fb51e3176ac449ab4f16ab6e4bba65e79da36838d97685eacecd257d89fd4d731011bceed9f0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c969f57211538087faf551101f9eef3edb27f9eb6f84fea38b11c83908f84d5f24d912916182227e134291362571f12f1f345b4784344f97228fbffbfd653887"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:36:27.388035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:36:27.388359) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1503580527.129919-1945186464 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:36:27.473427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:36:27.473747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:36:27.474077) ========= ========= Total master_lag: 0.06 =========