builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1499335620.28 results: success (0) revision: 018b3829d0a7f6944a5ae1489f3a64c9e2893909 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.282682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.283128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.283410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.322193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.322451) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-06 03:07:00-- 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% 415K=0.03s 2017-07-06 03:07:00 (415 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151599 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.501789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.502137) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014867 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:00.580586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-06 03:07:00.586908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 018b3829d0a7f6944a5ae1489f3a64c9e2893909 --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 018b3829d0a7f6944a5ae1489f3a64c9e2893909 --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=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-06 03:07:00,835 truncating revision to first 12 chars 2017-07-06 03:07:00,835 Setting DEBUG logging. 2017-07-06 03:07:00,836 attempt 1/10 2017-07-06 03:07:00,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/018b3829d0a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-06 03:07:01,538 unpacking tar archive at: mozilla-central-018b3829d0a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000732 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-06 03:07:01.620143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:01.620471) ========= script_repo_revision: 018b3829d0a7f6944a5ae1489f3a64c9e2893909 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:01.620921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:01.621193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-06 03:07:01.630013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-06 03:07:01.630423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:01 INFO - MultiFileLogger online at 20170706 03:07:01 in /builds/slave/test 03:07:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:07:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:01 INFO - {'append_to_log': False, 03:07:01 INFO - 'base_work_dir': '/builds/slave/test', 03:07:01 INFO - 'blob_upload_branch': 'Firefox', 03:07:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:01 INFO - 'branch': 'Firefox', 03:07:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:01 INFO - 'code_coverage': False, 03:07:01 INFO - 'config_files': ('talos/linux_config.py',), 03:07:01 INFO - 'default_actions': ('clobber', 03:07:01 INFO - 'read-buildbot-config', 03:07:01 INFO - 'download-and-extract', 03:07:01 INFO - 'populate-webroot', 03:07:01 INFO - 'create-virtualenv', 03:07:01 INFO - 'install', 03:07:01 INFO - 'setup-mitmproxy', 03:07:01 INFO - 'run-tests'), 03:07:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:01 INFO - 'disable_ccov_upload': False, 03:07:01 INFO - 'download_minidump_stackwalk': True, 03:07:01 INFO - 'download_symbols': 'ondemand', 03:07:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:01 INFO - 'gecko_profile': False, 03:07:01 INFO - 'gecko_profile_interval': 0, 03:07:01 INFO - 'installer_path': 'installer.exe', 03:07:01 INFO - 'log_level': 'info', 03:07:01 INFO - 'log_name': 'talos', 03:07:01 INFO - 'log_to_console': True, 03:07:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:07:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:07:01 INFO - 'opt_config_files': (), 03:07:01 INFO - 'pip_index': False, 03:07:01 INFO - 'suite': 'dromaeojs-e10s', 03:07:01 INFO - 'system_bits': '32', 03:07:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:01 INFO - 'title': 'talos-linux64-ix-033', 03:07:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:01 INFO - 'use_talos_json': True, 03:07:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:01 INFO - 'work_dir': 'build'} 03:07:01 INFO - [mozharness: 2017-07-06 10:07:01.966184Z] Running clobber step. 03:07:01 INFO - Running pre-action listener: _resource_record_pre_action 03:07:01 INFO - Running main action method: clobber 03:07:01 INFO - rmtree: /builds/slave/test/build 03:07:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:02 INFO - Running post-action listener: _resource_record_post_action 03:07:02 INFO - [mozharness: 2017-07-06 10:07:02.985752Z] Finished clobber step (success) 03:07:02 INFO - [mozharness: 2017-07-06 10:07:02.985853Z] Running read-buildbot-config step. 03:07:02 INFO - Running pre-action listener: _resource_record_pre_action 03:07:02 INFO - Running main action method: read_buildbot_config 03:07:02 INFO - Using buildbot properties: 03:07:02 INFO - { 03:07:02 INFO - "project": "", 03:07:02 INFO - "product": "firefox", 03:07:02 INFO - "who": "cbook@mozilla.com", 03:07:02 INFO - "installer_path": "public/build/target.tar.bz2", 03:07:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:07:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:07:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:07:02 INFO - "stage_platform": "linux64-stylosequential", 03:07:02 INFO - "basedir": "/builds/slave/test", 03:07:02 INFO - "buildnumber": 91, 03:07:02 INFO - "platform": "ubuntu64_hw_styloseq", 03:07:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:07:02 INFO - "slavebuilddir": "test", 03:07:02 INFO - "taskId": "FTQ1WHS4QkS9-JqsfyCxow", 03:07:02 INFO - "branch": "mozilla-central", 03:07:02 INFO - "script_repo_revision": "production", 03:07:02 INFO - "revision": "018b3829d0a7f6944a5ae1489f3a64c9e2893909", 03:07:02 INFO - "slavename": "talos-linux64-ix-033", 03:07:02 INFO - "repo_path": "mozilla-central" 03:07:02 INFO - } 03:07:02 INFO - Finding installer, test and symbols from parent task. 03:07:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTQ1WHS4QkS9-JqsfyCxow'}, attempt #1 03:07:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTQ1WHS4QkS9-JqsfyCxow'}, attempt #1 03:07:03 INFO - Task dependencies: BG5iXpesRiGnUepGQ4t3oA 03:07:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA'}, attempt #1 03:07:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 03:07:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/test_packages.json 03:07:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.crashreporter-symbols.zip 03:07:04 INFO - Running post-action listener: _resource_record_post_action 03:07:04 INFO - [mozharness: 2017-07-06 10:07:04.354687Z] Finished read-buildbot-config step (success) 03:07:04 INFO - [mozharness: 2017-07-06 10:07:04.354910Z] Running download-and-extract step. 03:07:04 INFO - Running pre-action listener: _resource_record_pre_action 03:07:04 INFO - Running main action method: download_and_extract 03:07:04 INFO - mkdir: /builds/slave/test/build/tests 03:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:04 INFO - trying https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.test_packages.json 03:07:04 INFO - Downloading https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:07:04 INFO - Downloaded 989 bytes. 03:07:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:07:04 INFO - Using the following test package requirements: 03:07:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:07:04 INFO - u'common': [u'target.common.tests.zip'], 03:07:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:07:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:07:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:07:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:07:04 INFO - u'mozbase': [u'target.common.tests.zip'], 03:07:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:07:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:07:04 INFO - u'web-platform': [u'target.common.tests.zip', 03:07:04 INFO - u'target.web-platform.tests.tar.gz'], 03:07:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:07:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:07:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip 03:07:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:07:04 INFO - Fetch https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip into memory 03:07:06 INFO - Content-Length response header: 67420936 03:07:06 INFO - Bytes received: 67420936 03:07:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:07:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip 03:07:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:07:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.common.tests.zip into memory 03:07:18 INFO - Content-Length response header: 67420936 03:07:18 INFO - Bytes received: 67420936 03:07:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.talos.tests.zip 03:07:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:07:30 INFO - Fetch https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.talos.tests.zip into memory 03:07:31 INFO - Content-Length response header: 14472293 03:07:31 INFO - Bytes received: 14472293 03: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')]} 03:07:31 INFO - trying https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 03:07:31 INFO - Downloading https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:07:32 INFO - Downloaded 61942564 bytes. 03:07:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 03:07:32 INFO - mkdir: /builds/slave/test/properties 03:07:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:32 INFO - Contents: 03:07:32 INFO - build_url:https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - Running post-action listener: set_extra_try_arguments 03:07:32 INFO - [mozharness: 2017-07-06 10:07:32.835809Z] Finished download-and-extract step (success) 03:07:32 INFO - [mozharness: 2017-07-06 10:07:32.835906Z] Running populate-webroot step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: populate_webroot 03:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:32 INFO - '--tppagecycles', 03:07:32 INFO - '7'], 03:07:32 INFO - 'tests': ['tsvgm']}}, 03:07:32 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['damp', 'tps']}, 03:07:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'tests': ['damp', 'tps']}, 03:07:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['dromaeo_dom']}, 03:07:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:07:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:07:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:07:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_many_windows', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_many_windows', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_many_windows', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 03:07:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:07:32 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:32 INFO - 'talos_options': ['--mitmproxy', 03:07:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:32 INFO - '--firstNonBlankPaint'], 03:07:32 INFO - 'tests': ['quantum_pageload_google', 03:07:32 INFO - 'quantum_pageload_youtube', 03:07:32 INFO - 'quantum_pageload_amazon', 03:07:32 INFO - 'quantum_pageload_facebook']}, 03:07:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tsvgx', 03:07:32 INFO - 'tsvgr_opacity', 03:07:32 INFO - 'tart', 03:07:32 INFO - 'tscrollx', 03:07:32 INFO - 'cart', 03:07:32 INFO - 'tsvg_static']}, 03:07:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:32 INFO - 'tsvgr_opacity', 03:07:32 INFO - 'tart', 03:07:32 INFO - 'tscrollx', 03:07:32 INFO - 'cart', 03:07:32 INFO - 'tsvg_static']}, 03:07:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tp5o']}, 03:07:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:07:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s', 03:07:32 INFO - '--xperf_path', 03:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:32 INFO - 'tests': ['tp5n']}, 03:07:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:07:32 INFO - 'talos_options': ['--xperf_path', 03:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:32 INFO - 'tests': ['tp5n']}}, 03:07:32 INFO - 'talos.zip': {'path': '', 03:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - [mozharness: 2017-07-06 10:07:32.850975Z] Finished populate-webroot step (success) 03:07:32 INFO - [mozharness: 2017-07-06 10:07:32.851067Z] Running create-virtualenv step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: create_virtualenv 03:07:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:32 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 03:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:32 INFO - Using real prefix '/usr' 03:07:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:35 INFO - Installing pip.................done. 03:07:35 INFO - Return code: 0 03:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:35 INFO - Reading from file tmpfile_stdout 03:07:35 INFO - Output received: 03:07:35 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) 03:07:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03: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')]} 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03: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', 'pip>=1.5'] in /builds/slave/test/build 03: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 pip>=1.5 03:07:35 INFO - Using env: {'DISPLAY': ':0', 03:07:35 INFO - 'HOME': '/home/cltbld', 03:07:35 INFO - 'LANG': 'en_US.UTF-8', 03:07:35 INFO - 'LANGUAGE': 'en_US:en', 03:07:35 INFO - 'LOGNAME': 'cltbld', 03:07:35 INFO - 'MAIL': '/var/mail/cltbld', 03:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:35 INFO - 'MOZ_NO_REMOTE': '1', 03:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:35 INFO - 'NO_EM_RESTART': '1', 03:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:35 INFO - 'PWD': '/builds/slave/test', 03:07:35 INFO - 'SHELL': '/bin/bash', 03:07:35 INFO - 'SHLVL': '1', 03:07:35 INFO - 'TERM': 'linux', 03:07:35 INFO - 'TMOUT': '86400', 03:07:35 INFO - 'USER': 'cltbld', 03:07:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:35 INFO - '_': '/tools/buildbot/bin/python'} 03:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:35 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 03:07:35 INFO - Cleaning up... 03:07:35 INFO - Return code: 0 03:07:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03: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')]} 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03: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', '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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03: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 psutil>=3.1.1 03:07:35 INFO - Using env: {'DISPLAY': ':0', 03:07:35 INFO - 'HOME': '/home/cltbld', 03:07:35 INFO - 'LANG': 'en_US.UTF-8', 03:07:35 INFO - 'LANGUAGE': 'en_US:en', 03:07:35 INFO - 'LOGNAME': 'cltbld', 03:07:35 INFO - 'MAIL': '/var/mail/cltbld', 03:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:35 INFO - 'MOZ_NO_REMOTE': '1', 03:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:35 INFO - 'NO_EM_RESTART': '1', 03:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:35 INFO - 'PWD': '/builds/slave/test', 03:07:35 INFO - 'SHELL': '/bin/bash', 03:07:35 INFO - 'SHLVL': '1', 03:07:35 INFO - 'TERM': 'linux', 03:07:35 INFO - 'TMOUT': '86400', 03:07:35 INFO - 'USER': 'cltbld', 03:07:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:35 INFO - '_': '/tools/buildbot/bin/python'} 03:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:36 INFO - Downloading/unpacking psutil>=3.1.1 03: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 03: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 03: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 03: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 03:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:37 INFO - Installing collected packages: psutil 03:07:37 INFO - Running setup.py install for psutil 03:07:37 INFO - building 'psutil._psutil_linux' extension 03:07:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:07:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:07:37 INFO - building 'psutil._psutil_posix' extension 03:07:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:07:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:37 INFO - Successfully installed psutil 03:07:37 INFO - Cleaning up... 03:07:37 INFO - Return code: 0 03:07:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03: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')]} 03:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03: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 mozsystemmonitor==0.3 03:07:37 INFO - Using env: {'DISPLAY': ':0', 03:07:37 INFO - 'HOME': '/home/cltbld', 03:07:37 INFO - 'LANG': 'en_US.UTF-8', 03:07:37 INFO - 'LANGUAGE': 'en_US:en', 03:07:37 INFO - 'LOGNAME': 'cltbld', 03:07:37 INFO - 'MAIL': '/var/mail/cltbld', 03:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:37 INFO - 'MOZ_NO_REMOTE': '1', 03:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:37 INFO - 'NO_EM_RESTART': '1', 03:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:37 INFO - 'PWD': '/builds/slave/test', 03:07:37 INFO - 'SHELL': '/bin/bash', 03:07:37 INFO - 'SHLVL': '1', 03:07:37 INFO - 'TERM': 'linux', 03:07:37 INFO - 'TMOUT': '86400', 03:07:37 INFO - 'USER': 'cltbld', 03:07:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:37 INFO - '_': '/tools/buildbot/bin/python'} 03:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03: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 03: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 03: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 03: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 03:07:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:39 INFO - Installing collected packages: mozsystemmonitor 03:07:39 INFO - Running setup.py install for mozsystemmonitor 03:07:39 INFO - Successfully installed mozsystemmonitor 03:07:39 INFO - Cleaning up... 03:07:39 INFO - Return code: 0 03:07:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03: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')]} 03:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:39 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:07:39 INFO - Using env: {'DISPLAY': ':0', 03:07:39 INFO - 'HOME': '/home/cltbld', 03:07:39 INFO - 'LANG': 'en_US.UTF-8', 03:07:39 INFO - 'LANGUAGE': 'en_US:en', 03:07:39 INFO - 'LOGNAME': 'cltbld', 03:07:39 INFO - 'MAIL': '/var/mail/cltbld', 03:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:39 INFO - 'MOZ_NO_REMOTE': '1', 03:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:39 INFO - 'NO_EM_RESTART': '1', 03:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:39 INFO - 'PWD': '/builds/slave/test', 03:07:39 INFO - 'SHELL': '/bin/bash', 03:07:39 INFO - 'SHLVL': '1', 03:07:39 INFO - 'TERM': 'linux', 03:07:39 INFO - 'TMOUT': '86400', 03:07:39 INFO - 'USER': 'cltbld', 03:07:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:39 INFO - '_': '/tools/buildbot/bin/python'} 03:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:40 INFO - warning: no files found matching '*.txt' 03:07:40 INFO - no previously-included directories found matching 'build' 03:07:40 INFO - no previously-included directories found matching 'dist' 03:07:40 INFO - no previously-included directories found matching '.git*' 03:07:40 INFO - Installing collected packages: jsonschema, functools32 03:07:40 INFO - Running setup.py install for functools32 03:07:40 INFO - warning: no files found matching '*.txt' 03:07:40 INFO - no previously-included directories found matching 'build' 03:07:40 INFO - no previously-included directories found matching 'dist' 03:07:40 INFO - no previously-included directories found matching '.git*' 03:07:40 INFO - Successfully installed jsonschema functools32 03:07:40 INFO - Cleaning up... 03:07:41 INFO - Return code: 0 03:07:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:41 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:07:41 INFO - Using env: {'DISPLAY': ':0', 03:07:41 INFO - 'HOME': '/home/cltbld', 03:07:41 INFO - 'LANG': 'en_US.UTF-8', 03:07:41 INFO - 'LANGUAGE': 'en_US:en', 03:07:41 INFO - 'LOGNAME': 'cltbld', 03:07:41 INFO - 'MAIL': '/var/mail/cltbld', 03:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:41 INFO - 'MOZ_NO_REMOTE': '1', 03:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:41 INFO - 'NO_EM_RESTART': '1', 03:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:41 INFO - 'PWD': '/builds/slave/test', 03:07:41 INFO - 'SHELL': '/bin/bash', 03:07:41 INFO - 'SHLVL': '1', 03:07:41 INFO - 'TERM': 'linux', 03:07:41 INFO - 'TMOUT': '86400', 03:07:41 INFO - 'USER': 'cltbld', 03:07:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:41 INFO - '_': '/tools/buildbot/bin/python'} 03:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:41 INFO - Cleaning up... 03:07:41 INFO - Return code: 0 03:07:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:41 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:41 INFO - Using env: {'DISPLAY': ':0', 03:07:41 INFO - 'HOME': '/home/cltbld', 03:07:41 INFO - 'LANG': 'en_US.UTF-8', 03:07:41 INFO - 'LANGUAGE': 'en_US:en', 03:07:41 INFO - 'LOGNAME': 'cltbld', 03:07:41 INFO - 'MAIL': '/var/mail/cltbld', 03:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:41 INFO - 'MOZ_NO_REMOTE': '1', 03:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:41 INFO - 'NO_EM_RESTART': '1', 03:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:41 INFO - 'PWD': '/builds/slave/test', 03:07:41 INFO - 'SHELL': '/bin/bash', 03:07:41 INFO - 'SHLVL': '1', 03:07:41 INFO - 'TERM': 'linux', 03:07:41 INFO - 'TMOUT': '86400', 03:07:41 INFO - 'USER': 'cltbld', 03:07:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:41 INFO - '_': '/tools/buildbot/bin/python'} 03:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:43 INFO - Downloading docopt-0.6.1.tar.gz 03:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:43 INFO - Running setup.py install for blobuploader 03:07:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:43 INFO - Running setup.py install for requests 03:07:43 INFO - Running setup.py install for docopt 03:07:43 INFO - Successfully installed blobuploader requests docopt 03:07:43 INFO - Cleaning up... 03:07:43 INFO - Return code: 0 03:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:43 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:43 INFO - Using env: {'DISPLAY': ':0', 03:07:43 INFO - 'HOME': '/home/cltbld', 03:07:43 INFO - 'LANG': 'en_US.UTF-8', 03:07:43 INFO - 'LANGUAGE': 'en_US:en', 03:07:43 INFO - 'LOGNAME': 'cltbld', 03:07:43 INFO - 'MAIL': '/var/mail/cltbld', 03:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:43 INFO - 'MOZ_NO_REMOTE': '1', 03:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:43 INFO - 'NO_EM_RESTART': '1', 03:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:43 INFO - 'PWD': '/builds/slave/test', 03:07:43 INFO - 'SHELL': '/bin/bash', 03:07:43 INFO - 'SHLVL': '1', 03:07:43 INFO - 'TERM': 'linux', 03:07:43 INFO - 'TMOUT': '86400', 03:07:43 INFO - 'USER': 'cltbld', 03:07:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:43 INFO - '_': '/tools/buildbot/bin/python'} 03:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:43 INFO - Running setup.py (path:/tmp/pip-mgCljh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:44 INFO - Running setup.py (path:/tmp/pip-twovHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:44 INFO - Running setup.py (path:/tmp/pip-gqKhQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:44 INFO - Running setup.py (path:/tmp/pip-7u30f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:44 INFO - Running setup.py (path:/tmp/pip-omXEg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:44 INFO - Running setup.py (path:/tmp/pip-FKiamy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:44 INFO - Running setup.py (path:/tmp/pip-JZrUnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:44 INFO - Running setup.py (path:/tmp/pip-TO_V3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:44 INFO - Running setup.py (path:/tmp/pip-gw3kJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:44 INFO - Running setup.py (path:/tmp/pip-rQyDdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:44 INFO - Running setup.py (path:/tmp/pip-QuigQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:44 INFO - Running setup.py (path:/tmp/pip-3rfmuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:44 INFO - Running setup.py (path:/tmp/pip-zEGPP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:44 INFO - Running setup.py (path:/tmp/pip-j4OFRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:44 INFO - Running setup.py (path:/tmp/pip-gpwok_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:45 INFO - Running setup.py (path:/tmp/pip-tLqCrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:45 INFO - Running setup.py (path:/tmp/pip-zjXzV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:45 INFO - Running setup.py install for manifestparser 03:07:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Running setup.py install for mozcrash 03:07:45 INFO - Running setup.py install for mozdebug 03:07:45 INFO - Running setup.py install for mozdevice 03:07:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Running setup.py install for mozfile 03:07:45 INFO - Running setup.py install for mozhttpd 03:07:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Running setup.py install for mozinfo 03:07:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Running setup.py install for mozInstall 03:07:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:45 INFO - Running setup.py install for mozleak 03:07:46 INFO - Running setup.py install for mozlog 03:07:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Running setup.py install for moznetwork 03:07:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Running setup.py install for mozprocess 03:07:46 INFO - Running setup.py install for mozprofile 03:07:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Running setup.py install for mozrunner 03:07:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Running setup.py install for mozscreenshot 03:07:46 INFO - Running setup.py install for moztest 03:07:46 INFO - Running setup.py install for mozversion 03:07:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:46 INFO - Cleaning up... 03:07:46 INFO - Return code: 0 03:07:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:46 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:46 INFO - Using env: {'DISPLAY': ':0', 03:07:46 INFO - 'HOME': '/home/cltbld', 03:07:46 INFO - 'LANG': 'en_US.UTF-8', 03:07:46 INFO - 'LANGUAGE': 'en_US:en', 03:07:46 INFO - 'LOGNAME': 'cltbld', 03:07:46 INFO - 'MAIL': '/var/mail/cltbld', 03:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:46 INFO - 'MOZ_NO_REMOTE': '1', 03:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:46 INFO - 'NO_EM_RESTART': '1', 03:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:46 INFO - 'PWD': '/builds/slave/test', 03:07:46 INFO - 'SHELL': '/bin/bash', 03:07:46 INFO - 'SHLVL': '1', 03:07:47 INFO - 'TERM': 'linux', 03:07:47 INFO - 'TMOUT': '86400', 03:07:47 INFO - 'USER': 'cltbld', 03:07:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:47 INFO - '_': '/tools/buildbot/bin/python'} 03:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:47 INFO - Running setup.py (path:/tmp/pip-IWleFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:47 INFO - Running setup.py (path:/tmp/pip-aNUgc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:47 INFO - Running setup.py (path:/tmp/pip-IySYzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:47 INFO - Running setup.py (path:/tmp/pip-cy4j1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:47 INFO - Running setup.py (path:/tmp/pip-s7edee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:47 INFO - Running setup.py (path:/tmp/pip-qyhuUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:47 INFO - Running setup.py (path:/tmp/pip-qkofRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:47 INFO - Running setup.py (path:/tmp/pip-NTGlKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:47 INFO - Running setup.py (path:/tmp/pip-vqzOUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:47 INFO - Running setup.py (path:/tmp/pip-jwKIIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:47 INFO - Running setup.py (path:/tmp/pip-hTpS3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:48 INFO - Running setup.py (path:/tmp/pip-eW7aX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:48 INFO - Running setup.py (path:/tmp/pip-Up9G55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:48 INFO - Running setup.py (path:/tmp/pip-Xy2YTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:48 INFO - Running setup.py (path:/tmp/pip-kTY6GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:48 INFO - Running setup.py (path:/tmp/pip-AJitjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:48 INFO - Running setup.py (path:/tmp/pip-3_RfoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:07:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:49 INFO - Downloading blessings-1.6.tar.gz 03:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:49 INFO - Installing collected packages: blessings 03:07:49 INFO - Running setup.py install for blessings 03:07:49 INFO - Successfully installed blessings 03:07:49 INFO - Cleaning up... 03:07:49 INFO - Return code: 0 03:07:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:49 INFO - Reading from file tmpfile_stdout 03:07:49 INFO - Current package versions: 03:07:49 INFO - argparse == 1.2.1 03:07:49 INFO - blessings == 1.6 03:07:49 INFO - blobuploader == 1.2.4 03:07:49 INFO - docopt == 0.6.1 03:07:49 INFO - functools32 == 3.2.3-2 03:07:49 INFO - jsonschema == 2.5.1 03:07:49 INFO - manifestparser == 1.1 03:07:49 INFO - mozInstall == 1.13 03:07:49 INFO - mozcrash == 1.0 03:07:49 INFO - mozdebug == 0.1 03:07:49 INFO - mozdevice == 0.51 03:07:49 INFO - mozfile == 1.2 03:07:49 INFO - mozhttpd == 0.7 03:07:49 INFO - mozinfo == 0.10 03:07:49 INFO - mozleak == 0.1 03:07:49 INFO - mozlog == 3.5 03:07:49 INFO - moznetwork == 0.27 03:07:49 INFO - mozprocess == 0.25 03:07:49 INFO - mozprofile == 0.28 03:07:49 INFO - mozrunner == 6.13 03:07:49 INFO - mozscreenshot == 0.1 03:07:49 INFO - mozsystemmonitor == 0.3 03:07:49 INFO - moztest == 0.8 03:07:49 INFO - mozversion == 1.4 03:07:49 INFO - psutil == 3.1.1 03:07:49 INFO - requests == 1.2.3 03:07:49 INFO - wsgiref == 0.1.2 03:07:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:50 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 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:50 INFO - Using env: {'DISPLAY': ':0', 03:07:50 INFO - 'HOME': '/home/cltbld', 03:07:50 INFO - 'LANG': 'en_US.UTF-8', 03:07:50 INFO - 'LANGUAGE': 'en_US:en', 03:07:50 INFO - 'LOGNAME': 'cltbld', 03:07:50 INFO - 'MAIL': '/var/mail/cltbld', 03:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:50 INFO - 'MOZ_NO_REMOTE': '1', 03:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:50 INFO - 'NO_EM_RESTART': '1', 03:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:50 INFO - 'PWD': '/builds/slave/test', 03:07:50 INFO - 'SHELL': '/bin/bash', 03:07:50 INFO - 'SHLVL': '1', 03:07:50 INFO - 'TERM': 'linux', 03:07:50 INFO - 'TMOUT': '86400', 03:07:50 INFO - 'USER': 'cltbld', 03:07:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:50 INFO - '_': '/tools/buildbot/bin/python'} 03:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:07:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:07:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:51 INFO - Installing collected packages: marionette-driver, simplejson 03:07:51 INFO - Running setup.py install for marionette-driver 03:07:51 INFO - Running setup.py install for simplejson 03:07:51 INFO - building 'simplejson._speedups' extension 03:07:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:07:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:07:52 INFO - Successfully installed marionette-driver simplejson 03:07:52 INFO - Cleaning up... 03:07:52 INFO - Return code: 0 03:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1683a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1826fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:07:52 INFO - Using env: {'DISPLAY': ':0', 03:07:52 INFO - 'HOME': '/home/cltbld', 03:07:52 INFO - 'LANG': 'en_US.UTF-8', 03:07:52 INFO - 'LANGUAGE': 'en_US:en', 03:07:52 INFO - 'LOGNAME': 'cltbld', 03:07:52 INFO - 'MAIL': '/var/mail/cltbld', 03:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:52 INFO - 'MOZ_NO_REMOTE': '1', 03:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:52 INFO - 'NO_EM_RESTART': '1', 03:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:52 INFO - 'PWD': '/builds/slave/test', 03:07:52 INFO - 'SHELL': '/bin/bash', 03:07:52 INFO - 'SHLVL': '1', 03:07:52 INFO - 'TERM': 'linux', 03:07:52 INFO - 'TMOUT': '86400', 03:07:52 INFO - 'USER': 'cltbld', 03:07:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:52 INFO - '_': '/tools/buildbot/bin/python'} 03:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:52 INFO - Cleaning up... 03:07:53 INFO - Return code: 0 03:07:53 INFO - Running post-action listener: _resource_record_post_action 03:07:53 INFO - Running post-action listener: _start_resource_monitoring 03:07:53 INFO - Starting resource monitoring. 03:07:53 INFO - [mozharness: 2017-07-06 10:07:53.028705Z] Finished create-virtualenv step (success) 03:07:53 INFO - [mozharness: 2017-07-06 10:07:53.029222Z] Running install step. 03:07:53 INFO - Running pre-action listener: _resource_record_pre_action 03:07:53 INFO - Running main action method: install 03:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:53 INFO - Reading from file tmpfile_stdout 03:07:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:53 INFO - Reading from file tmpfile_stdout 03:07:53 INFO - Output received: 03:07:53 INFO - Usage: mozinstall [options] installer 03:07:53 INFO - Options: 03:07:53 INFO - -h, --help show this help message and exit 03:07:53 INFO - -d DEST, --destination=DEST 03:07:53 INFO - Directory to install application into. [default: 03:07:53 INFO - "/builds/slave/test"] 03:07:53 INFO - --app=APP Application being installed. [default: firefox] 03:07:53 INFO - mkdir: /builds/slave/test/build/application 03:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:08:11 INFO - Reading from file tmpfile_stdout 03:08:11 INFO - Output received: 03:08:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:08:11 INFO - Running post-action listener: _resource_record_post_action 03:08:11 INFO - [mozharness: 2017-07-06 10:08:11.366385Z] Finished install step (success) 03:08:11 INFO - [mozharness: 2017-07-06 10:08:11.366532Z] Running setup-mitmproxy step. 03:08:11 INFO - Running pre-action listener: _resource_record_pre_action 03:08:11 INFO - Running main action method: setup_mitmproxy 03:08:11 INFO - Skipping: mitmproxy is not required 03:08:11 INFO - Running post-action listener: _resource_record_post_action 03:08:11 INFO - [mozharness: 2017-07-06 10:08:11.367066Z] Finished setup-mitmproxy step (success) 03:08:11 INFO - [mozharness: 2017-07-06 10:08:11.367179Z] Running run-tests step. 03:08:11 INFO - Running pre-action listener: _resource_record_pre_action 03:08:11 INFO - Running pre-action listener: _set_gcov_prefix 03:08:11 INFO - Running main action method: run_tests 03:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:11 INFO - Python 2.7.3 03:08:11 INFO - Return code: 0 03:08:11 INFO - grabbing minidump binary from tooltool 03:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:11 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 0x182a2a0>, '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 0x182b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18254d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:11 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 03:08:11 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 03:08:11 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 03:08:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:11 INFO - Return code: 0 03:08:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:08:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:11 INFO - ENV: RUST_BACKTRACE is now 1 03:08:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:08:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:08:11 INFO - Using env: {'DISPLAY': ':0', 03:08:11 INFO - 'HOME': '/home/cltbld', 03:08:11 INFO - 'LANG': 'en_US.UTF-8', 03:08:11 INFO - 'LANGUAGE': 'en_US:en', 03:08:11 INFO - 'LOGNAME': 'cltbld', 03:08:11 INFO - 'MAIL': '/var/mail/cltbld', 03:08:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:11 INFO - 'MOZ_NO_REMOTE': '1', 03:08:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:11 INFO - 'NO_EM_RESTART': '1', 03:08:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:11 INFO - 'PWD': '/builds/slave/test', 03:08:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:11 INFO - 'RUST_BACKTRACE': '1', 03:08:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:08:11 INFO - 'SHELL': '/bin/bash', 03:08:11 INFO - 'SHLVL': '1', 03:08:11 INFO - 'TERM': 'linux', 03:08:11 INFO - 'TMOUT': '86400', 03:08:11 INFO - 'USER': 'cltbld', 03:08:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268', 03:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:11 INFO - '_': '/tools/buildbot/bin/python'} 03:08:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:08:11 INFO - mozversion application_buildid: 20170706091821 03:08:11 INFO - mozversion application_changeset: 018b3829d0a7f6944a5ae1489f3a64c9e2893909 03:08:11 INFO - mozversion application_display_name: Nightly 03:08:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:11 INFO - mozversion application_name: Firefox 03:08:11 INFO - mozversion application_remotingname: firefox 03:08:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:08:11 INFO - mozversion application_vendor: Mozilla 03:08:11 INFO - mozversion application_version: 56.0a1 03:08:11 INFO - mozversion platform_buildid: 20170706091821 03:08:11 INFO - mozversion platform_changeset: 018b3829d0a7f6944a5ae1489f3a64c9e2893909 03:08:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:08:11 INFO - mozversion platform_version: 56.0a1 03:08:11 INFO - using testdate: 1499335691 03:08:11 INFO - actual date: 1499335691 03:08:11 INFO - starting webserver on 'localhost:55457' 03:08:11 INFO - SUITE-START | Running 2 tests 03:08:11 INFO - TEST-START | dromaeo_css 03:08:11 INFO - Initialising browser for dromaeo_css test... 03:08:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55457/getInfo.html -profile /tmp/tmpLV2uDa/profile 03:08:11 INFO - TEST-INFO | started process 9222 (/builds/slave/test/build/application/firefox/firefox http://localhost:55457/getInfo.html) 03:08:18 INFO - TEST-INFO | 9222: exit 0 03:08:18 INFO - Browser initialized. 03:08:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:18 INFO - TEST-INFO | started process 9446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLV2uDa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:30 INFO - PID 9446 | RSS: Main: 172142592 03:08:30 INFO - PID 9446 | 03:11:29 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55457/tests/dromaeo/cssquery-ext.html) 03:11:31 INFO - PID 9446 | RSS: Main: 179793920 03:11:31 INFO - PID 9446 | 03:14:33 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-ext.html (next: http://localhost:55457/tests/dromaeo/cssquery-jquery.html) 03:14:34 INFO - PID 9446 | RSS: Main: 177623040 03:14:34 INFO - PID 9446 | 03:17:35 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55457/tests/dromaeo/cssquery-mootools.html) 03:17:36 INFO - PID 9446 | RSS: Main: 180015104 03:17:36 INFO - PID 9446 | 03:20:38 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55457/tests/dromaeo/cssquery-prototype.html) 03:20:38 INFO - PID 9446 | RSS: Main: 179179520 03:20:38 INFO - PID 9446 | 03:23:42 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55457/tests/dromaeo/cssquery-yui.html) 03:23:42 INFO - PID 9446 | RSS: Main: 178450432 03:23:42 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | Cycle 1(1): loaded http://localhost:55457/tests/dromaeo/cssquery-yui.html (next: http://localhost:55457/tests/dromaeo/cssquery-dojo.html) 03:26:44 INFO - PID 9446 | RSS: Main: 181440512 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | __start_tp_report 03:26:44 INFO - PID 9446 | _x_x_mozilla_page_load 03:26:44 INFO - PID 9446 | _x_x_mozilla_page_load_details 03:26:44 INFO - PID 9446 | |i|pagename|runs| 03:26:44 INFO - PID 9446 | |0;dojo.html;3015.20097174249;3052.0996306089714;3069.6776838431965;3075.600171977643;3080.291532947422;5853.765849366026;5895;5975.760969561213;5988.550858685594;6035.849103772413;5843.737031833567;5946.494547963428;5961.791337303195;5981.431763982415;6003.339632640406;5474.91787623186;5486.972565137189;5488.286522752057;5501.504864562188;5516.062269414189;5500.3949565547955;5546.223528705985;5552.11166213406;5556.222128901957;5572.359178694442;5537.640053396536;5556.749946252408;5557.944420555783;5559.63862348946;5561.555075593963;5511.338639363262;5525;5535.169724541351;5536.944630553683;5539.25220095288;5480.7533660985355;5491;5501.477359650827;5504.504594586467;5509.090999984997;5999.970000149971;6015.368386319461;6056.4851987581105;6075.756969721206;6080.878382432326;6245.812625621194;6400.775972840928;6401.743930242785;6508;6514.739410423577;5164.528109488778;6457.3865482779065;6464.353564643498;6467.902981455282;6493.837654058639;5998.940010599882;6008.519318454513;6009.579329446897;6073.1497590337385;6107.328193898667;6573.211214654272;6582.44049255809;6663.6001839888795;6674.16572928384;6692.933070669328;6214.937850621526;6292.4966002719675;6304.65324407162;6346.9682651586445;6364.936350636434;6301.054841773771;6308.7476500940365;6312.116303717483;6319.55763096588;6329.145565348711;6214.161088253119;6273.749050037947;6274.874502510015;6285.465735412449;6311.084892690534;5329.822781107006;6300.747970081237;6334.8416289592205;6347.682615869188;6464;5144.819931302386;5149.0474262261605;5216.7913283469;5221.634485586049;5226.320578324793;4435.312526558324;4441.800118994653;4471.463424389094;4493.1013797240685;4498.212812757754;5551.639143455663;5630.211770352154;5630.324361076697;5634;5696.829095127153;6435.034744788226;6435.4208121268375;6447.6131432114225;6448.871022579522;6455.903161452582;5555.722213889289;5592.552595792326;5601.579881508822;5620.606557541015;5629.831105066773;5631.690257035821;5658.490735833712;5660.745266462936;5675.262215911905;5701.486866182064;5030.974845125751;6202.255729312421;6249.062640603855;6257.124002639634;6280.5603607747935;6388.233411990591;6389.48884089281;6465.224173099258;6465.676716164267;6482.222133344029;6161.507079433724;6206.410391012847;6216.067589861557;6292.4966002720585;6294.464970477561;5935.970320148372;5964.433378829004;5987.072003839412;6017.939820601738;6048.183495228088;6103.6032657877095;6110.908336375047;6194.349593292639;6460.773872914426;6548.869022619426;6163.506919446523;6186.381361863778;6236.937630623817;6336.398042185985;6347.587406818542;6171.228596425447;6230.626162430269;6264.123022776724;6295.559310848196;6331.841703957438;5990.850228744316;6188.44304012641;6202.472789812736;6213;6260.123582698517;6118.143459915705;6232.5637205397;6277.2153480814895;6288.245410550763;6297.740451909544;5949.910751338647;5966.313873904556;5966.49284810796;6000.51995840323;6009.098635204754 03:26:44 INFO - PID 9446 | |1;ext.html;734.6987735028639;786.1784435265147;818.1859050245006;833.6915341323711;837.417994493827;40076;41352.793236033816;41467.37798933018;41545;41567.960800979956;37563.436548451726;37648.247035059285;37717;37742.62257377426;37817.810910945474;6804.455643548529;6908.6545672716165;6909.965450172742;6910.965445172767;6924.861502769942;6803.897941530881;6898.827529311757;6926.411255043327;6927.064846245743;6941.652917354138;6866.725330986755;6876.346747059021;6900.861982760342;6918.861622767542;6930.688119034656;6829.624370659587;6836.4530837533375;6843.110395648584;6867.656617169147;6898.655067246643;6098.237720284965;6098.847528811771;6186.412290832363;6186.969065154691;6229.501639868799;33649;33753.32493350144;33936.321273574635;33966.1508462288;34062.318753624786;3056.495678213092;3083.1213104265403;3136.027831372282;3179.2687681833077;3249.138978170763;31785.84107079473;31840.363192736015;31854.522182167286;31869.84065079683;31912.521312180335;4699.600533954618;4847.733374664392;4913.434954980187;5011.774470148852;5049.444561098277;194108;198043;199732.00133999382;210056;210930;47047;48027.27959080617;48433;48433.75783121062;48465.515344846805;50510;50801.237981430306;50892.74553627208;51037.23444148341;51297.97404051973;16373.67252654964;16596.25316860744;16620.252088655798;16777;16844.663106737797;13724.519641812489;13780.586582402344;13799.379027943767;13847.376868040963;13876.4449422024;14429.278536073154;14533.709325813636;14565.344559494848;14710.33803478846;14728.484503042342;5756.42435756421;5933.821985340447;5960.910586341209;5961.577835594712;5979.252593425822;999.9700008999741;1010.1918465227789;1033.813913495578;1037.1495373793568;1055.4036969112426;23119.768802312097;23271.185508507122;23371.53256934886;23498.530029399317;23623.645645315333;1122.7193201699574;1123.27548731068;1140.520981187903;1141.0757286597882;1141.520561364229;11819.527218911147;12373.072019598567;12405.131640785059;12462.376881155906;12693.809592856114;242398;242418;243009;243092;243377;52715.472845271055;53131;53259.20111198335;53377.1993420099;53584.732076339365;1417.3551034279378;1456.978145327821;1469.5077149154938;1474.9778753318924;1480.2080886725767;21598.89200553987;23086.307410777703;23151.76848231496;23222.954967026188;23395.766042339357;37221.44167837431;37416.43875341817;37568.62431375651;37584;37770.43344349782;190634;192097;192859;192888;193337;31192.53211201879;31498.842505787325;31689;31858.04425867228;35226.823865880506;38832.6116738829;43025.569744302156;44313.33529996988;44970.325445119;45224.547754522035;30224;31561;31640.525392118678;31882.043538693877;32667.836660816545;31827.68172318247;32003.199920002186;32337.35325293434;34705.82647086748;35412.645873541966;39190.216195675355;39371.60628393794;39453;39734.80132599318;40218;33248.77971895333;33442.49836252507;34465;34585.135371615914;34788.652113479555;24185.316450633734;25005;25525;25593.360165996;25620.487590247718 03:26:44 INFO - PID 9446 | |2;jquery.html;556.7132926542831;561.9719014049297;563.4393778190699;573.6787399056532;588.9057750759878;21715.565688686238;22214.222502212426;22713;22745.952864242234;22785;26515.469690606176;26958.5956210657;27001.594976075325;27164.32089197771;27197.18408447745;6388.520860935437;6553.672316384185;6557.77047803327;6562.671866406685;6583.07836902834;3802.9429558556503;6505.869882602345;6579.572327798702;6582.802515924506;6597.109390232329;5302.734863256841;6483.740650373979;6561.409473147416;6561.606303621798;6568.967155164218;6472.190976127984;6503.739850406026;6531.640759758211;6533.673316334188;6544.312847151028;5988.131720900488;6059.7273122709585;6060.575759696823;6068.605540639845;6073.058675905242;29049.273768155756;29485.70514294851;30250.697493025007;30600.2349941251;30618.693813061807;1858.9070546472622;1915.0233380975803;1917.549375896677;1917.8178073083034;1921.8174273444001;18452.815471845242;18978;19010.52473688155;19013.809861901344;19035.333763318216;2268.965965510519;2358.0921345282018;2395.2574701842486;2396;2414.1429792423787;116868;119896.80103198944;121155;121326.39336803347;121662;14104.403377138764;14365.712685746226;14430.556944305485;14521.419143234152;14914.254287285808;23410.414739631644;23516.882415587814;23577.29268121959;23679.408014799425;23699.763002370102;10160.33957792741;10375.16998640107;10388.11701005423;10463.215258855616;10487.067349743846;9775.120239178508;9796.363236389612;9832.705018849447;9867.753306167404;9921.156701680293;8320.459170153921;8885.333599979898;8914.153155450222;9006.86489702655;9072.95463522678;2693.501702185102;2720.34711669198;2751.834889906612;2764.4194719109214;2818.168640251131;961.6105477281712;970.4371464550544;976.8974257702981;997.6059456514636;1010.2120346130031;19160.233590656495;19409.32067377635;19541.609167816565;19959.501012474804;20118.59762804765;1046;1050.1598721023151;1086.7337502311825;1092.3282181458346;1095.7863216672831;10808.51361688726;10827.350358978329;11135.276207046516;11164.274322169033;11251;463693;477816;492725;494331;498868;105600;108478.45760771146;115349.42325288319;115468;115663.42168289104;1230.5816022552376;1267.7211013576998;1308.3131356037966;1309.9148555343872;1317.8616245294106;19736.605267894847;20398.11388325195;20738.585228295047;20746.79253207509;20925.79074209299;51992.74003630109;52860;52864.471355285954;53009.46990530045;53658.195127072344;62259.37740622536;65267;65951.34048659644;66003.33996659971;66398;12536;13231.073824832169;13311.068225224142;13311.800322995357;13378.9965752567;15341.079535227922;16052.117133557766;16139.919300403422;16213.67572648564;19849.106790194186;12984.63661315586;13126.409311581192;15111.54665360041;16035.599110022344;16327.836721633106;13429.798553021908;13559.118657287245;13682.589522314347;13933.651658708613;14153.43386264538;16168.191590420196;16431.26059327357;16551.83448165503;16689;16924.746128808325;12981.091323607257;13031.804522931974;13042.282674452617;13090.476380945036;13092.149010314299;14808.851911481179;16163.67672646564;16201.189940503164;16224.594385140466;16323.755143672617 03:26:44 INFO - PID 9446 | |3;mootools.html;1335.9465621375145;1399.0836002418414;1417.7377185220735;1419.7941298511723;1420.9307894946917;12931.547395841135;13839.100458470193;13863.82157516611;13911.860881391183;13948.581542553715;12850.871491285085;13327.000474964369;13652.658683532916;13661.521846735366;13722.313884305795;2640.1419538649966;2697.2447714639934;2698.433329000912;2709.552923767586;2717.1440996086267;2640.8415495070262;2645.31221882311;2668.7064422913463;2670.65281513403;2690.7847372210276;2611.294950363401;2628.5137249608883;2663.706992230853;2670.6661667291587;2676.625272461857;2537.3402915242077;2664.1208401227645;2749.463854548364;2752.4357506711076;2753.6420265365573;2698.6761588609297;2734.7128551502005;2735.3435175557725;2737.452509498108;2741.6024676421807;13726.176429414267;13855.584332469942;13864.098833575785;13869.306534673327;13887.44450222;7402.407807375451;7691.846163076763;7702.576358300291;7729.304362607336;7771.339436147934;4840.709557426566;4969.568985267586;5106.08090543702;5122.564582010534;5124.282600435905;1825.187791432813;1865.6735071362457;1878.690016147334;1930.3436831477225;1941.0779879557097;22374.440638983993;22402.66396004045;22577.774222257733;22593.887030564907;22614;6351.460125889351;6411.775587854403;6443.259025212067;6602.669866506655;6613.735450582019;15422.614434639223;15422.691546169013;15433.614159646098;15483.767743483857;15510.146941918303;7352.301531354513;7610.1628820829665;7625.351845093229;7630.8855367169535;7640.083190017233;6931.4108300795;7029.718811247493;7036.788896333118;7092.4680648951535;7110.3600675939415;4688.859334219979;4735.763211839394;4781.11549363362;4783.210770222944;4788.904221915543;1343.1605246720799;1351.9526816561372;1360.1091285208204;1370.6778906956856;1380.6272306477194;780.7969927818808;791.0783936713664;791.6041979010495;808.9271965523131;810.1493431896486;7003.369696727319;7113.786586402416;8362.665493380318;8529.872051919227;8652.437591556529;962.9614815407446;972.5769290358717;988.1551273661061;995.2535598301274;1007.0433088565892;5645.774169033192;5701.287339082614;5797.623154494944;5901.793437229762;5928.170056192051;18725.25098996025;18854.71717924232;19128.426147215327;19176.232950681817;19294.421167365002;17583.20875560603;18905.621887562447;18910.432687019413;18913.338033168773;19046.33337833197;10475.790484190426;10647.787044259072;10739.463026848782;10921.890781092088;10933.617323393642;7867.409944254089;8422.326213902996;8507.361947854059;8588.65645374178;8678.435901666371;16248.3500659977;16278.104704240906;16792.412265570645;16938.237779299714;17021.148942552576;15712.92143539275;16630.750538741686;16904.83095169082;16917.746233806258;17180.570485737957;12676.87323126757;12980.350982450651;13021.739565208833;13036.674083147996;13038.608841734764;12842.935785321013;13007.414666339848;13020.28388438607;13042.804357934448;13097.345132743134;10252.43611601369;10554;10670.146388288764;10696.465176740976;10712.839307410239;10132.949335253572;10382.792344153226;10592.576296948344;10856.240063195817;10913.454327283764;9757.51212439361;9778.462184579916;9817.803643926938;9818.509074546388;9870.111689947938;6699.732010719516;6735.158105236846;6841.21326047491;6889.207741109636;6983.476239282176;6861.2795656455355;6899.103116594811;7185.640717964186;7431.888521672287;7591.620418978919 03:26:44 INFO - PID 9446 | |4;prototype.html;497.78043792707854;501.23065578507857;519.7868873761757;522.7934965688555;533.2401328107449;5941.702914854256;5988;6005.309389420218;6018.037114061751;6030.185924900137;5675.716214189295;5852.356240813507;5863.706814659261;5871.324797648272;5891.792182602567;4844.636652251095;4862.2463518154655;4868.878278043042;4873.48828373021;4900.681455705386;4836;4846.957904050629;4864.878378040542;4871.464138944713;4882.658213925027;4796.928046079312;4842.539958703917;4844.854654360357;4874.8537543873745;4881.536254055877;4627.699199552018;4816.54242846929;4838.250071238964;4851.466338702722;4857.9757101214445;4294.935575966363;4296.355546667994;4310.31035034393;4326.437563116775;4336.306191009423;5671.404502527258;5689.317281926154;5746.454086861783;5781.855453613652;5816.47651711348;5475.589330800166;5485.670859748428;5530.5022547970475;5534.584906132016;5553.944460555384;6230.906536401958;6232.13036089176;6253.687315634245;6311.93688063118;6328.430441260309;4748.738819364934;4781.545753153479;4789.449213340441;4809.206480930642;4819.759012049419;6622.344413896526;6641.5018873584195;6641.535092543524;6665.8000259991795;6706.497012724065;4863.270509423614;4893.168161412568;4919.7540122993705;4923.803047878117;4946.851594452172;4988.451270360258;5010.67430617016;5019.3976722793495;5020.673656212334;5022.9748851256245;5457.2359869618285;5517.531009864127;5541.501264886179;5551.3893471718075;5553.361363443175;6251.28110267316;6306.369363063657;6309.905351419732;6348.809535713936;6372.458341041063;1702.3190723710368;1720.8365205305477;1720.931162753501;1735.0630659444012;1737.3658614605831;1104.2049724198725;1197.0961923747689;1217.2392254840724;1219.195331081482;1227.1961864978452;5467.633091727068;5582.106862901916;5590.217369568264;5609.1305847593685;5691.886162276731;6300.141458269822;6438.645874476855;6471.805845824632;6501.4148726613885;6529.477641788645;5533.418991005887;5556.333240011225;5608.327000759935;5617.612514681244;5635.070213414822;3379.8648054078053;3407.1822762536813;3467.2025434150287;3502.4571191465366;3512.2799826035603;6267.4986001119805;6274.215723034621;6319.24169099711;6325.367463253638;6355.491560675135;6622.635755033423;6642.575459957081;6648.739428594205;6677.797996360701;6680.665966701646;6296.590721603081;6309.305976342691;6325.272593651697;6330.525210609223;6366.140571022946;6407.647579383179;6451.48388128958;6483.299607784507;6539.149910511603;6565.474762019123;6469.611823290617;6469.902951455638;6498.220213574401;6501.414872661294;6528.37980391862;6176.282435728265;6191.659458729633;6221;6282.780102696383;6384.585001974857;4769.640652414184;4820.39745031871;4854.320395144753;4855.2717092435005;4920.803167873245;6453.548251622529;6457.741690332334;6460.935390646221;6515.218173819172;6522.967385163044;6260.655663938345;6301.842453938688;6364.554481186273;6370.299267080525;6375.968120159555;6344.936550634435;6353.301136875032;6372.681365931778;6378.362163783585;6384.170057892445;6199.628022318675;6240.375962403905;6332.353588067228;6340.239171299474;6341.841453963503;6215.446138465383;6232.470240029648;6253.37466253371;6293.653849038347;6346.50857048584;5589.133684278943;6026.879462410815;6070.268379229453;6075.908861366995;6095.878082438415 03:26:44 INFO - PID 9446 | |5;yui.html;823.1727114250185;830.1615368477837;849.5539841583168;851.948883067016;858.2533196119377;17492.475225743234;18231.544211394707;18360.908195459022;18442.262309507638;20357.898210508927;20046.198152073935;20515.692264616042;21053.368398948056;21058.157673693073;21108.472288192763;992.8163289791376;1062.9468526573678;1068;1072.6835583502886;1073.849661047454;1055.2033214922722;1055.6147006342705;1069.6844430892904;1069.7272195590115;1074.9462526873665;1110.2228440091928;1111.644273832374;1114.6656003199007;1114.9052330551913;1118.82658187981;992.3153024413168;1029.0841151375282;1079.4494807648077;1086.8424078508651;1101.493313075982;770.684019551981;773.2963003666692;774.5817258680306;774.9883751743729;778.3656320099158;17966.550836229067;19175.520611984673;19383.612327753508;19429.125689344015;19483.415497535098;19491.707624385646;19681.31115410968;19908.70136947947;20004.89997550003;20021.1991520339;15739;15778.28997695095;15816.28826702801;15852.76220856688;15895;3449.1549570355173;3558.021544075374;3592.4252119660728;3598.6401359864067;3608.8195590220384;112615.43692281569;113543;116902.41548792287;117761;119639.99999999913;15347.923260383626;15351.539453816404;15602.531924042298;15639.139847308506;15666.451674191349;26310.21069367922;28519;28566.28584285368;28578.28554286118;28951.855240724082;7715.344195743312;8636.309095272363;8807.823843523094;8889.4666320021;8892.199702026848;3570.5001299818045;3785.507883975121;4039.2123535910805;4042.3330150524835;4049.6760259179196;4922.064807686528;5005.374328208974;5028.321176641107;5032.72320022395;5080.415752188472;1062.654637242899;1120.075937351688;1129.1362107987395;1137.4426530999751;1141.0928311991986;579.1891352107;579.7999690106907;595.9165716799652;597.1252115650593;614.1984709953464;11246.437678116225;11852.70368240801;12533.498660053678;12692.365381730877;12716.809247861289;570.8782589702342;576.762843700269;586.7506309818395;587.6180482686202;603.5805115444724;5162.993216322856;5797.88404231913;5856.575295973174;5955.464008239279;6122.510199184055;99767.50116249372;102762.7342833621;103309;104332.47833760934;105877.47061264644;87452;88115;90742;91799;92663;76012.61993689997;78377.60811195908;80159.797603036;81174;81455;12066.215695979734;12084.274943503418;12112.70829290635;12228.755424891275;12300.261984280973;34746;35314.47028294629;35420.64579354277;36209.27581448409;37198;43303.566964331214;59395.40604593899;60052;66130.66934665489;67012.664936675;17931.193096310435;18135.27458901629;18406.079696014876;18436.631267374847;18558.44324670262;17289.82710172882;21369.893150534146;21390.251341202984;21664.458388540414;21896.233631822808;17715.73426398631;17948.730769038215;18127.90936045311;18954.52613684669;19375.612487750448;18244.270229191214;18624.720629190844;18969.715454268473;19393.0303484828;19609.70585441248;16265.105419201584;16293.837061629232;18063.819361806214;18842;18855.434336969913;13068.281244531261;13191.934040329737;13196.20822750638;13418.127821691558;13420;12442.564510242099;12836.486540538273;12838.16551924122;13002.219866808022;13863.237521936391 03:26:44 INFO - PID 9446 | __end_tp_report 03:26:44 INFO - PID 9446 | __start_cc_report 03:26:44 INFO - PID 9446 | _x_x_mozilla_cycle_collect,373 03:26:44 INFO - PID 9446 | __end_cc_report 03:26:44 INFO - PID 9446 | __startTimestamp1499336804862__endTimestamp 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | ------- Summary: start ------- 03:26:44 INFO - PID 9446 | Number of tests: 6 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#0] dojo.html Cycles:165 Average:5873.43 Median:6035.85 stddev:678.82 (11.2%) stddev-sans-first:642.80 03:26:44 INFO - PID 9446 | Values: 3015.2 3052.1 3069.7 3075.6 3080.3 5853.8 5895.0 5975.8 5988.6 6035.8 5843.7 5946.5 5961.8 5981.4 6003.3 5474.9 5487.0 5488.3 5501.5 5516.1 5500.4 5546.2 5552.1 5556.2 5572.4 5537.6 5556.7 5557.9 5559.6 5561.6 5511.3 5525.0 5535.2 5536.9 5539.3 5480.8 5491.0 5501.5 5504.5 5509.1 6000.0 6015.4 6056.5 6075.8 6080.9 6245.8 6400.8 6401.7 6508.0 6514.7 5164.5 6457.4 6464.4 6467.9 6493.8 5998.9 6008.5 6009.6 6073.1 6107.3 6573.2 6582.4 6663.6 6674.2 6692.9 6214.9 6292.5 6304.7 6347.0 6364.9 6301.1 6308.7 6312.1 6319.6 6329.1 6214.2 6273.7 6274.9 6285.5 6311.1 5329.8 6300.7 6334.8 6347.7 6464.0 5144.8 5149.0 5216.8 5221.6 5226.3 4435.3 4441.8 4471.5 4493.1 4498.2 5551.6 5630.2 5630.3 5634.0 5696.8 6435.0 6435.4 6447.6 6448.9 6455.9 5555.7 5592.6 5601.6 5620.6 5629.8 5631.7 5658.5 5660.7 5675.3 5701.5 5031.0 6202.3 6249.1 6257.1 6280.6 6388.2 6389.5 6465.2 6465.7 6482.2 6161.5 6206.4 6216.1 6292.5 6294.5 5936.0 5964.4 5987.1 6017.9 6048.2 6103.6 6110.9 6194.3 6460.8 6548.9 6163.5 6186.4 6236.9 6336.4 6347.6 6171.2 6230.6 6264.1 6295.6 6331.8 5990.9 6188.4 6202.5 6213.0 6260.1 6118.1 6232.6 6277.2 6288.2 6297.7 5949.9 5966.3 5966.5 6000.5 6009.1 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#1] ext.html Cycles:180 Average:37977.56 Median:33951.24 stddev:55474.01 (163.4%) stddev-sans-first:55559.15 03:26:44 INFO - PID 9446 | Values: 734.7 786.2 818.2 833.7 837.4 40076.0 41352.8 41467.4 41545.0 41568.0 37563.4 37648.2 37717.0 37742.6 37817.8 6804.5 6908.7 6910.0 6911.0 6924.9 6803.9 6898.8 6926.4 6927.1 6941.7 6866.7 6876.3 6900.9 6918.9 6930.7 6829.6 6836.5 6843.1 6867.7 6898.7 6098.2 6098.8 6186.4 6187.0 6229.5 33649.0 33753.3 33936.3 33966.2 34062.3 3056.5 3083.1 3136.0 3179.3 3249.1 31785.8 31840.4 31854.5 31869.8 31912.5 4699.6 4847.7 4913.4 5011.8 5049.4 194108.0 198043.0 199732.0 210056.0 210930.0 47047.0 48027.3 48433.0 48433.8 48465.5 50510.0 50801.2 50892.7 51037.2 51298.0 16373.7 16596.3 16620.3 16777.0 16844.7 13724.5 13780.6 13799.4 13847.4 13876.4 14429.3 14533.7 14565.3 14710.3 14728.5 5756.4 5933.8 5960.9 5961.6 5979.3 1000.0 1010.2 1033.8 1037.1 1055.4 23119.8 23271.2 23371.5 23498.5 23623.6 1122.7 1123.3 1140.5 1141.1 1141.5 11819.5 12373.1 12405.1 12462.4 12693.8 242398.0 242418.0 243009.0 243092.0 243377.0 52715.5 53131.0 53259.2 53377.2 53584.7 1417.4 1457.0 1469.5 1475.0 1480.2 21598.9 23086.3 23151.8 23223.0 23395.8 37221.4 37416.4 37568.6 37584.0 37770.4 190634.0 192097.0 192859.0 192888.0 193337.0 31192.5 31498.8 31689.0 31858.0 35226.8 38832.6 43025.6 44313.3 44970.3 45224.5 30224.0 31561.0 31640.5 31882.0 32667.8 31827.7 32003.2 32337.4 34705.8 35412.6 39190.2 39371.6 39453.0 39734.8 40218.0 33248.8 33442.5 34465.0 34585.1 34788.7 24185.3 25005.0 25525.0 25593.4 25620.5 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#2] jquery.html Cycles:180 Average:33295.67 Median:21320.68 stddev:81240.89 (381.0%) stddev-sans-first:81431.61 03:26:44 INFO - PID 9446 | Values: 556.7 562.0 563.4 573.7 588.9 21715.6 22214.2 22713.0 22746.0 22785.0 26515.5 26958.6 27001.6 27164.3 27197.2 6388.5 6553.7 6557.8 6562.7 6583.1 3802.9 6505.9 6579.6 6582.8 6597.1 5302.7 6483.7 6561.4 6561.6 6569.0 6472.2 6503.7 6531.6 6533.7 6544.3 5988.1 6059.7 6060.6 6068.6 6073.1 29049.3 29485.7 30250.7 30600.2 30618.7 1858.9 1915.0 1917.5 1917.8 1921.8 18452.8 18978.0 19010.5 19013.8 19035.3 2269.0 2358.1 2395.3 2396.0 2414.1 116868.0 119896.8 121155.0 121326.4 121662.0 14104.4 14365.7 14430.6 14521.4 14914.3 23410.4 23516.9 23577.3 23679.4 23699.8 10160.3 10375.2 10388.1 10463.2 10487.1 9775.1 9796.4 9832.7 9867.8 9921.2 8320.5 8885.3 8914.2 9006.9 9073.0 2693.5 2720.3 2751.8 2764.4 2818.2 961.6 970.4 976.9 997.6 1010.2 19160.2 19409.3 19541.6 19959.5 20118.6 1046.0 1050.2 1086.7 1092.3 1095.8 10808.5 10827.4 11135.3 11164.3 11251.0 463693.0 477816.0 492725.0 494331.0 498868.0 105600.0 108478.5 115349.4 115468.0 115663.4 1230.6 1267.7 1308.3 1309.9 1317.9 19736.6 20398.1 20738.6 20746.8 20925.8 51992.7 52860.0 52864.5 53009.5 53658.2 62259.4 65267.0 65951.3 66003.3 66398.0 12536.0 13231.1 13311.1 13311.8 13379.0 15341.1 16052.1 16139.9 16213.7 19849.1 12984.6 13126.4 15111.5 16035.6 16327.8 13429.8 13559.1 13682.6 13933.7 14153.4 16168.2 16431.3 16551.8 16689.0 16924.7 12981.1 13031.8 13042.3 13090.5 13092.1 14808.9 16163.7 16201.2 16224.6 16323.8 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#3] mootools.html Cycles:180 Average:8672.36 Median:2643.08 stddev:5800.82 (219.5%) stddev-sans-first:5790.90 03:26:44 INFO - PID 9446 | Values: 1335.9 1399.1 1417.7 1419.8 1420.9 12931.5 13839.1 13863.8 13911.9 13948.6 12850.9 13327.0 13652.7 13661.5 13722.3 2640.1 2697.2 2698.4 2709.6 2717.1 2640.8 2645.3 2668.7 2670.7 2690.8 2611.3 2628.5 2663.7 2670.7 2676.6 2537.3 2664.1 2749.5 2752.4 2753.6 2698.7 2734.7 2735.3 2737.5 2741.6 13726.2 13855.6 13864.1 13869.3 13887.4 7402.4 7691.8 7702.6 7729.3 7771.3 4840.7 4969.6 5106.1 5122.6 5124.3 1825.2 1865.7 1878.7 1930.3 1941.1 22374.4 22402.7 22577.8 22593.9 22614.0 6351.5 6411.8 6443.3 6602.7 6613.7 15422.6 15422.7 15433.6 15483.8 15510.1 7352.3 7610.2 7625.4 7630.9 7640.1 6931.4 7029.7 7036.8 7092.5 7110.4 4688.9 4735.8 4781.1 4783.2 4788.9 1343.2 1352.0 1360.1 1370.7 1380.6 780.8 791.1 791.6 808.9 810.1 7003.4 7113.8 8362.7 8529.9 8652.4 963.0 972.6 988.2 995.3 1007.0 5645.8 5701.3 5797.6 5901.8 5928.2 18725.3 18854.7 19128.4 19176.2 19294.4 17583.2 18905.6 18910.4 18913.3 19046.3 10475.8 10647.8 10739.5 10921.9 10933.6 7867.4 8422.3 8507.4 8588.7 8678.4 16248.4 16278.1 16792.4 16938.2 17021.1 15712.9 16630.8 16904.8 16917.7 17180.6 12676.9 12980.4 13021.7 13036.7 13038.6 12842.9 13007.4 13020.3 13042.8 13097.3 10252.4 10554.0 10670.1 10696.5 10712.8 10132.9 10382.8 10592.6 10856.2 10913.5 9757.5 9778.5 9817.8 9818.5 9870.1 6699.7 6735.2 6841.2 6889.2 6983.5 6861.3 6899.1 7185.6 7431.9 7591.6 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#4] prototype.html Cycles:180 Average:5329.10 Median:5799.17 stddev:1481.14 (25.5%) stddev-sans-first:1440.22 03:26:44 INFO - PID 9446 | Values: 497.8 501.2 519.8 522.8 533.2 5941.7 5988.0 6005.3 6018.0 6030.2 5675.7 5852.4 5863.7 5871.3 5891.8 4844.6 4862.2 4868.9 4873.5 4900.7 4836.0 4847.0 4864.9 4871.5 4882.7 4796.9 4842.5 4844.9 4874.9 4881.5 4627.7 4816.5 4838.3 4851.5 4858.0 4294.9 4296.4 4310.3 4326.4 4336.3 5671.4 5689.3 5746.5 5781.9 5816.5 5475.6 5485.7 5530.5 5534.6 5553.9 6230.9 6232.1 6253.7 6311.9 6328.4 4748.7 4781.5 4789.4 4809.2 4819.8 6622.3 6641.5 6641.5 6665.8 6706.5 4863.3 4893.2 4919.8 4923.8 4946.9 4988.5 5010.7 5019.4 5020.7 5023.0 5457.2 5517.5 5541.5 5551.4 5553.4 6251.3 6306.4 6309.9 6348.8 6372.5 1702.3 1720.8 1720.9 1735.1 1737.4 1104.2 1197.1 1217.2 1219.2 1227.2 5467.6 5582.1 5590.2 5609.1 5691.9 6300.1 6438.6 6471.8 6501.4 6529.5 5533.4 5556.3 5608.3 5617.6 5635.1 3379.9 3407.2 3467.2 3502.5 3512.3 6267.5 6274.2 6319.2 6325.4 6355.5 6622.6 6642.6 6648.7 6677.8 6680.7 6296.6 6309.3 6325.3 6330.5 6366.1 6407.6 6451.5 6483.3 6539.1 6565.5 6469.6 6469.9 6498.2 6501.4 6528.4 6176.3 6191.7 6221.0 6282.8 6384.6 4769.6 4820.4 4854.3 4855.3 4920.8 6453.5 6457.7 6460.9 6515.2 6523.0 6260.7 6301.8 6364.6 6370.3 6376.0 6344.9 6353.3 6372.7 6378.4 6384.2 6199.6 6240.4 6332.4 6340.2 6341.8 6215.4 6232.5 6253.4 6293.7 6346.5 5589.1 6026.9 6070.3 6075.9 6095.9 03:26:44 INFO - PID 9446 | 03:26:44 INFO - PID 9446 | [#5] yui.html Cycles:180 Average:22259.82 Median:19487.56 stddev:29434.22 (151.0%) stddev-sans-first:29472.77 03:26:44 INFO - PID 9446 | Values: 823.2 830.2 849.6 851.9 858.3 17492.5 18231.5 18360.9 18442.3 20357.9 20046.2 20515.7 21053.4 21058.2 21108.5 992.8 1062.9 1068.0 1072.7 1073.8 1055.2 1055.6 1069.7 1069.7 1074.9 1110.2 1111.6 1114.7 1114.9 1118.8 992.3 1029.1 1079.4 1086.8 1101.5 770.7 773.3 774.6 775.0 778.4 17966.6 19175.5 19383.6 19429.1 19483.4 19491.7 19681.3 19908.7 20004.9 20021.2 15739.0 15778.3 15816.3 15852.8 15895.0 3449.2 3558.0 3592.4 3598.6 3608.8 112615.4 113543.0 116902.4 117761.0 119640.0 15347.9 15351.5 15602.5 15639.1 15666.5 26310.2 28519.0 28566.3 28578.3 28951.9 7715.3 8636.3 8807.8 8889.5 8892.2 3570.5 3785.5 4039.2 4042.3 4049.7 4922.1 5005.4 5028.3 5032.7 5080.4 1062.7 1120.1 1129.1 1137.4 1141.1 579.2 579.8 595.9 597.1 614.2 11246.4 11852.7 12533.5 12692.4 12716.8 570.9 576.8 586.8 587.6 603.6 5163.0 5797.9 5856.6 5955.5 6122.5 99767.5 102762.7 103309.0 104332.5 105877.5 87452.0 88115.0 90742.0 91799.0 92663.0 76012.6 78377.6 80159.8 81174.0 81455.0 12066.2 12084.3 12112.7 12228.8 12300.3 34746.0 35314.5 35420.6 36209.3 37198.0 43303.6 59395.4 60052.0 66130.7 67012.7 17931.2 18135.3 18406.1 18436.6 18558.4 17289.8 21369.9 21390.3 21664.5 21896.2 17715.7 17948.7 18127.9 18954.5 19375.6 18244.3 18624.7 18969.7 19393.0 19609.7 16265.1 16293.8 18063.8 18842.0 18855.4 13068.3 13191.9 13196.2 13418.1 13420.0 12442.6 12836.5 12838.2 13002.2 13863.2 03:26:44 INFO - PID 9446 | -------- Summary: end -------- 03:26:44 INFO - PID 9446 | 03:26:45 INFO - TEST-INFO | 9446: exit 0 03:26:45 INFO - TEST-OK | dromaeo_css | took 1113693ms 03:26:45 INFO - TEST-START | kraken 03:26:45 INFO - Initialising browser for kraken test... 03:26:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55457/getInfo.html -profile /tmp/tmpbk5oc8/profile 03:26:45 INFO - TEST-INFO | started process 9871 (/builds/slave/test/build/application/firefox/firefox http://localhost:55457/getInfo.html) 03:26:51 INFO - TEST-INFO | 9871: exit 0 03:26:51 INFO - Browser initialized. 03:26:51 INFO - Running cycle 1/1 for kraken test... 03:26:51 INFO - TEST-INFO | started process 10097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbk5oc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:03 INFO - PID 10097 | RSS: Main: 172904448 03:27:03 INFO - PID 10097 | 03:27:05 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55457/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:06 INFO - PID 10097 | RSS: Main: 176406528 03:27:06 INFO - PID 10097 | 03:27:09 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55457/tests/kraken/driver.html?testName=audio-dft) 03:27:10 INFO - PID 10097 | RSS: Main: 177037312 03:27:10 INFO - PID 10097 | 03:27:12 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55457/tests/kraken/driver.html?testName=audio-fft) 03:27:13 INFO - PID 10097 | RSS: Main: 172617728 03:27:13 INFO - PID 10097 | 03:27:15 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55457/tests/kraken/driver.html?testName=audio-oscillator) 03:27:16 INFO - PID 10097 | RSS: Main: 173219840 03:27:16 INFO - PID 10097 | 03:27:18 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55457/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:19 INFO - PID 10097 | RSS: Main: 173363200 03:27:19 INFO - PID 10097 | 03:27:22 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55457/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:22 INFO - PID 10097 | RSS: Main: 177360896 03:27:22 INFO - PID 10097 | 03:27:26 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55457/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:26 INFO - PID 10097 | RSS: Main: 178012160 03:27:26 INFO - PID 10097 | 03:27:29 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55457/tests/kraken/driver.html?testName=json-parse-financial) 03:27:30 INFO - PID 10097 | RSS: Main: 178147328 03:27:30 INFO - PID 10097 | 03:27:31 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55457/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:32 INFO - PID 10097 | RSS: Main: 177119232 03:27:32 INFO - PID 10097 | 03:27:34 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:34 INFO - PID 10097 | RSS: Main: 177160192 03:27:34 INFO - PID 10097 | 03:27:36 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:37 INFO - PID 10097 | RSS: Main: 177225728 03:27:37 INFO - PID 10097 | 03:27:40 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:40 INFO - PID 10097 | RSS: Main: 176926720 03:27:40 INFO - PID 10097 | 03:27:43 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:44 INFO - PID 10097 | RSS: Main: 177045504 03:27:44 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | Cycle 1(1): loaded http://localhost:55457/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55457/tests/kraken/driver.html?testName=ai-astar) 03:27:46 INFO - PID 10097 | RSS: Main: 178671616 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | __start_tp_report 03:27:46 INFO - PID 10097 | _x_x_mozilla_page_load 03:27:46 INFO - PID 10097 | _x_x_mozilla_page_load_details 03:27:46 INFO - PID 10097 | |i|pagename|runs| 03:27:46 INFO - PID 10097 | |0;ai-astar;102;109;108;109;109;109;111;111;109;109 03:27:46 INFO - PID 10097 | |1;audio-beat-detection;157;121;155;196;127;152;153;127;165;122 03:27:46 INFO - PID 10097 | |2;audio-dft;164;165;161;163;164;164;162;165;170;168 03:27:46 INFO - PID 10097 | |3;audio-fft;77;75;74;173;76;77;77;76;96;75 03:27:46 INFO - PID 10097 | |4;audio-oscillator;82;81;127;82;82;81;130;81;81;129 03:27:46 INFO - PID 10097 | |5;imaging-gaussian-blur;114;113;114;114;113;113;114;114;114;113 03:27:46 INFO - PID 10097 | |6;imaging-darkroom;151;150;149;152;151;151;149;151;151;150 03:27:46 INFO - PID 10097 | |7;imaging-desaturate;95;94;96;94;94;94;94;94;94;94 03:27:46 INFO - PID 10097 | |8;json-parse-financial;57;56;57;55;59;55;55;55;59;58 03:27:46 INFO - PID 10097 | |9;json-stringify-tinderbox;54;54;55;54;54;54;58;54;54;54 03:27:46 INFO - PID 10097 | |10;stanford-crypto-aes;79;78;82;80;80;80;77;77;90;79 03:27:46 INFO - PID 10097 | |11;stanford-crypto-ccm;134;129;136;128;127;126;123;127;130;153 03:27:46 INFO - PID 10097 | |12;stanford-crypto-pbkdf2;181;188;182;180;192;183;183;186;177;182 03:27:46 INFO - PID 10097 | |13;stanford-crypto-sha256-iterative;69;75;69;68;70;69;69;74;69;69 03:27:46 INFO - PID 10097 | __end_tp_report 03:27:46 INFO - PID 10097 | __start_cc_report 03:27:46 INFO - PID 10097 | _x_x_mozilla_cycle_collect,934 03:27:46 INFO - PID 10097 | __end_cc_report 03:27:46 INFO - PID 10097 | __startTimestamp1499336866505__endTimestamp 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | ------- Summary: start ------- 03:27:46 INFO - PID 10097 | Number of tests: 14 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:2.50 (2.3%) stddev-sans-first:1.00 03:27:46 INFO - PID 10097 | Values: 102.0 109.0 108.0 109.0 109.0 109.0 111.0 111.0 109.0 109.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:154.00 stddev:23.68 (15.4%) stddev-sans-first:24.87 03:27:46 INFO - PID 10097 | Values: 157.0 121.0 155.0 196.0 127.0 152.0 153.0 127.0 165.0 122.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.83 03:27:46 INFO - PID 10097 | Values: 164.0 165.0 161.0 163.0 164.0 164.0 162.0 165.0 170.0 168.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#3] audio-fft Cycles:10 Average:87.60 Median:76.50 stddev:30.68 (40.1%) stddev-sans-first:32.30 03:27:46 INFO - PID 10097 | Values: 77.0 75.0 74.0 173.0 76.0 77.0 77.0 76.0 96.0 75.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:81.00 stddev:22.83 (28.2%) stddev-sans-first:23.68 03:27:46 INFO - PID 10097 | Values: 82.0 81.0 127.0 82.0 82.0 81.0 130.0 81.0 81.0 129.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:27:46 INFO - PID 10097 | Values: 114.0 113.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 113.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 03:27:46 INFO - PID 10097 | Values: 151.0 150.0 149.0 152.0 151.0 151.0 149.0 151.0 151.0 150.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:27:46 INFO - PID 10097 | Values: 95.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.65 (2.9%) stddev-sans-first:1.74 03:27:46 INFO - PID 10097 | Values: 57.0 56.0 57.0 55.0 59.0 55.0 55.0 55.0 59.0 58.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:1.27 (2.4%) stddev-sans-first:1.33 03:27:46 INFO - PID 10097 | Values: 54.0 54.0 55.0 54.0 54.0 54.0 58.0 54.0 54.0 54.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:3.77 (4.7%) stddev-sans-first:3.97 03:27:46 INFO - PID 10097 | Values: 79.0 78.0 82.0 80.0 80.0 80.0 77.0 77.0 90.0 79.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.50 stddev:8.51 (6.6%) stddev-sans-first:8.97 03:27:46 INFO - PID 10097 | Values: 134.0 129.0 136.0 128.0 127.0 126.0 123.0 127.0 130.0 153.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:183.00 stddev:4.27 (2.3%) stddev-sans-first:4.44 03:27:46 INFO - PID 10097 | Values: 181.0 188.0 182.0 180.0 192.0 183.0 183.0 186.0 177.0 182.0 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.00 stddev:2.38 (3.4%) stddev-sans-first:2.49 03:27:46 INFO - PID 10097 | Values: 69.0 75.0 69.0 68.0 70.0 69.0 69.0 74.0 69.0 69.0 03:27:46 INFO - PID 10097 | -------- Summary: end -------- 03:27:46 INFO - PID 10097 | 03:27:46 INFO - PID 10097 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:27:47 INFO - TEST-INFO | 10097: exit 0 03:27:47 INFO - TEST-OK | kraken | took 61793ms 03:27:47 INFO - SUITE-END | took 1175s 03:27:47 INFO - Completed test suite (00:19:35) 03:27:47 INFO - javascript benchmark 03:27:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8234.154448940204, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.20097174249, 3052.0996306089714, 3069.6776838431965, 3075.600171977643, 3080.291532947422, 5853.765849366026, 5895.0, 5975.760969561213, 5988.550858685594, 6035.849103772413, 5843.737031833567, 5946.494547963428, 5961.791337303195, 5981.431763982415, 6003.339632640406, 5474.91787623186, 5486.972565137189, 5488.286522752057, 5501.504864562188, 5516.062269414189, 5500.3949565547955, 5546.223528705985, 5552.11166213406, 5556.222128901957, 5572.359178694442, 5537.640053396536, 5556.749946252408, 5557.944420555783, 5559.63862348946, 5561.555075593963, 5511.338639363262, 5525.0, 5535.169724541351, 5536.944630553683, 5539.25220095288, 5480.7533660985355, 5491.0, 5501.477359650827, 5504.504594586467, 5509.090999984997, 5999.970000149971, 6015.368386319461, 6056.4851987581105, 6075.756969721206, 6080.878382432326, 6245.812625621194, 6400.775972840928, 6401.743930242785, 6508.0, 6514.739410423577, 5164.528109488778, 6457.3865482779065, 6464.353564643498, 6467.902981455282, 6493.837654058639, 5998.940010599882, 6008.519318454513, 6009.579329446897, 6073.1497590337385, 6107.328193898667, 6573.211214654272, 6582.44049255809, 6663.6001839888795, 6674.16572928384, 6692.933070669328, 6214.937850621526, 6292.4966002719675, 6304.65324407162, 6346.9682651586445, 6364.936350636434, 6301.054841773771, 6308.7476500940365, 6312.116303717483, 6319.55763096588, 6329.145565348711, 6214.161088253119, 6273.749050037947, 6274.874502510015, 6285.465735412449, 6311.084892690534, 5329.822781107006, 6300.747970081237, 6334.8416289592205, 6347.682615869188, 6464.0, 5144.819931302386, 5149.0474262261605, 5216.7913283469, 5221.634485586049, 5226.320578324793, 4435.312526558324, 4441.800118994653, 4471.463424389094, 4493.1013797240685, 4498.212812757754, 5551.639143455663, 5630.211770352154, 5630.324361076697, 5634.0, 5696.829095127153, 6435.034744788226, 6435.4208121268375, 6447.6131432114225, 6448.871022579522, 6455.903161452582, 5555.722213889289, 5592.552595792326, 5601.579881508822, 5620.606557541015, 5629.831105066773, 5631.690257035821, 5658.490735833712, 5660.745266462936, 5675.262215911905, 5701.486866182064, 5030.974845125751, 6202.255729312421, 6249.062640603855, 6257.124002639634, 6280.5603607747935, 6388.233411990591, 6389.48884089281, 6465.224173099258, 6465.676716164267, 6482.222133344029, 6161.507079433724, 6206.410391012847, 6216.067589861557, 6292.4966002720585, 6294.464970477561, 5935.970320148372, 5964.433378829004, 5987.072003839412, 6017.939820601738, 6048.183495228088, 6103.6032657877095, 6110.908336375047, 6194.349593292639, 6460.773872914426, 6548.869022619426, 6163.506919446523, 6186.381361863778, 6236.937630623817, 6336.398042185985, 6347.587406818542, 6171.228596425447, 6230.626162430269, 6264.123022776724, 6295.559310848196, 6331.841703957438, 5990.850228744316, 6188.44304012641, 6202.472789812736, 6213.0, 6260.123582698517, 6118.143459915705, 6232.5637205397, 6277.2153480814895, 6288.245410550763, 6297.740451909544, 5949.910751338647, 5966.313873904556, 5966.49284810796, 6000.51995840323, 6009.098635204754], "value": 5825.522474713559, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6987735028639, 786.1784435265147, 818.1859050245006, 833.6915341323711, 837.417994493827, 40076.0, 41352.793236033816, 41467.37798933018, 41545.0, 41567.960800979956, 37563.436548451726, 37648.247035059285, 37717.0, 37742.62257377426, 37817.810910945474, 6804.455643548529, 6908.6545672716165, 6909.965450172742, 6910.965445172767, 6924.861502769942, 6803.897941530881, 6898.827529311757, 6926.411255043327, 6927.064846245743, 6941.652917354138, 6866.725330986755, 6876.346747059021, 6900.861982760342, 6918.861622767542, 6930.688119034656, 6829.624370659587, 6836.4530837533375, 6843.110395648584, 6867.656617169147, 6898.655067246643, 6098.237720284965, 6098.847528811771, 6186.412290832363, 6186.969065154691, 6229.501639868799, 33649.0, 33753.32493350144, 33936.321273574635, 33966.1508462288, 34062.318753624786, 3056.495678213092, 3083.1213104265403, 3136.027831372282, 3179.2687681833077, 3249.138978170763, 31785.84107079473, 31840.363192736015, 31854.522182167286, 31869.84065079683, 31912.521312180335, 4699.600533954618, 4847.733374664392, 4913.434954980187, 5011.774470148852, 5049.444561098277, 194108.0, 198043.0, 199732.00133999382, 210056.0, 210930.0, 47047.0, 48027.27959080617, 48433.0, 48433.75783121062, 48465.515344846805, 50510.0, 50801.237981430306, 50892.74553627208, 51037.23444148341, 51297.97404051973, 16373.67252654964, 16596.25316860744, 16620.252088655798, 16777.0, 16844.663106737797, 13724.519641812489, 13780.586582402344, 13799.379027943767, 13847.376868040963, 13876.4449422024, 14429.278536073154, 14533.709325813636, 14565.344559494848, 14710.33803478846, 14728.484503042342, 5756.42435756421, 5933.821985340447, 5960.910586341209, 5961.577835594712, 5979.252593425822, 999.9700008999741, 1010.1918465227789, 1033.813913495578, 1037.1495373793568, 1055.4036969112426, 23119.768802312097, 23271.185508507122, 23371.53256934886, 23498.530029399317, 23623.645645315333, 1122.7193201699574, 1123.27548731068, 1140.520981187903, 1141.0757286597882, 1141.520561364229, 11819.527218911147, 12373.072019598567, 12405.131640785059, 12462.376881155906, 12693.809592856114, 242398.0, 242418.0, 243009.0, 243092.0, 243377.0, 52715.472845271055, 53131.0, 53259.20111198335, 53377.1993420099, 53584.732076339365, 1417.3551034279378, 1456.978145327821, 1469.5077149154938, 1474.9778753318924, 1480.2080886725767, 21598.89200553987, 23086.307410777703, 23151.76848231496, 23222.954967026188, 23395.766042339357, 37221.44167837431, 37416.43875341817, 37568.62431375651, 37584.0, 37770.43344349782, 190634.0, 192097.0, 192859.0, 192888.0, 193337.0, 31192.53211201879, 31498.842505787325, 31689.0, 31858.04425867228, 35226.823865880506, 38832.6116738829, 43025.569744302156, 44313.33529996988, 44970.325445119, 45224.547754522035, 30224.0, 31561.0, 31640.525392118678, 31882.043538693877, 32667.836660816545, 31827.68172318247, 32003.199920002186, 32337.35325293434, 34705.82647086748, 35412.645873541966, 39190.216195675355, 39371.60628393794, 39453.0, 39734.80132599318, 40218.0, 33248.77971895333, 33442.49836252507, 34465.0, 34585.135371615914, 34788.652113479555, 24185.316450633734, 25005.0, 25525.0, 25593.360165996, 25620.487590247718], "value": 16864.494139695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.7132926542831, 561.9719014049297, 563.4393778190699, 573.6787399056532, 588.9057750759878, 21715.565688686238, 22214.222502212426, 22713.0, 22745.952864242234, 22785.0, 26515.469690606176, 26958.5956210657, 27001.594976075325, 27164.32089197771, 27197.18408447745, 6388.520860935437, 6553.672316384185, 6557.77047803327, 6562.671866406685, 6583.07836902834, 3802.9429558556503, 6505.869882602345, 6579.572327798702, 6582.802515924506, 6597.109390232329, 5302.734863256841, 6483.740650373979, 6561.409473147416, 6561.606303621798, 6568.967155164218, 6472.190976127984, 6503.739850406026, 6531.640759758211, 6533.673316334188, 6544.312847151028, 5988.131720900488, 6059.7273122709585, 6060.575759696823, 6068.605540639845, 6073.058675905242, 29049.273768155756, 29485.70514294851, 30250.697493025007, 30600.2349941251, 30618.693813061807, 1858.9070546472622, 1915.0233380975803, 1917.549375896677, 1917.8178073083034, 1921.8174273444001, 18452.815471845242, 18978.0, 19010.52473688155, 19013.809861901344, 19035.333763318216, 2268.965965510519, 2358.0921345282018, 2395.2574701842486, 2396.0, 2414.1429792423787, 116868.0, 119896.80103198944, 121155.0, 121326.39336803347, 121662.0, 14104.403377138764, 14365.712685746226, 14430.556944305485, 14521.419143234152, 14914.254287285808, 23410.414739631644, 23516.882415587814, 23577.29268121959, 23679.408014799425, 23699.763002370102, 10160.33957792741, 10375.16998640107, 10388.11701005423, 10463.215258855616, 10487.067349743846, 9775.120239178508, 9796.363236389612, 9832.705018849447, 9867.753306167404, 9921.156701680293, 8320.459170153921, 8885.333599979898, 8914.153155450222, 9006.86489702655, 9072.95463522678, 2693.501702185102, 2720.34711669198, 2751.834889906612, 2764.4194719109214, 2818.168640251131, 961.6105477281712, 970.4371464550544, 976.8974257702981, 997.6059456514636, 1010.2120346130031, 19160.233590656495, 19409.32067377635, 19541.609167816565, 19959.501012474804, 20118.59762804765, 1046.0, 1050.1598721023151, 1086.7337502311825, 1092.3282181458346, 1095.7863216672831, 10808.51361688726, 10827.350358978329, 11135.276207046516, 11164.274322169033, 11251.0, 463693.0, 477816.0, 492725.0, 494331.0, 498868.0, 105600.0, 108478.45760771146, 115349.42325288319, 115468.0, 115663.42168289104, 1230.5816022552376, 1267.7211013576998, 1308.3131356037966, 1309.9148555343872, 1317.8616245294106, 19736.605267894847, 20398.11388325195, 20738.585228295047, 20746.79253207509, 20925.79074209299, 51992.74003630109, 52860.0, 52864.471355285954, 53009.46990530045, 53658.195127072344, 62259.37740622536, 65267.0, 65951.34048659644, 66003.33996659971, 66398.0, 12536.0, 13231.073824832169, 13311.068225224142, 13311.800322995357, 13378.9965752567, 15341.079535227922, 16052.117133557766, 16139.919300403422, 16213.67572648564, 19849.106790194186, 12984.63661315586, 13126.409311581192, 15111.54665360041, 16035.599110022344, 16327.836721633106, 13429.798553021908, 13559.118657287245, 13682.589522314347, 13933.651658708613, 14153.43386264538, 16168.191590420196, 16431.26059327357, 16551.83448165503, 16689.0, 16924.746128808325, 12981.091323607257, 13031.804522931974, 13042.282674452617, 13090.476380945036, 13092.149010314299, 14808.851911481179, 16163.67672646564, 16201.189940503164, 16224.594385140466, 16323.755143672617], "value": 11498.301144665335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.9465621375145, 1399.0836002418414, 1417.7377185220735, 1419.7941298511723, 1420.9307894946917, 12931.547395841135, 13839.100458470193, 13863.82157516611, 13911.860881391183, 13948.581542553715, 12850.871491285085, 13327.000474964369, 13652.658683532916, 13661.521846735366, 13722.313884305795, 2640.1419538649966, 2697.2447714639934, 2698.433329000912, 2709.552923767586, 2717.1440996086267, 2640.8415495070262, 2645.31221882311, 2668.7064422913463, 2670.65281513403, 2690.7847372210276, 2611.294950363401, 2628.5137249608883, 2663.706992230853, 2670.6661667291587, 2676.625272461857, 2537.3402915242077, 2664.1208401227645, 2749.463854548364, 2752.4357506711076, 2753.6420265365573, 2698.6761588609297, 2734.7128551502005, 2735.3435175557725, 2737.452509498108, 2741.6024676421807, 13726.176429414267, 13855.584332469942, 13864.098833575785, 13869.306534673327, 13887.44450222, 7402.407807375451, 7691.846163076763, 7702.576358300291, 7729.304362607336, 7771.339436147934, 4840.709557426566, 4969.568985267586, 5106.08090543702, 5122.564582010534, 5124.282600435905, 1825.187791432813, 1865.6735071362457, 1878.690016147334, 1930.3436831477225, 1941.0779879557097, 22374.440638983993, 22402.66396004045, 22577.774222257733, 22593.887030564907, 22614.0, 6351.460125889351, 6411.775587854403, 6443.259025212067, 6602.669866506655, 6613.735450582019, 15422.614434639223, 15422.691546169013, 15433.614159646098, 15483.767743483857, 15510.146941918303, 7352.301531354513, 7610.1628820829665, 7625.351845093229, 7630.8855367169535, 7640.083190017233, 6931.4108300795, 7029.718811247493, 7036.788896333118, 7092.4680648951535, 7110.3600675939415, 4688.859334219979, 4735.763211839394, 4781.11549363362, 4783.210770222944, 4788.904221915543, 1343.1605246720799, 1351.9526816561372, 1360.1091285208204, 1370.6778906956856, 1380.6272306477194, 780.7969927818808, 791.0783936713664, 791.6041979010495, 808.9271965523131, 810.1493431896486, 7003.369696727319, 7113.786586402416, 8362.665493380318, 8529.872051919227, 8652.437591556529, 962.9614815407446, 972.5769290358717, 988.1551273661061, 995.2535598301274, 1007.0433088565892, 5645.774169033192, 5701.287339082614, 5797.623154494944, 5901.793437229762, 5928.170056192051, 18725.25098996025, 18854.71717924232, 19128.426147215327, 19176.232950681817, 19294.421167365002, 17583.20875560603, 18905.621887562447, 18910.432687019413, 18913.338033168773, 19046.33337833197, 10475.790484190426, 10647.787044259072, 10739.463026848782, 10921.890781092088, 10933.617323393642, 7867.409944254089, 8422.326213902996, 8507.361947854059, 8588.65645374178, 8678.435901666371, 16248.3500659977, 16278.104704240906, 16792.412265570645, 16938.237779299714, 17021.148942552576, 15712.92143539275, 16630.750538741686, 16904.83095169082, 16917.746233806258, 17180.570485737957, 12676.87323126757, 12980.350982450651, 13021.739565208833, 13036.674083147996, 13038.608841734764, 12842.935785321013, 13007.414666339848, 13020.28388438607, 13042.804357934448, 13097.345132743134, 10252.43611601369, 10554.0, 10670.146388288764, 10696.465176740976, 10712.839307410239, 10132.949335253572, 10382.792344153226, 10592.576296948344, 10856.240063195817, 10913.454327283764, 9757.51212439361, 9778.462184579916, 9817.803643926938, 9818.509074546388, 9870.111689947938, 6699.732010719516, 6735.158105236846, 6841.21326047491, 6889.207741109636, 6983.476239282176, 6861.2795656455355, 6899.103116594811, 7185.640717964186, 7431.888521672287, 7591.620418978919], "value": 6357.037475463146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.78043792707854, 501.23065578507857, 519.7868873761757, 522.7934965688555, 533.2401328107449, 5941.702914854256, 5988.0, 6005.309389420218, 6018.037114061751, 6030.185924900137, 5675.716214189295, 5852.356240813507, 5863.706814659261, 5871.324797648272, 5891.792182602567, 4844.636652251095, 4862.2463518154655, 4868.878278043042, 4873.48828373021, 4900.681455705386, 4836.0, 4846.957904050629, 4864.878378040542, 4871.464138944713, 4882.658213925027, 4796.928046079312, 4842.539958703917, 4844.854654360357, 4874.8537543873745, 4881.536254055877, 4627.699199552018, 4816.54242846929, 4838.250071238964, 4851.466338702722, 4857.9757101214445, 4294.935575966363, 4296.355546667994, 4310.31035034393, 4326.437563116775, 4336.306191009423, 5671.404502527258, 5689.317281926154, 5746.454086861783, 5781.855453613652, 5816.47651711348, 5475.589330800166, 5485.670859748428, 5530.5022547970475, 5534.584906132016, 5553.944460555384, 6230.906536401958, 6232.13036089176, 6253.687315634245, 6311.93688063118, 6328.430441260309, 4748.738819364934, 4781.545753153479, 4789.449213340441, 4809.206480930642, 4819.759012049419, 6622.344413896526, 6641.5018873584195, 6641.535092543524, 6665.8000259991795, 6706.497012724065, 4863.270509423614, 4893.168161412568, 4919.7540122993705, 4923.803047878117, 4946.851594452172, 4988.451270360258, 5010.67430617016, 5019.3976722793495, 5020.673656212334, 5022.9748851256245, 5457.2359869618285, 5517.531009864127, 5541.501264886179, 5551.3893471718075, 5553.361363443175, 6251.28110267316, 6306.369363063657, 6309.905351419732, 6348.809535713936, 6372.458341041063, 1702.3190723710368, 1720.8365205305477, 1720.931162753501, 1735.0630659444012, 1737.3658614605831, 1104.2049724198725, 1197.0961923747689, 1217.2392254840724, 1219.195331081482, 1227.1961864978452, 5467.633091727068, 5582.106862901916, 5590.217369568264, 5609.1305847593685, 5691.886162276731, 6300.141458269822, 6438.645874476855, 6471.805845824632, 6501.4148726613885, 6529.477641788645, 5533.418991005887, 5556.333240011225, 5608.327000759935, 5617.612514681244, 5635.070213414822, 3379.8648054078053, 3407.1822762536813, 3467.2025434150287, 3502.4571191465366, 3512.2799826035603, 6267.4986001119805, 6274.215723034621, 6319.24169099711, 6325.367463253638, 6355.491560675135, 6622.635755033423, 6642.575459957081, 6648.739428594205, 6677.797996360701, 6680.665966701646, 6296.590721603081, 6309.305976342691, 6325.272593651697, 6330.525210609223, 6366.140571022946, 6407.647579383179, 6451.48388128958, 6483.299607784507, 6539.149910511603, 6565.474762019123, 6469.611823290617, 6469.902951455638, 6498.220213574401, 6501.414872661294, 6528.37980391862, 6176.282435728265, 6191.659458729633, 6221.0, 6282.780102696383, 6384.585001974857, 4769.640652414184, 4820.39745031871, 4854.320395144753, 4855.2717092435005, 4920.803167873245, 6453.548251622529, 6457.741690332334, 6460.935390646221, 6515.218173819172, 6522.967385163044, 6260.655663938345, 6301.842453938688, 6364.554481186273, 6370.299267080525, 6375.968120159555, 6344.936550634435, 6353.301136875032, 6372.681365931778, 6378.362163783585, 6384.170057892445, 6199.628022318675, 6240.375962403905, 6332.353588067228, 6340.239171299474, 6341.841453963503, 6215.446138465383, 6232.470240029648, 6253.37466253371, 6293.653849038347, 6346.50857048584, 5589.133684278943, 6026.879462410815, 6070.268379229453, 6075.908861366995, 6095.878082438415], "value": 4898.422409230313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.1727114250185, 830.1615368477837, 849.5539841583168, 851.948883067016, 858.2533196119377, 17492.475225743234, 18231.544211394707, 18360.908195459022, 18442.262309507638, 20357.898210508927, 20046.198152073935, 20515.692264616042, 21053.368398948056, 21058.157673693073, 21108.472288192763, 992.8163289791376, 1062.9468526573678, 1068.0, 1072.6835583502886, 1073.849661047454, 1055.2033214922722, 1055.6147006342705, 1069.6844430892904, 1069.7272195590115, 1074.9462526873665, 1110.2228440091928, 1111.644273832374, 1114.6656003199007, 1114.9052330551913, 1118.82658187981, 992.3153024413168, 1029.0841151375282, 1079.4494807648077, 1086.8424078508651, 1101.493313075982, 770.684019551981, 773.2963003666692, 774.5817258680306, 774.9883751743729, 778.3656320099158, 17966.550836229067, 19175.520611984673, 19383.612327753508, 19429.125689344015, 19483.415497535098, 19491.707624385646, 19681.31115410968, 19908.70136947947, 20004.89997550003, 20021.1991520339, 15739.0, 15778.28997695095, 15816.28826702801, 15852.76220856688, 15895.0, 3449.1549570355173, 3558.021544075374, 3592.4252119660728, 3598.6401359864067, 3608.8195590220384, 112615.43692281569, 113543.0, 116902.41548792287, 117761.0, 119639.99999999913, 15347.923260383626, 15351.539453816404, 15602.531924042298, 15639.139847308506, 15666.451674191349, 26310.21069367922, 28519.0, 28566.28584285368, 28578.28554286118, 28951.855240724082, 7715.344195743312, 8636.309095272363, 8807.823843523094, 8889.4666320021, 8892.199702026848, 3570.5001299818045, 3785.507883975121, 4039.2123535910805, 4042.3330150524835, 4049.6760259179196, 4922.064807686528, 5005.374328208974, 5028.321176641107, 5032.72320022395, 5080.415752188472, 1062.654637242899, 1120.075937351688, 1129.1362107987395, 1137.4426530999751, 1141.0928311991986, 579.1891352107, 579.7999690106907, 595.9165716799652, 597.1252115650593, 614.1984709953464, 11246.437678116225, 11852.70368240801, 12533.498660053678, 12692.365381730877, 12716.809247861289, 570.8782589702342, 576.762843700269, 586.7506309818395, 587.6180482686202, 603.5805115444724, 5162.993216322856, 5797.88404231913, 5856.575295973174, 5955.464008239279, 6122.510199184055, 99767.50116249372, 102762.7342833621, 103309.0, 104332.47833760934, 105877.47061264644, 87452.0, 88115.0, 90742.0, 91799.0, 92663.0, 76012.61993689997, 78377.60811195908, 80159.797603036, 81174.0, 81455.0, 12066.215695979734, 12084.274943503418, 12112.70829290635, 12228.755424891275, 12300.261984280973, 34746.0, 35314.47028294629, 35420.64579354277, 36209.27581448409, 37198.0, 43303.566964331214, 59395.40604593899, 60052.0, 66130.66934665489, 67012.664936675, 17931.193096310435, 18135.27458901629, 18406.079696014876, 18436.631267374847, 18558.44324670262, 17289.82710172882, 21369.893150534146, 21390.251341202984, 21664.458388540414, 21896.233631822808, 17715.73426398631, 17948.730769038215, 18127.90936045311, 18954.52613684669, 19375.612487750448, 18244.270229191214, 18624.720629190844, 18969.715454268473, 19393.0303484828, 19609.70585441248, 16265.105419201584, 16293.837061629232, 18063.819361806214, 18842.0, 18855.434336969913, 13068.281244531261, 13191.934040329737, 13196.20822750638, 13418.127821691558, 13420.0, 12442.564510242099, 12836.486540538273, 12838.16551924122, 13002.219866808022, 13863.237521936391], "value": 8859.996827082043, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 108.0, 109.0, 109.0, 109.0, 111.0, 111.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 155.0, 196.0, 127.0, 152.0, 153.0, 127.0, 165.0, 122.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 163.0, 164.0, 164.0, 162.0, 165.0, 170.0, 168.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 173.0, 76.0, 77.0, 77.0, 76.0, 96.0, 75.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 127.0, 82.0, 82.0, 81.0, 130.0, 81.0, 81.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 152.0, 151.0, 151.0, 149.0, 151.0, 151.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 55.0, 59.0, 55.0, 55.0, 55.0, 59.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 58.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 82.0, 80.0, 80.0, 80.0, 77.0, 77.0, 90.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 136.0, 128.0, 127.0, 126.0, 123.0, 127.0, 130.0, 153.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 182.0, 180.0, 192.0, 183.0, 183.0, 186.0, 177.0, 182.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 69.0, 68.0, 70.0, 69.0, 69.0, 74.0, 69.0, 69.0], "value": 70.1, "unit": "score"}]}]} 03:27:47 INFO - Return code: 0 03:27:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:47 INFO - # TBPL SUCCESS # 03:27:47 INFO - Running post-action listener: _package_coverage_data 03:27:47 INFO - Running post-action listener: _resource_record_post_action 03:27:47 INFO - [mozharness: 2017-07-06 10:27:47.764036Z] Finished run-tests step (success) 03:27:47 INFO - Running post-run listener: _resource_record_post_run 03:27:47 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 436023296; Read time: 520; Write time: 555160 03:27:47 INFO - TinderboxPrint: CPU usage
13.2% 03:27:47 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 520 03:27:47 INFO - TinderboxPrint: I/O write bytes / time
436,023,296 / 555,160 03:27:47 INFO - TinderboxPrint: CPU idle
8,268.4 (86.8%) 03:27:47 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 03:27:47 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106717184; Read time: 64; Write time: 177172 03:27:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:27:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 328183808; Read time: 440; Write time: 377948 03:27:48 INFO - Running post-run listener: _upload_blobber_files 03:27:48 INFO - Blob upload gear active. 03:27:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:48 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 03:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:27:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:49 INFO - (blobuploader) - INFO - Done attempting. 03:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:51 INFO - (blobuploader) - INFO - Done attempting. 03:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:54 INFO - (blobuploader) - INFO - Done attempting. 03:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:54 INFO - (blobuploader) - INFO - Done attempting. 03:27:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:54 INFO - Return code: 0 03:27:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6d57760c5df1145484cd6a989e5a6c9aea1261ebb76d305a6262a7820726d33b75a7757a7f7597e8bd6eefc005cc38322027bfc693c990a32dfc10f927a211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf6e434797a1b4d8854ae2e0ff965c3f932d4b462d2c95bb38011493c2f6f046fb5b4a6f1990e3de29bac3dcf7e392f20217f8ea6646995f14c66dc2ff65da08", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881daa3836d5168eb6ec8ceca14388f76c5c0ed8a489b1f0565016a2bfbf78c6d85a5b44ce08d11ac98e152a5446526fbf30ca126444c07c526a3310abf9be5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e281ef0477517616290fee9402c5ee94a66916840f39636ade3be73f79e94b39e37a5275e39720d92c11cd00fa9b73265133796e2b86f6a3177893ac391568b3"} 03:27:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:54 INFO - Contents: 03:27:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6d57760c5df1145484cd6a989e5a6c9aea1261ebb76d305a6262a7820726d33b75a7757a7f7597e8bd6eefc005cc38322027bfc693c990a32dfc10f927a211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf6e434797a1b4d8854ae2e0ff965c3f932d4b462d2c95bb38011493c2f6f046fb5b4a6f1990e3de29bac3dcf7e392f20217f8ea6646995f14c66dc2ff65da08", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881daa3836d5168eb6ec8ceca14388f76c5c0ed8a489b1f0565016a2bfbf78c6d85a5b44ce08d11ac98e152a5446526fbf30ca126444c07c526a3310abf9be5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e281ef0477517616290fee9402c5ee94a66916840f39636ade3be73f79e94b39e37a5275e39720d92c11cd00fa9b73265133796e2b86f6a3177893ac391568b3"} 03:27:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:54 INFO - Copying logs to upload dir... 03:27:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.088419 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-06 03:27:54.815237) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-06 03:27:54.824247) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6d57760c5df1145484cd6a989e5a6c9aea1261ebb76d305a6262a7820726d33b75a7757a7f7597e8bd6eefc005cc38322027bfc693c990a32dfc10f927a211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf6e434797a1b4d8854ae2e0ff965c3f932d4b462d2c95bb38011493c2f6f046fb5b4a6f1990e3de29bac3dcf7e392f20217f8ea6646995f14c66dc2ff65da08", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881daa3836d5168eb6ec8ceca14388f76c5c0ed8a489b1f0565016a2bfbf78c6d85a5b44ce08d11ac98e152a5446526fbf30ca126444c07c526a3310abf9be5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e281ef0477517616290fee9402c5ee94a66916840f39636ade3be73f79e94b39e37a5275e39720d92c11cd00fa9b73265133796e2b86f6a3177893ac391568b3"} build_url:https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/BG5iXpesRiGnUepGQ4t3oA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6d57760c5df1145484cd6a989e5a6c9aea1261ebb76d305a6262a7820726d33b75a7757a7f7597e8bd6eefc005cc38322027bfc693c990a32dfc10f927a211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf6e434797a1b4d8854ae2e0ff965c3f932d4b462d2c95bb38011493c2f6f046fb5b4a6f1990e3de29bac3dcf7e392f20217f8ea6646995f14c66dc2ff65da08", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/881daa3836d5168eb6ec8ceca14388f76c5c0ed8a489b1f0565016a2bfbf78c6d85a5b44ce08d11ac98e152a5446526fbf30ca126444c07c526a3310abf9be5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e281ef0477517616290fee9402c5ee94a66916840f39636ade3be73f79e94b39e37a5275e39720d92c11cd00fa9b73265133796e2b86f6a3177893ac391568b3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-06 03:27:54.848200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:27:54.848497) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1499322886.949748-305397268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 03:27:54.933870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-06 03:27:54.934191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-06 03:27:54.934501) ========= ========= Total master_lag: 0.31 =========