builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1503011216.62 results: success (0) revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.616836) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.617265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.617553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.633302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.633574) ========= 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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 16:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.3M=0s 2017-08-17 16:06:57 (23.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.785062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.785374) ========= 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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.834205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:56.834527) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 54ad22b649e547a5b20babdecc84f5563a9b7dea --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 54ad22b649e547a5b20babdecc84f5563a9b7dea --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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 16:06:57,283 truncating revision to first 12 chars 2017-08-17 16:06:57,283 Setting DEBUG logging. 2017-08-17 16:06:57,283 attempt 1/10 2017-08-17 16:06:57,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/54ad22b649e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 16:06:57,705 unpacking tar archive at: mozilla-central-54ad22b649e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:57.651522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:57.651840) ========= script_repo_revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:57.652209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:57.652481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:06:57.664049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 16:06:57.664313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:58 INFO - MultiFileLogger online at 20170817 16:06:58 in /builds/slave/test 16:06:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:58 INFO - {'append_to_log': False, 16:06:58 INFO - 'base_work_dir': '/builds/slave/test', 16:06:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:58 INFO - 'branch': 'Firefox-Non-PGO', 16:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:58 INFO - 'code_coverage': False, 16:06:58 INFO - 'config_files': ('talos/linux_config.py',), 16:06:58 INFO - 'default_actions': ('clobber', 16:06:58 INFO - 'read-buildbot-config', 16:06:58 INFO - 'download-and-extract', 16:06:58 INFO - 'populate-webroot', 16:06:58 INFO - 'create-virtualenv', 16:06:58 INFO - 'install', 16:06:58 INFO - 'setup-mitmproxy', 16:06:58 INFO - 'run-tests'), 16:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:58 INFO - 'disable_ccov_upload': False, 16:06:58 INFO - 'download_minidump_stackwalk': True, 16:06:58 INFO - 'download_symbols': 'ondemand', 16:06:58 INFO - 'enable_stylo': False, 16:06:58 INFO - 'enable_webrender': False, 16:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:58 INFO - 'gecko_profile': False, 16:06:58 INFO - 'gecko_profile_interval': 0, 16:06:58 INFO - 'installer_path': 'installer.exe', 16:06:58 INFO - 'log_level': 'info', 16:06:58 INFO - 'log_name': 'talos', 16:06:58 INFO - 'log_to_console': True, 16:06:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:58 INFO - 'opt_config_files': (), 16:06:58 INFO - 'pip_index': False, 16:06:58 INFO - 'suite': 'dromaeojs-e10s', 16:06:58 INFO - 'system_bits': '32', 16:06:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:58 INFO - 'title': 'talos-linux64-ix-035', 16:06:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:58 INFO - 'use_talos_json': True, 16:06:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:58 INFO - 'work_dir': 'build'} 16:06:58 INFO - [mozharness: 2017-08-17 23:06:58.211483Z] Running clobber step. 16:06:58 INFO - Running pre-action listener: _resource_record_pre_action 16:06:58 INFO - Running main action method: clobber 16:06:58 INFO - rmtree: /builds/slave/test/build 16:06:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:59 INFO - Running post-action listener: _resource_record_post_action 16:06:59 INFO - [mozharness: 2017-08-17 23:06:59.795957Z] Finished clobber step (success) 16:06:59 INFO - [mozharness: 2017-08-17 23:06:59.796058Z] Running read-buildbot-config step. 16:06:59 INFO - Running pre-action listener: _resource_record_pre_action 16:06:59 INFO - Running main action method: read_buildbot_config 16:06:59 INFO - Using buildbot properties: 16:06:59 INFO - { 16:06:59 INFO - "project": "", 16:06:59 INFO - "product": "firefox", 16:06:59 INFO - "who": "dtownsend@mozilla.com", 16:06:59 INFO - "installer_path": "public/build/target.tar.bz2", 16:06:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:06:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:06:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:06:59 INFO - "stage_platform": "linux64", 16:06:59 INFO - "basedir": "/builds/slave/test", 16:06:59 INFO - "buildnumber": 776, 16:06:59 INFO - "platform": "ubuntu64_hw", 16:06:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:06:59 INFO - "slavebuilddir": "test", 16:06:59 INFO - "taskId": "XdmlJHwMQ_6KCM5SVGyJ9w", 16:06:59 INFO - "branch": "mozilla-central", 16:06:59 INFO - "script_repo_revision": "production", 16:06:59 INFO - "revision": "54ad22b649e547a5b20babdecc84f5563a9b7dea", 16:06:59 INFO - "slavename": "talos-linux64-ix-035", 16:06:59 INFO - "repo_path": "mozilla-central" 16:06:59 INFO - } 16:06:59 INFO - Finding installer, test and symbols from parent task. 16:06:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdmlJHwMQ_6KCM5SVGyJ9w'}, attempt #1 16:07:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdmlJHwMQ_6KCM5SVGyJ9w'}, attempt #1 16:07:00 INFO - Task dependencies: aWkJAhYOSgqx_drvisgeVA 16:07:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA'}, attempt #1 16:07:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:07:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json 16:07:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip 16:07:01 INFO - Running post-action listener: _resource_record_post_action 16:07:01 INFO - [mozharness: 2017-08-17 23:07:01.137701Z] Finished read-buildbot-config step (success) 16:07:01 INFO - [mozharness: 2017-08-17 23:07:01.137923Z] Running download-and-extract step. 16:07:01 INFO - Running pre-action listener: _resource_record_pre_action 16:07:01 INFO - Running main action method: download_and_extract 16:07:01 INFO - mkdir: /builds/slave/test/build/tests 16:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:01 INFO - trying https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json 16:07:01 INFO - Downloading https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:07:01 INFO - Downloaded 989 bytes. 16:07:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:07:01 INFO - Using the following test package requirements: 16:07:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:07:01 INFO - u'common': [u'target.common.tests.zip'], 16:07:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:07:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:07:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:07:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:07:01 INFO - u'mozbase': [u'target.common.tests.zip'], 16:07:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:07:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:07:01 INFO - u'web-platform': [u'target.common.tests.zip', 16:07:01 INFO - u'target.web-platform.tests.tar.gz'], 16:07:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:07:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:07:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip 16:07:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:01 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip into memory 16:07:02 INFO - Content-Length response header: 53999336 16:07:02 INFO - Bytes received: 53999336 16:07:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:07:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip 16:07:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:13 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip into memory 16:07:14 INFO - Content-Length response header: 53999336 16:07:14 INFO - Bytes received: 53999336 16:07:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip 16:07:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:07:26 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip into memory 16:07:27 INFO - Content-Length response header: 14496161 16:07:27 INFO - Bytes received: 14496161 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:27 INFO - trying https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:07:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:07:28 INFO - Downloaded 62367576 bytes. 16:07:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:07:28 INFO - mkdir: /builds/slave/test/properties 16:07:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:28 INFO - Contents: 16:07:28 INFO - build_url:https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:07:28 INFO - Running post-action listener: _resource_record_post_action 16:07:28 INFO - Running post-action listener: set_extra_try_arguments 16:07:28 INFO - [mozharness: 2017-08-17 23:07:28.631608Z] Finished download-and-extract step (success) 16:07:28 INFO - [mozharness: 2017-08-17 23:07:28.631839Z] Running populate-webroot step. 16:07:28 INFO - Running pre-action listener: _resource_record_pre_action 16:07:28 INFO - Running main action method: populate_webroot 16:07:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:07:28 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:07:28 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:28 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'tests': ['damp', 'tps']}, 16:07:28 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['damp', 'tps']}, 16:07:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:07:28 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:07:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:07:28 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:07:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:07:28 INFO - 'ts_paint', 16:07:28 INFO - 'tpaint', 16:07:28 INFO - 'sessionrestore', 16:07:28 INFO - 'sessionrestore_many_windows', 16:07:28 INFO - 'sessionrestore_no_auto_restore', 16:07:28 INFO - 'tabpaint']}, 16:07:28 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['a11yr', 16:07:28 INFO - 'ts_paint', 16:07:28 INFO - 'tpaint', 16:07:28 INFO - 'sessionrestore', 16:07:28 INFO - 'sessionrestore_many_windows', 16:07:28 INFO - 'sessionrestore_no_auto_restore', 16:07:28 INFO - 'tabpaint']}, 16:07:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:07:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:07:28 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['bloom_basic_singleton']}, 16:07:28 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['bloom_basic']}, 16:07:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:07:28 INFO - 'tsvgr_opacity', 16:07:28 INFO - 'tart', 16:07:28 INFO - 'tscrollx', 16:07:28 INFO - 'tsvg_static']}, 16:07:28 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['tsvgx', 16:07:28 INFO - 'tsvgr_opacity', 16:07:28 INFO - 'tart', 16:07:28 INFO - 'tscrollx', 16:07:28 INFO - 'tsvg_static']}, 16:07:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:07:28 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--stylo'], 16:07:28 INFO - 'tests': ['tp5o']}, 16:07:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:07:28 INFO - 'talos_options': ['--mitmproxy', 16:07:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:07:28 INFO - '--firstNonBlankPaint'], 16:07:28 INFO - 'tests': ['tp6_google', 16:07:28 INFO - 'tp6_youtube', 16:07:28 INFO - 'tp6_amazon', 16:07:28 INFO - 'tp6_facebook']}, 16:07:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:07:28 INFO - 'talos_options': ['--stylo', 16:07:28 INFO - '--mitmproxy', 16:07:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:07:28 INFO - '--firstNonBlankPaint'], 16:07:28 INFO - 'tests': ['tp6_google', 16:07:28 INFO - 'tp6_youtube', 16:07:28 INFO - 'tp6_amazon', 16:07:28 INFO - 'tp6_facebook']}, 16:07:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:07:28 INFO - 'talos_options': ['--stylo', 16:07:28 INFO - '--stylo-threads=1', 16:07:28 INFO - '--mitmproxy', 16:07:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:07:28 INFO - '--firstNonBlankPaint'], 16:07:28 INFO - 'tests': ['tp6_google', 16:07:28 INFO - 'tp6_youtube', 16:07:28 INFO - 'tp6_amazon', 16:07:28 INFO - 'tp6_facebook']}, 16:07:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--xperf_path', 16:07:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:28 INFO - 'tests': ['tp5n']}, 16:07:28 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:07:28 INFO - 'talos_options': ['--stylo', 16:07:28 INFO - '--xperf_path', 16:07:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:28 INFO - 'tests': ['tp5n']}}} 16:07:28 INFO - Running post-action listener: _resource_record_post_action 16:07:28 INFO - [mozharness: 2017-08-17 23:07:28.651889Z] Finished populate-webroot step (success) 16:07:28 INFO - [mozharness: 2017-08-17 23:07:28.651979Z] Running create-virtualenv step. 16:07:28 INFO - Running pre-action listener: _resource_record_pre_action 16:07:28 INFO - Running main action method: create_virtualenv 16:07:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:07:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:07:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:28 INFO - Using real prefix '/usr' 16:07:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:31 INFO - Installing pip.................done. 16:07:31 INFO - Return code: 0 16:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:07:31 INFO - Reading from file tmpfile_stdout 16:07:31 INFO - Output received: 16:07:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:07:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07:31 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')]} 16:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:31 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')]} 16:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:31 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:31 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 16:07:31 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 16:07:31 INFO - Using env: {'DISPLAY': ':0', 16:07:31 INFO - 'HOME': '/home/cltbld', 16:07:31 INFO - 'LANG': 'en_US.UTF-8', 16:07:31 INFO - 'LANGUAGE': 'en_US:en', 16:07:31 INFO - 'LOGNAME': 'cltbld', 16:07:31 INFO - 'MAIL': '/var/mail/cltbld', 16:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:31 INFO - 'MOZ_NO_REMOTE': '1', 16:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:31 INFO - 'NO_EM_RESTART': '1', 16:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:31 INFO - 'PWD': '/builds/slave/test', 16:07:31 INFO - 'SHELL': '/bin/bash', 16:07:31 INFO - 'SHLVL': '1', 16:07:31 INFO - 'TERM': 'linux', 16:07:31 INFO - 'TMOUT': '86400', 16:07:31 INFO - 'USER': 'cltbld', 16:07:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:31 INFO - '_': '/tools/buildbot/bin/python'} 16:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:07:31 INFO - Cleaning up... 16:07:31 INFO - Return code: 0 16:07:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:07:31 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')]} 16:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:31 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')]} 16:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:31 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:31 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 16:07:31 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 16:07:31 INFO - Using env: {'DISPLAY': ':0', 16:07:31 INFO - 'HOME': '/home/cltbld', 16:07:31 INFO - 'LANG': 'en_US.UTF-8', 16:07:31 INFO - 'LANGUAGE': 'en_US:en', 16:07:31 INFO - 'LOGNAME': 'cltbld', 16:07:31 INFO - 'MAIL': '/var/mail/cltbld', 16:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:31 INFO - 'MOZ_NO_REMOTE': '1', 16:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:31 INFO - 'NO_EM_RESTART': '1', 16:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:31 INFO - 'PWD': '/builds/slave/test', 16:07:31 INFO - 'SHELL': '/bin/bash', 16:07:31 INFO - 'SHLVL': '1', 16:07:31 INFO - 'TERM': 'linux', 16:07:31 INFO - 'TMOUT': '86400', 16:07:31 INFO - 'USER': 'cltbld', 16:07:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:31 INFO - '_': '/tools/buildbot/bin/python'} 16:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:31 INFO - Downloading/unpacking psutil>=3.1.1 16:07:31 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 16:07:31 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 16:07:31 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 16:07:31 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 16:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:33 INFO - Installing collected packages: psutil 16:07:33 INFO - Running setup.py install for psutil 16:07:33 INFO - building 'psutil._psutil_linux' extension 16:07:33 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 16:07:33 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 16:07:33 INFO - building 'psutil._psutil_posix' extension 16:07:33 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 16:07:33 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 16:07:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:33 INFO - Successfully installed psutil 16:07:33 INFO - Cleaning up... 16:07:33 INFO - Return code: 0 16:07:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:33 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:33 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 16:07:33 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 16:07:33 INFO - Using env: {'DISPLAY': ':0', 16:07:33 INFO - 'HOME': '/home/cltbld', 16:07:33 INFO - 'LANG': 'en_US.UTF-8', 16:07:33 INFO - 'LANGUAGE': 'en_US:en', 16:07:33 INFO - 'LOGNAME': 'cltbld', 16:07:33 INFO - 'MAIL': '/var/mail/cltbld', 16:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:33 INFO - 'MOZ_NO_REMOTE': '1', 16:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:33 INFO - 'NO_EM_RESTART': '1', 16:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:33 INFO - 'PWD': '/builds/slave/test', 16:07:33 INFO - 'SHELL': '/bin/bash', 16:07:33 INFO - 'SHLVL': '1', 16:07:33 INFO - 'TERM': 'linux', 16:07:33 INFO - 'TMOUT': '86400', 16:07:33 INFO - 'USER': 'cltbld', 16:07:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:33 INFO - '_': '/tools/buildbot/bin/python'} 16:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:07:33 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 16:07:33 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 16:07:33 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 16:07:33 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 16:07:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:07:34 INFO - Installing collected packages: mozsystemmonitor 16:07:34 INFO - Running setup.py install for mozsystemmonitor 16:07:35 INFO - Successfully installed mozsystemmonitor 16:07:35 INFO - Cleaning up... 16:07:35 INFO - Return code: 0 16:07:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:07:35 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')]} 16:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:35 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')]} 16:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:35 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:35 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 16:07:35 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 16:07:35 INFO - Using env: {'DISPLAY': ':0', 16:07:35 INFO - 'HOME': '/home/cltbld', 16:07:35 INFO - 'LANG': 'en_US.UTF-8', 16:07:35 INFO - 'LANGUAGE': 'en_US:en', 16:07:35 INFO - 'LOGNAME': 'cltbld', 16:07:35 INFO - 'MAIL': '/var/mail/cltbld', 16:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:35 INFO - 'MOZ_NO_REMOTE': '1', 16:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:35 INFO - 'NO_EM_RESTART': '1', 16:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:35 INFO - 'PWD': '/builds/slave/test', 16:07:35 INFO - 'SHELL': '/bin/bash', 16:07:35 INFO - 'SHLVL': '1', 16:07:35 INFO - 'TERM': 'linux', 16:07:35 INFO - 'TMOUT': '86400', 16:07:35 INFO - 'USER': 'cltbld', 16:07:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:35 INFO - '_': '/tools/buildbot/bin/python'} 16:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:07:35 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 16:07:35 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 16:07:35 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 16:07:35 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 16:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:07:36 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 16:07:36 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 16:07:36 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 16:07:36 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 16:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:36 INFO - warning: no files found matching '*.txt' 16:07:36 INFO - no previously-included directories found matching 'build' 16:07:36 INFO - no previously-included directories found matching 'dist' 16:07:36 INFO - no previously-included directories found matching '.git*' 16:07:36 INFO - Installing collected packages: jsonschema, functools32 16:07:36 INFO - Running setup.py install for functools32 16:07:36 INFO - warning: no files found matching '*.txt' 16:07:36 INFO - no previously-included directories found matching 'build' 16:07:36 INFO - no previously-included directories found matching 'dist' 16:07:36 INFO - no previously-included directories found matching '.git*' 16:07:36 INFO - Successfully installed jsonschema functools32 16:07:36 INFO - Cleaning up... 16:07:36 INFO - Return code: 0 16:07:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:07:36 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')]} 16:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:36 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')]} 16:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:36 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:36 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 16:07:36 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 16:07:36 INFO - Using env: {'DISPLAY': ':0', 16:07:36 INFO - 'HOME': '/home/cltbld', 16:07:36 INFO - 'LANG': 'en_US.UTF-8', 16:07:36 INFO - 'LANGUAGE': 'en_US:en', 16:07:36 INFO - 'LOGNAME': 'cltbld', 16:07:36 INFO - 'MAIL': '/var/mail/cltbld', 16:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:36 INFO - 'MOZ_NO_REMOTE': '1', 16:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:36 INFO - 'NO_EM_RESTART': '1', 16:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:36 INFO - 'PWD': '/builds/slave/test', 16:07:36 INFO - 'SHELL': '/bin/bash', 16:07:36 INFO - 'SHLVL': '1', 16:07:36 INFO - 'TERM': 'linux', 16:07:36 INFO - 'TMOUT': '86400', 16:07:36 INFO - 'USER': 'cltbld', 16:07:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:36 INFO - '_': '/tools/buildbot/bin/python'} 16:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:07:37 INFO - Cleaning up... 16:07:37 INFO - Return code: 0 16:07:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07:37 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')]} 16:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:37 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')]} 16:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:37 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:37 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 16:07:37 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 16:07:37 INFO - Using env: {'DISPLAY': ':0', 16:07:37 INFO - 'HOME': '/home/cltbld', 16:07:37 INFO - 'LANG': 'en_US.UTF-8', 16:07:37 INFO - 'LANGUAGE': 'en_US:en', 16:07:37 INFO - 'LOGNAME': 'cltbld', 16:07:37 INFO - 'MAIL': '/var/mail/cltbld', 16:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:37 INFO - 'MOZ_NO_REMOTE': '1', 16:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:37 INFO - 'NO_EM_RESTART': '1', 16:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:37 INFO - 'PWD': '/builds/slave/test', 16:07:37 INFO - 'SHELL': '/bin/bash', 16:07:37 INFO - 'SHLVL': '1', 16:07:37 INFO - 'TERM': 'linux', 16:07:37 INFO - 'TMOUT': '86400', 16:07:37 INFO - 'USER': 'cltbld', 16:07:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:37 INFO - '_': '/tools/buildbot/bin/python'} 16:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:37 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 16:07:37 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 16:07:37 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 16:07:37 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 16:07:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:38 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 16:07:38 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 16:07:38 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 16:07:38 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 16:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:38 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 16:07:38 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 16:07:38 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 16:07:38 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 16:07:38 INFO - Downloading docopt-0.6.1.tar.gz 16:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:38 INFO - Running setup.py install for blobuploader 16:07:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:39 INFO - Running setup.py install for requests 16:07:39 INFO - Running setup.py install for docopt 16:07:39 INFO - Successfully installed blobuploader requests docopt 16:07:39 INFO - Cleaning up... 16:07:39 INFO - Return code: 0 16:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:39 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')]} 16:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:39 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')]} 16:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:39 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:39 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 16:07:39 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 16:07:39 INFO - Using env: {'DISPLAY': ':0', 16:07:39 INFO - 'HOME': '/home/cltbld', 16:07:39 INFO - 'LANG': 'en_US.UTF-8', 16:07:39 INFO - 'LANGUAGE': 'en_US:en', 16:07:39 INFO - 'LOGNAME': 'cltbld', 16:07:39 INFO - 'MAIL': '/var/mail/cltbld', 16:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:39 INFO - 'MOZ_NO_REMOTE': '1', 16:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:39 INFO - 'NO_EM_RESTART': '1', 16:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:39 INFO - 'PWD': '/builds/slave/test', 16:07:39 INFO - 'SHELL': '/bin/bash', 16:07:39 INFO - 'SHLVL': '1', 16:07:39 INFO - 'TERM': 'linux', 16:07:39 INFO - 'TMOUT': '86400', 16:07:39 INFO - 'USER': 'cltbld', 16:07:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:39 INFO - '_': '/tools/buildbot/bin/python'} 16:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:39 INFO - Running setup.py (path:/tmp/pip-SK_vJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:39 INFO - Running setup.py (path:/tmp/pip-RGQtFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:39 INFO - Running setup.py (path:/tmp/pip-tD9bxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:39 INFO - Running setup.py (path:/tmp/pip-6uYPWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:40 INFO - Running setup.py (path:/tmp/pip-TAs_z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:40 INFO - Running setup.py (path:/tmp/pip-ls3fBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:40 INFO - Running setup.py (path:/tmp/pip-hm2lDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:40 INFO - Running setup.py (path:/tmp/pip-sj2_15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:40 INFO - Running setup.py (path:/tmp/pip-rADTi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:40 INFO - Running setup.py (path:/tmp/pip-Kkz3GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:40 INFO - Running setup.py (path:/tmp/pip-aPNCG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:40 INFO - Running setup.py (path:/tmp/pip-YXQGCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:40 INFO - Running setup.py (path:/tmp/pip-bYwbFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:40 INFO - Running setup.py (path:/tmp/pip-zFjCso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:40 INFO - Running setup.py (path:/tmp/pip-HhoTn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:40 INFO - Running setup.py (path:/tmp/pip-WvUQUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:40 INFO - Running setup.py (path:/tmp/pip-xMNhzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:40 INFO - Running setup.py install for manifestparser 16:07:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for mozcrash 16:07:41 INFO - Running setup.py install for mozdebug 16:07:41 INFO - Running setup.py install for mozdevice 16:07:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for mozfile 16:07:41 INFO - Running setup.py install for mozhttpd 16:07:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for mozinfo 16:07:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for mozInstall 16:07:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for mozleak 16:07:41 INFO - Running setup.py install for mozlog 16:07:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:41 INFO - Running setup.py install for moznetwork 16:07:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Running setup.py install for mozprocess 16:07:42 INFO - Running setup.py install for mozprofile 16:07:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Running setup.py install for mozrunner 16:07:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Running setup.py install for mozscreenshot 16:07:42 INFO - Running setup.py install for moztest 16:07:42 INFO - Running setup.py install for mozversion 16:07:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:42 INFO - Cleaning up... 16:07:42 INFO - Return code: 0 16:07:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:42 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')]} 16:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:42 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')]} 16:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:42 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:42 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 16:07:42 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 16:07:42 INFO - Using env: {'DISPLAY': ':0', 16:07:42 INFO - 'HOME': '/home/cltbld', 16:07:42 INFO - 'LANG': 'en_US.UTF-8', 16:07:42 INFO - 'LANGUAGE': 'en_US:en', 16:07:42 INFO - 'LOGNAME': 'cltbld', 16:07:42 INFO - 'MAIL': '/var/mail/cltbld', 16:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:42 INFO - 'MOZ_NO_REMOTE': '1', 16:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:42 INFO - 'NO_EM_RESTART': '1', 16:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:42 INFO - 'PWD': '/builds/slave/test', 16:07:42 INFO - 'SHELL': '/bin/bash', 16:07:42 INFO - 'SHLVL': '1', 16:07:42 INFO - 'TERM': 'linux', 16:07:42 INFO - 'TMOUT': '86400', 16:07:42 INFO - 'USER': 'cltbld', 16:07:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:42 INFO - '_': '/tools/buildbot/bin/python'} 16:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:42 INFO - Running setup.py (path:/tmp/pip-y9EwmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:43 INFO - Running setup.py (path:/tmp/pip-Ujqp8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:43 INFO - Running setup.py (path:/tmp/pip-57j1ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:43 INFO - Running setup.py (path:/tmp/pip-0KtXlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:43 INFO - Running setup.py (path:/tmp/pip-h5bdw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:43 INFO - Running setup.py (path:/tmp/pip-wu0wMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:43 INFO - Running setup.py (path:/tmp/pip-2B79Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:43 INFO - Running setup.py (path:/tmp/pip-ABraTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:43 INFO - Running setup.py (path:/tmp/pip-JPF6hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:43 INFO - Running setup.py (path:/tmp/pip-ubxkAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:43 INFO - Running setup.py (path:/tmp/pip-aV1LED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:43 INFO - Running setup.py (path:/tmp/pip-tas6r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:43 INFO - Running setup.py (path:/tmp/pip-T_9uC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:43 INFO - Running setup.py (path:/tmp/pip-YVwZlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:43 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)) 16:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:43 INFO - Running setup.py (path:/tmp/pip-LKp6eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:44 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)) 16:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:44 INFO - Running setup.py (path:/tmp/pip-3Eb7uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:44 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)) 16:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:44 INFO - Running setup.py (path:/tmp/pip-xYd5Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:44 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)) 16:07:44 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)) 16:07:44 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)) 16:07:44 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)) 16:07:44 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)) 16:07:44 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)) 16:07:44 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)) 16:07:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:44 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 16:07:44 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 16:07:44 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 16:07:44 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 16:07:45 INFO - Downloading blessings-1.6.tar.gz 16:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:45 INFO - Installing collected packages: blessings 16:07:45 INFO - Running setup.py install for blessings 16:07:45 INFO - Successfully installed blessings 16:07:45 INFO - Cleaning up... 16:07:45 INFO - Return code: 0 16:07:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:45 INFO - Reading from file tmpfile_stdout 16:07:45 INFO - Current package versions: 16:07:45 INFO - argparse == 1.2.1 16:07:45 INFO - blessings == 1.6 16:07:45 INFO - blobuploader == 1.2.4 16:07:45 INFO - docopt == 0.6.1 16:07:45 INFO - functools32 == 3.2.3-2 16:07:45 INFO - jsonschema == 2.5.1 16:07:45 INFO - manifestparser == 1.1 16:07:45 INFO - mozInstall == 1.13 16:07:45 INFO - mozcrash == 1.0 16:07:45 INFO - mozdebug == 0.1 16:07:45 INFO - mozdevice == 0.51 16:07:45 INFO - mozfile == 1.2 16:07:45 INFO - mozhttpd == 0.7 16:07:45 INFO - mozinfo == 0.10 16:07:45 INFO - mozleak == 0.1 16:07:45 INFO - mozlog == 3.5 16:07:45 INFO - moznetwork == 0.27 16:07:45 INFO - mozprocess == 0.25 16:07:45 INFO - mozprofile == 0.28 16:07:45 INFO - mozrunner == 6.13 16:07:45 INFO - mozscreenshot == 0.1 16:07:45 INFO - mozsystemmonitor == 0.3 16:07:45 INFO - moztest == 0.8 16:07:45 INFO - mozversion == 1.4 16:07:45 INFO - psutil == 3.1.1 16:07:45 INFO - requests == 1.2.3 16:07:45 INFO - wsgiref == 0.1.2 16:07:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:45 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 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:45 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 16:07:45 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 16:07:45 INFO - Using env: {'DISPLAY': ':0', 16:07:45 INFO - 'HOME': '/home/cltbld', 16:07:45 INFO - 'LANG': 'en_US.UTF-8', 16:07:45 INFO - 'LANGUAGE': 'en_US:en', 16:07:45 INFO - 'LOGNAME': 'cltbld', 16:07:45 INFO - 'MAIL': '/var/mail/cltbld', 16:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:45 INFO - 'MOZ_NO_REMOTE': '1', 16:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:45 INFO - 'NO_EM_RESTART': '1', 16:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:45 INFO - 'PWD': '/builds/slave/test', 16:07:45 INFO - 'SHELL': '/bin/bash', 16:07:45 INFO - 'SHLVL': '1', 16:07:45 INFO - 'TERM': 'linux', 16:07:45 INFO - 'TMOUT': '86400', 16:07:45 INFO - 'USER': 'cltbld', 16:07:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:45 INFO - '_': '/tools/buildbot/bin/python'} 16:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 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)) 16:07:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:07:45 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 16:07:45 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 16:07:45 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 16:07:45 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 16:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:07:47 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)) 16:07:47 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)) 16:07:47 INFO - Installing collected packages: simplejson 16:07:47 INFO - Running setup.py install for simplejson 16:07:47 INFO - building 'simplejson._speedups' extension 16:07:47 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 16:07:48 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 16:07:48 INFO - Successfully installed simplejson 16:07:48 INFO - Cleaning up... 16:07:48 INFO - Return code: 0 16:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, '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': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', '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 16:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:07:48 INFO - Using env: {'DISPLAY': ':0', 16:07:48 INFO - 'HOME': '/home/cltbld', 16:07:48 INFO - 'LANG': 'en_US.UTF-8', 16:07:48 INFO - 'LANGUAGE': 'en_US:en', 16:07:48 INFO - 'LOGNAME': 'cltbld', 16:07:48 INFO - 'MAIL': '/var/mail/cltbld', 16:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:48 INFO - 'MOZ_NO_REMOTE': '1', 16:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:48 INFO - 'NO_EM_RESTART': '1', 16:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:48 INFO - 'PWD': '/builds/slave/test', 16:07:48 INFO - 'SHELL': '/bin/bash', 16:07:48 INFO - 'SHLVL': '1', 16:07:48 INFO - 'TERM': 'linux', 16:07:48 INFO - 'TMOUT': '86400', 16:07:48 INFO - 'USER': 'cltbld', 16:07:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:48 INFO - '_': '/tools/buildbot/bin/python'} 16:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:07:48 INFO - Cleaning up... 16:07:48 INFO - Return code: 0 16:07:48 INFO - Running post-action listener: _resource_record_post_action 16:07:48 INFO - Running post-action listener: _start_resource_monitoring 16:07:48 INFO - Starting resource monitoring. 16:07:48 INFO - [mozharness: 2017-08-17 23:07:48.477192Z] Finished create-virtualenv step (success) 16:07:48 INFO - [mozharness: 2017-08-17 23:07:48.477852Z] Running install step. 16:07:48 INFO - Running pre-action listener: _resource_record_pre_action 16:07:48 INFO - Running main action method: install 16:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:48 INFO - Reading from file tmpfile_stdout 16:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:48 INFO - Reading from file tmpfile_stdout 16:07:48 INFO - Output received: 16:07:48 INFO - Usage: mozinstall [options] installer 16:07:48 INFO - Options: 16:07:48 INFO - -h, --help show this help message and exit 16:07:48 INFO - -d DEST, --destination=DEST 16:07:48 INFO - Directory to install application into. [default: 16:07:48 INFO - "/builds/slave/test"] 16:07:48 INFO - --app=APP Application being installed. [default: firefox] 16:07:48 INFO - mkdir: /builds/slave/test/build/application 16:07:48 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'] 16:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:08:06 INFO - Reading from file tmpfile_stdout 16:08:06 INFO - Output received: 16:08:06 INFO - /builds/slave/test/build/application/firefox/firefox 16:08:06 INFO - Running post-action listener: _resource_record_post_action 16:08:06 INFO - [mozharness: 2017-08-17 23:08:06.841323Z] Finished install step (success) 16:08:06 INFO - [mozharness: 2017-08-17 23:08:06.841613Z] Running setup-mitmproxy step. 16:08:06 INFO - Running pre-action listener: _resource_record_pre_action 16:08:06 INFO - Running main action method: setup_mitmproxy 16:08:06 INFO - Skipping: mitmproxy is not required 16:08:06 INFO - Running post-action listener: _resource_record_post_action 16:08:06 INFO - [mozharness: 2017-08-17 23:08:06.842772Z] Finished setup-mitmproxy step (success) 16:08:06 INFO - [mozharness: 2017-08-17 23:08:06.842994Z] Running run-tests step. 16:08:06 INFO - Running pre-action listener: _resource_record_pre_action 16:08:06 INFO - Running pre-action listener: _set_gcov_prefix 16:08:06 INFO - Running main action method: run_tests 16:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:08:06 INFO - Python 2.7.3 16:08:06 INFO - Return code: 0 16:08:06 INFO - grabbing minidump binary from tooltool 16:08:06 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')]} 16:08:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1ad4bb0>, '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 0x1ad5ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5f40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:08:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 16:08:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:08:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 16:08:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:06 INFO - Return code: 0 16:08:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:08:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:08:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:08:06 INFO - ENV: RUST_BACKTRACE is now full 16:08:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:08:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 16:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 16:08:06 INFO - Using env: {'DISPLAY': ':0', 16:08:06 INFO - 'HOME': '/home/cltbld', 16:08:06 INFO - 'LANG': 'en_US.UTF-8', 16:08:06 INFO - 'LANGUAGE': 'en_US:en', 16:08:06 INFO - 'LOGNAME': 'cltbld', 16:08:06 INFO - 'MAIL': '/var/mail/cltbld', 16:08:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:06 INFO - 'MOZ_NO_REMOTE': '1', 16:08:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:06 INFO - 'NO_EM_RESTART': '1', 16:08:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:06 INFO - 'PWD': '/builds/slave/test', 16:08:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:06 INFO - 'RUST_BACKTRACE': 'full', 16:08:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:08:06 INFO - 'SHELL': '/bin/bash', 16:08:06 INFO - 'SHLVL': '1', 16:08:06 INFO - 'TERM': 'linux', 16:08:06 INFO - 'TMOUT': '86400', 16:08:06 INFO - 'USER': 'cltbld', 16:08:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419', 16:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:06 INFO - '_': '/tools/buildbot/bin/python'} 16:08:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 16:08:07 INFO - mozversion application_buildid: 20170817221603 16:08:07 INFO - mozversion application_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:08:07 INFO - mozversion application_display_name: Nightly 16:08:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:07 INFO - mozversion application_name: Firefox 16:08:07 INFO - mozversion application_remotingname: firefox 16:08:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:08:07 INFO - mozversion application_vendor: Mozilla 16:08:07 INFO - mozversion application_version: 57.0a1 16:08:07 INFO - mozversion platform_buildid: 20170817221603 16:08:07 INFO - mozversion platform_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:08:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:08:07 INFO - mozversion platform_version: 57.0a1 16:08:07 INFO - using testdate: 1503011287 16:08:07 INFO - actual date: 1503011287 16:08:07 INFO - starting webserver on 'localhost:47252' 16:08:07 INFO - SUITE-START | Running 2 tests 16:08:07 INFO - TEST-START | dromaeo_css 16:08:07 INFO - Initialising browser for dromaeo_css test... 16:08:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47252/getInfo.html -profile /tmp/tmpUKlCmH/profile 16:08:07 INFO - TEST-INFO | started process 24906 (/builds/slave/test/build/application/firefox/firefox http://localhost:47252/getInfo.html) 16:08:12 INFO - TEST-INFO | 24906: exit 0 16:08:12 INFO - Browser initialized. 16:08:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:12 INFO - TEST-INFO | started process 25078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKlCmH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:13 INFO - PID 25078 | 16:08:13 INFO - PID 25078 | (/builds/slave/test/build/application/firefox/firefox:25125): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:08:13 INFO - PID 25078 | 16:08:24 INFO - PID 25078 | RSS: Main: 167120896 16:08:24 INFO - PID 25078 | 16:11:22 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47252/tests/dromaeo/cssquery-ext.html) 16:11:24 INFO - PID 25078 | RSS: Main: 172085248 16:11:24 INFO - PID 25078 | 16:14:26 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-ext.html (next: http://localhost:47252/tests/dromaeo/cssquery-jquery.html) 16:14:26 INFO - PID 25078 | RSS: Main: 168476672 16:14:26 INFO - PID 25078 | 16:17:28 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47252/tests/dromaeo/cssquery-mootools.html) 16:17:28 INFO - PID 25078 | RSS: Main: 171474944 16:17:28 INFO - PID 25078 | 16:20:30 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47252/tests/dromaeo/cssquery-prototype.html) 16:20:31 INFO - PID 25078 | RSS: Main: 169414656 16:20:31 INFO - PID 25078 | 16:23:35 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47252/tests/dromaeo/cssquery-yui.html) 16:23:35 INFO - PID 25078 | RSS: Main: 173244416 16:23:35 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | Cycle 1(1): loaded http://localhost:47252/tests/dromaeo/cssquery-yui.html (next: http://localhost:47252/tests/dromaeo/cssquery-dojo.html) 16:26:37 INFO - PID 25078 | RSS: Main: 171474944 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | __start_tp_report 16:26:37 INFO - PID 25078 | _x_x_mozilla_page_load 16:26:37 INFO - PID 25078 | _x_x_mozilla_page_load_details 16:26:37 INFO - PID 25078 | |i|pagename|runs| 16:26:37 INFO - PID 25078 | |0;dojo.html;3172.5558421820947;3185.506246531788;3198.976327575177;3203.567518385018;3214.3410600826833;6128.142060111577;6164.982777841657;6196.411340922611;6226.221722284715;6259.342769009257;6025.246844144482;6113.32753397126;6147.415995480434;6167.907481387782;6242.500599952004;5626.127950167731;5699.173619825123;5730.4269573042675;5760.049591817345;5770.7691692332255;881.0652075082218;5593.804216852411;5607.074832652628;5613.691246981414;5714.171445140452;5655.717214139277;5689.772409103631;5703.030484817591;5711.114777209539;5733.713314334266;5613.4386561343945;5643.6049476536655;5706.343770466367;5732.684702341369;5754.88490230193;5610.551155907518;5621.128725047624;5667.4049224831215;5686.488216060533;5691.26013618227;5983.880322393571;6011.068284415923;6097.878042439126;6108.5418593605655;6122.693865306762;6519.771807986698;6600.735970561172;6616.073749675049;6640;6712.5301228913995;6682.231543372526;6698.799036028879;6767.796966090976;6773.322667733237;6782.593044417351;6148.600340977911;6186.443220110166;6272.372762723737;6272.749090036393;6274.1843560336865;6722.932770672329;6774.83062923421;6859.176898772179;6863.176418829772;6913.723451062002;6512.413882750575;6531.346865313526;6559.048937903977;6589.80230593083;6599.967000164968;6691.76578819739;6734.259231484532;6755.898661520081;6765.458763298924;6769.120014398097;6646.136002319668;6658.1011563438315;6659.4006539411685;6721.596704197764;6752;6461.450776683941;6532.052852336385;6549.869002619921;6640.335966403321;6721.563098398588;5399.919001214985;5404.621676482609;5415.214793854948;5431.782728690887;5431.94077154951;4629.837955671603;4643.3731446255;4709.62323014158;4711.434627844681;4749.121412538691;5659.5755318351285;5670.319561652628;5699.629524080921;5760.279965004374;5774.509166720875;6580.670966451658;6593.076969224312;6677.499187560952;6693.297203793629;6693.665316734241;5665.518430933417;5678.943210567842;5720.2849643794525;5720.570957178228;5742.511886489695;5866.2960444746905;5869.06095024794;5909.940900590939;5953.583249172603;5967.433093856077;6395.488360931115;6510.381513756186;6521.315261897433;6530.477561795045;6535.8692826143215;6602.636854973022;6669.799906002828;6694.497912656668;6707.564008339442;6727.899081513683;6242.438180563771;6342.619442833445;6421.486281097407;6503.967480162569;6507.284198738041;6512.153420055362;6552.868942621216;6559.704813283318;6579.835504112435;6580.638064906476;6643.40209381158;6685.298043705341;6736.831579210559;6761.560498567577;6791.2190098139345;6392.616443013434;6438.8390290243115;6509.674516274262;6524.9021264682015;6532.771353002622;6423.839404014937;6442.871142577216;6491.350864913471;6508.284088750328;6533.248676402274;6289.9056514153235;6328.873422531616;6383.361663833765;6390.616563006049;6404.455621272244;6449.516286278454;6476.6114033158165;6512.283648798723;6515.185601799775;6531.477481801539;6315.084312774714;6319.210098737658;6320.5575609706875;6327.303996560283;6339.4928405726505 16:26:37 INFO - PID 25078 | |1;ext.html;826.194460401109;878.885744853169;906.8413027720147;1159.1480262007428;1186.199315462063;30963.535546966814;42438.57561424385;43105.137897242035;43201.78399108;43291;43084.78457607715;43327;43421;43450.782746086305;43507.78246108773;7688.461807673465;7730.304272615464;7940.36477081835;7942.3646108311195;7946.801329966739;7714.575698336589;7809.3752499799875;7849.607519623996;7850.214978502161;7859.331956783652;7869.291763741262;7932.524048557077;7934.285914267714;7938.6427610757655;7941.880871786899;7846.764597062097;7877.0547534295965;7880.2513761192595;7880.605969701549;7885.487443316195;7757.069151701832;7804.921950780476;7806.765797026098;7815.804604884866;7824;39142.21715565701;39435.21129577392;39617.80191099026;39623.8018809907;39749.80125099385;3565.7682250653884;3600.5859326177565;3601.459781032866;3610.1155216971747;3611.747177697562;31565;31583.684163158305;31709;31709.365812683616;31733;5118.334616499868;5140.588752899759;5144.305518754958;5164.509371609729;5207.60942929278;183232;184407;185668.99999999866;185986;186355;50393.24410133851;50451;50593.22923697726;50657.24014139791;50700.23949640759;52413;52449.73775131176;52505.2124218137;52534.47465525296;52575.21137182946;14993.32530036151;15229.086254824746;15751.054936703835;15790.842091578937;15902.363905443653;12698.238105713686;12935.741285174245;12940.935295323463;12942.029347798953;12944.09391342597;15101.39594416211;15117.470888519068;15143.848561514464;15226.162561059247;15234.619134521725;5567.3040869891265;5737.8565535861935;5812.418758124154;5854.092615644582;5881.117832325185;1019.7603563162651;1026.7946410717886;1027.1628622672497;1027.6660085472251;1048.3447845096814;23432.76567234306;23837;23924.04303827862;23945;30034;1095.9835602465969;1101.218135124055;1104.7072525780675;1107.8449017137607;1125.352922069813;12759.744805103846;16385;16486.917565412336;16507.174641267888;17050.806443548834;239773;242845;242912;243616;244072;60589;60748.08877866835;60933;61260.38739612636;61562.38437615566;1438.4821464272854;1476.7489526780473;1494.5441640299596;1514.8788096952217;1524.5273965070865;28083.578746318413;28839.5674064885;28979;29056.7094329054;29310.706892930797;53553;54185.18722219091;54306.45693543014;54431.45568544422;54628.180577292165;221581;223098;223374;224409;225152;37016.62983370132;38192.70843749384;39382.409263861635;39459;39550.60449395469;47012.7649361751;48771.75614122049;49110;49168.50831491639;49289.75355123202;35735;35924.82037589795;35940.46089308715;36209;36304;35105.29789404249;35302;35347.82326088353;35491.64508354987;35617.64382356143;39366.409503858034;39427.60572394239;39624.603753963245;39792.60207397889;39851.2029759409;33781;34425.48361774525;34429.655703442644;34617;34747.65252347444;23887.880560597085;25119;25143.748562514873;25560.360990975376;25646.61530077013 16:26:37 INFO - PID 25078 | |2;jquery.html;574.5518495573451;580.4891695308128;583.2155750515558;588.997055014725;599.8890205312016;22457.438564035907;22492.88753556232;23388.532229355424;23599.999999999978;23619.5276094478;24217.51564968704;25878.870605646993;25902.611460828102;25910.35224119398;25992.22023339303;6380.457661098812;6521.891278482669;6525.314841941599;6526.738930442777;6527.184101987252;6092.055731361646;6395.552311338208;6401.199850018747;6401.391867772554;6443.25902521209;6369.394907483782;6369.490440764751;6375.2987171411105;6376.139221205124;6376.362363763633;6361.61830290184;6370.968145159244;6371.8407039823915;6373.490120790326;6379.649119298437;5888.705564721747;5929;5934;5935.584509084366;5941.049432090888;28278.575821362698;28923;29438.264043399085;29615.40769184626;29738.70261297381;1881.6424879272895;1916.8849869007904;1919.443361425185;1919.6640587897061;1922.2311075569744;18830.246790128378;19390.70913936292;19481.707774383394;19507.707384389247;19515;2346.341727913084;2425.248173066355;2474.8267621266336;2484.91302804401;2496.450780828215;129210.3539482306;130960.41638542606;130983;131027;131350;13748.518801841887;14555.272236388138;14928.328225229674;15052.172130532706;15092.698146037017;23163.76836231616;23516.176933807234;23855;23875;23877.641835372484;10182.847257291147;10259.384436933808;10286.537105830255;10441.373517588969;10629.309094908805;9611.183049440737;9637.22902167839;9737.026297370348;9753.951230243803;9842.60629574809;9070.319726020574;9196.816063678689;9335.346525743133;9538.666146684833;9749.658761943298;2600.8829602667925;2614.5293847107705;2724.3053021479395;2746.134967485276;2812.3812761192503;950.4772375193616;955.4315182466421;969.898160693117;972.5088830140734;981.3817295104038;19041.333553325567;19228.615427691646;19236.52246754026;19708.901455492633;19734.70397944032;1024.2983556263982;1029.6036026129843;1034.7051090439188;1044.1855352824657;1044.681372181492;10640.840387394195;13381.53164639233;13911.234882081582;14185.503507377192;14257.85742142586;507851;516828;517834;521063;561939;113692;116523.41738291254;120398;122245.38877305735;122612;1261.9305938173488;1274.5730180389487;1302.5896842494583;1304.8499422566335;1308.2346827106248;20590.382288531368;20702.171913123308;20879.791202087785;21045.789542104383;21163.047662855515;47334.28998565093;48325;51928;55130.72434637801;59003.81992360215;66755.33244667492;67582;67611.32388676248;70721.29278707353;76253;14645.121292722471;14964.326605302569;14986.550403487912;15175.772363414779;15178.620534486285;23660.763392366545;23820.404489887893;23963.16128935479;23974.52050959006;24013.159539416036;16634.500964970586;16782.16089195511;16910.239039243017;16929.32282708678;18325.816741832943;15544.766828497355;16008.839911600735;16794.244259008618;16922.15389230558;17213.74179387285;15806.051636901822;16789.32842686279;17177.227024784166;18850.3402380916;19281.80718192856;14782.48261310849;14796.260186990823;14891.776623350443;14917.104973701178;14931.92534037323;17999.820001799813;18219.362322318655;18360.540986475444;18889.527761806065;18993 16:26:37 INFO - PID 25078 | |3;mootools.html;1310.606817954614;1330.514362257776;1351.5134551561437;1354.1265883505134;1363.8227030486034;13551.119177253471;14162.787558186636;14741.115533068023;14769.0400123992;14787.33456994435;14753.557393278192;14923.701525969474;14927.626809329773;14929;14939.103653780781;2640.4455064436493;2697.581874809398;2699.91900242993;2714.6335244742004;2718.0486829609677;2652.814302998791;2757.9448411031767;2771.1547977866744;2772.7365900239547;2774.708655591164;2688.475747229291;2711.430599574092;2719.456108778252;2747.217043142705;2747.3269049083;2608.0610980047168;2630.092618046771;2644.9735502645017;2654.3894904172053;2675.638788763531;2547.6305935639416;2570.588705807062;2582.4705935283223;2582.5093232285994;2583.7287084856193;14043.719125617532;14455.421783128662;14472.059316144523;14472.276386180649;14481.131132132106;7548.698052077911;7801.453898227126;7805.765827025199;7809.258120478546;7839.529628222325;4971.776270067856;5132;5196.324477817897;5214.165733482662;5219.373675159005;1829.6249268899844;1846.4276074416973;1886.8962207078605;1923.422973108076;1935.3613307608455;22175.223867164732;22219.333419997427;22572;22591.20930767432;22611.660825087638;6652.368025037614;6715.1941766988275;6736.124303840469;6809.455243580502;6834.589924604539;16627.83372166287;16629.750553741702;16633.916830415772;16666;16668;7555.773326800205;7851.293383595504;8099.83800324002;8122.796930076795;8123.147069557729;7072.08062951813;7258.782236532912;7263.346298833025;7267.30960558746;7277.526960747535;5100.923486147711;5251.10731175701;5276.577873770089;5314.22943673173;5322.042032434199;1523.3373482534912;1526.2292542266084;1528.6866192430525;1538.3615799443105;1568.4510421352663;888.3692578269372;911.6763548940031;922.280621115531;927.9304052196112;930.8882934047822;7316.707331706779;7407.2222416646555;7460.253974602605;7496.962515187498;7533.585652789149;661.2263651527724;690.4165979747106;699.464909344352;700.9754658587027;706.2795948132979;4614.423197100363;4823.324734537167;5017.698938063728;5120.001599688099;5132.127538318495;19515.414537563895;20005.899970500053;20120.89939550293;20387.490312742004;20387.59224815525;19236.80763192378;19516.609667806566;20028.69956950647;20072.09675564603;20121.496962576053;10821.188410869216;11042.723931901606;11135.220534562664;11145.554177832795;11275.548978040786;8100.79748006281;8110.310623596824;8113.797155071171;8162;8180.631871565674;17433.215505302545;17757.46727598174;17836.19737111859;17867.553311167325;18067;17495.38766143179;18121.818781812013;18149.092545372943;18220.726689099938;18296.268149274412;10317.638882639072;11094.278871873303;11288.20982531215;11293.37886416255;11325.546978120783;13287.335633218494;13329.866701332863;13397.12918660284;13435.193888366339;13446;11153.944230278797;11157.497912594115;11179.552817887194;11273.887261127611;11476.942615286871;10429.217808664533;10624.415657138932;10638.52126654287;10667.839982400115;10954.39750813681;9202.815943681222;9447.763805904908;9471.337006409485;9473.194778443909;9511.334206605748;7120.252373500708;7181.82045448847;7199.460040497089;7222.819429514094;7243.45674074436;6582.0785090086465;6627.1716035495565;6659.101021362054;6705.0612914193025;6752.459803215829 16:26:37 INFO - PID 25078 | |4;prototype.html;495.0667990837272;503.2677454303988;526.1371350984385;532.0125658191853;536.3938749213388;6181.28915174755;6188.690565471731;6217.253929528451;6236.844078898024;6252.906206406908;5947.672877991719;6042.335343112254;6047.850908327426;6068.8482787930325;6071.848203794896;4879.487653796354;4904.337914381566;4909.828156014541;4926.3842019747535;4933.901321973558;4935.938773163769;4946.15915294399;4949.851504454872;4974.955259395531;5003.974980125113;4736.502667219944;4835.661503694742;4841.612670986313;4902.333206709718;4946.87632809179;4855.63582731293;4862.999999999983;4905.950940490585;4961.255811628249;4962.9007419851405;4391.5827996340295;4400.09797991411;4415.668824838118;4422.579854913778;4428.645708343357;5905.911411328791;5930.911036334415;5932.84309559636;5934.258217722785;5980.940190598082;5602.299712535933;5609;5609.439056094398;5648.858778530528;5724.227229324029;6371.87256254877;6406.2953075161695;6422.357764223587;6477.870442591122;6507.154069970874;4770.522947705236;4814.855554333376;4832.1543729847135;4838.564529192355;4856.465788763233;6709.36261055199;6801.727930882808;6821.69302381394;6828.46359569093;6889.586624802528;4917.803287868517;4924.651237158695;4991.975040124777;4998.400191976986;5082;4965.3048573199785;4978.626603004716;5021.4978502150225;5059.418166910852;5099.6685215460875;5656.151577263443;5667.688277144796;5694.686792226385;5702;5713.428657134336;6530.542861999615;6550.115734375799;6563.7702680405955;6577;6639.668016599151;1654.7754661550366;1705.351966252816;1750.8949463032004;1759.876808623384;1764.1796564597266;1221.6396163131897;1230.9076819238594;1231.9630411087683;1239.6054438756398;1253.166644181609;5753.33836608787;5757.395473475225;5771.394003629643;5801.94198058014;5813.331466881363;6583.539152259392;6654.966725166343;6672;6722.033999939961;6739.865202695919;5781.797637082682;5820.82537523875;5840.3575606683235;5867.882642347215;5872.942870283305;3589.9282014360087;3610.765300255475;3618.9638103619154;3629.4011488104693;3633.5276414066;6637.668116594151;6639.136912201383;6666.566673166229;6687.799366019027;6697.732090716317;6948.44412447003;6964.895526567106;6970.860582788418;6972.930270697329;7015.123109611299;6575.506836987341;6596.0105984102765;6643.800685979429;6671.833204169838;6706.128203333536;6763.154605674291;6789.830254243683;6795.52431329822;6814;6819.476793586405;6648.268690444144;6693.966530167318;6736.764213252709;6751.864962700817;6759.729610815512;6603.273639899511;6621.67566486695;6627.4698024158915;6636;6644;4986.900261994812;5004.124278251365;5005.299258103942;5014.197728363444;5035.723035233097;6684.498662600227;6755.088063111417;6790.388865002174;6812.965935170292;6877.558466744234;6473.643949582818;6522.641254731036;6568.573042752206;6591.703373348115;6604.63674497888;6407.583507072025;6477.611343319416;6486.805395838132;6520.250171230369;6531.804045878631;6201.565890387629;6265.457543281084;6303.023031430135;6346.333634968447;6460.353964603502;6474.935250647433;6489.643069631215;6524.804255872332;6534.4772418205475;6609.173853268341;6288.874222515433;6311.779087731908;6314;6327.715252813727;6327.778527751507 16:26:37 INFO - PID 25078 | |5;yui.html;919.6919032124238;923.1645360948341;934.3132797393919;946.1295608040602;952.1906379577358;19017.334393296238;20071.899640501815;20078.89960550197;20166.294179703713;21603.243886463977;21346.25288114916;21850.89074554629;21854.781452185474;21883.343499694995;21932.342029739095;1022.8925962773932;1046.0219694585548;1051.5373235776235;1052.947352632369;1053.2995557953952;999.000999000999;1071.1002757683543;1073.1843798712996;1073.8442925775757;1074.4412905289246;1088.0370871778493;1094.9945250273738;1101.7355834599678;1101.7906597746442;1104.0229396983686;1087.314991555319;1087.8313861351503;1090.3893819461086;1091.1489038549905;1091.5688303120303;801.0067516279829;803.4857691077715;804.1797366686006;804.2962407893093;804.4610111225493;19968.90015549913;20002.39992800218;20207.090680919395;20238.39284821458;20387.082581283878;21138.048787804586;21767.129314827387;22059.889700551554;22163.778362216333;22248.221312254154;16273.430429934895;16979.15104244783;17147.48557543263;17179.91410042954;17213.56966075858;3719.6652301293016;3732.701383889282;3742;3745.3632882410056;3748.9812550937345;122127;122225;122735;125870.37064814709;128341.35829320888;16304.51086467408;16843.41048063312;16868.831311686725;16923.661526769643;17143.399981000606;30902.381952360825;31587;31881.362372752414;32006.839965800023;32024.199395015312;7780.8832867507035;8156;8744.8688269676;8995.505247211335;9113.95443022794;4242.851500197478;4314.072474418015;4321.546237645065;4324.13517296542;4325.653947684178;4916.680415773035;5065.214891691794;5073.188289873677;5089.236614507853;5091.847244582668;1013.5287091502339;1030.05749738988;1039.1998161415668;1040.5213601743133;1044.7179261599326;667.4893706314673;681.9283975182534;682.576802382526;689.5896941319907;692.5256199503357;10784.892151078546;10931.836022459669;11019.72450688723;11478.827817582744;11504.36725980079;652.1717418877998;664.8304682306077;669.1769123977535;672.1832972937904;673.7406098652054;5310.734463276821;5371.731413429391;5423.864403389947;5442.673439593558;5480.068388373986;108286.45856770824;108563;108570;109730.45134774435;111663;97577.02422975822;100392;101865;103409;104019;83748;86388.13611863926;87300.12699873047;88375.55812221026;90112.09887901168;9960.701178964642;10075.596976120873;10178.338408003456;10278.486075696335;11849.466773995364;39145.825625231286;40415;40604.59395406126;41084.58915410808;41574.792126039174;67736;68981.65509172421;70534.29465705277;71228;75001.87497187656;14542.709145817236;18378.448646540626;18903.90548047251;18928.621427571095;19426.8057319425;19155.90422047881;19261.711074334176;19502;20102;20843.583128337046;16492;17033.659326813642;17148.657026859142;17203.13984300755;17306.48080557585;17858.91070544639;17965;18017.279308828023;18387.17257723379;18517.722234166227;16548.503544893672;16833.91583042077;17605.64788704193;18406.631867362845;18476.815231847508;13190;13285.83528473933;13341.466341346237;13625.931870340584;14133.858661413255;12723.681907952005;13123.737525249633;13244.337783110614;13958.302084895919;13988.090774099652 16:26:37 INFO - PID 25078 | __end_tp_report 16:26:37 INFO - PID 25078 | __start_cc_report 16:26:37 INFO - PID 25078 | _x_x_mozilla_cycle_collect,363 16:26:37 INFO - PID 25078 | __end_cc_report 16:26:37 INFO - PID 25078 | __startTimestamp1503012397599__endTimestamp 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | ------- Summary: start ------- 16:26:37 INFO - PID 25078 | Number of tests: 6 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#0] dojo.html Cycles:165 Average:6094.33 Median:6342.62 stddev:820.82 (12.9%) stddev-sans-first:790.69 16:26:37 INFO - PID 25078 | Values: 3172.6 3185.5 3199.0 3203.6 3214.3 6128.1 6165.0 6196.4 6226.2 6259.3 6025.2 6113.3 6147.4 6167.9 6242.5 5626.1 5699.2 5730.4 5760.0 5770.8 881.1 5593.8 5607.1 5613.7 5714.2 5655.7 5689.8 5703.0 5711.1 5733.7 5613.4 5643.6 5706.3 5732.7 5754.9 5610.6 5621.1 5667.4 5686.5 5691.3 5983.9 6011.1 6097.9 6108.5 6122.7 6519.8 6600.7 6616.1 6640.0 6712.5 6682.2 6698.8 6767.8 6773.3 6782.6 6148.6 6186.4 6272.4 6272.7 6274.2 6722.9 6774.8 6859.2 6863.2 6913.7 6512.4 6531.3 6559.0 6589.8 6600.0 6691.8 6734.3 6755.9 6765.5 6769.1 6646.1 6658.1 6659.4 6721.6 6752.0 6461.5 6532.1 6549.9 6640.3 6721.6 5399.9 5404.6 5415.2 5431.8 5431.9 4629.8 4643.4 4709.6 4711.4 4749.1 5659.6 5670.3 5699.6 5760.3 5774.5 6580.7 6593.1 6677.5 6693.3 6693.7 5665.5 5678.9 5720.3 5720.6 5742.5 5866.3 5869.1 5909.9 5953.6 5967.4 6395.5 6510.4 6521.3 6530.5 6535.9 6602.6 6669.8 6694.5 6707.6 6727.9 6242.4 6342.6 6421.5 6504.0 6507.3 6512.2 6552.9 6559.7 6579.8 6580.6 6643.4 6685.3 6736.8 6761.6 6791.2 6392.6 6438.8 6509.7 6524.9 6532.8 6423.8 6442.9 6491.4 6508.3 6533.2 6289.9 6328.9 6383.4 6390.6 6404.5 6449.5 6476.6 6512.3 6515.2 6531.5 6315.1 6319.2 6320.6 6327.3 6339.5 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#1] ext.html Cycles:180 Average:40397.68 Median:19910.37 stddev:56677.06 (284.7%) stddev-sans-first:56758.17 16:26:37 INFO - PID 25078 | Values: 826.2 878.9 906.8 1159.1 1186.2 30963.5 42438.6 43105.1 43201.8 43291.0 43084.8 43327.0 43421.0 43450.8 43507.8 7688.5 7730.3 7940.4 7942.4 7946.8 7714.6 7809.4 7849.6 7850.2 7859.3 7869.3 7932.5 7934.3 7938.6 7941.9 7846.8 7877.1 7880.3 7880.6 7885.5 7757.1 7804.9 7806.8 7815.8 7824.0 39142.2 39435.2 39617.8 39623.8 39749.8 3565.8 3600.6 3601.5 3610.1 3611.7 31565.0 31583.7 31709.0 31709.4 31733.0 5118.3 5140.6 5144.3 5164.5 5207.6 183232.0 184407.0 185669.0 185986.0 186355.0 50393.2 50451.0 50593.2 50657.2 50700.2 52413.0 52449.7 52505.2 52534.5 52575.2 14993.3 15229.1 15751.1 15790.8 15902.4 12698.2 12935.7 12940.9 12942.0 12944.1 15101.4 15117.5 15143.8 15226.2 15234.6 5567.3 5737.9 5812.4 5854.1 5881.1 1019.8 1026.8 1027.2 1027.7 1048.3 23432.8 23837.0 23924.0 23945.0 30034.0 1096.0 1101.2 1104.7 1107.8 1125.4 12759.7 16385.0 16486.9 16507.2 17050.8 239773.0 242845.0 242912.0 243616.0 244072.0 60589.0 60748.1 60933.0 61260.4 61562.4 1438.5 1476.7 1494.5 1514.9 1524.5 28083.6 28839.6 28979.0 29056.7 29310.7 53553.0 54185.2 54306.5 54431.5 54628.2 221581.0 223098.0 223374.0 224409.0 225152.0 37016.6 38192.7 39382.4 39459.0 39550.6 47012.8 48771.8 49110.0 49168.5 49289.8 35735.0 35924.8 35940.5 36209.0 36304.0 35105.3 35302.0 35347.8 35491.6 35617.6 39366.4 39427.6 39624.6 39792.6 39851.2 33781.0 34425.5 34429.7 34617.0 34747.7 23887.9 25119.0 25143.7 25560.4 25646.6 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#2] jquery.html Cycles:180 Average:35596.45 Median:23558.09 stddev:87855.10 (372.9%) stddev-sans-first:88062.20 16:26:37 INFO - PID 25078 | Values: 574.6 580.5 583.2 589.0 599.9 22457.4 22492.9 23388.5 23600.0 23619.5 24217.5 25878.9 25902.6 25910.4 25992.2 6380.5 6521.9 6525.3 6526.7 6527.2 6092.1 6395.6 6401.2 6401.4 6443.3 6369.4 6369.5 6375.3 6376.1 6376.4 6361.6 6371.0 6371.8 6373.5 6379.6 5888.7 5929.0 5934.0 5935.6 5941.0 28278.6 28923.0 29438.3 29615.4 29738.7 1881.6 1916.9 1919.4 1919.7 1922.2 18830.2 19390.7 19481.7 19507.7 19515.0 2346.3 2425.2 2474.8 2484.9 2496.5 129210.4 130960.4 130983.0 131027.0 131350.0 13748.5 14555.3 14928.3 15052.2 15092.7 23163.8 23516.2 23855.0 23875.0 23877.6 10182.8 10259.4 10286.5 10441.4 10629.3 9611.2 9637.2 9737.0 9754.0 9842.6 9070.3 9196.8 9335.3 9538.7 9749.7 2600.9 2614.5 2724.3 2746.1 2812.4 950.5 955.4 969.9 972.5 981.4 19041.3 19228.6 19236.5 19708.9 19734.7 1024.3 1029.6 1034.7 1044.2 1044.7 10640.8 13381.5 13911.2 14185.5 14257.9 507851.0 516828.0 517834.0 521063.0 561939.0 113692.0 116523.4 120398.0 122245.4 122612.0 1261.9 1274.6 1302.6 1304.8 1308.2 20590.4 20702.2 20879.8 21045.8 21163.0 47334.3 48325.0 51928.0 55130.7 59003.8 66755.3 67582.0 67611.3 70721.3 76253.0 14645.1 14964.3 14986.6 15175.8 15178.6 23660.8 23820.4 23963.2 23974.5 24013.2 16634.5 16782.2 16910.2 16929.3 18325.8 15544.8 16008.8 16794.2 16922.2 17213.7 15806.1 16789.3 17177.2 18850.3 19281.8 14782.5 14796.3 14891.8 14917.1 14931.9 17999.8 18219.4 18360.5 18889.5 18993.0 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#3] mootools.html Cycles:180 Average:8876.76 Median:2619.08 stddev:6104.88 (233.1%) stddev-sans-first:6095.54 16:26:37 INFO - PID 25078 | Values: 1310.6 1330.5 1351.5 1354.1 1363.8 13551.1 14162.8 14741.1 14769.0 14787.3 14753.6 14923.7 14927.6 14929.0 14939.1 2640.4 2697.6 2699.9 2714.6 2718.0 2652.8 2757.9 2771.2 2772.7 2774.7 2688.5 2711.4 2719.5 2747.2 2747.3 2608.1 2630.1 2645.0 2654.4 2675.6 2547.6 2570.6 2582.5 2582.5 2583.7 14043.7 14455.4 14472.1 14472.3 14481.1 7548.7 7801.5 7805.8 7809.3 7839.5 4971.8 5132.0 5196.3 5214.2 5219.4 1829.6 1846.4 1886.9 1923.4 1935.4 22175.2 22219.3 22572.0 22591.2 22611.7 6652.4 6715.2 6736.1 6809.5 6834.6 16627.8 16629.8 16633.9 16666.0 16668.0 7555.8 7851.3 8099.8 8122.8 8123.1 7072.1 7258.8 7263.3 7267.3 7277.5 5100.9 5251.1 5276.6 5314.2 5322.0 1523.3 1526.2 1528.7 1538.4 1568.5 888.4 911.7 922.3 927.9 930.9 7316.7 7407.2 7460.3 7497.0 7533.6 661.2 690.4 699.5 701.0 706.3 4614.4 4823.3 5017.7 5120.0 5132.1 19515.4 20005.9 20120.9 20387.5 20387.6 19236.8 19516.6 20028.7 20072.1 20121.5 10821.2 11042.7 11135.2 11145.6 11275.5 8100.8 8110.3 8113.8 8162.0 8180.6 17433.2 17757.5 17836.2 17867.6 18067.0 17495.4 18121.8 18149.1 18220.7 18296.3 10317.6 11094.3 11288.2 11293.4 11325.5 13287.3 13329.9 13397.1 13435.2 13446.0 11153.9 11157.5 11179.6 11273.9 11476.9 10429.2 10624.4 10638.5 10667.8 10954.4 9202.8 9447.8 9471.3 9473.2 9511.3 7120.3 7181.8 7199.5 7222.8 7243.5 6582.1 6627.2 6659.1 6705.1 6752.5 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#4] prototype.html Cycles:180 Average:5500.14 Median:6011.64 stddev:1553.10 (25.8%) stddev-sans-first:1511.34 16:26:37 INFO - PID 25078 | Values: 495.1 503.3 526.1 532.0 536.4 6181.3 6188.7 6217.3 6236.8 6252.9 5947.7 6042.3 6047.9 6068.8 6071.8 4879.5 4904.3 4909.8 4926.4 4933.9 4935.9 4946.2 4949.9 4975.0 5004.0 4736.5 4835.7 4841.6 4902.3 4946.9 4855.6 4863.0 4906.0 4961.3 4962.9 4391.6 4400.1 4415.7 4422.6 4428.6 5905.9 5930.9 5932.8 5934.3 5980.9 5602.3 5609.0 5609.4 5648.9 5724.2 6371.9 6406.3 6422.4 6477.9 6507.2 4770.5 4814.9 4832.2 4838.6 4856.5 6709.4 6801.7 6821.7 6828.5 6889.6 4917.8 4924.7 4992.0 4998.4 5082.0 4965.3 4978.6 5021.5 5059.4 5099.7 5656.2 5667.7 5694.7 5702.0 5713.4 6530.5 6550.1 6563.8 6577.0 6639.7 1654.8 1705.4 1750.9 1759.9 1764.2 1221.6 1230.9 1232.0 1239.6 1253.2 5753.3 5757.4 5771.4 5801.9 5813.3 6583.5 6655.0 6672.0 6722.0 6739.9 5781.8 5820.8 5840.4 5867.9 5872.9 3589.9 3610.8 3619.0 3629.4 3633.5 6637.7 6639.1 6666.6 6687.8 6697.7 6948.4 6964.9 6970.9 6972.9 7015.1 6575.5 6596.0 6643.8 6671.8 6706.1 6763.2 6789.8 6795.5 6814.0 6819.5 6648.3 6694.0 6736.8 6751.9 6759.7 6603.3 6621.7 6627.5 6636.0 6644.0 4986.9 5004.1 5005.3 5014.2 5035.7 6684.5 6755.1 6790.4 6813.0 6877.6 6473.6 6522.6 6568.6 6591.7 6604.6 6407.6 6477.6 6486.8 6520.3 6531.8 6201.6 6265.5 6303.0 6346.3 6460.4 6474.9 6489.6 6524.8 6534.5 6609.2 6288.9 6311.8 6314.0 6327.7 6327.8 16:26:37 INFO - PID 25078 | 16:26:37 INFO - PID 25078 | [#5] yui.html Cycles:180 Average:23820.73 Median:19735.45 stddev:32274.92 (163.5%) stddev-sans-first:32319.65 16:26:37 INFO - PID 25078 | Values: 919.7 923.2 934.3 946.1 952.2 19017.3 20071.9 20078.9 20166.3 21603.2 21346.3 21850.9 21854.8 21883.3 21932.3 1022.9 1046.0 1051.5 1052.9 1053.3 999.0 1071.1 1073.2 1073.8 1074.4 1088.0 1095.0 1101.7 1101.8 1104.0 1087.3 1087.8 1090.4 1091.1 1091.6 801.0 803.5 804.2 804.3 804.5 19968.9 20002.4 20207.1 20238.4 20387.1 21138.0 21767.1 22059.9 22163.8 22248.2 16273.4 16979.2 17147.5 17179.9 17213.6 3719.7 3732.7 3742.0 3745.4 3749.0 122127.0 122225.0 122735.0 125870.4 128341.4 16304.5 16843.4 16868.8 16923.7 17143.4 30902.4 31587.0 31881.4 32006.8 32024.2 7780.9 8156.0 8744.9 8995.5 9114.0 4242.9 4314.1 4321.5 4324.1 4325.7 4916.7 5065.2 5073.2 5089.2 5091.8 1013.5 1030.1 1039.2 1040.5 1044.7 667.5 681.9 682.6 689.6 692.5 10784.9 10931.8 11019.7 11478.8 11504.4 652.2 664.8 669.2 672.2 673.7 5310.7 5371.7 5423.9 5442.7 5480.1 108286.5 108563.0 108570.0 109730.5 111663.0 97577.0 100392.0 101865.0 103409.0 104019.0 83748.0 86388.1 87300.1 88375.6 90112.1 9960.7 10075.6 10178.3 10278.5 11849.5 39145.8 40415.0 40604.6 41084.6 41574.8 67736.0 68981.7 70534.3 71228.0 75001.9 14542.7 18378.4 18903.9 18928.6 19426.8 19155.9 19261.7 19502.0 20102.0 20843.6 16492.0 17033.7 17148.7 17203.1 17306.5 17858.9 17965.0 18017.3 18387.2 18517.7 16548.5 16833.9 17605.6 18406.6 18476.8 13190.0 13285.8 13341.5 13625.9 14133.9 12723.7 13123.7 13244.3 13958.3 13988.1 16:26:37 INFO - PID 25078 | -------- Summary: end -------- 16:26:37 INFO - PID 25078 | 16:26:38 INFO - TEST-INFO | 25078: exit 0 16:26:38 INFO - TEST-OK | dromaeo_css | took 1111150ms 16:26:38 INFO - TEST-START | kraken 16:26:38 INFO - Initialising browser for kraken test... 16:26:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47252/getInfo.html -profile /tmp/tmpdGPIFX/profile 16:26:38 INFO - TEST-INFO | started process 25446 (/builds/slave/test/build/application/firefox/firefox http://localhost:47252/getInfo.html) 16:26:44 INFO - TEST-INFO | 25446: exit 0 16:26:44 INFO - Browser initialized. 16:26:44 INFO - Running cycle 1/1 for kraken test... 16:26:44 INFO - TEST-INFO | started process 25615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdGPIFX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:45 INFO - PID 25615 | 16:26:45 INFO - PID 25615 | (/builds/slave/test/build/application/firefox/firefox:25664): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:26:45 INFO - PID 25615 | 16:26:55 INFO - PID 25615 | RSS: Main: 163848192 16:26:55 INFO - PID 25615 | 16:26:58 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47252/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:59 INFO - PID 25615 | RSS: Main: 169156608 16:26:59 INFO - PID 25615 | 16:27:01 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47252/tests/kraken/driver.html?testName=audio-dft) 16:27:02 INFO - PID 25615 | RSS: Main: 169648128 16:27:02 INFO - PID 25615 | 16:27:05 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47252/tests/kraken/driver.html?testName=audio-fft) 16:27:05 INFO - PID 25615 | RSS: Main: 164790272 16:27:05 INFO - PID 25615 | 16:27:08 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47252/tests/kraken/driver.html?testName=audio-oscillator) 16:27:08 INFO - PID 25615 | RSS: Main: 165081088 16:27:08 INFO - PID 25615 | 16:27:10 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:11 INFO - PID 25615 | RSS: Main: 165740544 16:27:11 INFO - PID 25615 | 16:27:14 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47252/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:15 INFO - PID 25615 | RSS: Main: 168284160 16:27:15 INFO - PID 25615 | 16:27:18 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47252/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:19 INFO - PID 25615 | RSS: Main: 168816640 16:27:19 INFO - PID 25615 | 16:27:22 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47252/tests/kraken/driver.html?testName=json-parse-financial) 16:27:22 INFO - PID 25615 | RSS: Main: 169328640 16:27:22 INFO - PID 25615 | 16:27:24 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:24 INFO - PID 25615 | RSS: Main: 168865792 16:27:24 INFO - PID 25615 | 16:27:26 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:27 INFO - PID 25615 | RSS: Main: 169390080 16:27:27 INFO - PID 25615 | 16:27:29 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:30 INFO - PID 25615 | RSS: Main: 169238528 16:27:30 INFO - PID 25615 | 16:27:32 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:33 INFO - PID 25615 | RSS: Main: 170000384 16:27:33 INFO - PID 25615 | 16:27:36 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:37 INFO - PID 25615 | RSS: Main: 169652224 16:27:37 INFO - PID 25615 | 16:27:38 INFO - PID 25615 | Cycle 1(1): loaded http://localhost:47252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47252/tests/kraken/driver.html?testName=ai-astar) 16:27:39 INFO - PID 25615 | RSS: Main: 171704320 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | __start_tp_report 16:27:39 INFO - PID 25615 | _x_x_mozilla_page_load 16:27:39 INFO - PID 25615 | _x_x_mozilla_page_load_details 16:27:39 INFO - PID 25615 | |i|pagename|runs| 16:27:39 INFO - PID 25615 | |0;ai-astar;99;107;101;107;108;115;109;98;105;108 16:27:39 INFO - PID 25615 | |1;audio-beat-detection;142;118;155;174;122;152;144;118;173;131 16:27:39 INFO - PID 25615 | |2;audio-dft;164;161;161;164;162;163;161;166;167;168 16:27:39 INFO - PID 25615 | |3;audio-fft;75;75;75;182;75;76;74;75;150;76 16:27:39 INFO - PID 25615 | |4;audio-oscillator;79;79;137;78;78;78;129;79;78;126 16:27:39 INFO - PID 25615 | |5;imaging-gaussian-blur;114;114;113;113;114;113;113;114;114;114 16:27:39 INFO - PID 25615 | |6;imaging-darkroom;153;151;159;155;150;150;149;150;151;152 16:27:39 INFO - PID 25615 | |7;imaging-desaturate;94;94;94;93;93;93;94;94;94;94 16:27:39 INFO - PID 25615 | |8;json-parse-financial;53;54;54;55;54;54;54;54;52;53 16:27:39 INFO - PID 25615 | |9;json-stringify-tinderbox;54;54;54;54;56;54;54;55;54;55 16:27:39 INFO - PID 25615 | |10;stanford-crypto-aes;77;75;76;76;78;77;75;75;76;75 16:27:39 INFO - PID 25615 | |11;stanford-crypto-ccm;124;125;120;132;120;125;126;122;121;173 16:27:39 INFO - PID 25615 | |12;stanford-crypto-pbkdf2;174;177;183;176;173;173;175;188;171;170 16:27:39 INFO - PID 25615 | |13;stanford-crypto-sha256-iterative;68;66;68;68;67;67;65;68;70;64 16:27:39 INFO - PID 25615 | __end_tp_report 16:27:39 INFO - PID 25615 | __start_cc_report 16:27:39 INFO - PID 25615 | _x_x_mozilla_cycle_collect,921 16:27:39 INFO - PID 25615 | __end_cc_report 16:27:39 INFO - PID 25615 | __startTimestamp1503012459104__endTimestamp 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | ------- Summary: start ------- 16:27:39 INFO - PID 25615 | Number of tests: 14 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#0] ai-astar Cycles:10 Average:105.70 Median:108.50 stddev:5.14 (4.7%) stddev-sans-first:4.85 16:27:39 INFO - PID 25615 | Values: 99.0 107.0 101.0 107.0 108.0 115.0 109.0 98.0 105.0 108.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:148.00 stddev:20.88 (14.1%) stddev-sans-first:22.14 16:27:39 INFO - PID 25615 | Values: 142.0 118.0 155.0 174.0 122.0 152.0 144.0 118.0 173.0 131.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 16:27:39 INFO - PID 25615 | Values: 164.0 161.0 161.0 164.0 162.0 163.0 161.0 166.0 167.0 168.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:39.06 (52.1%) stddev-sans-first:40.86 16:27:39 INFO - PID 25615 | Values: 75.0 75.0 75.0 182.0 75.0 76.0 74.0 75.0 150.0 76.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.00 stddev:25.38 (32.5%) stddev-sans-first:26.32 16:27:39 INFO - PID 25615 | Values: 79.0 79.0 137.0 78.0 78.0 78.0 129.0 79.0 78.0 126.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:27:39 INFO - PID 25615 | Values: 114.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 114.0 114.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.50 stddev:3.02 (2.0%) stddev-sans-first:3.18 16:27:39 INFO - PID 25615 | Values: 153.0 151.0 159.0 155.0 150.0 150.0 149.0 150.0 151.0 152.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:27:39 INFO - PID 25615 | Values: 94.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 94.0 94.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 16:27:39 INFO - PID 25615 | Values: 53.0 54.0 54.0 55.0 54.0 54.0 54.0 54.0 52.0 53.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 16:27:39 INFO - PID 25615 | Values: 54.0 54.0 54.0 54.0 56.0 54.0 54.0 55.0 54.0 55.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.05 (1.4%) stddev-sans-first:1.05 16:27:39 INFO - PID 25615 | Values: 77.0 75.0 76.0 76.0 78.0 77.0 75.0 75.0 76.0 75.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:125.00 stddev:15.94 (12.7%) stddev-sans-first:16.81 16:27:39 INFO - PID 25615 | Values: 124.0 125.0 120.0 132.0 120.0 125.0 126.0 122.0 121.0 173.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:175.50 stddev:5.56 (3.2%) stddev-sans-first:5.85 16:27:39 INFO - PID 25615 | Values: 174.0 177.0 183.0 176.0 173.0 173.0 175.0 188.0 171.0 170.0 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.80 16:27:39 INFO - PID 25615 | Values: 68.0 66.0 68.0 68.0 67.0 67.0 65.0 68.0 70.0 64.0 16:27:39 INFO - PID 25615 | -------- Summary: end -------- 16:27:39 INFO - PID 25615 | 16:27:39 INFO - PID 25615 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:27:39 INFO - TEST-INFO | 25615: exit 0 16:27:39 INFO - TEST-OK | kraken | took 61445ms 16:27:39 INFO - SUITE-END | took 1172s 16:27:40 INFO - Completed test suite (00:19:33) 16:27:40 INFO - javascript benchmark 16:27:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8565.700969215193, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.5558421820947, 3185.506246531788, 3198.976327575177, 3203.567518385018, 3214.3410600826833, 6128.142060111577, 6164.982777841657, 6196.411340922611, 6226.221722284715, 6259.342769009257, 6025.246844144482, 6113.32753397126, 6147.415995480434, 6167.907481387782, 6242.500599952004, 5626.127950167731, 5699.173619825123, 5730.4269573042675, 5760.049591817345, 5770.7691692332255, 881.0652075082218, 5593.804216852411, 5607.074832652628, 5613.691246981414, 5714.171445140452, 5655.717214139277, 5689.772409103631, 5703.030484817591, 5711.114777209539, 5733.713314334266, 5613.4386561343945, 5643.6049476536655, 5706.343770466367, 5732.684702341369, 5754.88490230193, 5610.551155907518, 5621.128725047624, 5667.4049224831215, 5686.488216060533, 5691.26013618227, 5983.880322393571, 6011.068284415923, 6097.878042439126, 6108.5418593605655, 6122.693865306762, 6519.771807986698, 6600.735970561172, 6616.073749675049, 6640.0, 6712.5301228913995, 6682.231543372526, 6698.799036028879, 6767.796966090976, 6773.322667733237, 6782.593044417351, 6148.600340977911, 6186.443220110166, 6272.372762723737, 6272.749090036393, 6274.1843560336865, 6722.932770672329, 6774.83062923421, 6859.176898772179, 6863.176418829772, 6913.723451062002, 6512.413882750575, 6531.346865313526, 6559.048937903977, 6589.80230593083, 6599.967000164968, 6691.76578819739, 6734.259231484532, 6755.898661520081, 6765.458763298924, 6769.120014398097, 6646.136002319668, 6658.1011563438315, 6659.4006539411685, 6721.596704197764, 6752.0, 6461.450776683941, 6532.052852336385, 6549.869002619921, 6640.335966403321, 6721.563098398588, 5399.919001214985, 5404.621676482609, 5415.214793854948, 5431.782728690887, 5431.94077154951, 4629.837955671603, 4643.3731446255, 4709.62323014158, 4711.434627844681, 4749.121412538691, 5659.5755318351285, 5670.319561652628, 5699.629524080921, 5760.279965004374, 5774.509166720875, 6580.670966451658, 6593.076969224312, 6677.499187560952, 6693.297203793629, 6693.665316734241, 5665.518430933417, 5678.943210567842, 5720.2849643794525, 5720.570957178228, 5742.511886489695, 5866.2960444746905, 5869.06095024794, 5909.940900590939, 5953.583249172603, 5967.433093856077, 6395.488360931115, 6510.381513756186, 6521.315261897433, 6530.477561795045, 6535.8692826143215, 6602.636854973022, 6669.799906002828, 6694.497912656668, 6707.564008339442, 6727.899081513683, 6242.438180563771, 6342.619442833445, 6421.486281097407, 6503.967480162569, 6507.284198738041, 6512.153420055362, 6552.868942621216, 6559.704813283318, 6579.835504112435, 6580.638064906476, 6643.40209381158, 6685.298043705341, 6736.831579210559, 6761.560498567577, 6791.2190098139345, 6392.616443013434, 6438.8390290243115, 6509.674516274262, 6524.9021264682015, 6532.771353002622, 6423.839404014937, 6442.871142577216, 6491.350864913471, 6508.284088750328, 6533.248676402274, 6289.9056514153235, 6328.873422531616, 6383.361663833765, 6390.616563006049, 6404.455621272244, 6449.516286278454, 6476.6114033158165, 6512.283648798723, 6515.185601799775, 6531.477481801539, 6315.084312774714, 6319.210098737658, 6320.5575609706875, 6327.303996560283, 6339.4928405726505], "value": 6036.945189259608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.194460401109, 878.885744853169, 906.8413027720147, 1159.1480262007428, 1186.199315462063, 30963.535546966814, 42438.57561424385, 43105.137897242035, 43201.78399108, 43291.0, 43084.78457607715, 43327.0, 43421.0, 43450.782746086305, 43507.78246108773, 7688.461807673465, 7730.304272615464, 7940.36477081835, 7942.3646108311195, 7946.801329966739, 7714.575698336589, 7809.3752499799875, 7849.607519623996, 7850.214978502161, 7859.331956783652, 7869.291763741262, 7932.524048557077, 7934.285914267714, 7938.6427610757655, 7941.880871786899, 7846.764597062097, 7877.0547534295965, 7880.2513761192595, 7880.605969701549, 7885.487443316195, 7757.069151701832, 7804.921950780476, 7806.765797026098, 7815.804604884866, 7824.0, 39142.21715565701, 39435.21129577392, 39617.80191099026, 39623.8018809907, 39749.80125099385, 3565.7682250653884, 3600.5859326177565, 3601.459781032866, 3610.1155216971747, 3611.747177697562, 31565.0, 31583.684163158305, 31709.0, 31709.365812683616, 31733.0, 5118.334616499868, 5140.588752899759, 5144.305518754958, 5164.509371609729, 5207.60942929278, 183232.0, 184407.0, 185668.99999999866, 185986.0, 186355.0, 50393.24410133851, 50451.0, 50593.22923697726, 50657.24014139791, 50700.23949640759, 52413.0, 52449.73775131176, 52505.2124218137, 52534.47465525296, 52575.21137182946, 14993.32530036151, 15229.086254824746, 15751.054936703835, 15790.842091578937, 15902.363905443653, 12698.238105713686, 12935.741285174245, 12940.935295323463, 12942.029347798953, 12944.09391342597, 15101.39594416211, 15117.470888519068, 15143.848561514464, 15226.162561059247, 15234.619134521725, 5567.3040869891265, 5737.8565535861935, 5812.418758124154, 5854.092615644582, 5881.117832325185, 1019.7603563162651, 1026.7946410717886, 1027.1628622672497, 1027.6660085472251, 1048.3447845096814, 23432.76567234306, 23837.0, 23924.04303827862, 23945.0, 30034.0, 1095.9835602465969, 1101.218135124055, 1104.7072525780675, 1107.8449017137607, 1125.352922069813, 12759.744805103846, 16385.0, 16486.917565412336, 16507.174641267888, 17050.806443548834, 239773.0, 242845.0, 242912.0, 243616.0, 244072.0, 60589.0, 60748.08877866835, 60933.0, 61260.38739612636, 61562.38437615566, 1438.4821464272854, 1476.7489526780473, 1494.5441640299596, 1514.8788096952217, 1524.5273965070865, 28083.578746318413, 28839.5674064885, 28979.0, 29056.7094329054, 29310.706892930797, 53553.0, 54185.18722219091, 54306.45693543014, 54431.45568544422, 54628.180577292165, 221581.0, 223098.0, 223374.0, 224409.0, 225152.0, 37016.62983370132, 38192.70843749384, 39382.409263861635, 39459.0, 39550.60449395469, 47012.7649361751, 48771.75614122049, 49110.0, 49168.50831491639, 49289.75355123202, 35735.0, 35924.82037589795, 35940.46089308715, 36209.0, 36304.0, 35105.29789404249, 35302.0, 35347.82326088353, 35491.64508354987, 35617.64382356143, 39366.409503858034, 39427.60572394239, 39624.603753963245, 39792.60207397889, 39851.2029759409, 33781.0, 34425.48361774525, 34429.655703442644, 34617.0, 34747.65252347444, 23887.880560597085, 25119.0, 25143.748562514873, 25560.360990975376, 25646.61530077013], "value": 18332.15154104794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.5518495573451, 580.4891695308128, 583.2155750515558, 588.997055014725, 599.8890205312016, 22457.438564035907, 22492.88753556232, 23388.532229355424, 23599.999999999978, 23619.5276094478, 24217.51564968704, 25878.870605646993, 25902.611460828102, 25910.35224119398, 25992.22023339303, 6380.457661098812, 6521.891278482669, 6525.314841941599, 6526.738930442777, 6527.184101987252, 6092.055731361646, 6395.552311338208, 6401.199850018747, 6401.391867772554, 6443.25902521209, 6369.394907483782, 6369.490440764751, 6375.2987171411105, 6376.139221205124, 6376.362363763633, 6361.61830290184, 6370.968145159244, 6371.8407039823915, 6373.490120790326, 6379.649119298437, 5888.705564721747, 5929.0, 5934.0, 5935.584509084366, 5941.049432090888, 28278.575821362698, 28923.0, 29438.264043399085, 29615.40769184626, 29738.70261297381, 1881.6424879272895, 1916.8849869007904, 1919.443361425185, 1919.6640587897061, 1922.2311075569744, 18830.246790128378, 19390.70913936292, 19481.707774383394, 19507.707384389247, 19515.0, 2346.341727913084, 2425.248173066355, 2474.8267621266336, 2484.91302804401, 2496.450780828215, 129210.3539482306, 130960.41638542606, 130983.0, 131027.0, 131350.0, 13748.518801841887, 14555.272236388138, 14928.328225229674, 15052.172130532706, 15092.698146037017, 23163.76836231616, 23516.176933807234, 23855.0, 23875.0, 23877.641835372484, 10182.847257291147, 10259.384436933808, 10286.537105830255, 10441.373517588969, 10629.309094908805, 9611.183049440737, 9637.22902167839, 9737.026297370348, 9753.951230243803, 9842.60629574809, 9070.319726020574, 9196.816063678689, 9335.346525743133, 9538.666146684833, 9749.658761943298, 2600.8829602667925, 2614.5293847107705, 2724.3053021479395, 2746.134967485276, 2812.3812761192503, 950.4772375193616, 955.4315182466421, 969.898160693117, 972.5088830140734, 981.3817295104038, 19041.333553325567, 19228.615427691646, 19236.52246754026, 19708.901455492633, 19734.70397944032, 1024.2983556263982, 1029.6036026129843, 1034.7051090439188, 1044.1855352824657, 1044.681372181492, 10640.840387394195, 13381.53164639233, 13911.234882081582, 14185.503507377192, 14257.85742142586, 507851.0, 516828.0, 517834.0, 521063.0, 561939.0, 113692.0, 116523.41738291254, 120398.0, 122245.38877305735, 122612.0, 1261.9305938173488, 1274.5730180389487, 1302.5896842494583, 1304.8499422566335, 1308.2346827106248, 20590.382288531368, 20702.171913123308, 20879.791202087785, 21045.789542104383, 21163.047662855515, 47334.28998565093, 48325.0, 51928.0, 55130.72434637801, 59003.81992360215, 66755.33244667492, 67582.0, 67611.32388676248, 70721.29278707353, 76253.0, 14645.121292722471, 14964.326605302569, 14986.550403487912, 15175.772363414779, 15178.620534486285, 23660.763392366545, 23820.404489887893, 23963.16128935479, 23974.52050959006, 24013.159539416036, 16634.500964970586, 16782.16089195511, 16910.239039243017, 16929.32282708678, 18325.816741832943, 15544.766828497355, 16008.839911600735, 16794.244259008618, 16922.15389230558, 17213.74179387285, 15806.051636901822, 16789.32842686279, 17177.227024784166, 18850.3402380916, 19281.80718192856, 14782.48261310849, 14796.260186990823, 14891.776623350443, 14917.104973701178, 14931.92534037323, 17999.820001799813, 18219.362322318655, 18360.540986475444, 18889.527761806065, 18993.0], "value": 12046.97376951908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.606817954614, 1330.514362257776, 1351.5134551561437, 1354.1265883505134, 1363.8227030486034, 13551.119177253471, 14162.787558186636, 14741.115533068023, 14769.0400123992, 14787.33456994435, 14753.557393278192, 14923.701525969474, 14927.626809329773, 14929.0, 14939.103653780781, 2640.4455064436493, 2697.581874809398, 2699.91900242993, 2714.6335244742004, 2718.0486829609677, 2652.814302998791, 2757.9448411031767, 2771.1547977866744, 2772.7365900239547, 2774.708655591164, 2688.475747229291, 2711.430599574092, 2719.456108778252, 2747.217043142705, 2747.3269049083, 2608.0610980047168, 2630.092618046771, 2644.9735502645017, 2654.3894904172053, 2675.638788763531, 2547.6305935639416, 2570.588705807062, 2582.4705935283223, 2582.5093232285994, 2583.7287084856193, 14043.719125617532, 14455.421783128662, 14472.059316144523, 14472.276386180649, 14481.131132132106, 7548.698052077911, 7801.453898227126, 7805.765827025199, 7809.258120478546, 7839.529628222325, 4971.776270067856, 5132.0, 5196.324477817897, 5214.165733482662, 5219.373675159005, 1829.6249268899844, 1846.4276074416973, 1886.8962207078605, 1923.422973108076, 1935.3613307608455, 22175.223867164732, 22219.333419997427, 22572.0, 22591.20930767432, 22611.660825087638, 6652.368025037614, 6715.1941766988275, 6736.124303840469, 6809.455243580502, 6834.589924604539, 16627.83372166287, 16629.750553741702, 16633.916830415772, 16666.0, 16668.0, 7555.773326800205, 7851.293383595504, 8099.83800324002, 8122.796930076795, 8123.147069557729, 7072.08062951813, 7258.782236532912, 7263.346298833025, 7267.30960558746, 7277.526960747535, 5100.923486147711, 5251.10731175701, 5276.577873770089, 5314.22943673173, 5322.042032434199, 1523.3373482534912, 1526.2292542266084, 1528.6866192430525, 1538.3615799443105, 1568.4510421352663, 888.3692578269372, 911.6763548940031, 922.280621115531, 927.9304052196112, 930.8882934047822, 7316.707331706779, 7407.2222416646555, 7460.253974602605, 7496.962515187498, 7533.585652789149, 661.2263651527724, 690.4165979747106, 699.464909344352, 700.9754658587027, 706.2795948132979, 4614.423197100363, 4823.324734537167, 5017.698938063728, 5120.001599688099, 5132.127538318495, 19515.414537563895, 20005.899970500053, 20120.89939550293, 20387.490312742004, 20387.59224815525, 19236.80763192378, 19516.609667806566, 20028.69956950647, 20072.09675564603, 20121.496962576053, 10821.188410869216, 11042.723931901606, 11135.220534562664, 11145.554177832795, 11275.548978040786, 8100.79748006281, 8110.310623596824, 8113.797155071171, 8162.0, 8180.631871565674, 17433.215505302545, 17757.46727598174, 17836.19737111859, 17867.553311167325, 18067.0, 17495.38766143179, 18121.818781812013, 18149.092545372943, 18220.726689099938, 18296.268149274412, 10317.638882639072, 11094.278871873303, 11288.20982531215, 11293.37886416255, 11325.546978120783, 13287.335633218494, 13329.866701332863, 13397.12918660284, 13435.193888366339, 13446.0, 11153.944230278797, 11157.497912594115, 11179.552817887194, 11273.887261127611, 11476.942615286871, 10429.217808664533, 10624.415657138932, 10638.52126654287, 10667.839982400115, 10954.39750813681, 9202.815943681222, 9447.763805904908, 9471.337006409485, 9473.194778443909, 9511.334206605748, 7120.252373500708, 7181.82045448847, 7199.460040497089, 7222.819429514094, 7243.45674074436, 6582.0785090086465, 6627.1716035495565, 6659.101021362054, 6705.0612914193025, 6752.459803215829], "value": 6404.219000473835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.0667990837272, 503.2677454303988, 526.1371350984385, 532.0125658191853, 536.3938749213388, 6181.28915174755, 6188.690565471731, 6217.253929528451, 6236.844078898024, 6252.906206406908, 5947.672877991719, 6042.335343112254, 6047.850908327426, 6068.8482787930325, 6071.848203794896, 4879.487653796354, 4904.337914381566, 4909.828156014541, 4926.3842019747535, 4933.901321973558, 4935.938773163769, 4946.15915294399, 4949.851504454872, 4974.955259395531, 5003.974980125113, 4736.502667219944, 4835.661503694742, 4841.612670986313, 4902.333206709718, 4946.87632809179, 4855.63582731293, 4862.999999999983, 4905.950940490585, 4961.255811628249, 4962.9007419851405, 4391.5827996340295, 4400.09797991411, 4415.668824838118, 4422.579854913778, 4428.645708343357, 5905.911411328791, 5930.911036334415, 5932.84309559636, 5934.258217722785, 5980.940190598082, 5602.299712535933, 5609.0, 5609.439056094398, 5648.858778530528, 5724.227229324029, 6371.87256254877, 6406.2953075161695, 6422.357764223587, 6477.870442591122, 6507.154069970874, 4770.522947705236, 4814.855554333376, 4832.1543729847135, 4838.564529192355, 4856.465788763233, 6709.36261055199, 6801.727930882808, 6821.69302381394, 6828.46359569093, 6889.586624802528, 4917.803287868517, 4924.651237158695, 4991.975040124777, 4998.400191976986, 5082.0, 4965.3048573199785, 4978.626603004716, 5021.4978502150225, 5059.418166910852, 5099.6685215460875, 5656.151577263443, 5667.688277144796, 5694.686792226385, 5702.0, 5713.428657134336, 6530.542861999615, 6550.115734375799, 6563.7702680405955, 6577.0, 6639.668016599151, 1654.7754661550366, 1705.351966252816, 1750.8949463032004, 1759.876808623384, 1764.1796564597266, 1221.6396163131897, 1230.9076819238594, 1231.9630411087683, 1239.6054438756398, 1253.166644181609, 5753.33836608787, 5757.395473475225, 5771.394003629643, 5801.94198058014, 5813.331466881363, 6583.539152259392, 6654.966725166343, 6672.0, 6722.033999939961, 6739.865202695919, 5781.797637082682, 5820.82537523875, 5840.3575606683235, 5867.882642347215, 5872.942870283305, 3589.9282014360087, 3610.765300255475, 3618.9638103619154, 3629.4011488104693, 3633.5276414066, 6637.668116594151, 6639.136912201383, 6666.566673166229, 6687.799366019027, 6697.732090716317, 6948.44412447003, 6964.895526567106, 6970.860582788418, 6972.930270697329, 7015.123109611299, 6575.506836987341, 6596.0105984102765, 6643.800685979429, 6671.833204169838, 6706.128203333536, 6763.154605674291, 6789.830254243683, 6795.52431329822, 6814.0, 6819.476793586405, 6648.268690444144, 6693.966530167318, 6736.764213252709, 6751.864962700817, 6759.729610815512, 6603.273639899511, 6621.67566486695, 6627.4698024158915, 6636.0, 6644.0, 4986.900261994812, 5004.124278251365, 5005.299258103942, 5014.197728363444, 5035.723035233097, 6684.498662600227, 6755.088063111417, 6790.388865002174, 6812.965935170292, 6877.558466744234, 6473.643949582818, 6522.641254731036, 6568.573042752206, 6591.703373348115, 6604.63674497888, 6407.583507072025, 6477.611343319416, 6486.805395838132, 6520.250171230369, 6531.804045878631, 6201.565890387629, 6265.457543281084, 6303.023031430135, 6346.333634968447, 6460.353964603502, 6474.935250647433, 6489.643069631215, 6524.804255872332, 6534.4772418205475, 6609.173853268341, 6288.874222515433, 6311.779087731908, 6314.0, 6327.715252813727, 6327.778527751507], "value": 5045.469920891382, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [919.6919032124238, 923.1645360948341, 934.3132797393919, 946.1295608040602, 952.1906379577358, 19017.334393296238, 20071.899640501815, 20078.89960550197, 20166.294179703713, 21603.243886463977, 21346.25288114916, 21850.89074554629, 21854.781452185474, 21883.343499694995, 21932.342029739095, 1022.8925962773932, 1046.0219694585548, 1051.5373235776235, 1052.947352632369, 1053.2995557953952, 999.000999000999, 1071.1002757683543, 1073.1843798712996, 1073.8442925775757, 1074.4412905289246, 1088.0370871778493, 1094.9945250273738, 1101.7355834599678, 1101.7906597746442, 1104.0229396983686, 1087.314991555319, 1087.8313861351503, 1090.3893819461086, 1091.1489038549905, 1091.5688303120303, 801.0067516279829, 803.4857691077715, 804.1797366686006, 804.2962407893093, 804.4610111225493, 19968.90015549913, 20002.39992800218, 20207.090680919395, 20238.39284821458, 20387.082581283878, 21138.048787804586, 21767.129314827387, 22059.889700551554, 22163.778362216333, 22248.221312254154, 16273.430429934895, 16979.15104244783, 17147.48557543263, 17179.91410042954, 17213.56966075858, 3719.6652301293016, 3732.701383889282, 3742.0, 3745.3632882410056, 3748.9812550937345, 122127.0, 122225.0, 122735.0, 125870.37064814709, 128341.35829320888, 16304.51086467408, 16843.41048063312, 16868.831311686725, 16923.661526769643, 17143.399981000606, 30902.381952360825, 31587.0, 31881.362372752414, 32006.839965800023, 32024.199395015312, 7780.8832867507035, 8156.0, 8744.8688269676, 8995.505247211335, 9113.95443022794, 4242.851500197478, 4314.072474418015, 4321.546237645065, 4324.13517296542, 4325.653947684178, 4916.680415773035, 5065.214891691794, 5073.188289873677, 5089.236614507853, 5091.847244582668, 1013.5287091502339, 1030.05749738988, 1039.1998161415668, 1040.5213601743133, 1044.7179261599326, 667.4893706314673, 681.9283975182534, 682.576802382526, 689.5896941319907, 692.5256199503357, 10784.892151078546, 10931.836022459669, 11019.72450688723, 11478.827817582744, 11504.36725980079, 652.1717418877998, 664.8304682306077, 669.1769123977535, 672.1832972937904, 673.7406098652054, 5310.734463276821, 5371.731413429391, 5423.864403389947, 5442.673439593558, 5480.068388373986, 108286.45856770824, 108563.0, 108570.0, 109730.45134774435, 111663.0, 97577.02422975822, 100392.0, 101865.0, 103409.0, 104019.0, 83748.0, 86388.13611863926, 87300.12699873047, 88375.55812221026, 90112.09887901168, 9960.701178964642, 10075.596976120873, 10178.338408003456, 10278.486075696335, 11849.466773995364, 39145.825625231286, 40415.0, 40604.59395406126, 41084.58915410808, 41574.792126039174, 67736.0, 68981.65509172421, 70534.29465705277, 71228.0, 75001.87497187656, 14542.709145817236, 18378.448646540626, 18903.90548047251, 18928.621427571095, 19426.8057319425, 19155.90422047881, 19261.711074334176, 19502.0, 20102.0, 20843.583128337046, 16492.0, 17033.659326813642, 17148.657026859142, 17203.13984300755, 17306.48080557585, 17858.91070544639, 17965.0, 18017.279308828023, 18387.17257723379, 18517.722234166227, 16548.503544893672, 16833.91583042077, 17605.64788704193, 18406.631867362845, 18476.815231847508, 13190.0, 13285.83528473933, 13341.466341346237, 13625.931870340584, 14133.858661413255, 12723.681907952005, 13123.737525249633, 13244.337783110614, 13958.302084895919, 13988.090774099652], "value": 9167.951286834865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 107.0, 108.0, 115.0, 109.0, 98.0, 105.0, 108.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 155.0, 174.0, 122.0, 152.0, 144.0, 118.0, 173.0, 131.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 164.0, 162.0, 163.0, 161.0, 166.0, 167.0, 168.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 182.0, 75.0, 76.0, 74.0, 75.0, 150.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 137.0, 78.0, 78.0, 78.0, 129.0, 79.0, 78.0, 126.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 159.0, 155.0, 150.0, 150.0, 149.0, 150.0, 151.0, 152.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 52.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 76.0, 78.0, 77.0, 75.0, 75.0, 76.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 120.0, 132.0, 120.0, 125.0, 126.0, 122.0, 121.0, 173.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 183.0, 176.0, 173.0, 173.0, 175.0, 188.0, 171.0, 170.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 68.0, 67.0, 67.0, 65.0, 68.0, 70.0, 64.0], "value": 67.1, "unit": "score"}]}]} 16:27:40 INFO - Return code: 0 16:27:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:27:40 INFO - # TBPL SUCCESS # 16:27:40 INFO - Running post-action listener: _package_coverage_data 16:27:40 INFO - Running post-action listener: _resource_record_post_action 16:27:40 INFO - [mozharness: 2017-08-17 23:27:40.417627Z] Finished run-tests step (success) 16:27:40 INFO - Running post-run listener: _resource_record_post_run 16:27:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434294784; Read time: 304; Write time: 244440 16:27:40 INFO - TinderboxPrint: CPU usage
13.1% 16:27:40 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 304 16:27:40 INFO - TinderboxPrint: I/O write bytes / time
434,294,784 / 244,440 16:27:40 INFO - TinderboxPrint: CPU idle
8,252.7 (86.9%) 16:27:40 INFO - TinderboxPrint: CPU user
1,197.1 (12.6%) 16:27:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:27:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107794432; Read time: 0; Write time: 91356 16:27:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:27:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326500352; Read time: 292; Write time: 153084 16:27:41 INFO - Running post-run listener: _upload_blobber_files 16:27:41 INFO - Blob upload gear active. 16:27:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:41 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 16:27:41 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:27:41 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:27:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:42 INFO - (blobuploader) - INFO - Done attempting. 16:27:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:27:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:49 INFO - (blobuploader) - INFO - Done attempting. 16:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:27:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:50 INFO - (blobuploader) - INFO - Done attempting. 16:27:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:27:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:51 INFO - (blobuploader) - INFO - Done attempting. 16:27:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:51 INFO - Return code: 0 16:27:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e789d9395cd544068599d07577065dc7fe4853eb3799e758060ea91ea2ad55019186e4298f9344821a90c5da44ce0dacf39b1eae26eef9fc970d87d1a44637d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ddef764f03a90bd9abd335c8509b217792bab20a8d883b1df1f30631c055858f36c245d37028c85f64c18928eb99f11330463fe918cc1138bb7813c927791a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcd46e2c9b92235e70a7dd0893e80866d6538b8962882965a4f7cb741a8fa27b86b61ece5d43c7e2768300f7da9fb2071d4920acd8f47dc59e7dffdd31b979c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0bbca31470416e58fd8c0c38b43c5ecf9c0801e4f0abd68035f0a7a493ac5789c8a7b767cef1179058ca28a9e53a5a58772bef0de6fd63bc1df8409bb5ba72"} 16:27:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:51 INFO - Contents: 16:27:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e789d9395cd544068599d07577065dc7fe4853eb3799e758060ea91ea2ad55019186e4298f9344821a90c5da44ce0dacf39b1eae26eef9fc970d87d1a44637d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ddef764f03a90bd9abd335c8509b217792bab20a8d883b1df1f30631c055858f36c245d37028c85f64c18928eb99f11330463fe918cc1138bb7813c927791a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcd46e2c9b92235e70a7dd0893e80866d6538b8962882965a4f7cb741a8fa27b86b61ece5d43c7e2768300f7da9fb2071d4920acd8f47dc59e7dffdd31b979c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0bbca31470416e58fd8c0c38b43c5ecf9c0801e4f0abd68035f0a7a493ac5789c8a7b767cef1179058ca28a9e53a5a58772bef0de6fd63bc1df8409bb5ba72"} 16:27:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:51 INFO - Copying logs to upload dir... 16:27:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.102315 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-17 16:27:51.099692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:27:51.107376) ========= 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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e789d9395cd544068599d07577065dc7fe4853eb3799e758060ea91ea2ad55019186e4298f9344821a90c5da44ce0dacf39b1eae26eef9fc970d87d1a44637d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ddef764f03a90bd9abd335c8509b217792bab20a8d883b1df1f30631c055858f36c245d37028c85f64c18928eb99f11330463fe918cc1138bb7813c927791a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcd46e2c9b92235e70a7dd0893e80866d6538b8962882965a4f7cb741a8fa27b86b61ece5d43c7e2768300f7da9fb2071d4920acd8f47dc59e7dffdd31b979c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0bbca31470416e58fd8c0c38b43c5ecf9c0801e4f0abd68035f0a7a493ac5789c8a7b767cef1179058ca28a9e53a5a58772bef0de6fd63bc1df8409bb5ba72"} build_url:https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e789d9395cd544068599d07577065dc7fe4853eb3799e758060ea91ea2ad55019186e4298f9344821a90c5da44ce0dacf39b1eae26eef9fc970d87d1a44637d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ddef764f03a90bd9abd335c8509b217792bab20a8d883b1df1f30631c055858f36c245d37028c85f64c18928eb99f11330463fe918cc1138bb7813c927791a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcd46e2c9b92235e70a7dd0893e80866d6538b8962882965a4f7cb741a8fa27b86b61ece5d43c7e2768300f7da9fb2071d4920acd8f47dc59e7dffdd31b979c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0bbca31470416e58fd8c0c38b43c5ecf9c0801e4f0abd68035f0a7a493ac5789c8a7b767cef1179058ca28a9e53a5a58772bef0de6fd63bc1df8409bb5ba72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:27:51.136480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:27:51.136763) ========= 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=ed14279e38b05397cf4aa391000001a4-1503011215.793497-1461293419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:27:51.216870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:27:51.220197) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:27:51.220490) ========= ========= Total master_lag: 0.50 =========