builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1496048712.52 results: success (0) revision: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.522453) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.523204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.523499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.577198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.577454) ========= 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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-29 02:05:13-- 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% 40.1M=0s 2017-05-29 02:05:13 (40.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.699431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.702738) ========= 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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021253 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.772607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:12.773242) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab --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 cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab --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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-29 02:05:13,503 truncating revision to first 12 chars 2017-05-29 02:05:13,503 Setting DEBUG logging. 2017-05-29 02:05:13,503 attempt 1/10 2017-05-29 02:05:13,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cce4d83d2b99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-29 02:05:14,081 unpacking tar archive at: mozilla-central-cce4d83d2b99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:13.687303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:13.687604) ========= script_repo_revision: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:13.688061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:13.688320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 02:05:13.703358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-29 02:05:13.703628) ========= /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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:14 INFO - MultiFileLogger online at 20170529 02:05:14 in /builds/slave/test 02:05:14 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 02:05:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:14 INFO - {'append_to_log': False, 02:05:14 INFO - 'base_work_dir': '/builds/slave/test', 02:05:14 INFO - 'blob_upload_branch': 'Firefox', 02:05:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:14 INFO - 'branch': 'Firefox', 02:05:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:14 INFO - 'config_files': ('talos/linux_config.py',), 02:05:14 INFO - 'default_actions': ('clobber', 02:05:14 INFO - 'read-buildbot-config', 02:05:14 INFO - 'download-and-extract', 02:05:14 INFO - 'populate-webroot', 02:05:14 INFO - 'create-virtualenv', 02:05:14 INFO - 'install', 02:05:14 INFO - 'setup-mitmproxy', 02:05:14 INFO - 'run-tests'), 02:05:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:14 INFO - 'download_minidump_stackwalk': True, 02:05:14 INFO - 'download_symbols': 'ondemand', 02:05:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:14 INFO - 'gecko_profile': False, 02:05:14 INFO - 'gecko_profile_interval': 0, 02:05:14 INFO - 'installer_path': 'installer.exe', 02:05:14 INFO - 'log_level': 'info', 02:05:14 INFO - 'log_name': 'talos', 02:05:14 INFO - 'log_to_console': True, 02:05:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:14 INFO - 'opt_config_files': (), 02:05:14 INFO - 'pip_index': False, 02:05:14 INFO - 'suite': 'dromaeojs-e10s', 02:05:14 INFO - 'system_bits': '32', 02:05:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:14 INFO - 'title': 'talos-linux64-ix-082', 02:05:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:14 INFO - 'use_talos_json': True, 02:05:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:14 INFO - 'work_dir': 'build'} 02:05:14 INFO - [mozharness: 2017-05-29 09:05:14.534581Z] Running clobber step. 02:05:14 INFO - Running pre-action listener: _resource_record_pre_action 02:05:14 INFO - Running main action method: clobber 02:05:14 INFO - rmtree: /builds/slave/test/build 02:05:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:16 INFO - Running post-action listener: _resource_record_post_action 02:05:16 INFO - [mozharness: 2017-05-29 09:05:16.051234Z] Finished clobber step (success) 02:05:16 INFO - [mozharness: 2017-05-29 09:05:16.051334Z] Running read-buildbot-config step. 02:05:16 INFO - Running pre-action listener: _resource_record_pre_action 02:05:16 INFO - Running main action method: read_buildbot_config 02:05:16 INFO - Using buildbot properties: 02:05:16 INFO - { 02:05:16 INFO - "project": "", 02:05:16 INFO - "product": "firefox", 02:05:16 INFO - "who": "cbook@mozilla.com", 02:05:16 INFO - "installer_path": "public/build/target.tar.bz2", 02:05:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:05:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:05:16 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:05:16 INFO - "stage_platform": "linux64-stylosequential", 02:05:16 INFO - "basedir": "/builds/slave/test", 02:05:16 INFO - "buildnumber": 31, 02:05:16 INFO - "platform": "ubuntu64_hw_styloseq", 02:05:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:05:16 INFO - "slavebuilddir": "test", 02:05:16 INFO - "taskId": "NE9MKHIwS5KTD8Xypf7RXg", 02:05:16 INFO - "branch": "mozilla-central", 02:05:16 INFO - "script_repo_revision": "production", 02:05:16 INFO - "revision": "cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab", 02:05:16 INFO - "slavename": "talos-linux64-ix-082", 02:05:16 INFO - "repo_path": "mozilla-central" 02:05:16 INFO - } 02:05:16 INFO - Finding installer, test and symbols from parent task. 02:05:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NE9MKHIwS5KTD8Xypf7RXg'}, attempt #1 02:05:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NE9MKHIwS5KTD8Xypf7RXg'}, attempt #1 02:05:17 INFO - Task dependencies: HYS1ATMJRyK5GBZPOti8jQ 02:05:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ'}, attempt #1 02:05:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 02:05:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/test_packages.json 02:05:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.crashreporter-symbols.zip 02:05:17 INFO - Running post-action listener: _resource_record_post_action 02:05:17 INFO - [mozharness: 2017-05-29 09:05:17.462361Z] Finished read-buildbot-config step (success) 02:05:17 INFO - [mozharness: 2017-05-29 09:05:17.462587Z] Running download-and-extract step. 02:05:17 INFO - Running pre-action listener: _resource_record_pre_action 02:05:17 INFO - Running main action method: download_and_extract 02:05:17 INFO - mkdir: /builds/slave/test/build/tests 02:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:17 INFO - trying https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.test_packages.json 02:05:17 INFO - Downloading https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:05:18 INFO - Downloaded 986 bytes. 02:05:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:05:18 INFO - Using the following test package requirements: 02:05:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:05:18 INFO - u'common': [u'target.common.tests.zip'], 02:05:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:05:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:05:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:05:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:05:18 INFO - u'mozbase': [u'target.common.tests.zip'], 02:05:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:05:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:05:18 INFO - u'web-platform': [u'target.common.tests.zip', 02:05:18 INFO - u'target.web-platform.tests.zip'], 02:05:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:05:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:05:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip 02:05:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:05:18 INFO - Fetch https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip into memory 02:05:20 INFO - Content-Length response header: 63527375 02:05:20 INFO - Bytes received: 63527375 02:05:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:05:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip 02:05:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:05:31 INFO - Fetch https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.common.tests.zip into memory 02:05:33 INFO - Content-Length response header: 63527375 02:05:33 INFO - Bytes received: 63527375 02:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.talos.tests.zip 02:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.talos.tests.zip into memory 02:05:46 INFO - Content-Length response header: 14447425 02:05:46 INFO - Bytes received: 14447425 02:05: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')]} 02:05:46 INFO - trying https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 02:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:05:49 INFO - Downloaded 55919092 bytes. 02:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 02:05:49 INFO - mkdir: /builds/slave/test/properties 02:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:49 INFO - Contents: 02:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 02:05:49 INFO - Running post-action listener: _resource_record_post_action 02:05:49 INFO - Running post-action listener: set_extra_try_arguments 02:05:49 INFO - [mozharness: 2017-05-29 09:05:49.275422Z] Finished download-and-extract step (success) 02:05:49 INFO - [mozharness: 2017-05-29 09:05:49.275649Z] Running populate-webroot step. 02:05:49 INFO - Running pre-action listener: _resource_record_pre_action 02:05:49 INFO - Running main action method: populate_webroot 02:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:49 INFO - '--tppagecycles', 02:05:49 INFO - '7'], 02:05:49 INFO - 'tests': ['tsvgm']}}, 02:05:49 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['damp', 'tps']}, 02:05:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'tests': ['damp', 'tps']}, 02:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['dromaeo_dom']}, 02:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:05:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['a11yr', 02:05:49 INFO - 'ts_paint', 02:05:49 INFO - 'tpaint', 02:05:49 INFO - 'sessionrestore', 02:05:49 INFO - 'sessionrestore_no_auto_restore', 02:05:49 INFO - 'tabpaint']}, 02:05:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:05:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:05:49 INFO - 'bloom_basic_ref']}, 02:05:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:05:49 INFO - 'talos_options': ['--mitmproxy', 02:05:49 INFO - 'mitmproxy-recording-1.mp', 02:05:49 INFO - '--firstNonBlankPaint'], 02:05:49 INFO - 'tests': ['Quantum_1']}, 02:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['tsvgx', 02:05:49 INFO - 'tsvgr_opacity', 02:05:49 INFO - 'tart', 02:05:49 INFO - 'tscrollx', 02:05:49 INFO - 'cart', 02:05:49 INFO - 'tsvg_static']}, 02:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:49 INFO - 'tsvgr_opacity', 02:05:49 INFO - 'tart', 02:05:49 INFO - 'tscrollx', 02:05:49 INFO - 'cart', 02:05:49 INFO - 'tsvg_static']}, 02:05:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'talos_options': ['--disable-e10s'], 02:05:49 INFO - 'tests': ['tp5o']}, 02:05:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:05:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'talos_options': ['--disable-e10s', 02:05:49 INFO - '--xperf_path', 02:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:49 INFO - 'tests': ['tp5n']}, 02:05:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:05:49 INFO - 'talos_options': ['--xperf_path', 02:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:49 INFO - 'tests': ['tp5n']}}, 02:05:49 INFO - 'talos.zip': {'path': '', 02:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:49 INFO - Running post-action listener: _resource_record_post_action 02:05:49 INFO - [mozharness: 2017-05-29 09:05:49.296659Z] Finished populate-webroot step (success) 02:05:49 INFO - [mozharness: 2017-05-29 09:05:49.296749Z] Running create-virtualenv step. 02:05:49 INFO - Running pre-action listener: _resource_record_pre_action 02:05:49 INFO - Running main action method: create_virtualenv 02:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:49 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 02:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:49 INFO - Using real prefix '/usr' 02:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:51 INFO - Installing pip.................done. 02:05:51 INFO - Return code: 0 02:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:05:52 INFO - Reading from file tmpfile_stdout 02:05:52 INFO - Output received: 02:05:52 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) 02:05:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05: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')]} 02:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:05:52 INFO - Using env: {'DISPLAY': ':0', 02:05:52 INFO - 'HOME': '/home/cltbld', 02:05:52 INFO - 'LANG': 'en_US.UTF-8', 02:05:52 INFO - 'LANGUAGE': 'en_US:en', 02:05:52 INFO - 'LOGNAME': 'cltbld', 02:05:52 INFO - 'MAIL': '/var/mail/cltbld', 02:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:52 INFO - 'MOZ_NO_REMOTE': '1', 02:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:52 INFO - 'NO_EM_RESTART': '1', 02:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:52 INFO - 'PWD': '/builds/slave/test', 02:05:52 INFO - 'SHELL': '/bin/bash', 02:05:52 INFO - 'SHLVL': '1', 02:05:52 INFO - 'TERM': 'linux', 02:05:52 INFO - 'TMOUT': '86400', 02:05:52 INFO - 'USER': 'cltbld', 02:05:52 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:52 INFO - '_': '/tools/buildbot/bin/python'} 02:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:52 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 02:05:52 INFO - Cleaning up... 02:05:52 INFO - Return code: 0 02:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05: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')]} 02:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05: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', '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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:05: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 psutil>=3.1.1 02:05:52 INFO - Using env: {'DISPLAY': ':0', 02:05:52 INFO - 'HOME': '/home/cltbld', 02:05:52 INFO - 'LANG': 'en_US.UTF-8', 02:05:52 INFO - 'LANGUAGE': 'en_US:en', 02:05:52 INFO - 'LOGNAME': 'cltbld', 02:05:52 INFO - 'MAIL': '/var/mail/cltbld', 02:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:52 INFO - 'MOZ_NO_REMOTE': '1', 02:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:52 INFO - 'NO_EM_RESTART': '1', 02:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:52 INFO - 'PWD': '/builds/slave/test', 02:05:52 INFO - 'SHELL': '/bin/bash', 02:05:52 INFO - 'SHLVL': '1', 02:05:52 INFO - 'TERM': 'linux', 02:05:52 INFO - 'TMOUT': '86400', 02:05:52 INFO - 'USER': 'cltbld', 02:05:52 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:52 INFO - '_': '/tools/buildbot/bin/python'} 02:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:52 INFO - Downloading/unpacking psutil>=3.1.1 02:05:52 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 02:05:52 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 02:05:52 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 02:05:52 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 02:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:53 INFO - Installing collected packages: psutil 02:05:53 INFO - Running setup.py install for psutil 02:05:53 INFO - building 'psutil._psutil_linux' extension 02:05:53 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 02:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:05:54 INFO - building 'psutil._psutil_posix' extension 02:05:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:54 INFO - Successfully installed psutil 02:05:54 INFO - Cleaning up... 02:05:54 INFO - Return code: 0 02:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:05:54 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')]} 02:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:54 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')]} 02:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:54 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05:54 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 02:05:54 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 02:05:54 INFO - Using env: {'DISPLAY': ':0', 02:05:54 INFO - 'HOME': '/home/cltbld', 02:05:54 INFO - 'LANG': 'en_US.UTF-8', 02:05:54 INFO - 'LANGUAGE': 'en_US:en', 02:05:54 INFO - 'LOGNAME': 'cltbld', 02:05:54 INFO - 'MAIL': '/var/mail/cltbld', 02:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:54 INFO - 'MOZ_NO_REMOTE': '1', 02:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:54 INFO - 'NO_EM_RESTART': '1', 02:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:54 INFO - 'PWD': '/builds/slave/test', 02:05:54 INFO - 'SHELL': '/bin/bash', 02:05:54 INFO - 'SHLVL': '1', 02:05:54 INFO - 'TERM': 'linux', 02:05:54 INFO - 'TMOUT': '86400', 02:05:54 INFO - 'USER': 'cltbld', 02:05:54 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:54 INFO - '_': '/tools/buildbot/bin/python'} 02:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:05:54 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 02:05:54 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 02:05:54 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 02:05:54 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 02:05:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:05:55 INFO - Installing collected packages: mozsystemmonitor 02:05:55 INFO - Running setup.py install for mozsystemmonitor 02:05:55 INFO - Successfully installed mozsystemmonitor 02:05:55 INFO - Cleaning up... 02:05:55 INFO - Return code: 0 02:05:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:05:55 INFO - Using env: {'DISPLAY': ':0', 02:05:55 INFO - 'HOME': '/home/cltbld', 02:05:55 INFO - 'LANG': 'en_US.UTF-8', 02:05:55 INFO - 'LANGUAGE': 'en_US:en', 02:05:55 INFO - 'LOGNAME': 'cltbld', 02:05:55 INFO - 'MAIL': '/var/mail/cltbld', 02:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:55 INFO - 'MOZ_NO_REMOTE': '1', 02:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:55 INFO - 'NO_EM_RESTART': '1', 02:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:55 INFO - 'PWD': '/builds/slave/test', 02:05:55 INFO - 'SHELL': '/bin/bash', 02:05:55 INFO - 'SHLVL': '1', 02:05:55 INFO - 'TERM': 'linux', 02:05:55 INFO - 'TMOUT': '86400', 02:05:55 INFO - 'USER': 'cltbld', 02:05:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:55 INFO - '_': '/tools/buildbot/bin/python'} 02:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:05:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:05:57 INFO - warning: no files found matching '*.txt' 02:05:57 INFO - no previously-included directories found matching 'build' 02:05:57 INFO - no previously-included directories found matching 'dist' 02:05:57 INFO - no previously-included directories found matching '.git*' 02:05:57 INFO - Installing collected packages: jsonschema, functools32 02:05:57 INFO - Running setup.py install for functools32 02:05:57 INFO - warning: no files found matching '*.txt' 02:05:57 INFO - no previously-included directories found matching 'build' 02:05:57 INFO - no previously-included directories found matching 'dist' 02:05:57 INFO - no previously-included directories found matching '.git*' 02:05:57 INFO - Successfully installed jsonschema functools32 02:05:57 INFO - Cleaning up... 02:05:57 INFO - Return code: 0 02:05:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:05:57 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')]} 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:57 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')]} 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:57 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05:57 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 02:05:57 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 02:05:57 INFO - Using env: {'DISPLAY': ':0', 02:05:57 INFO - 'HOME': '/home/cltbld', 02:05:57 INFO - 'LANG': 'en_US.UTF-8', 02:05:57 INFO - 'LANGUAGE': 'en_US:en', 02:05:57 INFO - 'LOGNAME': 'cltbld', 02:05:57 INFO - 'MAIL': '/var/mail/cltbld', 02:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:57 INFO - 'MOZ_NO_REMOTE': '1', 02:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:57 INFO - 'NO_EM_RESTART': '1', 02:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:57 INFO - 'PWD': '/builds/slave/test', 02:05:57 INFO - 'SHELL': '/bin/bash', 02:05:57 INFO - 'SHLVL': '1', 02:05:57 INFO - 'TERM': 'linux', 02:05:57 INFO - 'TMOUT': '86400', 02:05:57 INFO - 'USER': 'cltbld', 02:05:57 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:57 INFO - '_': '/tools/buildbot/bin/python'} 02:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:05:57 INFO - Cleaning up... 02:05:57 INFO - Return code: 0 02:05:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:05:57 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')]} 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:57 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')]} 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:57 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:05:57 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 02:05:57 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 02:05:57 INFO - Using env: {'DISPLAY': ':0', 02:05:57 INFO - 'HOME': '/home/cltbld', 02:05:57 INFO - 'LANG': 'en_US.UTF-8', 02:05:57 INFO - 'LANGUAGE': 'en_US:en', 02:05:57 INFO - 'LOGNAME': 'cltbld', 02:05:57 INFO - 'MAIL': '/var/mail/cltbld', 02:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:57 INFO - 'MOZ_NO_REMOTE': '1', 02:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:57 INFO - 'NO_EM_RESTART': '1', 02:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:57 INFO - 'PWD': '/builds/slave/test', 02:05:57 INFO - 'SHELL': '/bin/bash', 02:05:57 INFO - 'SHLVL': '1', 02:05:57 INFO - 'TERM': 'linux', 02:05:57 INFO - 'TMOUT': '86400', 02:05:57 INFO - 'USER': 'cltbld', 02:05:57 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:57 INFO - '_': '/tools/buildbot/bin/python'} 02:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:05:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:05:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - Downloading docopt-0.6.1.tar.gz 02:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:05:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:05:59 INFO - Running setup.py install for blobuploader 02:05:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:05:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:05:59 INFO - Running setup.py install for requests 02:06:00 INFO - Running setup.py install for docopt 02:06:00 INFO - Successfully installed blobuploader requests docopt 02:06:00 INFO - Cleaning up... 02:06:00 INFO - Return code: 0 02:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:00 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')]} 02:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:00 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')]} 02:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:00 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:06:00 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 02:06:00 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 02:06:00 INFO - Using env: {'DISPLAY': ':0', 02:06:00 INFO - 'HOME': '/home/cltbld', 02:06:00 INFO - 'LANG': 'en_US.UTF-8', 02:06:00 INFO - 'LANGUAGE': 'en_US:en', 02:06:00 INFO - 'LOGNAME': 'cltbld', 02:06:00 INFO - 'MAIL': '/var/mail/cltbld', 02:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:00 INFO - 'MOZ_NO_REMOTE': '1', 02:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:00 INFO - 'NO_EM_RESTART': '1', 02:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:00 INFO - 'PWD': '/builds/slave/test', 02:06:00 INFO - 'SHELL': '/bin/bash', 02:06:00 INFO - 'SHLVL': '1', 02:06:00 INFO - 'TERM': 'linux', 02:06:00 INFO - 'TMOUT': '86400', 02:06:00 INFO - 'USER': 'cltbld', 02:06:00 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:00 INFO - '_': '/tools/buildbot/bin/python'} 02:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 INFO - Running setup.py (path:/tmp/pip-GmumFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Running setup.py (path:/tmp/pip-B5K64l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:00 INFO - Running setup.py (path:/tmp/pip-FqouVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:00 INFO - Running setup.py (path:/tmp/pip-bNwnBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:00 INFO - Running setup.py (path:/tmp/pip-vL6SYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:00 INFO - Running setup.py (path:/tmp/pip-GKZuUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:00 INFO - Running setup.py (path:/tmp/pip-NWyEiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:00 INFO - Running setup.py (path:/tmp/pip-_0XIfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:01 INFO - Running setup.py (path:/tmp/pip-3cYN1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:01 INFO - Running setup.py (path:/tmp/pip-BRJtZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 INFO - Running setup.py (path:/tmp/pip-ff9Acr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 INFO - Running setup.py (path:/tmp/pip-SAOzmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:01 INFO - Running setup.py (path:/tmp/pip-YiLOiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Running setup.py (path:/tmp/pip-kOONKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:01 INFO - Running setup.py (path:/tmp/pip-U68Nb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:01 INFO - Running setup.py (path:/tmp/pip-AVb5yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:01 INFO - Running setup.py (path:/tmp/pip-7lMiOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:01 INFO - Running setup.py install for manifestparser 02:06:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:01 INFO - Running setup.py install for mozcrash 02:06:01 INFO - Running setup.py install for mozdebug 02:06:01 INFO - Running setup.py install for mozdevice 02:06:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozfile 02:06:02 INFO - Running setup.py install for mozhttpd 02:06:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozinfo 02:06:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozInstall 02:06:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozleak 02:06:02 INFO - Running setup.py install for mozlog 02:06:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for moznetwork 02:06:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozprocess 02:06:02 INFO - Running setup.py install for mozprofile 02:06:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozrunner 02:06:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for mozscreenshot 02:06:03 INFO - Running setup.py install for moztest 02:06:03 INFO - Running setup.py install for mozversion 02:06:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:03 INFO - Cleaning up... 02:06:03 INFO - Return code: 0 02:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:03 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:06:03 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 02:06:03 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 02:06:03 INFO - Using env: {'DISPLAY': ':0', 02:06:03 INFO - 'HOME': '/home/cltbld', 02:06:03 INFO - 'LANG': 'en_US.UTF-8', 02:06:03 INFO - 'LANGUAGE': 'en_US:en', 02:06:03 INFO - 'LOGNAME': 'cltbld', 02:06:03 INFO - 'MAIL': '/var/mail/cltbld', 02:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:03 INFO - 'MOZ_NO_REMOTE': '1', 02:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:03 INFO - 'NO_EM_RESTART': '1', 02:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:03 INFO - 'PWD': '/builds/slave/test', 02:06:03 INFO - 'SHELL': '/bin/bash', 02:06:03 INFO - 'SHLVL': '1', 02:06:03 INFO - 'TERM': 'linux', 02:06:03 INFO - 'TMOUT': '86400', 02:06:03 INFO - 'USER': 'cltbld', 02:06:03 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:03 INFO - '_': '/tools/buildbot/bin/python'} 02:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:03 INFO - Running setup.py (path:/tmp/pip-UWvJbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:03 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)) 02:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:03 INFO - Running setup.py (path:/tmp/pip-Ub_aRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:03 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)) 02:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:03 INFO - Running setup.py (path:/tmp/pip-Q5Ehfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:03 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)) 02:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:03 INFO - Running setup.py (path:/tmp/pip-T2RbgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:03 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)) 02:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:03 INFO - Running setup.py (path:/tmp/pip-PSfHNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:04 INFO - Running setup.py (path:/tmp/pip-LVrE2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:04 INFO - Running setup.py (path:/tmp/pip-1g7fYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:04 INFO - Running setup.py (path:/tmp/pip-ZzJGv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:04 INFO - Running setup.py (path:/tmp/pip-sbXhA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:04 INFO - Running setup.py (path:/tmp/pip-I9GGTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:04 INFO - Running setup.py (path:/tmp/pip-Bdvxhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:04 INFO - Running setup.py (path:/tmp/pip-CS7fcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:04 INFO - Running setup.py (path:/tmp/pip-kyTQF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:04 INFO - Running setup.py (path:/tmp/pip-BoNDAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:04 INFO - Running setup.py (path:/tmp/pip-nx2YGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:04 INFO - Running setup.py (path:/tmp/pip-oef7ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:04 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)) 02:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:04 INFO - Running setup.py (path:/tmp/pip-pgcRM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:04 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)) 02:06:04 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)) 02:06:04 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)) 02:06:04 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)) 02:06:04 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)) 02:06:04 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)) 02:06:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:05 INFO - Downloading blessings-1.6.tar.gz 02:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:06 INFO - Installing collected packages: blessings 02:06:06 INFO - Running setup.py install for blessings 02:06:06 INFO - Successfully installed blessings 02:06:06 INFO - Cleaning up... 02:06:06 INFO - Return code: 0 02:06:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:06 INFO - Reading from file tmpfile_stdout 02:06:06 INFO - Current package versions: 02:06:06 INFO - argparse == 1.2.1 02:06:06 INFO - blessings == 1.6 02:06:06 INFO - blobuploader == 1.2.4 02:06:06 INFO - docopt == 0.6.1 02:06:06 INFO - functools32 == 3.2.3-2 02:06:06 INFO - jsonschema == 2.5.1 02:06:06 INFO - manifestparser == 1.1 02:06:06 INFO - mozInstall == 1.12 02:06:06 INFO - mozcrash == 1.0 02:06:06 INFO - mozdebug == 0.1 02:06:06 INFO - mozdevice == 0.51 02:06:06 INFO - mozfile == 1.2 02:06:06 INFO - mozhttpd == 0.7 02:06:06 INFO - mozinfo == 0.9 02:06:06 INFO - mozleak == 0.1 02:06:06 INFO - mozlog == 3.4 02:06:06 INFO - moznetwork == 0.27 02:06:06 INFO - mozprocess == 0.25 02:06:06 INFO - mozprofile == 0.28 02:06:06 INFO - mozrunner == 6.13 02:06:06 INFO - mozscreenshot == 0.1 02:06:06 INFO - mozsystemmonitor == 0.3 02:06:06 INFO - moztest == 0.8 02:06:06 INFO - mozversion == 1.4 02:06:06 INFO - psutil == 3.1.1 02:06:06 INFO - requests == 1.2.3 02:06:06 INFO - wsgiref == 0.1.2 02:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:06 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 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:06:06 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 02:06:06 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 02:06:06 INFO - Using env: {'DISPLAY': ':0', 02:06:06 INFO - 'HOME': '/home/cltbld', 02:06:06 INFO - 'LANG': 'en_US.UTF-8', 02:06:06 INFO - 'LANGUAGE': 'en_US:en', 02:06:06 INFO - 'LOGNAME': 'cltbld', 02:06:06 INFO - 'MAIL': '/var/mail/cltbld', 02:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:06 INFO - 'MOZ_NO_REMOTE': '1', 02:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:06 INFO - 'NO_EM_RESTART': '1', 02:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:06 INFO - 'PWD': '/builds/slave/test', 02:06:06 INFO - 'SHELL': '/bin/bash', 02:06:06 INFO - 'SHLVL': '1', 02:06:06 INFO - 'TERM': 'linux', 02:06:06 INFO - 'TMOUT': '86400', 02:06:06 INFO - 'USER': 'cltbld', 02:06:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:06 INFO - '_': '/tools/buildbot/bin/python'} 02:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 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)) 02:06:06 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:06:06 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 02:06:06 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 02:06:06 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 02:06:06 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 02:06:07 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:06:07 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)) 02:06:07 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)) 02:06:07 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)) 02:06:07 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)) 02:06:07 INFO - Installing collected packages: marionette-driver 02:06:07 INFO - Running setup.py install for marionette-driver 02:06:07 INFO - Successfully installed marionette-driver 02:06:07 INFO - Cleaning up... 02:06:07 INFO - Return code: 0 02:06:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23833b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2700ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, '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': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', '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 02:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:06:07 INFO - Using env: {'DISPLAY': ':0', 02:06:07 INFO - 'HOME': '/home/cltbld', 02:06:07 INFO - 'LANG': 'en_US.UTF-8', 02:06:07 INFO - 'LANGUAGE': 'en_US:en', 02:06:07 INFO - 'LOGNAME': 'cltbld', 02:06:07 INFO - 'MAIL': '/var/mail/cltbld', 02:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:07 INFO - 'MOZ_NO_REMOTE': '1', 02:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:07 INFO - 'NO_EM_RESTART': '1', 02:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:07 INFO - 'PWD': '/builds/slave/test', 02:06:07 INFO - 'SHELL': '/bin/bash', 02:06:07 INFO - 'SHLVL': '1', 02:06:07 INFO - 'TERM': 'linux', 02:06:07 INFO - 'TMOUT': '86400', 02:06:07 INFO - 'USER': 'cltbld', 02:06:07 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:07 INFO - '_': '/tools/buildbot/bin/python'} 02:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:08 INFO - Cleaning up... 02:06:08 INFO - Return code: 0 02:06:08 INFO - Running post-action listener: _resource_record_post_action 02:06:08 INFO - Running post-action listener: _start_resource_monitoring 02:06:08 INFO - Starting resource monitoring. 02:06:08 INFO - [mozharness: 2017-05-29 09:06:08.234591Z] Finished create-virtualenv step (success) 02:06:08 INFO - [mozharness: 2017-05-29 09:06:08.235057Z] Running install step. 02:06:08 INFO - Running pre-action listener: _resource_record_pre_action 02:06:08 INFO - Running main action method: install 02:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:08 INFO - Reading from file tmpfile_stdout 02:06:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:08 INFO - Reading from file tmpfile_stdout 02:06:08 INFO - Output received: 02:06:08 INFO - Usage: mozinstall [options] installer 02:06:08 INFO - Options: 02:06:08 INFO - -h, --help show this help message and exit 02:06:08 INFO - -d DEST, --destination=DEST 02:06:08 INFO - Directory to install application into. [default: 02:06:08 INFO - "/builds/slave/test"] 02:06:08 INFO - --app=APP Application being installed. [default: firefox] 02:06:08 INFO - mkdir: /builds/slave/test/build/application 02:06:08 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'] 02:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:06:24 INFO - Reading from file tmpfile_stdout 02:06:24 INFO - Output received: 02:06:24 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:24 INFO - Running post-action listener: _resource_record_post_action 02:06:24 INFO - [mozharness: 2017-05-29 09:06:24.755741Z] Finished install step (success) 02:06:24 INFO - [mozharness: 2017-05-29 09:06:24.756019Z] Running setup-mitmproxy step. 02:06:24 INFO - Running pre-action listener: _resource_record_pre_action 02:06:24 INFO - Running main action method: setup_mitmproxy 02:06:24 INFO - Skipping: mitmproxy is not required 02:06:24 INFO - Running post-action listener: _resource_record_post_action 02:06:24 INFO - [mozharness: 2017-05-29 09:06:24.757158Z] Finished setup-mitmproxy step (success) 02:06:24 INFO - [mozharness: 2017-05-29 09:06:24.757379Z] Running run-tests step. 02:06:24 INFO - Running pre-action listener: _resource_record_pre_action 02:06:24 INFO - Running main action method: run_tests 02:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:24 INFO - Python 2.7.3 02:06:24 INFO - Return code: 0 02:06:24 INFO - grabbing minidump binary from tooltool 02:06:24 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')]} 02:06:24 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 0x26fde40>, '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 0x26fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:24 INFO - Return code: 0 02:06:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:24 INFO - ENV: RUST_BACKTRACE is now 1 02:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:24 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/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 02:06:24 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/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 02:06:24 INFO - Using env: {'DISPLAY': ':0', 02:06:24 INFO - 'HOME': '/home/cltbld', 02:06:24 INFO - 'LANG': 'en_US.UTF-8', 02:06:24 INFO - 'LANGUAGE': 'en_US:en', 02:06:24 INFO - 'LOGNAME': 'cltbld', 02:06:24 INFO - 'MAIL': '/var/mail/cltbld', 02:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:24 INFO - 'MOZ_NO_REMOTE': '1', 02:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:24 INFO - 'NO_EM_RESTART': '1', 02:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:24 INFO - 'PWD': '/builds/slave/test', 02:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:24 INFO - 'RUST_BACKTRACE': '1', 02:06:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:06:24 INFO - 'SHELL': '/bin/bash', 02:06:24 INFO - 'SHLVL': '1', 02:06:24 INFO - 'TERM': 'linux', 02:06:24 INFO - 'TMOUT': '86400', 02:06:24 INFO - 'USER': 'cltbld', 02:06:24 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235', 02:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:24 INFO - '_': '/tools/buildbot/bin/python'} 02:06:24 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/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 02:06:25 INFO - mozversion application_buildid: 20170529082334 02:06:25 INFO - mozversion application_changeset: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab 02:06:25 INFO - mozversion application_display_name: Nightly 02:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:25 INFO - mozversion application_name: Firefox 02:06:25 INFO - mozversion application_remotingname: firefox 02:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:06:25 INFO - mozversion application_vendor: Mozilla 02:06:25 INFO - mozversion application_version: 55.0a1 02:06:25 INFO - mozversion platform_buildid: 20170529082334 02:06:25 INFO - mozversion platform_changeset: cce4d83d2b99ffedbd67a2f40ce26e53e9ae27ab 02:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:06:25 INFO - mozversion platform_version: 55.0a1 02:06:25 INFO - using testdate: 1496048785 02:06:25 INFO - actual date: 1496048785 02:06:25 INFO - starting webserver on 'localhost:53475' 02:06:25 INFO - SUITE-START | Running 2 tests 02:06:25 INFO - TEST-START | dromaeo_css 02:06:25 INFO - operating with platform_type : linux_ 02:06:25 INFO - Initialising browser for dromaeo_css test... 02:06:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53475/getInfo.html -profile /tmp/tmpYQDX2z/profile 02:06:25 INFO - TEST-INFO | started process 15689 (/builds/slave/test/build/application/firefox/firefox http://localhost:53475/getInfo.html) 02:07:00 INFO - TEST-INFO | 15689: killed by SIGTERM 02:07:00 INFO - Browser initialized. 02:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:00 INFO - TEST-INFO | started process 15912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQDX2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:12 INFO - PID 15912 | RSS: Main: 186470400 02:07:12 INFO - PID 15912 | 02:10:17 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53475/tests/dromaeo/cssquery-ext.html) 02:10:18 INFO - PID 15912 | RSS: Main: 181354496 02:10:18 INFO - PID 15912 | 02:13:20 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-ext.html (next: http://localhost:53475/tests/dromaeo/cssquery-jquery.html) 02:13:21 INFO - PID 15912 | RSS: Main: 187084800 02:13:21 INFO - PID 15912 | 02:16:23 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53475/tests/dromaeo/cssquery-mootools.html) 02:16:24 INFO - PID 15912 | RSS: Main: 183324672 02:16:24 INFO - PID 15912 | 02:19:25 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53475/tests/dromaeo/cssquery-prototype.html) 02:19:26 INFO - PID 15912 | RSS: Main: 188317696 02:19:26 INFO - PID 15912 | 02:22:29 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53475/tests/dromaeo/cssquery-yui.html) 02:22:30 INFO - PID 15912 | RSS: Main: 188764160 02:22:30 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | Cycle 1(1): loaded http://localhost:53475/tests/dromaeo/cssquery-yui.html (next: http://localhost:53475/tests/dromaeo/cssquery-dojo.html) 02:25:32 INFO - PID 15912 | RSS: Main: 186392576 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | __start_tp_report 02:25:32 INFO - PID 15912 | _x_x_mozilla_page_load 02:25:32 INFO - PID 15912 | _x_x_mozilla_page_load_details 02:25:32 INFO - PID 15912 | |i|pagename|runs| 02:25:32 INFO - PID 15912 | |0;dojo.html;2695.420484595812;2706.2963629456335;2711.539038363478;2716.1172618898863;2737.4798788230237;5137.871553211172;5242.056429842627;5245.527902488775;5283.788648454067;5322.068637988351;5192.454792246816;5202.947970520303;5228.372595288571;5300.09898317286;5332.093544097503;4610.953890461103;4665.950161213734;4690.507496712848;4698.64760142989;4715.457722361921;4624.953750462486;4629.282461218517;4728.858134255978;4735.952640473585;4764.499727528611;4572.268437050056;4633.652476064275;4668.066386722669;4729.787159577827;4731.432228132629;4665.533446655341;4733.810647574093;4757.09615173116;4757.738324392157;4778.092162489116;4694.131585656631;4702.294655801623;4706.505816889246;4708.811647534095;4745.928811067837;5187.04039752647;5259.421463638997;5269.1832765921345;5276;5319.255304257407;5466.590005749545;5531.889362212773;5623.887522249532;5694.943050569483;5703.17303990919;5652.321721393418;5656.971715141439;5657.8019769307875;5701.0308247598;5724.771009159628;5238.528532432099;5246.422893481714;5250.921236181461;5257.027449921777;5300.602454815904;5631.746571404296;5739.512141468022;5756.798512052058;5839.620424672383;5860.531157507389;5573.164025396142;5614.017546929271;5648.293963254593;5666.631668941505;5668.319801623831;5585.441455854382;5654.971725141348;5667.433256674382;5673.8014169504695;5675.602707810496;5495.587830912697;5528;5631.352394474688;5637.7181140942785;5645.266115404971;5578.832635020955;5589.944100559023;5619.213310136584;5622.57830662702;5685.914711279334;4807.495213002654;4808.711477311373;4808.759562021885;4812.1578723723205;4851.296561998491;4059.6346328830546;4073.45008423859;4076.938845917254;4105.178964207171;4157.563455837154;4670.439547254351;4672.813087476531;4735.502772208937;4784.856454306377;4798.95201047985;5753.769849206069;5771.480566748929;5791.971040144772;5804.738786754522;5821.505172060422;4841.903161936812;4852.247901575191;4859.052484765508;4861.368022157168;4898.975505122523;4921.680090794159;5133.948660513347;5148.974255128775;5149.536541711264;5150.948490515122;5231.895362092813;5242.633015688865;5291.841244762663;5297.655652382583;5313.521783039545;5480.808171713971;5573.944260557342;5660.235868157746;5744.770209191585;5774.711264436845;5224.05966925957;5326.041312563776;5326.600504962221;5330.147176451749;5340.412554619066;5517.310336207974;5536.197251398444;5540.445955404427;5550.75021624036;5555.444455554412;5539.19681646151;5588.972055139861;5625.353084395347;5630.774769009194;5707.914381284367;5517.089680202722;5550.805721799879;5567.888642227052;5602.327720673546;5616.297962754656;5551.361593416647;5551.417101204315;5559.833205003856;5562.276904002454;5570.498655121059;5361.27622770921;5439.564834813126;5443.891122177613;5449.264349312951;5478.205660179331;5442.918356224581;5504.311961004874;5505.614606977633;5535.501804837584;5547.084731019498;5414.404415514369;5433.049216387038;5443.945560544502;5499.1476321170285;5503.367112781922 02:25:32 INFO - PID 15912 | |1;ext.html;605.5125623872783;652.4780175859313;676.2696288008951;1053.6944286157016;1074.3392813419748;30019.549706754387;30749.38501229974;30952.988055776357;31185.376292474164;31211;29629.259268518297;29710;29767.553486697663;29825;30764.53853192204;6308.495320374359;6602.2737498875085;6720.966395168018;6725.730970761164;6727.562708423937;6754.290799466059;6795.286494918037;6800;6807.591544507345;6819.693113809891;6791.660416979156;6842.9315706843045;6849.554778939378;6852.6231057291825;6854.246032936373;6797.728090876359;6811.693473793691;6816.556923799937;6824;6824.454043676519;6656.866862662768;6678.4991125665765;6695.564788288746;6715.56348837324;6717.798466046026;28023;28140.859295703594;28205.576916346065;28291.85854070737;28359;2394.3535245483795;2402.4714562796157;2427.271818454474;2430.052279610953;2446.8164887633498;22805.31584052481;22845;23041.654375184386;23268.65097023546;23300;2853.4578430098213;2866.885324587014;2874.870630821597;2957.985210073936;2977.002704094131;147776;147918;147964;155916.22041889717;163029.18485407496;33101.36580878679;33109.503357449656;33526;34101.31797364039;34583.4812477813;33552;33817.83091084529;34680.826595866856;35090;36339.27321453609;11305.152113591514;11402.087832973508;11413.714657133472;11475.368854713071;11590.188686792013;9304.53477326131;9312.44125352481;9324;9348;9385.436873787594;10165.44090075053;10204.43875586835;10230.181585473145;10457.163426925828;10490.475476226158;4590.42619672541;4612.423447069116;4617.376654151713;4625.121226966866;4677.345171675968;770.9036370453694;779.1040303650734;780.157429975625;787.4173111897155;796.2714116583261;18247.27010919575;18301;18930.526736831413;19131.13909874059;19417.708734368996;834.9916500835035;845.9154084591491;850.2942557677113;858.4849090545747;886.9423487473293;9603.135717785433;9842.311038227255;9883.357581757164;10002.449865257335;10018.39889606626;178707;179937;180379;180877;181721;33084.503732443554;33320.66679333176;33447.993120412364;34020.48969265463;34193.31613367719;1015.5024038221219;1061.7702824069238;1075.451519724946;1085.647164671485;1086.0334302470808;17614.735778963583;17818.376356827448;17915.820841791414;18368;18903;25304.74695253024;25572.104976326482;26130.346741331618;26222.60666089972;26410.603840942018;154806;155017;155322;155566.22216888843;156108.219458902;25288.620670689586;25512.48975020452;25619.6157057648;25725.099621513156;25854.095106671175;30946.84526577353;31178.376432471676;32303;33158.17104572405;33848.1537961553;25081.122160724288;25490.9078251875;25555.318610797985;25617.359566011;25750.484990299716;24223.273301800975;24406.389840254134;24937.251882443557;25303.87348063248;25689.357766055997;27985.720142799128;28047.57928631113;28183;28488.85755571209;28644;23107.422314442272;23198.65202021937;23937;24016.51966960686;24986.75013249844;18628.534286642942;19577.510562236057;19747.210111595374;19911.502212444804;19960.3013894513 02:25:32 INFO - PID 15912 | |2;jquery.html;372.396717317945;385.387234297467;388.38634956768317;390.0988716065888;402.4707509624843;15873.761893571591;16706.749398759028;17469;17655.823441765577;17775.466735997907;15531.37874485022;15953.12257825822;16326;16479.588010299747;16500.75248871265;5848.327442344132;6103.26760788706;6112.388761123874;6112.602680825732;6115.449609535141;5656.886862262772;5883.411658834125;5895.380984996556;6084.239470066242;6108.419700128481;5883.646981181143;5885.823425297248;5898.970505147468;5900.616459930091;5904.616199947011;5547.611667183279;5726.198332233491;5750.65496070233;5876;5886.823395298148;5604.691741954191;5607.102863541854;5619.185218143346;5628.268325117709;5638.915416268759;21265.36203913885;21812.672809907865;21909;21929.561408771893;22013.339599811872;1684.7196130940451;1693.8898971566932;1721.0878234535717;1725.094325479121;1725.1460527039071;14628.926855365762;15169.544913652608;15190.316435760416;15392.153431561259;15396.384144634201;2152.4834039830484;2152.6770984352474;2198.1756841184556;2211.2592281585526;2224.8974718890654;94708;95782;97115;97774;101959.49020254925;16650.83349166517;16687.165641717864;17079.44917901662;17222.397216097375;17260.91369543144;28203.43593128126;28291.575626365622;28313.57529637057;28368.148955531367;28539.429211415656;7896.921030789734;8004.239597238253;8018.639161237758;8208.09710931797;8358.498490090615;6522.804315870531;6580.8354791130605;6666.866662666719;6758.560693555001;6805.897911531331;7981.321587664997;8169.5098294102545;8196;8273.35252719124;8307.418480706292;3192.170035790711;3212.9196770080466;3295.549958018464;3334.1497918030745;3339.899803005914;687.5118665747375;692.6467501574233;693.8967042402604;694.8575542013875;716.1120210938399;14206.786898196535;14526.782098268535;14540;14737.778933316009;15262.694746105015;724.2069933422894;748.0649188514357;771.5872008475438;772.4824367673672;776.6039319946755;8383.580820958927;8402.327813774884;8762.649494020168;8781.385303028854;8829.735107946643;351566;355368;358420;360156;360698;79247;80163;82722.58638706888;83030.16969830345;83328.58335708283;946.6733976778138;954.4464210757744;956.2493442647627;956.6795123633522;960.8991055939166;13007.544735934196;13170.670733231746;13222.272774997082;13431.261280629658;13684.178949263076;37576.43635345527;38562.80718596389;39047.41428878626;39129;39931.40102898401;49512.50487495079;49600.751996239786;49660;50557.241641376146;51018.48981510138;7351.889721654073;7409.147947985835;7429.8082065791805;7518.135414427411;7529.774106776806;11750.647480575597;11881;11928.403579821148;12082.75834483323;12262.570810021607;10166.745831354276;10246.231532634933;10380.429076400871;10544.103751181236;10682.092022178202;9609.279304052085;9624.903750962681;9633.133018028411;9781.462019588991;10111.3427627204;10066.295359324777;10147;10198.33710808795;10537.789244215226;10864.565417383215;7443.292887175709;7644.617769111634;7645.120811106572;7697.499662521918;7818.374530037469;10130.594776208869;10224.64213752515;10359.94820025895;10447.738806529898;10543.193226942445 02:25:32 INFO - PID 15912 | |3;mootools.html;1056.7146870345007;1103.2442776697962;1112.9109671226297;1116.5477981417523;1123.8145705958518;9673.129418352355;10168.847467287987;10195.337303075295;10524.315919465249;10601.416922069284;10413.114885234763;10428.270021098526;10530.947345263263;10590.470476476185;10649.78700425991;2191.4521369657546;2220.0342850859847;2220.211824802196;2245.6743772153027;2247.0562363807157;2089.6552068908613;2130.476709152955;2131.7548481924546;2138.6043581937315;2156.8058874701273;2087.279888438486;2104;2109.504266497372;2118.5127420693248;2129.2866889592005;1854.6198029404006;1860.7581014468167;1863.6086421851428;1869.7662792150982;1870.251899240301;1752.71080271755;1814.410316647095;1920.990395048016;1952.2678995376734;2082.55225126597;9855.507224638812;9906.157976572;9932.205423566169;9940.105390514816;9970;5210.374755029383;5404.567634589223;5422.8373148805595;5442.99304628641;5457.454254574511;3290.2596915694016;3393.7794043387103;3479.1302174456387;3485.100620162018;3496;1106.4744246482855;1112.2047735868894;1139.4872307461676;1153.3425947210094;1155.7226265696256;15129.243537823066;15189.240537973057;15218.619534511616;15224.923875380662;15262.31319590621;4427.756473393994;4505.823394506865;4667.556582124693;4676.3686902267755;4739.146953548395;9801.460919649346;9842.606295748234;9876.061774131445;9884.505774711235;9890.109890109925;5135.871603209875;5240.816571420059;5274.947250527445;5278.076336641149;5285.101532739443;4777.092352453023;4813;4817.710937343701;4833.32333473314;4850.5149485051215;3681.9079523011605;3715.20123173519;3735.7571757835653;3775.7923314217433;3785.7917814520465;1065.616378103882;1067.7010437077631;1070.6787963610886;1078.46615925116;1086.8587083679229;506.9974650126726;513.958883289336;516.9483051694875;522.27925462861;526.1660268474511;4728.858134255978;4771.66598338113;4785.736784476818;4804.759762011886;4816.229403295456;454.7430701653555;471.94572624147975;472.35523510408734;473.28533913790426;479.2595440045139;3573.8701290924773;3613.7831730096277;3780.4140358244517;3873.1866308075055;3895.5714871364125;14175.362108705132;14474.638134046523;14778.63053423673;14791.186484743443;14856.331465084097;14569.271536423137;14613.196274204809;14640.121592704472;14673.486427974969;14673.706525869422;6773.762918297836;7210.31502007319;7212.206657267697;7269.7455589054125;7270.563766174047;5453.536449401687;5696.8006119785605;5700.3444603871085;5754.280714910637;5861.208736820475;12603.747925041265;12856.228626282453;12905.548305809252;12906.41921113571;12968.8054679178;13022.934885325512;13101.934490327487;13123.60629181126;13324.133931294435;13332.533361332695;7944.960275198587;8102.716404925799;8107.594620268845;8135.227153420416;8174.141715120065;9479.715608531755;9486.810263794823;9529;9581.568829402555;9602.855957160788;7810.336121429515;7931.286184243446;7948.721794737156;7973.561454120079;7984.6806127754235;7737.5744334062165;7763.961180194063;7826.7651970440975;7904.170062143622;7951.3638908886;6611.537192396486;6661.500387470862;6684.4318232950745;6691.464682825265;6698;4180.853670121531;4825.927611085766;4837.951620483891;4838.7338696372035;4947.60419166473;5023.899522009612;5051.3433253676785;5069.619778516552;5096.082705112967;5138.177891537336 02:25:32 INFO - PID 15912 | |4;prototype.html;365.6782031812005;368.43261377478683;371.9163188282637;373.231143843682;378.47581100176257;5419.701916394597;5423.837284881455;5427.864303392417;5447.809326673567;5567.220589117527;5287.312649355588;5358.812441564546;5366.91949620756;5371.462853714636;5379.488948549882;3954.3673012318036;4057.3102572562734;4080.9387859182134;4098.118904435546;4103.692223083273;4060.533038700543;4075.8981025474454;4098.877033688994;4102.953746794563;4113.950942509656;4021.3766866135797;4030.919381612366;4035.273650742865;4043.5349934757437;4049.473568436114;3939.7242193046213;4043.9595604043875;4052.5744796796207;4064.918701625951;4070.287699652579;3560.732945029133;3591.6947059499976;3600.9279814403567;3603.6576525230325;3612.422012478017;5291.206319052135;5308.70802105884;5315.734213289359;5317.308749862532;5326.414094449608;4746.691465054761;4830.130576496229;4833.709977401332;4833.854984350475;4850.878728031792;5712.828615141552;5714.257146570961;5740.842536604892;5744.310682718059;5765.567582431292;3997.6801855851463;4004.379321205218;4007.519097708294;4013.137175507251;4017.7589344639414;5974.6713930733795;6064.120702498113;6099.878002439971;6112.633242005494;6114.724837382284;4096.672266218696;4106.240345536085;4113.753174809521;4114.847842604076;4116.547179810218;4146.792660366969;4147.2534943710425;4151.190517849051;4156.958430415718;4157.750534967911;4695.882602934886;4762.618990480753;4773.952260477351;4778.354922085544;4780.306855505932;5755.424457554295;5757.88484230313;5782.236417892499;5782.942170578324;5786.846168837909;1425.2731107135435;1439.6251579741322;1442.949496767608;1443.256722787765;1448.2758620689656;902.1429641840278;940.4028441939417;958.075457183807;962.7785609309758;967.4582233949011;4967.5777558907175;4973.1297023020825;4978.477259887732;4989.55094041538;4993.825216117491;5970.701464926737;5974.671393073336;5984.970075149597;6000.279966404059;6015.939840601625;4828;4953.826616068421;4953.975230123826;4972.5276098770555;5000.949990500048;3129.139486641192;3152.8265945373223;3158.5578019077348;3174.5714428507263;3182.10900947735;5456.236126942231;5495.972520137374;5519.39286678465;5548.805791797348;5568.9443105569235;6089.238845144357;6109.419605137505;6110.5722599418505;6133.325334213233;6168.814935551851;5379.381371142291;5498.917516237259;5502.972485137629;5511.22842802;5529.944700553024;5979.043353063489;5995.280566332068;6004.249468816398;6012.038073908154;6025.126356678169;5680.176374425602;5860.443257890493;5893.116032595145;5898.380670029585;5932.614380065282;5531.751071201725;5563.443655634566;5577.386487486292;5583.525400341016;5599.776008959596;3984.5854721573423;4059.3707975263883;4059.573744756758;4070.2063097695664;4073.144639625712;6006.279246490449;6010.2186715726675;6033.728482218398;6035.1249068885645;6050.757969681164;5809.215755873072;5818.592698511064;5838.532917366516;5849.444302791228;5851.502622277154;5683.602147849776;5774.48029677331;5793.536517078708;5796.1305804129715;5843.2403787507355;5709.029464991045;5712.857178570569;5748.367679555329;5762.423757624204;5764.337101233412;5743.798967036134;5784;5845.620034697731;5868.794592189253;5887.852803679943;5635.746391412478;5643.545057899827;5654.745536450787;5655.740161649705;5663.32040155184 02:25:32 INFO - PID 15912 | |5;yui.html;467.9321498382737;511.4169846375132;513.2993463921748;517.7980587570847;522.3209827224607;11886.286822790627;12223.449944752485;12373.257604543722;13738.519151829689;14442.711145777079;12252.326122063283;12297.569585064524;12298.38508074595;12335.444904979275;12450.003999680026;508.0195223219204;508.5067484540009;516.1148630099378;519.7713006277245;525.3039722367859;520.9973950130244;521.1635325302891;522.3757609656462;547.4990383798819;552.4475524475524;550.807217473885;567.0501909301923;571.1261769492662;572.461885827321;574.4399210769487;548.8984537860508;549.5081901697978;550.0127271547582;555.0037682360173;567.2512283785405;394.15257197026335;395.5925396841258;397.52098721041364;408.53427093113874;410.19396885120585;12286.385680716017;12317.938410307981;12428.37858107091;12439.875601244054;12534.74930501394;12435.813462798065;12480.126391152622;13235;13274.070815042951;13325.600231993056;11029.944850275777;11314.094872410187;11323.43382830855;11405.543778248943;11430.142739294586;2826.5194916864184;2846.245744877609;2847;2847.7152284771564;2852.3154442933546;83463;84507.7323840149;84704;84875;85244;9413.19987801031;9521.28590355726;9563.282753793494;9573.664921727845;10314.27800054004;15898.682026359407;16741.246643901053;17091;17238.741418878726;17390.565235869206;5980.13288073227;6069.635821850703;6097.634141951497;6148.047052706837;6154.599951003171;2963.3332500187284;3003.7747168962414;3032.9696703032687;3035.2867076237067;3039.4954497523427;3173.76196785242;3289.91775205617;3310.576452125561;3333.983330083334;3347.1297462659395;627.8650090230623;628.6982248520644;635.269440143829;636.3096040795789;637.445422482434;454.0895504513429;467.70768269831353;472.499150900047;474.23411190927095;478.8611302722241;8857.158569935846;8931.285497160212;9442.651774742955;9553.331266811256;9706.272029597809;482.53917508779034;484.6074679509608;487.381026096855;495.7942453881671;503.66779867250915;4023.6781057515914;4154.709170358106;4214.978925105354;4258.467691538558;4275.845521709121;74077.62961185268;75528.24471755321;77583.61208193922;86541;86652;63615.6819215901;66008.33991660118;66921.33078669249;68323.65838170778;68475.31524684689;56771.432285676616;59178;59585.40414595798;61606.69196653988;62113.37886621076;8698.652053918026;9069.954650226706;9185.402948808307;9298.163165315154;9567.091126342986;27326;27331.59002615002;28284.43431131407;28552;28946.7105328944;50643.04514276705;51439;52212.216816748536;52709.7364513175;54118;11863.822042669539;11924.642260732191;12245.448954797233;12544.811827822772;12653.367331633566;13508.32458377097;13663.111897726616;13746.587602371945;13774.449022039005;14252.144871307755;11689;11852.111091667986;11940.223885447418;11965.76068478608;11972.76054478923;11540.653780386601;11920.463579138786;11988.280703157838;12068.275903445821;12160;12268;12295.9385203077;12371.319577423328;12371.75256494883;12456.937715311366;9486.762830929281;9774.560144793359;9890;9946.950265248628;10108.39349639024;10049.040437114692;10103.494825258855;10116.89883101189;10184.388936663823;10433.739156521147 02:25:32 INFO - PID 15912 | __end_tp_report 02:25:32 INFO - PID 15912 | __start_cc_report 02:25:32 INFO - PID 15912 | _x_x_mozilla_cycle_collect,402 02:25:32 INFO - PID 15912 | __end_cc_report 02:25:32 INFO - PID 15912 | __startTimestamp1496049932320__endTimestamp 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | ------- Summary: start ------- 02:25:32 INFO - PID 15912 | Number of tests: 6 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#0] dojo.html Cycles:165 Average:5184.25 Median:5330.15 stddev:605.08 (11.4%) stddev-sans-first:574.57 02:25:32 INFO - PID 15912 | Values: 2695.4 2706.3 2711.5 2716.1 2737.5 5137.9 5242.1 5245.5 5283.8 5322.1 5192.5 5202.9 5228.4 5300.1 5332.1 4611.0 4666.0 4690.5 4698.6 4715.5 4625.0 4629.3 4728.9 4736.0 4764.5 4572.3 4633.7 4668.1 4729.8 4731.4 4665.5 4733.8 4757.1 4757.7 4778.1 4694.1 4702.3 4706.5 4708.8 4745.9 5187.0 5259.4 5269.2 5276.0 5319.3 5466.6 5531.9 5623.9 5694.9 5703.2 5652.3 5657.0 5657.8 5701.0 5724.8 5238.5 5246.4 5250.9 5257.0 5300.6 5631.7 5739.5 5756.8 5839.6 5860.5 5573.2 5614.0 5648.3 5666.6 5668.3 5585.4 5655.0 5667.4 5673.8 5675.6 5495.6 5528.0 5631.4 5637.7 5645.3 5578.8 5589.9 5619.2 5622.6 5685.9 4807.5 4808.7 4808.8 4812.2 4851.3 4059.6 4073.5 4076.9 4105.2 4157.6 4670.4 4672.8 4735.5 4784.9 4799.0 5753.8 5771.5 5792.0 5804.7 5821.5 4841.9 4852.2 4859.1 4861.4 4899.0 4921.7 5133.9 5149.0 5149.5 5150.9 5231.9 5242.6 5291.8 5297.7 5313.5 5480.8 5573.9 5660.2 5744.8 5774.7 5224.1 5326.0 5326.6 5330.1 5340.4 5517.3 5536.2 5540.4 5550.8 5555.4 5539.2 5589.0 5625.4 5630.8 5707.9 5517.1 5550.8 5567.9 5602.3 5616.3 5551.4 5551.4 5559.8 5562.3 5570.5 5361.3 5439.6 5443.9 5449.3 5478.2 5442.9 5504.3 5505.6 5535.5 5547.1 5414.4 5433.0 5443.9 5499.1 5503.4 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#1] ext.html Cycles:180 Average:28701.04 Median:28325.43 stddev:42185.31 (148.9%) stddev-sans-first:42250.90 02:25:32 INFO - PID 15912 | Values: 605.5 652.5 676.3 1053.7 1074.3 30019.5 30749.4 30953.0 31185.4 31211.0 29629.3 29710.0 29767.6 29825.0 30764.5 6308.5 6602.3 6721.0 6725.7 6727.6 6754.3 6795.3 6800.0 6807.6 6819.7 6791.7 6842.9 6849.6 6852.6 6854.2 6797.7 6811.7 6816.6 6824.0 6824.5 6656.9 6678.5 6695.6 6715.6 6717.8 28023.0 28140.9 28205.6 28291.9 28359.0 2394.4 2402.5 2427.3 2430.1 2446.8 22805.3 22845.0 23041.7 23268.7 23300.0 2853.5 2866.9 2874.9 2958.0 2977.0 147776.0 147918.0 147964.0 155916.2 163029.2 33101.4 33109.5 33526.0 34101.3 34583.5 33552.0 33817.8 34680.8 35090.0 36339.3 11305.2 11402.1 11413.7 11475.4 11590.2 9304.5 9312.4 9324.0 9348.0 9385.4 10165.4 10204.4 10230.2 10457.2 10490.5 4590.4 4612.4 4617.4 4625.1 4677.3 770.9 779.1 780.2 787.4 796.3 18247.3 18301.0 18930.5 19131.1 19417.7 835.0 845.9 850.3 858.5 886.9 9603.1 9842.3 9883.4 10002.4 10018.4 178707.0 179937.0 180379.0 180877.0 181721.0 33084.5 33320.7 33448.0 34020.5 34193.3 1015.5 1061.8 1075.5 1085.6 1086.0 17614.7 17818.4 17915.8 18368.0 18903.0 25304.7 25572.1 26130.3 26222.6 26410.6 154806.0 155017.0 155322.0 155566.2 156108.2 25288.6 25512.5 25619.6 25725.1 25854.1 30946.8 31178.4 32303.0 33158.2 33848.2 25081.1 25490.9 25555.3 25617.4 25750.5 24223.3 24406.4 24937.3 25303.9 25689.4 27985.7 28047.6 28183.0 28488.9 28644.0 23107.4 23198.7 23937.0 24016.5 24986.8 18628.5 19577.5 19747.2 19911.5 19960.3 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#2] jquery.html Cycles:180 Average:25209.76 Median:20166.94 stddev:59985.04 (297.4%) stddev-sans-first:60124.33 02:25:32 INFO - PID 15912 | Values: 372.4 385.4 388.4 390.1 402.5 15873.8 16706.7 17469.0 17655.8 17775.5 15531.4 15953.1 16326.0 16479.6 16500.8 5848.3 6103.3 6112.4 6112.6 6115.4 5656.9 5883.4 5895.4 6084.2 6108.4 5883.6 5885.8 5899.0 5900.6 5904.6 5547.6 5726.2 5750.7 5876.0 5886.8 5604.7 5607.1 5619.2 5628.3 5638.9 21265.4 21812.7 21909.0 21929.6 22013.3 1684.7 1693.9 1721.1 1725.1 1725.1 14628.9 15169.5 15190.3 15392.2 15396.4 2152.5 2152.7 2198.2 2211.3 2224.9 94708.0 95782.0 97115.0 97774.0 101959.5 16650.8 16687.2 17079.4 17222.4 17260.9 28203.4 28291.6 28313.6 28368.1 28539.4 7896.9 8004.2 8018.6 8208.1 8358.5 6522.8 6580.8 6666.9 6758.6 6805.9 7981.3 8169.5 8196.0 8273.4 8307.4 3192.2 3212.9 3295.5 3334.1 3339.9 687.5 692.6 693.9 694.9 716.1 14206.8 14526.8 14540.0 14737.8 15262.7 724.2 748.1 771.6 772.5 776.6 8383.6 8402.3 8762.6 8781.4 8829.7 351566.0 355368.0 358420.0 360156.0 360698.0 79247.0 80163.0 82722.6 83030.2 83328.6 946.7 954.4 956.2 956.7 960.9 13007.5 13170.7 13222.3 13431.3 13684.2 37576.4 38562.8 39047.4 39129.0 39931.4 49512.5 49600.8 49660.0 50557.2 51018.5 7351.9 7409.1 7429.8 7518.1 7529.8 11750.6 11881.0 11928.4 12082.8 12262.6 10166.7 10246.2 10380.4 10544.1 10682.1 9609.3 9624.9 9633.1 9781.5 10111.3 10066.3 10147.0 10198.3 10537.8 10864.6 7443.3 7644.6 7645.1 7697.5 7818.4 10130.6 10224.6 10359.9 10447.7 10543.2 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#3] mootools.html Cycles:180 Average:6222.34 Median:4466.79 stddev:4296.83 (96.2%) stddev-sans-first:4291.35 02:25:32 INFO - PID 15912 | Values: 1056.7 1103.2 1112.9 1116.5 1123.8 9673.1 10168.8 10195.3 10524.3 10601.4 10413.1 10428.3 10530.9 10590.5 10649.8 2191.5 2220.0 2220.2 2245.7 2247.1 2089.7 2130.5 2131.8 2138.6 2156.8 2087.3 2104.0 2109.5 2118.5 2129.3 1854.6 1860.8 1863.6 1869.8 1870.3 1752.7 1814.4 1921.0 1952.3 2082.6 9855.5 9906.2 9932.2 9940.1 9970.0 5210.4 5404.6 5422.8 5443.0 5457.5 3290.3 3393.8 3479.1 3485.1 3496.0 1106.5 1112.2 1139.5 1153.3 1155.7 15129.2 15189.2 15218.6 15224.9 15262.3 4427.8 4505.8 4667.6 4676.4 4739.1 9801.5 9842.6 9876.1 9884.5 9890.1 5135.9 5240.8 5274.9 5278.1 5285.1 4777.1 4813.0 4817.7 4833.3 4850.5 3681.9 3715.2 3735.8 3775.8 3785.8 1065.6 1067.7 1070.7 1078.5 1086.9 507.0 514.0 516.9 522.3 526.2 4728.9 4771.7 4785.7 4804.8 4816.2 454.7 471.9 472.4 473.3 479.3 3573.9 3613.8 3780.4 3873.2 3895.6 14175.4 14474.6 14778.6 14791.2 14856.3 14569.3 14613.2 14640.1 14673.5 14673.7 6773.8 7210.3 7212.2 7269.7 7270.6 5453.5 5696.8 5700.3 5754.3 5861.2 12603.7 12856.2 12905.5 12906.4 12968.8 13022.9 13101.9 13123.6 13324.1 13332.5 7945.0 8102.7 8107.6 8135.2 8174.1 9479.7 9486.8 9529.0 9581.6 9602.9 7810.3 7931.3 7948.7 7973.6 7984.7 7737.6 7764.0 7826.8 7904.2 7951.4 6611.5 6661.5 6684.4 6691.5 6698.0 4180.9 4825.9 4838.0 4838.7 4947.6 5023.9 5051.3 5069.6 5096.1 5138.2 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#4] prototype.html Cycles:180 Average:4740.26 Median:5399.60 stddev:1419.23 (26.3%) stddev-sans-first:1384.71 02:25:32 INFO - PID 15912 | Values: 365.7 368.4 371.9 373.2 378.5 5419.7 5423.8 5427.9 5447.8 5567.2 5287.3 5358.8 5366.9 5371.5 5379.5 3954.4 4057.3 4080.9 4098.1 4103.7 4060.5 4075.9 4098.9 4103.0 4114.0 4021.4 4030.9 4035.3 4043.5 4049.5 3939.7 4044.0 4052.6 4064.9 4070.3 3560.7 3591.7 3600.9 3603.7 3612.4 5291.2 5308.7 5315.7 5317.3 5326.4 4746.7 4830.1 4833.7 4833.9 4850.9 5712.8 5714.3 5740.8 5744.3 5765.6 3997.7 4004.4 4007.5 4013.1 4017.8 5974.7 6064.1 6099.9 6112.6 6114.7 4096.7 4106.2 4113.8 4114.8 4116.5 4146.8 4147.3 4151.2 4157.0 4157.8 4695.9 4762.6 4774.0 4778.4 4780.3 5755.4 5757.9 5782.2 5782.9 5786.8 1425.3 1439.6 1442.9 1443.3 1448.3 902.1 940.4 958.1 962.8 967.5 4967.6 4973.1 4978.5 4989.6 4993.8 5970.7 5974.7 5985.0 6000.3 6015.9 4828.0 4953.8 4954.0 4972.5 5000.9 3129.1 3152.8 3158.6 3174.6 3182.1 5456.2 5496.0 5519.4 5548.8 5568.9 6089.2 6109.4 6110.6 6133.3 6168.8 5379.4 5498.9 5503.0 5511.2 5529.9 5979.0 5995.3 6004.2 6012.0 6025.1 5680.2 5860.4 5893.1 5898.4 5932.6 5531.8 5563.4 5577.4 5583.5 5599.8 3984.6 4059.4 4059.6 4070.2 4073.1 6006.3 6010.2 6033.7 6035.1 6050.8 5809.2 5818.6 5838.5 5849.4 5851.5 5683.6 5774.5 5793.5 5796.1 5843.2 5709.0 5712.9 5748.4 5762.4 5764.3 5743.8 5784.0 5845.6 5868.8 5887.9 5635.7 5643.5 5654.7 5655.7 5663.3 02:25:32 INFO - PID 15912 | 02:25:32 INFO - PID 15912 | [#5] yui.html Cycles:180 Average:16242.04 Median:4267.16 stddev:22440.71 (525.9%) stddev-sans-first:22472.41 02:25:32 INFO - PID 15912 | Values: 467.9 511.4 513.3 517.8 522.3 11886.3 12223.4 12373.3 13738.5 14442.7 12252.3 12297.6 12298.4 12335.4 12450.0 508.0 508.5 516.1 519.8 525.3 521.0 521.2 522.4 547.5 552.4 550.8 567.1 571.1 572.5 574.4 548.9 549.5 550.0 555.0 567.3 394.2 395.6 397.5 408.5 410.2 12286.4 12317.9 12428.4 12439.9 12534.7 12435.8 12480.1 13235.0 13274.1 13325.6 11029.9 11314.1 11323.4 11405.5 11430.1 2826.5 2846.2 2847.0 2847.7 2852.3 83463.0 84507.7 84704.0 84875.0 85244.0 9413.2 9521.3 9563.3 9573.7 10314.3 15898.7 16741.2 17091.0 17238.7 17390.6 5980.1 6069.6 6097.6 6148.0 6154.6 2963.3 3003.8 3033.0 3035.3 3039.5 3173.8 3289.9 3310.6 3334.0 3347.1 627.9 628.7 635.3 636.3 637.4 454.1 467.7 472.5 474.2 478.9 8857.2 8931.3 9442.7 9553.3 9706.3 482.5 484.6 487.4 495.8 503.7 4023.7 4154.7 4215.0 4258.5 4275.8 74077.6 75528.2 77583.6 86541.0 86652.0 63615.7 66008.3 66921.3 68323.7 68475.3 56771.4 59178.0 59585.4 61606.7 62113.4 8698.7 9070.0 9185.4 9298.2 9567.1 27326.0 27331.6 28284.4 28552.0 28946.7 50643.0 51439.0 52212.2 52709.7 54118.0 11863.8 11924.6 12245.4 12544.8 12653.4 13508.3 13663.1 13746.6 13774.4 14252.1 11689.0 11852.1 11940.2 11965.8 11972.8 11540.7 11920.5 11988.3 12068.3 12160.0 12268.0 12295.9 12371.3 12371.8 12456.9 9486.8 9774.6 9890.0 9947.0 10108.4 10049.0 10103.5 10116.9 10184.4 10433.7 02:25:32 INFO - PID 15912 | -------- Summary: end -------- 02:25:32 INFO - PID 15912 | 02:25:33 INFO - TEST-INFO | 15912: exit 0 02:25:33 INFO - TEST-OK | dromaeo_css | took 1148137ms 02:25:33 INFO - TEST-START | kraken 02:25:33 INFO - operating with platform_type : linux_ 02:25:33 INFO - Initialising browser for kraken test... 02:25:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53475/getInfo.html -profile /tmp/tmp0PK1R9/profile 02:25:33 INFO - TEST-INFO | started process 16338 (/builds/slave/test/build/application/firefox/firefox http://localhost:53475/getInfo.html) 02:26:08 INFO - TEST-INFO | 16338: killed by SIGTERM 02:26:08 INFO - Browser initialized. 02:26:08 INFO - Running cycle 1/1 for kraken test... 02:26:08 INFO - TEST-INFO | started process 16561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PK1R9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:20 INFO - PID 16561 | RSS: Main: 186355712 02:26:20 INFO - PID 16561 | 02:26:23 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53475/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:24 INFO - PID 16561 | RSS: Main: 189853696 02:26:24 INFO - PID 16561 | 02:26:26 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53475/tests/kraken/driver.html?testName=audio-dft) 02:26:27 INFO - PID 16561 | RSS: Main: 188878848 02:26:27 INFO - PID 16561 | 02:26:30 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53475/tests/kraken/driver.html?testName=audio-fft) 02:26:31 INFO - PID 16561 | RSS: Main: 185417728 02:26:31 INFO - PID 16561 | 02:26:33 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53475/tests/kraken/driver.html?testName=audio-oscillator) 02:26:33 INFO - PID 16561 | RSS: Main: 185888768 02:26:33 INFO - PID 16561 | 02:26:35 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:36 INFO - PID 16561 | RSS: Main: 186044416 02:26:36 INFO - PID 16561 | 02:26:39 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53475/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:40 INFO - PID 16561 | RSS: Main: 190025728 02:26:40 INFO - PID 16561 | 02:26:43 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53475/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:44 INFO - PID 16561 | RSS: Main: 186064896 02:26:44 INFO - PID 16561 | 02:26:47 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53475/tests/kraken/driver.html?testName=json-parse-financial) 02:26:48 INFO - PID 16561 | RSS: Main: 186560512 02:26:48 INFO - PID 16561 | 02:26:49 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:50 INFO - PID 16561 | RSS: Main: 186679296 02:26:50 INFO - PID 16561 | 02:26:52 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:52 INFO - PID 16561 | RSS: Main: 186101760 02:26:52 INFO - PID 16561 | 02:26:55 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:55 INFO - PID 16561 | RSS: Main: 186515456 02:26:55 INFO - PID 16561 | 02:26:58 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:59 INFO - PID 16561 | RSS: Main: 186556416 02:26:59 INFO - PID 16561 | 02:27:02 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:03 INFO - PID 16561 | RSS: Main: 186540032 02:27:03 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | Cycle 1(1): loaded http://localhost:53475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53475/tests/kraken/driver.html?testName=ai-astar) 02:27:05 INFO - PID 16561 | RSS: Main: 187744256 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | __start_tp_report 02:27:05 INFO - PID 16561 | _x_x_mozilla_page_load 02:27:05 INFO - PID 16561 | _x_x_mozilla_page_load_details 02:27:05 INFO - PID 16561 | |i|pagename|runs| 02:27:05 INFO - PID 16561 | |0;ai-astar;103;110;110;110;109;109;109;110;110;111 02:27:05 INFO - PID 16561 | |1;audio-beat-detection;150;122;124;174;124;123;122;124;158;124 02:27:05 INFO - PID 16561 | |2;audio-dft;165;164;163;169;177;177;164;164;164;162 02:27:05 INFO - PID 16561 | |3;audio-fft;79;74;74;114;74;74;74;75;100;73 02:27:05 INFO - PID 16561 | |4;audio-oscillator;86;84;104;87;86;83;97;83;84;105 02:27:05 INFO - PID 16561 | |5;imaging-gaussian-blur;113;115;119;116;114;114;115;118;118;113 02:27:05 INFO - PID 16561 | |6;imaging-darkroom;152;151;151;152;154;154;151;153;152;154 02:27:05 INFO - PID 16561 | |7;imaging-desaturate;95;96;95;94;95;94;99;94;99;99 02:27:05 INFO - PID 16561 | |8;json-parse-financial;60;58;56;56;57;58;56;56;57;57 02:27:05 INFO - PID 16561 | |9;json-stringify-tinderbox;58;57;57;56;59;57;57;57;57;56 02:27:05 INFO - PID 16561 | |10;stanford-crypto-aes;88;89;88;88;88;96;89;89;119;87 02:27:05 INFO - PID 16561 | |11;stanford-crypto-ccm;143;134;134;139;142;134;139;134;157;129 02:27:05 INFO - PID 16561 | |12;stanford-crypto-pbkdf2;187;199;192;197;195;213;211;194;196;193 02:27:05 INFO - PID 16561 | |13;stanford-crypto-sha256-iterative;73;74;73;85;72;73;76;75;72;78 02:27:05 INFO - PID 16561 | __end_tp_report 02:27:05 INFO - PID 16561 | __start_cc_report 02:27:05 INFO - PID 16561 | _x_x_mozilla_cycle_collect,1035 02:27:05 INFO - PID 16561 | __end_cc_report 02:27:05 INFO - PID 16561 | __startTimestamp1496050025351__endTimestamp 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | ------- Summary: start ------- 02:27:05 INFO - PID 16561 | Number of tests: 14 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.23 (2.0%) stddev-sans-first:0.67 02:27:05 INFO - PID 16561 | Values: 103.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 111.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:124.00 stddev:18.97 (15.3%) stddev-sans-first:19.27 02:27:05 INFO - PID 16561 | Values: 150.0 122.0 124.0 174.0 124.0 123.0 122.0 124.0 158.0 124.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#2] audio-dft Cycles:10 Average:166.90 Median:164.50 stddev:5.63 (3.4%) stddev-sans-first:5.93 02:27:05 INFO - PID 16561 | Values: 165.0 164.0 163.0 169.0 177.0 177.0 164.0 164.0 164.0 162.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.00 stddev:14.14 (19.1%) stddev-sans-first:14.97 02:27:05 INFO - PID 16561 | Values: 79.0 74.0 74.0 114.0 74.0 74.0 74.0 75.0 100.0 73.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:85.00 stddev:8.70 (10.2%) stddev-sans-first:9.11 02:27:05 INFO - PID 16561 | Values: 86.0 84.0 104.0 87.0 86.0 83.0 97.0 83.0 84.0 105.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:2.17 (1.9%) stddev-sans-first:2.11 02:27:05 INFO - PID 16561 | Values: 113.0 115.0 119.0 116.0 114.0 114.0 115.0 118.0 118.0 113.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.50 stddev:1.26 (0.8%) stddev-sans-first:1.33 02:27:05 INFO - PID 16561 | Values: 152.0 151.0 151.0 152.0 154.0 154.0 151.0 153.0 152.0 154.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:2.16 (2.3%) stddev-sans-first:2.26 02:27:05 INFO - PID 16561 | Values: 95.0 96.0 95.0 94.0 95.0 94.0 99.0 94.0 99.0 99.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:1.29 (2.3%) stddev-sans-first:0.83 02:27:05 INFO - PID 16561 | Values: 60.0 58.0 56.0 56.0 57.0 58.0 56.0 56.0 57.0 57.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.87 02:27:05 INFO - PID 16561 | Values: 58.0 57.0 57.0 56.0 59.0 57.0 57.0 57.0 57.0 56.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:88.50 stddev:9.78 (11.1%) stddev-sans-first:10.26 02:27:05 INFO - PID 16561 | Values: 88.0 89.0 88.0 88.0 88.0 96.0 89.0 89.0 119.0 87.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.00 stddev:7.79 (5.6%) stddev-sans-first:8.09 02:27:05 INFO - PID 16561 | Values: 143.0 134.0 134.0 139.0 142.0 134.0 139.0 134.0 157.0 129.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:196.50 stddev:8.21 (4.2%) stddev-sans-first:7.74 02:27:05 INFO - PID 16561 | Values: 187.0 199.0 192.0 197.0 195.0 213.0 211.0 194.0 196.0 193.0 02:27:05 INFO - PID 16561 | 02:27:05 INFO - PID 16561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:74.50 stddev:3.96 (5.3%) stddev-sans-first:4.12 02:27:05 INFO - PID 16561 | Values: 73.0 74.0 73.0 85.0 72.0 73.0 76.0 75.0 72.0 78.0 02:27:05 INFO - PID 16561 | -------- Summary: end -------- 02:27:05 INFO - PID 16561 | 02:27:06 INFO - TEST-INFO | 16561: exit 0 02:27:06 INFO - TEST-OK | kraken | took 93367ms 02:27:06 INFO - SUITE-END | took 1241s 02:27:07 INFO - Completed test suite (00:20:41) 02:27:07 INFO - javascript benchmark 02:27:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6419.606531978643, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.420484595812, 2706.2963629456335, 2711.539038363478, 2716.1172618898863, 2737.4798788230237, 5137.871553211172, 5242.056429842627, 5245.527902488775, 5283.788648454067, 5322.068637988351, 5192.454792246816, 5202.947970520303, 5228.372595288571, 5300.09898317286, 5332.093544097503, 4610.953890461103, 4665.950161213734, 4690.507496712848, 4698.64760142989, 4715.457722361921, 4624.953750462486, 4629.282461218517, 4728.858134255978, 4735.952640473585, 4764.499727528611, 4572.268437050056, 4633.652476064275, 4668.066386722669, 4729.787159577827, 4731.432228132629, 4665.533446655341, 4733.810647574093, 4757.09615173116, 4757.738324392157, 4778.092162489116, 4694.131585656631, 4702.294655801623, 4706.505816889246, 4708.811647534095, 4745.928811067837, 5187.04039752647, 5259.421463638997, 5269.1832765921345, 5276.0, 5319.255304257407, 5466.590005749545, 5531.889362212773, 5623.887522249532, 5694.943050569483, 5703.17303990919, 5652.321721393418, 5656.971715141439, 5657.8019769307875, 5701.0308247598, 5724.771009159628, 5238.528532432099, 5246.422893481714, 5250.921236181461, 5257.027449921777, 5300.602454815904, 5631.746571404296, 5739.512141468022, 5756.798512052058, 5839.620424672383, 5860.531157507389, 5573.164025396142, 5614.017546929271, 5648.293963254593, 5666.631668941505, 5668.319801623831, 5585.441455854382, 5654.971725141348, 5667.433256674382, 5673.8014169504695, 5675.602707810496, 5495.587830912697, 5528.0, 5631.352394474688, 5637.7181140942785, 5645.266115404971, 5578.832635020955, 5589.944100559023, 5619.213310136584, 5622.57830662702, 5685.914711279334, 4807.495213002654, 4808.711477311373, 4808.759562021885, 4812.1578723723205, 4851.296561998491, 4059.6346328830546, 4073.45008423859, 4076.938845917254, 4105.178964207171, 4157.563455837154, 4670.439547254351, 4672.813087476531, 4735.502772208937, 4784.856454306377, 4798.95201047985, 5753.769849206069, 5771.480566748929, 5791.971040144772, 5804.738786754522, 5821.505172060422, 4841.903161936812, 4852.247901575191, 4859.052484765508, 4861.368022157168, 4898.975505122523, 4921.680090794159, 5133.948660513347, 5148.974255128775, 5149.536541711264, 5150.948490515122, 5231.895362092813, 5242.633015688865, 5291.841244762663, 5297.655652382583, 5313.521783039545, 5480.808171713971, 5573.944260557342, 5660.235868157746, 5744.770209191585, 5774.711264436845, 5224.05966925957, 5326.041312563776, 5326.600504962221, 5330.147176451749, 5340.412554619066, 5517.310336207974, 5536.197251398444, 5540.445955404427, 5550.75021624036, 5555.444455554412, 5539.19681646151, 5588.972055139861, 5625.353084395347, 5630.774769009194, 5707.914381284367, 5517.089680202722, 5550.805721799879, 5567.888642227052, 5602.327720673546, 5616.297962754656, 5551.361593416647, 5551.417101204315, 5559.833205003856, 5562.276904002454, 5570.498655121059, 5361.27622770921, 5439.564834813126, 5443.891122177613, 5449.264349312951, 5478.205660179331, 5442.918356224581, 5504.311961004874, 5505.614606977633, 5535.501804837584, 5547.084731019498, 5414.404415514369, 5433.049216387038, 5443.945560544502, 5499.1476321170285, 5503.367112781922], "value": 5140.1910366983275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.5125623872783, 652.4780175859313, 676.2696288008951, 1053.6944286157016, 1074.3392813419748, 30019.549706754387, 30749.38501229974, 30952.988055776357, 31185.376292474164, 31211.0, 29629.259268518297, 29710.0, 29767.553486697663, 29825.0, 30764.53853192204, 6308.495320374359, 6602.2737498875085, 6720.966395168018, 6725.730970761164, 6727.562708423937, 6754.290799466059, 6795.286494918037, 6800.0, 6807.591544507345, 6819.693113809891, 6791.660416979156, 6842.9315706843045, 6849.554778939378, 6852.6231057291825, 6854.246032936373, 6797.728090876359, 6811.693473793691, 6816.556923799937, 6824.0, 6824.454043676519, 6656.866862662768, 6678.4991125665765, 6695.564788288746, 6715.56348837324, 6717.798466046026, 28023.0, 28140.859295703594, 28205.576916346065, 28291.85854070737, 28359.0, 2394.3535245483795, 2402.4714562796157, 2427.271818454474, 2430.052279610953, 2446.8164887633498, 22805.31584052481, 22845.0, 23041.654375184386, 23268.65097023546, 23300.0, 2853.4578430098213, 2866.885324587014, 2874.870630821597, 2957.985210073936, 2977.002704094131, 147776.0, 147918.0, 147964.0, 155916.22041889717, 163029.18485407496, 33101.36580878679, 33109.503357449656, 33526.0, 34101.31797364039, 34583.4812477813, 33552.0, 33817.83091084529, 34680.826595866856, 35090.0, 36339.27321453609, 11305.152113591514, 11402.087832973508, 11413.714657133472, 11475.368854713071, 11590.188686792013, 9304.53477326131, 9312.44125352481, 9324.0, 9348.0, 9385.436873787594, 10165.44090075053, 10204.43875586835, 10230.181585473145, 10457.163426925828, 10490.475476226158, 4590.42619672541, 4612.423447069116, 4617.376654151713, 4625.121226966866, 4677.345171675968, 770.9036370453694, 779.1040303650734, 780.157429975625, 787.4173111897155, 796.2714116583261, 18247.27010919575, 18301.0, 18930.526736831413, 19131.13909874059, 19417.708734368996, 834.9916500835035, 845.9154084591491, 850.2942557677113, 858.4849090545747, 886.9423487473293, 9603.135717785433, 9842.311038227255, 9883.357581757164, 10002.449865257335, 10018.39889606626, 178707.0, 179937.0, 180379.0, 180877.0, 181721.0, 33084.503732443554, 33320.66679333176, 33447.993120412364, 34020.48969265463, 34193.31613367719, 1015.5024038221219, 1061.7702824069238, 1075.451519724946, 1085.647164671485, 1086.0334302470808, 17614.735778963583, 17818.376356827448, 17915.820841791414, 18368.0, 18903.0, 25304.74695253024, 25572.104976326482, 26130.346741331618, 26222.60666089972, 26410.603840942018, 154806.0, 155017.0, 155322.0, 155566.22216888843, 156108.219458902, 25288.620670689586, 25512.48975020452, 25619.6157057648, 25725.099621513156, 25854.095106671175, 30946.84526577353, 31178.376432471676, 32303.0, 33158.17104572405, 33848.1537961553, 25081.122160724288, 25490.9078251875, 25555.318610797985, 25617.359566011, 25750.484990299716, 24223.273301800975, 24406.389840254134, 24937.251882443557, 25303.87348063248, 25689.357766055997, 27985.720142799128, 28047.57928631113, 28183.0, 28488.85755571209, 28644.0, 23107.422314442272, 23198.65202021937, 23937.0, 24016.51966960686, 24986.75013249844, 18628.534286642942, 19577.510562236057, 19747.210111595374, 19911.502212444804, 19960.3013894513], "value": 13123.568698697347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.396717317945, 385.387234297467, 388.38634956768317, 390.0988716065888, 402.4707509624843, 15873.761893571591, 16706.749398759028, 17469.0, 17655.823441765577, 17775.466735997907, 15531.37874485022, 15953.12257825822, 16326.0, 16479.588010299747, 16500.75248871265, 5848.327442344132, 6103.26760788706, 6112.388761123874, 6112.602680825732, 6115.449609535141, 5656.886862262772, 5883.411658834125, 5895.380984996556, 6084.239470066242, 6108.419700128481, 5883.646981181143, 5885.823425297248, 5898.970505147468, 5900.616459930091, 5904.616199947011, 5547.611667183279, 5726.198332233491, 5750.65496070233, 5876.0, 5886.823395298148, 5604.691741954191, 5607.102863541854, 5619.185218143346, 5628.268325117709, 5638.915416268759, 21265.36203913885, 21812.672809907865, 21909.0, 21929.561408771893, 22013.339599811872, 1684.7196130940451, 1693.8898971566932, 1721.0878234535717, 1725.094325479121, 1725.1460527039071, 14628.926855365762, 15169.544913652608, 15190.316435760416, 15392.153431561259, 15396.384144634201, 2152.4834039830484, 2152.6770984352474, 2198.1756841184556, 2211.2592281585526, 2224.8974718890654, 94708.0, 95782.0, 97115.0, 97774.0, 101959.49020254925, 16650.83349166517, 16687.165641717864, 17079.44917901662, 17222.397216097375, 17260.91369543144, 28203.43593128126, 28291.575626365622, 28313.57529637057, 28368.148955531367, 28539.429211415656, 7896.921030789734, 8004.239597238253, 8018.639161237758, 8208.09710931797, 8358.498490090615, 6522.804315870531, 6580.8354791130605, 6666.866662666719, 6758.560693555001, 6805.897911531331, 7981.321587664997, 8169.5098294102545, 8196.0, 8273.35252719124, 8307.418480706292, 3192.170035790711, 3212.9196770080466, 3295.549958018464, 3334.1497918030745, 3339.899803005914, 687.5118665747375, 692.6467501574233, 693.8967042402604, 694.8575542013875, 716.1120210938399, 14206.786898196535, 14526.782098268535, 14540.0, 14737.778933316009, 15262.694746105015, 724.2069933422894, 748.0649188514357, 771.5872008475438, 772.4824367673672, 776.6039319946755, 8383.580820958927, 8402.327813774884, 8762.649494020168, 8781.385303028854, 8829.735107946643, 351566.0, 355368.0, 358420.0, 360156.0, 360698.0, 79247.0, 80163.0, 82722.58638706888, 83030.16969830345, 83328.58335708283, 946.6733976778138, 954.4464210757744, 956.2493442647627, 956.6795123633522, 960.8991055939166, 13007.544735934196, 13170.670733231746, 13222.272774997082, 13431.261280629658, 13684.178949263076, 37576.43635345527, 38562.80718596389, 39047.41428878626, 39129.0, 39931.40102898401, 49512.50487495079, 49600.751996239786, 49660.0, 50557.241641376146, 51018.48981510138, 7351.889721654073, 7409.147947985835, 7429.8082065791805, 7518.135414427411, 7529.774106776806, 11750.647480575597, 11881.0, 11928.403579821148, 12082.75834483323, 12262.570810021607, 10166.745831354276, 10246.231532634933, 10380.429076400871, 10544.103751181236, 10682.092022178202, 9609.279304052085, 9624.903750962681, 9633.133018028411, 9781.462019588991, 10111.3427627204, 10066.295359324777, 10147.0, 10198.33710808795, 10537.789244215226, 10864.565417383215, 7443.292887175709, 7644.617769111634, 7645.120811106572, 7697.499662521918, 7818.374530037469, 10130.594776208869, 10224.64213752515, 10359.94820025895, 10447.738806529898, 10543.193226942445], "value": 8995.879996227719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1056.7146870345007, 1103.2442776697962, 1112.9109671226297, 1116.5477981417523, 1123.8145705958518, 9673.129418352355, 10168.847467287987, 10195.337303075295, 10524.315919465249, 10601.416922069284, 10413.114885234763, 10428.270021098526, 10530.947345263263, 10590.470476476185, 10649.78700425991, 2191.4521369657546, 2220.0342850859847, 2220.211824802196, 2245.6743772153027, 2247.0562363807157, 2089.6552068908613, 2130.476709152955, 2131.7548481924546, 2138.6043581937315, 2156.8058874701273, 2087.279888438486, 2104.0, 2109.504266497372, 2118.5127420693248, 2129.2866889592005, 1854.6198029404006, 1860.7581014468167, 1863.6086421851428, 1869.7662792150982, 1870.251899240301, 1752.71080271755, 1814.410316647095, 1920.990395048016, 1952.2678995376734, 2082.55225126597, 9855.507224638812, 9906.157976572, 9932.205423566169, 9940.105390514816, 9970.0, 5210.374755029383, 5404.567634589223, 5422.8373148805595, 5442.99304628641, 5457.454254574511, 3290.2596915694016, 3393.7794043387103, 3479.1302174456387, 3485.100620162018, 3496.0, 1106.4744246482855, 1112.2047735868894, 1139.4872307461676, 1153.3425947210094, 1155.7226265696256, 15129.243537823066, 15189.240537973057, 15218.619534511616, 15224.923875380662, 15262.31319590621, 4427.756473393994, 4505.823394506865, 4667.556582124693, 4676.3686902267755, 4739.146953548395, 9801.460919649346, 9842.606295748234, 9876.061774131445, 9884.505774711235, 9890.109890109925, 5135.871603209875, 5240.816571420059, 5274.947250527445, 5278.076336641149, 5285.101532739443, 4777.092352453023, 4813.0, 4817.710937343701, 4833.32333473314, 4850.5149485051215, 3681.9079523011605, 3715.20123173519, 3735.7571757835653, 3775.7923314217433, 3785.7917814520465, 1065.616378103882, 1067.7010437077631, 1070.6787963610886, 1078.46615925116, 1086.8587083679229, 506.9974650126726, 513.958883289336, 516.9483051694875, 522.27925462861, 526.1660268474511, 4728.858134255978, 4771.66598338113, 4785.736784476818, 4804.759762011886, 4816.229403295456, 454.7430701653555, 471.94572624147975, 472.35523510408734, 473.28533913790426, 479.2595440045139, 3573.8701290924773, 3613.7831730096277, 3780.4140358244517, 3873.1866308075055, 3895.5714871364125, 14175.362108705132, 14474.638134046523, 14778.63053423673, 14791.186484743443, 14856.331465084097, 14569.271536423137, 14613.196274204809, 14640.121592704472, 14673.486427974969, 14673.706525869422, 6773.762918297836, 7210.31502007319, 7212.206657267697, 7269.7455589054125, 7270.563766174047, 5453.536449401687, 5696.8006119785605, 5700.3444603871085, 5754.280714910637, 5861.208736820475, 12603.747925041265, 12856.228626282453, 12905.548305809252, 12906.41921113571, 12968.8054679178, 13022.934885325512, 13101.934490327487, 13123.60629181126, 13324.133931294435, 13332.533361332695, 7944.960275198587, 8102.716404925799, 8107.594620268845, 8135.227153420416, 8174.141715120065, 9479.715608531755, 9486.810263794823, 9529.0, 9581.568829402555, 9602.855957160788, 7810.336121429515, 7931.286184243446, 7948.721794737156, 7973.561454120079, 7984.6806127754235, 7737.5744334062165, 7763.961180194063, 7826.7651970440975, 7904.170062143622, 7951.3638908886, 6611.537192396486, 6661.500387470862, 6684.4318232950745, 6691.464682825265, 6698.0, 4180.853670121531, 4825.927611085766, 4837.951620483891, 4838.7338696372035, 4947.60419166473, 5023.899522009612, 5051.3433253676785, 5069.619778516552, 5096.082705112967, 5138.177891537336], "value": 4490.369465220694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.6782031812005, 368.43261377478683, 371.9163188282637, 373.231143843682, 378.47581100176257, 5419.701916394597, 5423.837284881455, 5427.864303392417, 5447.809326673567, 5567.220589117527, 5287.312649355588, 5358.812441564546, 5366.91949620756, 5371.462853714636, 5379.488948549882, 3954.3673012318036, 4057.3102572562734, 4080.9387859182134, 4098.118904435546, 4103.692223083273, 4060.533038700543, 4075.8981025474454, 4098.877033688994, 4102.953746794563, 4113.950942509656, 4021.3766866135797, 4030.919381612366, 4035.273650742865, 4043.5349934757437, 4049.473568436114, 3939.7242193046213, 4043.9595604043875, 4052.5744796796207, 4064.918701625951, 4070.287699652579, 3560.732945029133, 3591.6947059499976, 3600.9279814403567, 3603.6576525230325, 3612.422012478017, 5291.206319052135, 5308.70802105884, 5315.734213289359, 5317.308749862532, 5326.414094449608, 4746.691465054761, 4830.130576496229, 4833.709977401332, 4833.854984350475, 4850.878728031792, 5712.828615141552, 5714.257146570961, 5740.842536604892, 5744.310682718059, 5765.567582431292, 3997.6801855851463, 4004.379321205218, 4007.519097708294, 4013.137175507251, 4017.7589344639414, 5974.6713930733795, 6064.120702498113, 6099.878002439971, 6112.633242005494, 6114.724837382284, 4096.672266218696, 4106.240345536085, 4113.753174809521, 4114.847842604076, 4116.547179810218, 4146.792660366969, 4147.2534943710425, 4151.190517849051, 4156.958430415718, 4157.750534967911, 4695.882602934886, 4762.618990480753, 4773.952260477351, 4778.354922085544, 4780.306855505932, 5755.424457554295, 5757.88484230313, 5782.236417892499, 5782.942170578324, 5786.846168837909, 1425.2731107135435, 1439.6251579741322, 1442.949496767608, 1443.256722787765, 1448.2758620689656, 902.1429641840278, 940.4028441939417, 958.075457183807, 962.7785609309758, 967.4582233949011, 4967.5777558907175, 4973.1297023020825, 4978.477259887732, 4989.55094041538, 4993.825216117491, 5970.701464926737, 5974.671393073336, 5984.970075149597, 6000.279966404059, 6015.939840601625, 4828.0, 4953.826616068421, 4953.975230123826, 4972.5276098770555, 5000.949990500048, 3129.139486641192, 3152.8265945373223, 3158.5578019077348, 3174.5714428507263, 3182.10900947735, 5456.236126942231, 5495.972520137374, 5519.39286678465, 5548.805791797348, 5568.9443105569235, 6089.238845144357, 6109.419605137505, 6110.5722599418505, 6133.325334213233, 6168.814935551851, 5379.381371142291, 5498.917516237259, 5502.972485137629, 5511.22842802, 5529.944700553024, 5979.043353063489, 5995.280566332068, 6004.249468816398, 6012.038073908154, 6025.126356678169, 5680.176374425602, 5860.443257890493, 5893.116032595145, 5898.380670029585, 5932.614380065282, 5531.751071201725, 5563.443655634566, 5577.386487486292, 5583.525400341016, 5599.776008959596, 3984.5854721573423, 4059.3707975263883, 4059.573744756758, 4070.2063097695664, 4073.144639625712, 6006.279246490449, 6010.2186715726675, 6033.728482218398, 6035.1249068885645, 6050.757969681164, 5809.215755873072, 5818.592698511064, 5838.532917366516, 5849.444302791228, 5851.502622277154, 5683.602147849776, 5774.48029677331, 5793.536517078708, 5796.1305804129715, 5843.2403787507355, 5709.029464991045, 5712.857178570569, 5748.367679555329, 5762.423757624204, 5764.337101233412, 5743.798967036134, 5784.0, 5845.620034697731, 5868.794592189253, 5887.852803679943, 5635.746391412478, 5643.545057899827, 5654.745536450787, 5655.740161649705, 5663.32040155184], "value": 4299.1623779438805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.9321498382737, 511.4169846375132, 513.2993463921748, 517.7980587570847, 522.3209827224607, 11886.286822790627, 12223.449944752485, 12373.257604543722, 13738.519151829689, 14442.711145777079, 12252.326122063283, 12297.569585064524, 12298.38508074595, 12335.444904979275, 12450.003999680026, 508.0195223219204, 508.5067484540009, 516.1148630099378, 519.7713006277245, 525.3039722367859, 520.9973950130244, 521.1635325302891, 522.3757609656462, 547.4990383798819, 552.4475524475524, 550.807217473885, 567.0501909301923, 571.1261769492662, 572.461885827321, 574.4399210769487, 548.8984537860508, 549.5081901697978, 550.0127271547582, 555.0037682360173, 567.2512283785405, 394.15257197026335, 395.5925396841258, 397.52098721041364, 408.53427093113874, 410.19396885120585, 12286.385680716017, 12317.938410307981, 12428.37858107091, 12439.875601244054, 12534.74930501394, 12435.813462798065, 12480.126391152622, 13235.0, 13274.070815042951, 13325.600231993056, 11029.944850275777, 11314.094872410187, 11323.43382830855, 11405.543778248943, 11430.142739294586, 2826.5194916864184, 2846.245744877609, 2847.0, 2847.7152284771564, 2852.3154442933546, 83463.0, 84507.7323840149, 84704.0, 84875.0, 85244.0, 9413.19987801031, 9521.28590355726, 9563.282753793494, 9573.664921727845, 10314.27800054004, 15898.682026359407, 16741.246643901053, 17091.0, 17238.741418878726, 17390.565235869206, 5980.13288073227, 6069.635821850703, 6097.634141951497, 6148.047052706837, 6154.599951003171, 2963.3332500187284, 3003.7747168962414, 3032.9696703032687, 3035.2867076237067, 3039.4954497523427, 3173.76196785242, 3289.91775205617, 3310.576452125561, 3333.983330083334, 3347.1297462659395, 627.8650090230623, 628.6982248520644, 635.269440143829, 636.3096040795789, 637.445422482434, 454.0895504513429, 467.70768269831353, 472.499150900047, 474.23411190927095, 478.8611302722241, 8857.158569935846, 8931.285497160212, 9442.651774742955, 9553.331266811256, 9706.272029597809, 482.53917508779034, 484.6074679509608, 487.381026096855, 495.7942453881671, 503.66779867250915, 4023.6781057515914, 4154.709170358106, 4214.978925105354, 4258.467691538558, 4275.845521709121, 74077.62961185268, 75528.24471755321, 77583.61208193922, 86541.0, 86652.0, 63615.6819215901, 66008.33991660118, 66921.33078669249, 68323.65838170778, 68475.31524684689, 56771.432285676616, 59178.0, 59585.40414595798, 61606.69196653988, 62113.37886621076, 8698.652053918026, 9069.954650226706, 9185.402948808307, 9298.163165315154, 9567.091126342986, 27326.0, 27331.59002615002, 28284.43431131407, 28552.0, 28946.7105328944, 50643.04514276705, 51439.0, 52212.216816748536, 52709.7364513175, 54118.0, 11863.822042669539, 11924.642260732191, 12245.448954797233, 12544.811827822772, 12653.367331633566, 13508.32458377097, 13663.111897726616, 13746.587602371945, 13774.449022039005, 14252.144871307755, 11689.0, 11852.111091667986, 11940.223885447418, 11965.76068478608, 11972.76054478923, 11540.653780386601, 11920.463579138786, 11988.280703157838, 12068.275903445821, 12160.0, 12268.0, 12295.9385203077, 12371.319577423328, 12371.75256494883, 12456.937715311366, 9486.762830929281, 9774.560144793359, 9890.0, 9946.950265248628, 10108.39349639024, 10049.040437114692, 10103.494825258855, 10116.89883101189, 10184.388936663823, 10433.739156521147], "value": 5974.193725403209, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 124.0, 174.0, 124.0, 123.0, 122.0, 124.0, 158.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 169.0, 177.0, 177.0, 164.0, 164.0, 164.0, 162.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 74.0, 114.0, 74.0, 74.0, 74.0, 75.0, 100.0, 73.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 104.0, 87.0, 86.0, 83.0, 97.0, 83.0, 84.0, 105.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 119.0, 116.0, 114.0, 114.0, 115.0, 118.0, 118.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 152.0, 154.0, 154.0, 151.0, 153.0, 152.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 99.0, 94.0, 99.0, 99.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 56.0, 56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 59.0, 57.0, 57.0, 57.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 88.0, 96.0, 89.0, 89.0, 119.0, 87.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 134.0, 139.0, 142.0, 134.0, 139.0, 134.0, 157.0, 129.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 199.0, 192.0, 197.0, 195.0, 213.0, 211.0, 194.0, 196.0, 193.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 85.0, 72.0, 73.0, 76.0, 75.0, 72.0, 78.0], "value": 75.1, "unit": "score"}]}]} 02:27:07 INFO - Return code: 0 02:27:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:27:07 INFO - # TBPL SUCCESS # 02:27:07 INFO - Running post-action listener: _resource_record_post_action 02:27:07 INFO - [mozharness: 2017-05-29 09:27:07.128973Z] Finished run-tests step (success) 02:27:07 INFO - Running post-run listener: _resource_record_post_run 02:27:07 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409870336; Read time: 16; Write time: 207372 02:27:07 INFO - TinderboxPrint: CPU usage
12.7% 02:27:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:27:07 INFO - TinderboxPrint: I/O write bytes / time
409,870,336 / 207,372 02:27:07 INFO - TinderboxPrint: CPU idle
8,766.5 (87.3%) 02:27:07 INFO - TinderboxPrint: CPU user
1,220.9 (12.2%) 02:27:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:27:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99352576; Read time: 0; Write time: 55468 02:27:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:27:07 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 310517760; Read time: 0; Write time: 151904 02:27:07 INFO - Running post-run listener: _upload_blobber_files 02:27:07 INFO - Blob upload gear active. 02:27:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:07 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 02:27:07 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'] 02:27:07 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 02:27:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:14 INFO - (blobuploader) - INFO - Done attempting. 02:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:15 INFO - (blobuploader) - INFO - Done attempting. 02:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:16 INFO - (blobuploader) - INFO - Done attempting. 02:27:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:27:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:27:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:17 INFO - (blobuploader) - INFO - Done attempting. 02:27:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:17 INFO - Return code: 0 02:27:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0b7686f18b14d1a3599aea46b5a6e77a6ba38f5cfd75f8b86d8aa0338305fefa1e6b62ff138cecb6e5c2238fd8aa0014e87611fd1a8f89d0b85f6ff54665b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5b0f0a67926f07535e745dc1ccf4460f13447c28f543c45c15aeacba6c24a7779b801c33eb4b91b091c5ff5d5b49f4a95b0620c966bc74e51de12804fa54b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aee0bcb2b7d579ed2812587fe505b7469e865bbc84434bc4cffbfe7d28fc5884b42b40ee1329bedf7cb02deeab2dc1140ac057024389ab7707051a18d0c3dde6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6589d8f265c383833edbf5edce164a44775e49adcebf2025bd2e27148555f63703c6b0020510efe8403cb544db11c855efd72e38d6e8023c4a0153e7eea04d"} 02:27:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:17 INFO - Contents: 02:27:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0b7686f18b14d1a3599aea46b5a6e77a6ba38f5cfd75f8b86d8aa0338305fefa1e6b62ff138cecb6e5c2238fd8aa0014e87611fd1a8f89d0b85f6ff54665b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5b0f0a67926f07535e745dc1ccf4460f13447c28f543c45c15aeacba6c24a7779b801c33eb4b91b091c5ff5d5b49f4a95b0620c966bc74e51de12804fa54b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aee0bcb2b7d579ed2812587fe505b7469e865bbc84434bc4cffbfe7d28fc5884b42b40ee1329bedf7cb02deeab2dc1140ac057024389ab7707051a18d0c3dde6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6589d8f265c383833edbf5edce164a44775e49adcebf2025bd2e27148555f63703c6b0020510efe8403cb544db11c855efd72e38d6e8023c4a0153e7eea04d"} 02:27:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:17 INFO - Copying logs to upload dir... 02:27:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.873793 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-29 02:27:16.598787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 02:27:16.603139) ========= 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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0b7686f18b14d1a3599aea46b5a6e77a6ba38f5cfd75f8b86d8aa0338305fefa1e6b62ff138cecb6e5c2238fd8aa0014e87611fd1a8f89d0b85f6ff54665b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5b0f0a67926f07535e745dc1ccf4460f13447c28f543c45c15aeacba6c24a7779b801c33eb4b91b091c5ff5d5b49f4a95b0620c966bc74e51de12804fa54b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aee0bcb2b7d579ed2812587fe505b7469e865bbc84434bc4cffbfe7d28fc5884b42b40ee1329bedf7cb02deeab2dc1140ac057024389ab7707051a18d0c3dde6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6589d8f265c383833edbf5edce164a44775e49adcebf2025bd2e27148555f63703c6b0020510efe8403cb544db11c855efd72e38d6e8023c4a0153e7eea04d"} build_url:https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/HYS1ATMJRyK5GBZPOti8jQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0b7686f18b14d1a3599aea46b5a6e77a6ba38f5cfd75f8b86d8aa0338305fefa1e6b62ff138cecb6e5c2238fd8aa0014e87611fd1a8f89d0b85f6ff54665b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5b0f0a67926f07535e745dc1ccf4460f13447c28f543c45c15aeacba6c24a7779b801c33eb4b91b091c5ff5d5b49f4a95b0620c966bc74e51de12804fa54b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aee0bcb2b7d579ed2812587fe505b7469e865bbc84434bc4cffbfe7d28fc5884b42b40ee1329bedf7cb02deeab2dc1140ac057024389ab7707051a18d0c3dde6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6589d8f265c383833edbf5edce164a44775e49adcebf2025bd2e27148555f63703c6b0020510efe8403cb544db11c855efd72e38d6e8023c4a0153e7eea04d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 02:27:16.630298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:27:16.630639) ========= 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=51fc86400edbde9650d2781a000001d0-1496031173.280442-117941235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 02:27:16.709451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 02:27:16.712787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 02:27:16.713074) ========= ========= Total master_lag: 0.20 =========