builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1501167602.89 results: success (0) revision: d4d5e225250d6a71fa8fe31da16e8142a90caa5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:02.887393) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:02.892292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:02.892590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:02.945993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:02.946316) ========= 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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 08:00:02-- 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% 37.4M=0s 2017-07-27 08:00:03 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083257 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:03.064407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:03.064799) ========= 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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015808 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:03.168666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 47 secs) (at 2017-07-27 08:00:03.169006) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev d4d5e225250d6a71fa8fe31da16e8142a90caa5f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev d4d5e225250d6a71fa8fe31da16e8142a90caa5f --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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 08:00:03,204 truncating revision to first 12 chars 2017-07-27 08:00:03,204 Setting DEBUG logging. 2017-07-27 08:00:03,204 attempt 1/10 2017-07-27 08:00:03,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/d4d5e225250d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 08:00:03,959 attempt 1/10 2017-07-27 08:00:04,607 current task status: no status available at this point. state: PENDING 2017-07-27 08:00:04,608 sleeping for 9.00s (attempt 1/10) 2017-07-27 08:00:13,617 attempt 2/10 2017-07-27 08:00:14,178 current task status: no status available at this point. state: PENDING 2017-07-27 08:00:14,179 sleeping for 13.50s (attempt 2/10) 2017-07-27 08:00:27,692 attempt 3/10 2017-07-27 08:00:28,398 current task status: no status available at this point. state: STARTED 2017-07-27 08:00:28,398 sleeping for 21.25s (attempt 3/10) 2017-07-27 08:00:49,665 attempt 4/10 2017-07-27 08:00:49,981 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-07-27 08:00:50,215 unpacking tar archive at: cedar-d4d5e225250d/testing/mozharness/ program finished with exit code 0 elapsedTime=47.310636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 47 secs) (at 2017-07-27 08:00:50.500495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:50.503967) ========= script_repo_revision: d4d5e225250d6a71fa8fe31da16e8142a90caa5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:50.504423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:50.504749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 08:00:50.513421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-27 08:00:50.513854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:50 INFO - MultiFileLogger online at 20170727 08:00:50 in /builds/slave/test 08:00:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:00:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:50 INFO - {'append_to_log': False, 08:00:50 INFO - 'base_work_dir': '/builds/slave/test', 08:00:50 INFO - 'blob_upload_branch': 'Cedar', 08:00:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:50 INFO - 'branch': 'Cedar', 08:00:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:50 INFO - 'code_coverage': False, 08:00:50 INFO - 'config_files': ('talos/linux_config.py',), 08:00:50 INFO - 'default_actions': ('clobber', 08:00:50 INFO - 'read-buildbot-config', 08:00:50 INFO - 'download-and-extract', 08:00:50 INFO - 'populate-webroot', 08:00:50 INFO - 'create-virtualenv', 08:00:50 INFO - 'install', 08:00:50 INFO - 'setup-mitmproxy', 08:00:50 INFO - 'run-tests'), 08:00:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:50 INFO - 'disable_ccov_upload': False, 08:00:50 INFO - 'download_minidump_stackwalk': True, 08:00:50 INFO - 'download_symbols': 'ondemand', 08:00:50 INFO - 'enable_stylo': False, 08:00:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:50 INFO - 'gecko_profile': False, 08:00:50 INFO - 'gecko_profile_interval': 0, 08:00:50 INFO - 'installer_path': 'installer.exe', 08:00:50 INFO - 'log_level': 'info', 08:00:50 INFO - 'log_name': 'talos', 08:00:50 INFO - 'log_to_console': True, 08:00:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:50 INFO - 'opt_config_files': (), 08:00:50 INFO - 'pip_index': False, 08:00:50 INFO - 'suite': 'dromaeojs-e10s', 08:00:50 INFO - 'system_bits': '32', 08:00:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:50 INFO - 'title': 'talos-linux64-ix-026', 08:00:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:50 INFO - 'use_talos_json': True, 08:00:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:50 INFO - 'work_dir': 'build'} 08:00:50 INFO - [mozharness: 2017-07-27 15:00:50.654172Z] Running clobber step. 08:00:50 INFO - Running pre-action listener: _resource_record_pre_action 08:00:50 INFO - Running main action method: clobber 08:00:50 INFO - rmtree: /builds/slave/test/build 08:00:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:51 INFO - Running post-action listener: _resource_record_post_action 08:00:51 INFO - [mozharness: 2017-07-27 15:00:51.691627Z] Finished clobber step (success) 08:00:51 INFO - [mozharness: 2017-07-27 15:00:51.691728Z] Running read-buildbot-config step. 08:00:51 INFO - Running pre-action listener: _resource_record_pre_action 08:00:51 INFO - Running main action method: read_buildbot_config 08:00:51 INFO - Using buildbot properties: 08:00:51 INFO - { 08:00:51 INFO - "project": "", 08:00:51 INFO - "product": "firefox", 08:00:51 INFO - "who": "mconley@mozilla.com", 08:00:51 INFO - "installer_path": "public/build/target.tar.bz2", 08:00:51 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 08:00:51 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 08:00:51 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 08:00:51 INFO - "stage_platform": "linux64", 08:00:51 INFO - "basedir": "/builds/slave/test", 08:00:51 INFO - "buildnumber": 0, 08:00:51 INFO - "platform": "ubuntu64_hw", 08:00:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:00:51 INFO - "slavebuilddir": "test", 08:00:51 INFO - "taskId": "KBr531qRS6OpXHMdtNUgEw", 08:00:51 INFO - "branch": "cedar", 08:00:51 INFO - "script_repo_revision": "default", 08:00:51 INFO - "revision": "d4d5e225250d6a71fa8fe31da16e8142a90caa5f", 08:00:51 INFO - "slavename": "talos-linux64-ix-026", 08:00:51 INFO - "repo_path": "projects/cedar" 08:00:51 INFO - } 08:00:51 INFO - Finding installer, test and symbols from parent task. 08:00:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KBr531qRS6OpXHMdtNUgEw'}, attempt #1 08:00:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KBr531qRS6OpXHMdtNUgEw'}, attempt #1 08:00:52 INFO - Task dependencies: SKzf4K0JRlKy-0Xf39aB4g 08:00:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g'}, attempt #1 08:00:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 08:00:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/test_packages.json 08:00:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.crashreporter-symbols.zip 08:00:53 INFO - Running post-action listener: _resource_record_post_action 08:00:53 INFO - [mozharness: 2017-07-27 15:00:53.260847Z] Finished read-buildbot-config step (success) 08:00:53 INFO - [mozharness: 2017-07-27 15:00:53.261067Z] Running download-and-extract step. 08:00:53 INFO - Running pre-action listener: _resource_record_pre_action 08:00:53 INFO - Running main action method: download_and_extract 08:00:53 INFO - mkdir: /builds/slave/test/build/tests 08:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:53 INFO - trying https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.test_packages.json 08:00:53 INFO - Downloading https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:00:53 INFO - Downloaded 989 bytes. 08:00:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:00:53 INFO - Using the following test package requirements: 08:00:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:00:53 INFO - u'common': [u'target.common.tests.zip'], 08:00:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:00:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:00:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:00:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:00:53 INFO - u'mozbase': [u'target.common.tests.zip'], 08:00:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:00:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:00:53 INFO - u'web-platform': [u'target.common.tests.zip', 08:00:53 INFO - u'target.web-platform.tests.tar.gz'], 08:00:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:00:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:00:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip 08:00:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:00:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip into memory 08:00:55 INFO - Content-Length response header: 72556685 08:00:55 INFO - Bytes received: 72556685 08:01:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip 08:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.common.tests.zip into memory 08:01:07 INFO - Content-Length response header: 72556685 08:01:07 INFO - Bytes received: 72556685 08:01:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.talos.tests.zip 08:01:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:01:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.talos.tests.zip into memory 08:01:20 INFO - Content-Length response header: 14496465 08:01:20 INFO - Bytes received: 14496465 08:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:20 INFO - trying https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 08:01:20 INFO - Downloading https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:01:21 INFO - Downloaded 62099912 bytes. 08:01:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 08:01:21 INFO - mkdir: /builds/slave/test/properties 08:01:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:01:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:01:21 INFO - Contents: 08:01:21 INFO - build_url:https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 08:01:21 INFO - Running post-action listener: _resource_record_post_action 08:01:21 INFO - Running post-action listener: set_extra_try_arguments 08:01:21 INFO - [mozharness: 2017-07-27 15:01:21.552658Z] Finished download-and-extract step (success) 08:01:21 INFO - [mozharness: 2017-07-27 15:01:21.552755Z] Running populate-webroot step. 08:01:21 INFO - Running pre-action listener: _resource_record_pre_action 08:01:21 INFO - Running main action method: populate_webroot 08:01:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:01:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:01:21 INFO - 'tests': ['damp', 'tps']}, 08:01:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:01:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:01:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:01:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:21 INFO - 'ts_paint', 08:01:21 INFO - 'tpaint', 08:01:21 INFO - 'sessionrestore', 08:01:21 INFO - 'sessionrestore_many_windows', 08:01:21 INFO - 'sessionrestore_no_auto_restore', 08:01:21 INFO - 'tabpaint']}, 08:01:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:01:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:01:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:01:21 INFO - 'talos_options': ['--mitmproxy', 08:01:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:01:21 INFO - '--firstNonBlankPaint'], 08:01:21 INFO - 'tests': ['quantum_pageload_google', 08:01:21 INFO - 'quantum_pageload_youtube', 08:01:21 INFO - 'quantum_pageload_amazon', 08:01:21 INFO - 'quantum_pageload_facebook']}, 08:01:21 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:01:21 INFO - 'talos_options': ['--stylo', 08:01:21 INFO - '--mitmproxy', 08:01:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:01:21 INFO - '--firstNonBlankPaint'], 08:01:21 INFO - 'tests': ['quantum_pageload_google', 08:01:21 INFO - 'quantum_pageload_youtube', 08:01:21 INFO - 'quantum_pageload_amazon', 08:01:21 INFO - 'quantum_pageload_facebook']}, 08:01:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:21 INFO - 'tsvgr_opacity', 08:01:21 INFO - 'tart', 08:01:21 INFO - 'tscrollx', 08:01:21 INFO - 'cart', 08:01:21 INFO - 'tsvg_static']}, 08:01:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:01:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:01:21 INFO - 'talos_options': ['--xperf_path', 08:01:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:21 INFO - 'tests': ['tp5n']}}} 08:01:21 INFO - Running post-action listener: _resource_record_post_action 08:01:21 INFO - [mozharness: 2017-07-27 15:01:21.560101Z] Finished populate-webroot step (success) 08:01:21 INFO - [mozharness: 2017-07-27 15:01:21.560191Z] Running create-virtualenv step. 08:01:21 INFO - Running pre-action listener: _resource_record_pre_action 08:01:21 INFO - Running main action method: create_virtualenv 08:01:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:21 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 08:01:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:01:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:21 INFO - Using real prefix '/usr' 08:01:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:24 INFO - Installing pip.................done. 08:01:24 INFO - Return code: 0 08:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:01:24 INFO - Reading from file tmpfile_stdout 08:01:24 INFO - Output received: 08:01:24 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) 08:01:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01: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')]} 08:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:24 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:24 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 08:01:24 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 08:01:24 INFO - Using env: {'DISPLAY': ':0', 08:01:24 INFO - 'HOME': '/home/cltbld', 08:01:24 INFO - 'LANG': 'en_US.UTF-8', 08:01:24 INFO - 'LANGUAGE': 'en_US:en', 08:01:24 INFO - 'LOGNAME': 'cltbld', 08:01:24 INFO - 'MAIL': '/var/mail/cltbld', 08:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:24 INFO - 'MOZ_NO_REMOTE': '1', 08:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:24 INFO - 'NO_EM_RESTART': '1', 08:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:24 INFO - 'PWD': '/builds/slave/test', 08:01:24 INFO - 'SHELL': '/bin/bash', 08:01:24 INFO - 'SHLVL': '1', 08:01:24 INFO - 'TERM': 'linux', 08:01:24 INFO - 'TMOUT': '86400', 08:01:24 INFO - 'USER': 'cltbld', 08:01:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:24 INFO - '_': '/tools/buildbot/bin/python'} 08:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:24 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 08:01:24 INFO - Cleaning up... 08:01:24 INFO - Return code: 0 08:01:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01: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')]} 08:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:24 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:24 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 08:01:24 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 08:01:24 INFO - Using env: {'DISPLAY': ':0', 08:01:24 INFO - 'HOME': '/home/cltbld', 08:01:24 INFO - 'LANG': 'en_US.UTF-8', 08:01:24 INFO - 'LANGUAGE': 'en_US:en', 08:01:24 INFO - 'LOGNAME': 'cltbld', 08:01:24 INFO - 'MAIL': '/var/mail/cltbld', 08:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:24 INFO - 'MOZ_NO_REMOTE': '1', 08:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:24 INFO - 'NO_EM_RESTART': '1', 08:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:24 INFO - 'PWD': '/builds/slave/test', 08:01:24 INFO - 'SHELL': '/bin/bash', 08:01:24 INFO - 'SHLVL': '1', 08:01:24 INFO - 'TERM': 'linux', 08:01:24 INFO - 'TMOUT': '86400', 08:01:24 INFO - 'USER': 'cltbld', 08:01:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:24 INFO - '_': '/tools/buildbot/bin/python'} 08:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:24 INFO - Downloading/unpacking psutil>=3.1.1 08:01:24 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 08:01:24 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 08:01:24 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 08:01:24 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 08:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:25 INFO - Installing collected packages: psutil 08:01:25 INFO - Running setup.py install for psutil 08:01:26 INFO - building 'psutil._psutil_linux' extension 08:01:26 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 08:01:26 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 08:01:26 INFO - building 'psutil._psutil_posix' extension 08:01:26 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 08:01:26 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 08:01:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:26 INFO - Successfully installed psutil 08:01:26 INFO - Cleaning up... 08:01:26 INFO - Return code: 0 08:01:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:01:26 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')]} 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:26 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')]} 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:26 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:26 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 08:01:26 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 08:01:26 INFO - Using env: {'DISPLAY': ':0', 08:01:26 INFO - 'HOME': '/home/cltbld', 08:01:26 INFO - 'LANG': 'en_US.UTF-8', 08:01:26 INFO - 'LANGUAGE': 'en_US:en', 08:01:26 INFO - 'LOGNAME': 'cltbld', 08:01:26 INFO - 'MAIL': '/var/mail/cltbld', 08:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:26 INFO - 'MOZ_NO_REMOTE': '1', 08:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:26 INFO - 'NO_EM_RESTART': '1', 08:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:26 INFO - 'PWD': '/builds/slave/test', 08:01:26 INFO - 'SHELL': '/bin/bash', 08:01:26 INFO - 'SHLVL': '1', 08:01:26 INFO - 'TERM': 'linux', 08:01:26 INFO - 'TMOUT': '86400', 08:01:26 INFO - 'USER': 'cltbld', 08:01:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:26 INFO - '_': '/tools/buildbot/bin/python'} 08:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:01:26 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 08:01:26 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 08:01:26 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 08:01:26 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 08:01:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:01:27 INFO - Installing collected packages: mozsystemmonitor 08:01:27 INFO - Running setup.py install for mozsystemmonitor 08:01:27 INFO - Successfully installed mozsystemmonitor 08:01:27 INFO - Cleaning up... 08:01:27 INFO - Return code: 0 08:01:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:27 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:27 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 08:01:27 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 08:01:27 INFO - Using env: {'DISPLAY': ':0', 08:01:27 INFO - 'HOME': '/home/cltbld', 08:01:27 INFO - 'LANG': 'en_US.UTF-8', 08:01:27 INFO - 'LANGUAGE': 'en_US:en', 08:01:27 INFO - 'LOGNAME': 'cltbld', 08:01:27 INFO - 'MAIL': '/var/mail/cltbld', 08:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:27 INFO - 'MOZ_NO_REMOTE': '1', 08:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:27 INFO - 'NO_EM_RESTART': '1', 08:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:27 INFO - 'PWD': '/builds/slave/test', 08:01:27 INFO - 'SHELL': '/bin/bash', 08:01:27 INFO - 'SHLVL': '1', 08:01:27 INFO - 'TERM': 'linux', 08:01:27 INFO - 'TMOUT': '86400', 08:01:27 INFO - 'USER': 'cltbld', 08:01:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:27 INFO - '_': '/tools/buildbot/bin/python'} 08:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:01:28 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 08:01:28 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 08:01:28 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 08:01:28 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 08:01:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:01:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:01:29 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 08:01:29 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 08:01:29 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 08:01:29 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 08:01:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:01:29 INFO - warning: no files found matching '*.txt' 08:01:29 INFO - no previously-included directories found matching 'build' 08:01:29 INFO - no previously-included directories found matching 'dist' 08:01:29 INFO - no previously-included directories found matching '.git*' 08:01:29 INFO - Installing collected packages: jsonschema, functools32 08:01:29 INFO - Running setup.py install for functools32 08:01:29 INFO - warning: no files found matching '*.txt' 08:01:29 INFO - no previously-included directories found matching 'build' 08:01:29 INFO - no previously-included directories found matching 'dist' 08:01:29 INFO - no previously-included directories found matching '.git*' 08:01:29 INFO - Successfully installed jsonschema functools32 08:01:29 INFO - Cleaning up... 08:01:29 INFO - Return code: 0 08:01:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:01:29 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')]} 08:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:29 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')]} 08:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:29 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:29 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 08:01:29 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 08:01:29 INFO - Using env: {'DISPLAY': ':0', 08:01:29 INFO - 'HOME': '/home/cltbld', 08:01:29 INFO - 'LANG': 'en_US.UTF-8', 08:01:29 INFO - 'LANGUAGE': 'en_US:en', 08:01:29 INFO - 'LOGNAME': 'cltbld', 08:01:29 INFO - 'MAIL': '/var/mail/cltbld', 08:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:29 INFO - 'MOZ_NO_REMOTE': '1', 08:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:29 INFO - 'NO_EM_RESTART': '1', 08:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:29 INFO - 'PWD': '/builds/slave/test', 08:01:29 INFO - 'SHELL': '/bin/bash', 08:01:29 INFO - 'SHLVL': '1', 08:01:29 INFO - 'TERM': 'linux', 08:01:29 INFO - 'TMOUT': '86400', 08:01:29 INFO - 'USER': 'cltbld', 08:01:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:29 INFO - '_': '/tools/buildbot/bin/python'} 08:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:01:29 INFO - Cleaning up... 08:01:29 INFO - Return code: 0 08:01:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:01:29 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')]} 08:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:29 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')]} 08:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:29 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:29 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 08:01:29 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 08:01:29 INFO - Using env: {'DISPLAY': ':0', 08:01:29 INFO - 'HOME': '/home/cltbld', 08:01:29 INFO - 'LANG': 'en_US.UTF-8', 08:01:29 INFO - 'LANGUAGE': 'en_US:en', 08:01:29 INFO - 'LOGNAME': 'cltbld', 08:01:29 INFO - 'MAIL': '/var/mail/cltbld', 08:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:29 INFO - 'MOZ_NO_REMOTE': '1', 08:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:29 INFO - 'NO_EM_RESTART': '1', 08:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:29 INFO - 'PWD': '/builds/slave/test', 08:01:29 INFO - 'SHELL': '/bin/bash', 08:01:29 INFO - 'SHLVL': '1', 08:01:29 INFO - 'TERM': 'linux', 08:01:29 INFO - 'TMOUT': '86400', 08:01:29 INFO - 'USER': 'cltbld', 08:01:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:29 INFO - '_': '/tools/buildbot/bin/python'} 08:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:01:30 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 08:01:30 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 08:01:30 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 08:01:30 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 08:01:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:31 INFO - Downloading docopt-0.6.1.tar.gz 08:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:31 INFO - Running setup.py install for blobuploader 08:01:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:31 INFO - Running setup.py install for requests 08:01:32 INFO - Running setup.py install for docopt 08:01:32 INFO - Successfully installed blobuploader requests docopt 08:01:32 INFO - Cleaning up... 08:01:32 INFO - Return code: 0 08:01:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:32 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:32 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 08:01:32 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 08:01:32 INFO - Using env: {'DISPLAY': ':0', 08:01:32 INFO - 'HOME': '/home/cltbld', 08:01:32 INFO - 'LANG': 'en_US.UTF-8', 08:01:32 INFO - 'LANGUAGE': 'en_US:en', 08:01:32 INFO - 'LOGNAME': 'cltbld', 08:01:32 INFO - 'MAIL': '/var/mail/cltbld', 08:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:32 INFO - 'MOZ_NO_REMOTE': '1', 08:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:32 INFO - 'NO_EM_RESTART': '1', 08:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:32 INFO - 'PWD': '/builds/slave/test', 08:01:32 INFO - 'SHELL': '/bin/bash', 08:01:32 INFO - 'SHLVL': '1', 08:01:32 INFO - 'TERM': 'linux', 08:01:32 INFO - 'TMOUT': '86400', 08:01:32 INFO - 'USER': 'cltbld', 08:01:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:32 INFO - '_': '/tools/buildbot/bin/python'} 08:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:32 INFO - Running setup.py (path:/tmp/pip-YD7sF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:32 INFO - Running setup.py (path:/tmp/pip-dvh8x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:32 INFO - Running setup.py (path:/tmp/pip-ysovwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:32 INFO - Running setup.py (path:/tmp/pip-MuxYtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:32 INFO - Running setup.py (path:/tmp/pip-ra3aa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:32 INFO - Running setup.py (path:/tmp/pip-GRxZYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:32 INFO - Running setup.py (path:/tmp/pip-1LDLvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:33 INFO - Running setup.py (path:/tmp/pip-bnhFAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:33 INFO - Running setup.py (path:/tmp/pip-2HUZh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:33 INFO - Running setup.py (path:/tmp/pip-9gQTSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:33 INFO - Running setup.py (path:/tmp/pip-zPzBnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:33 INFO - Running setup.py (path:/tmp/pip-b2_kp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:33 INFO - Running setup.py (path:/tmp/pip-yFWgN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:33 INFO - Running setup.py (path:/tmp/pip-i76JC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:33 INFO - Running setup.py (path:/tmp/pip-7enz5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:33 INFO - Running setup.py (path:/tmp/pip-naYN3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:33 INFO - Running setup.py (path:/tmp/pip-1Uyh_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:33 INFO - Running setup.py install for manifestparser 08:01:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:33 INFO - Running setup.py install for mozcrash 08:01:33 INFO - Running setup.py install for mozdebug 08:01:34 INFO - Running setup.py install for mozdevice 08:01:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for mozfile 08:01:34 INFO - Running setup.py install for mozhttpd 08:01:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for mozinfo 08:01:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for mozInstall 08:01:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for mozleak 08:01:34 INFO - Running setup.py install for mozlog 08:01:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for moznetwork 08:01:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:34 INFO - Running setup.py install for mozprocess 08:01:35 INFO - Running setup.py install for mozprofile 08:01:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:35 INFO - Running setup.py install for mozrunner 08:01:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:35 INFO - Running setup.py install for mozscreenshot 08:01:35 INFO - Running setup.py install for moztest 08:01:35 INFO - Running setup.py install for mozversion 08:01:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:35 INFO - Cleaning up... 08:01:35 INFO - Return code: 0 08:01:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:35 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:35 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 08:01:35 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 08:01:35 INFO - Using env: {'DISPLAY': ':0', 08:01:35 INFO - 'HOME': '/home/cltbld', 08:01:35 INFO - 'LANG': 'en_US.UTF-8', 08:01:35 INFO - 'LANGUAGE': 'en_US:en', 08:01:35 INFO - 'LOGNAME': 'cltbld', 08:01:35 INFO - 'MAIL': '/var/mail/cltbld', 08:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:35 INFO - 'MOZ_NO_REMOTE': '1', 08:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:35 INFO - 'NO_EM_RESTART': '1', 08:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:35 INFO - 'PWD': '/builds/slave/test', 08:01:35 INFO - 'SHELL': '/bin/bash', 08:01:35 INFO - 'SHLVL': '1', 08:01:35 INFO - 'TERM': 'linux', 08:01:35 INFO - 'TMOUT': '86400', 08:01:35 INFO - 'USER': 'cltbld', 08:01:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:35 INFO - '_': '/tools/buildbot/bin/python'} 08:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:35 INFO - Running setup.py (path:/tmp/pip-FY_9oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:35 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)) 08:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:35 INFO - Running setup.py (path:/tmp/pip-aC4o64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:35 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)) 08:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:35 INFO - Running setup.py (path:/tmp/pip-fpQPNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:35 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)) 08:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:35 INFO - Running setup.py (path:/tmp/pip-C_T5IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:36 INFO - Running setup.py (path:/tmp/pip-sBPG1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:36 INFO - Running setup.py (path:/tmp/pip-nfbKIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:36 INFO - Running setup.py (path:/tmp/pip-4BLFGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:36 INFO - Running setup.py (path:/tmp/pip-g4b3c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:36 INFO - Running setup.py (path:/tmp/pip-cykaxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:36 INFO - Running setup.py (path:/tmp/pip-hR9DSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:36 INFO - Running setup.py (path:/tmp/pip-_TglNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:36 INFO - Running setup.py (path:/tmp/pip-vwK6cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:36 INFO - Running setup.py (path:/tmp/pip-gyHmBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:36 INFO - Running setup.py (path:/tmp/pip-yLauMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:36 INFO - Running setup.py (path:/tmp/pip-upKgQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:36 INFO - Running setup.py (path:/tmp/pip-v0kyJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:36 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)) 08:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:36 INFO - Running setup.py (path:/tmp/pip-LJ8pss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:37 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)) 08:01:37 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)) 08:01:37 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)) 08:01:37 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)) 08:01:37 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)) 08:01:37 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)) 08:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:01:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:39 INFO - Downloading blessings-1.6.tar.gz 08:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:39 INFO - Installing collected packages: blessings 08:01:39 INFO - Running setup.py install for blessings 08:01:39 INFO - Successfully installed blessings 08:01:39 INFO - Cleaning up... 08:01:39 INFO - Return code: 0 08:01:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:39 INFO - Reading from file tmpfile_stdout 08:01:39 INFO - Current package versions: 08:01:39 INFO - argparse == 1.2.1 08:01:39 INFO - blessings == 1.6 08:01:39 INFO - blobuploader == 1.2.4 08:01:39 INFO - docopt == 0.6.1 08:01:39 INFO - functools32 == 3.2.3-2 08:01:39 INFO - jsonschema == 2.5.1 08:01:39 INFO - manifestparser == 1.1 08:01:39 INFO - mozInstall == 1.13 08:01:39 INFO - mozcrash == 1.0 08:01:39 INFO - mozdebug == 0.1 08:01:39 INFO - mozdevice == 0.51 08:01:39 INFO - mozfile == 1.2 08:01:39 INFO - mozhttpd == 0.7 08:01:39 INFO - mozinfo == 0.10 08:01:39 INFO - mozleak == 0.1 08:01:39 INFO - mozlog == 3.5 08:01:39 INFO - moznetwork == 0.27 08:01:39 INFO - mozprocess == 0.25 08:01:39 INFO - mozprofile == 0.28 08:01:39 INFO - mozrunner == 6.13 08:01:39 INFO - mozscreenshot == 0.1 08:01:39 INFO - mozsystemmonitor == 0.3 08:01:39 INFO - moztest == 0.8 08:01:39 INFO - mozversion == 1.4 08:01:39 INFO - psutil == 3.1.1 08:01:39 INFO - requests == 1.2.3 08:01:39 INFO - wsgiref == 0.1.2 08:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:39 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:39 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 08:01:39 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 08:01:39 INFO - Using env: {'DISPLAY': ':0', 08:01:39 INFO - 'HOME': '/home/cltbld', 08:01:39 INFO - 'LANG': 'en_US.UTF-8', 08:01:39 INFO - 'LANGUAGE': 'en_US:en', 08:01:39 INFO - 'LOGNAME': 'cltbld', 08:01:39 INFO - 'MAIL': '/var/mail/cltbld', 08:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:39 INFO - 'MOZ_NO_REMOTE': '1', 08:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:39 INFO - 'NO_EM_RESTART': '1', 08:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:39 INFO - 'PWD': '/builds/slave/test', 08:01:39 INFO - 'SHELL': '/bin/bash', 08:01:39 INFO - 'SHLVL': '1', 08:01:39 INFO - 'TERM': 'linux', 08:01:39 INFO - 'TMOUT': '86400', 08:01:39 INFO - 'USER': 'cltbld', 08:01:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:39 INFO - '_': '/tools/buildbot/bin/python'} 08:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 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)) 08:01:39 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:40 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:01:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:01:41 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)) 08:01:41 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)) 08:01:41 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)) 08:01:41 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)) 08:01:41 INFO - Installing collected packages: marionette-driver, simplejson 08:01:41 INFO - Running setup.py install for marionette-driver 08:01:41 INFO - Running setup.py install for simplejson 08:01:41 INFO - building 'simplejson._speedups' extension 08:01:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:01:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:01:42 INFO - Successfully installed marionette-driver simplejson 08:01:42 INFO - Cleaning up... 08:01:42 INFO - Return code: 0 08:01:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:42 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, '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': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', '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 08:01:42 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 08:01:42 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 08:01:42 INFO - Using env: {'DISPLAY': ':0', 08:01:42 INFO - 'HOME': '/home/cltbld', 08:01:42 INFO - 'LANG': 'en_US.UTF-8', 08:01:42 INFO - 'LANGUAGE': 'en_US:en', 08:01:42 INFO - 'LOGNAME': 'cltbld', 08:01:42 INFO - 'MAIL': '/var/mail/cltbld', 08:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:42 INFO - 'MOZ_NO_REMOTE': '1', 08:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:42 INFO - 'NO_EM_RESTART': '1', 08:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:42 INFO - 'PWD': '/builds/slave/test', 08:01:42 INFO - 'SHELL': '/bin/bash', 08:01:42 INFO - 'SHLVL': '1', 08:01:42 INFO - 'TERM': 'linux', 08:01:42 INFO - 'TMOUT': '86400', 08:01:42 INFO - 'USER': 'cltbld', 08:01:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:42 INFO - '_': '/tools/buildbot/bin/python'} 08:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:01:42 INFO - Cleaning up... 08:01:42 INFO - Return code: 0 08:01:42 INFO - Running post-action listener: _resource_record_post_action 08:01:42 INFO - Running post-action listener: _start_resource_monitoring 08:01:42 INFO - Starting resource monitoring. 08:01:42 INFO - [mozharness: 2017-07-27 15:01:42.572709Z] Finished create-virtualenv step (success) 08:01:42 INFO - [mozharness: 2017-07-27 15:01:42.573279Z] Running install step. 08:01:42 INFO - Running pre-action listener: _resource_record_pre_action 08:01:42 INFO - Running main action method: install 08:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:42 INFO - Reading from file tmpfile_stdout 08:01:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:01:42 INFO - Reading from file tmpfile_stdout 08:01:42 INFO - Output received: 08:01:42 INFO - Usage: mozinstall [options] installer 08:01:42 INFO - Options: 08:01:42 INFO - -h, --help show this help message and exit 08:01:42 INFO - -d DEST, --destination=DEST 08:01:42 INFO - Directory to install application into. [default: 08:01:42 INFO - "/builds/slave/test"] 08:01:42 INFO - --app=APP Application being installed. [default: firefox] 08:01:42 INFO - mkdir: /builds/slave/test/build/application 08:01:42 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'] 08:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:02:00 INFO - Reading from file tmpfile_stdout 08:02:00 INFO - Output received: 08:02:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:02:00 INFO - Running post-action listener: _resource_record_post_action 08:02:00 INFO - [mozharness: 2017-07-27 15:02:00.982053Z] Finished install step (success) 08:02:00 INFO - [mozharness: 2017-07-27 15:02:00.982307Z] Running setup-mitmproxy step. 08:02:00 INFO - Running pre-action listener: _resource_record_pre_action 08:02:00 INFO - Running main action method: setup_mitmproxy 08:02:00 INFO - Skipping: mitmproxy is not required 08:02:00 INFO - Running post-action listener: _resource_record_post_action 08:02:00 INFO - [mozharness: 2017-07-27 15:02:00.983444Z] Finished setup-mitmproxy step (success) 08:02:00 INFO - [mozharness: 2017-07-27 15:02:00.983667Z] Running run-tests step. 08:02:00 INFO - Running pre-action listener: _resource_record_pre_action 08:02:00 INFO - Running pre-action listener: _set_gcov_prefix 08:02:00 INFO - Running main action method: run_tests 08:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:02:00 INFO - Python 2.7.3 08:02:00 INFO - Return code: 0 08:02:00 INFO - grabbing minidump binary from tooltool 08:02: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')]} 08:02:00 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 0xfaaeb0>, '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 0xfabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:02:00 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 08:02:00 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 08:02:00 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 08:02:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:01 INFO - Return code: 0 08:02:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:02:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:02:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:02:01 INFO - ENV: RUST_BACKTRACE is now 1 08:02:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:02:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 08:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 08:02:01 INFO - Using env: {'DISPLAY': ':0', 08:02:01 INFO - 'HOME': '/home/cltbld', 08:02:01 INFO - 'LANG': 'en_US.UTF-8', 08:02:01 INFO - 'LANGUAGE': 'en_US:en', 08:02:01 INFO - 'LOGNAME': 'cltbld', 08:02:01 INFO - 'MAIL': '/var/mail/cltbld', 08:02:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:01 INFO - 'MOZ_NO_REMOTE': '1', 08:02:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:01 INFO - 'NO_EM_RESTART': '1', 08:02:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:01 INFO - 'PWD': '/builds/slave/test', 08:02:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:01 INFO - 'RUST_BACKTRACE': '1', 08:02:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:02:01 INFO - 'SHELL': '/bin/bash', 08:02:01 INFO - 'SHLVL': '1', 08:02:01 INFO - 'TERM': 'linux', 08:02:01 INFO - 'TMOUT': '86400', 08:02:01 INFO - 'USER': 'cltbld', 08:02:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852', 08:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:01 INFO - '_': '/tools/buildbot/bin/python'} 08:02:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 08:02:01 INFO - mozversion application_buildid: 20170727134303 08:02:01 INFO - mozversion application_changeset: d4d5e225250d6a71fa8fe31da16e8142a90caa5f 08:02:01 INFO - mozversion application_display_name: Nightly 08:02:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:01 INFO - mozversion application_name: Firefox 08:02:01 INFO - mozversion application_remotingname: firefox 08:02:01 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:02:01 INFO - mozversion application_vendor: Mozilla 08:02:01 INFO - mozversion application_version: 56.0a1 08:02:01 INFO - mozversion platform_buildid: 20170727134303 08:02:01 INFO - mozversion platform_changeset: d4d5e225250d6a71fa8fe31da16e8142a90caa5f 08:02:01 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:02:01 INFO - mozversion platform_version: 56.0a1 08:02:01 INFO - using testdate: 1501167721 08:02:01 INFO - actual date: 1501167721 08:02:01 INFO - starting webserver on 'localhost:40160' 08:02:01 INFO - SUITE-START | Running 2 tests 08:02:01 INFO - TEST-START | dromaeo_css 08:02:01 INFO - Initialising browser for dromaeo_css test... 08:02:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40160/getInfo.html -profile /tmp/tmpBqgsaX/profile 08:02:01 INFO - TEST-INFO | started process 11234 (/builds/slave/test/build/application/firefox/firefox http://localhost:40160/getInfo.html) 08:02:07 INFO - TEST-INFO | 11234: exit 0 08:02:07 INFO - Browser initialized. 08:02:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:07 INFO - TEST-INFO | started process 11445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBqgsaX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:08 INFO - PID 11445 | 08:02:08 INFO - PID 11445 | (/builds/slave/test/build/application/firefox/firefox:11493): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:02:08 INFO - PID 11445 | 08:02:18 INFO - PID 11445 | RSS: Main: 171810816 08:02:18 INFO - PID 11445 | 08:05:17 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40160/tests/dromaeo/cssquery-ext.html) 08:05:19 INFO - PID 11445 | RSS: Main: 173481984 08:05:19 INFO - PID 11445 | 08:08:20 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-ext.html (next: http://localhost:40160/tests/dromaeo/cssquery-jquery.html) 08:08:21 INFO - PID 11445 | RSS: Main: 170975232 08:08:21 INFO - PID 11445 | 08:11:23 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40160/tests/dromaeo/cssquery-mootools.html) 08:11:23 INFO - PID 11445 | RSS: Main: 172281856 08:11:23 INFO - PID 11445 | 08:14:25 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40160/tests/dromaeo/cssquery-prototype.html) 08:14:26 INFO - PID 11445 | RSS: Main: 171474944 08:14:26 INFO - PID 11445 | 08:17:30 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40160/tests/dromaeo/cssquery-yui.html) 08:17:30 INFO - PID 11445 | RSS: Main: 172498944 08:17:30 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | Cycle 1(1): loaded http://localhost:40160/tests/dromaeo/cssquery-yui.html (next: http://localhost:40160/tests/dromaeo/cssquery-dojo.html) 08:20:32 INFO - PID 11445 | RSS: Main: 174505984 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | __start_tp_report 08:20:32 INFO - PID 11445 | _x_x_mozilla_page_load 08:20:32 INFO - PID 11445 | _x_x_mozilla_page_load_details 08:20:32 INFO - PID 11445 | |i|pagename|runs| 08:20:32 INFO - PID 11445 | |0;dojo.html;3118.251619611294;3128.780985331027;3135.529670549418;3163.2566346908457;3209.8716051357947;6146.754129834807;6166.753329866806;6206.162168107304;6212.751489940397;6268.122462855193;6125.326214116443;6161.784337548187;6197.349278325779;6221;6263.154474145989;5562.610617256793;5575.721213939307;5678.914816277759;5711.600187986832;5756.971215143939;5593.328800543941;5671.319441666985;5680.062789639725;5681.176229446728;5691.800786972436;5570.248016517779;5644.322681278252;5645.689487078209;5653.236813030229;5667.943320566804;5644.604877658566;5646.153077038436;5728.42715728428;5735.799247026334;5742.310922689262;5494.340679118492;5601.271834661508;5653.689047102449;5681.261436013333;5721.856953576153;6064.636121832704;6102.145699602059;6114.357992410822;6135.754569817202;6147.385261473862;6615.6030638161865;6665.233498147727;6709.597424154517;6730.966345168292;6739.157605299338;6710.563813352116;6717.798466045978;6815.522913396064;6816.488763342769;6828.2147553031045;6123.448889599868;6208.037754148114;6236.937630623681;6245.0320200368105;6334.778282760081;6814.48891333152;6947.40947019509;6952.895706564405;6955.374016338554;6961.477889158334;6507.577007494592;6519.119918810899;6575.539712220098;6601.801945941629;6603.80188594343;6617.702203400859;6663.900041499382;6700.262971073178;6720.361565651256;6740.83147921296;6568.277489476154;6569.441597464269;6646.60120392778;6648.833779155463;6651.534392592472;6674.199096108498;6694.933050669431;6695.966520167465;6698.363655452724;6715.7985260442265;5329.173978033411;5389.9191512127345;5392.05639013179;5434.049041417815;5439.075357189287;4620.630349572026;4636.721796692209;4647.117047760915;4662.230731929261;4670.346151538787;5810.1575271586225;5813.912791308134;5856.9750293698435;5900.822975310747;5906.675132867734;6561.1470508833545;6641.833954151185;6642.86714265712;6648.13574235356;6649.468042556584;5735.913961290584;5778.393268706809;5787.160861675117;5805.622634528742;5812.38969908162;5896.616719913192;5899.233099697012;5899.587028907935;5906.468417842415;5917.822465326047;6465.741370345228;6475.7733479328;6499.6750162492635;6515.218173819172;6529.314421985718;6433.581817181868;6673.466122710269;6735.191776986695;6743.089682892747;6764.797056088325;6409.935900640934;6478.384553467413;6479.157709497735;6486.870262594627;6496.123023391781;6579.934200657932;6596.472282217507;6604.636744979072;6674.8998765017595;6695.665216739046;6636.469082473487;6646.2356828965285;6720.462363011045;6747.493937954771;6777.695003724943;6549.214094308713;6568.770093046721;6570.507211959027;6571.507136964842;6574.901376479261;6553.049807777941;6564.901526477202;6575.473962082926;6585.176852893388;6587.374199451045;6335.208098987627;6410.262819775786;6473.611583305017;6508.642024688687;6531.379518945692;6547.639879806466;6548;6589.7364105435245;6665.700043497957;6671.833204169935;6251.4061164189325;6319.273283572448;6324.462420694293;6331.620102793847;6332.651704156316 08:20:32 INFO - PID 11445 | |1;ext.html;800.6557180412424;841.1336323586706;843.0599881132537;864.0668078475244;1184.4196343791546;30706.232344191405;31156.53265201024;31202.843985780095;41429.17141657165;42141.15717685652;41626.16747665045;41974.16051678965;42118.36822447658;42205;42431.15137697244;7818.413618978571;8016.67933282668;8036.799080022988;8037.6383062762025;8057.9524661793885;7656.234376562327;7696.268854458845;7734.5745983970855;7756.495827771205;7757.10793258774;7708.03649543807;7784.649690763929;7806.921930780704;7810.062792464883;7820;7696.384289256874;7751.6511756970785;7754.108277548098;7766.689332426753;7777.494462859896;7732;7810.101838288612;7812.257835505618;7835.177306382805;7840.098388685317;39034.41448378276;39233.41149882754;39249.21501569981;39287.41068883969;39381.40927886084;3565.144365352297;3601.891943241707;3603.8378272977516;3606;3607.981960090183;31031;31194.844025779727;31324.277164755928;31329.686703132906;31412.21469463259;4728.598069164125;4799.3041009053495;4860.829870954535;4882.09681208974;4905.828296009622;170295;172808.13595932064;172961;173380.1330993337;173748;46052.7697361511;46196;46243;48573;49135.75432122817;51484.485155148715;51589.484105159216;51635.22547161795;51718.22422663663;51732.48267517277;16282;16441.753373699405;16587.83412165887;16725.58186045334;16800.663986720443;13717.519886803913;13792.379342929593;13796.241206733726;13803;13824.101433406797;14329.426822926966;14371.06588071772;14385.928070359581;14531.92734036323;14633.122012679274;5795.507381872588;5891.852703682356;5986.551008674367;5997.100434934795;6012.609180403259;962.7496850818837;967.8451447768323;978.8384916488842;992.2805965674972;999.0309399882103;22306;22347.329580112622;22455.775442245696;22658.546829063656;22660.433489162904;1046.7121541575975;1079.5951518180682;1101.6750058732694;1113.493360520961;1113.5156207049959;11889;11890.702732431586;11905.404729763477;11973.940130299292;12055.457504412323;203587;209619;225959;227575;228512;52564;52581;52581.737091315066;52623.47376526262;52825.735871321165;1436.5690292912084;1436.719839631262;1452.6005348529238;1455.745244582194;1458.48223880523;25610.231693049238;26518.337041574116;26570.335741606614;26577.601335980362;26693.866530667223;47308;47731.76134119446;47927.28109078437;47947.76026119847;48033;208444;208791;209132;210167;210684;35297.823510882285;35697.82151089228;35815;36050.63949360473;36322;43461.78269108761;44792.776036120915;44967.55032449633;45270.09459810719;45304.32043519416;29867.701322986493;30979.225519362197;30990.380192395576;31295.530567041056;31405.214869628442;29814.701852981194;30744.231394215323;30936.53595196029;30965.845170774002;31099.22251943629;34902.65097348994;35858;35880;35967.100822479646;36001.099972500895;30200.84899575488;33436;33761.49357759685;34035.65964340325;34322.313553729284;24404.75595244096;24504.142355017488;24815.503689926463;24831.25506234816;25021.87489062543 08:20:32 INFO - PID 11445 | |2;jquery.html;568.173307837097;570.2244946872256;573.3349314794839;578.4880380862937;594.4234092929859;20594.48513787156;21299.57400851984;22252.443688907784;22279.77720222797;22333.553328933413;25370;25722.09972650953;25830;25859.96560137597;25933.351666208353;6463.935360646392;6653.500987425939;6657.800265992028;6657.9334206657795;6658;6342.809715708536;6571.211454625428;7007.614581198032;7019.298070192991;7045.154581450208;7016.438684905221;7023.789286321418;7024.121984751906;7027.648617569101;7028;6954.79135625932;6986.196587392438;6990.895136572955;7002.719891204346;7018.227994920555;6823.044773731682;6830.795076147723;6842.213145488233;6856.4514838813275;6866.107406037183;30076;30917.22706932322;31001.224969375948;31215.375692486024;31405.214869628442;1857.6377606366764;1877.727729479218;1890.0738638067248;1892.8485721142276;1894.2991093295432;19104.522386940298;19627.607447851107;19728.901355493275;19767.505812354662;19826.900865495725;2334.48641298914;2336.719593648756;2417.721961974378;2420.189236605739;2502.7121880983736;123803;129121.35439322838;130114.3494282532;130289.34855325663;130402;20205.57357225325;21580.784192158193;21727;21764;21893.67159492609;22819.630822150724;24063.51872962531;42075;42144.57855421468;42164.78917605392;10412.68761937143;10452;10698.679039628823;10724.517396717167;10829.512671929782;9739;9757.219422446187;9785.483250096104;9928.106470417697;9953.601855925826;8904.777380565409;9364.971166715652;9374.437533747861;9477.715668529956;9497.762555936019;2871.5118429866975;2893.696161903012;2902.0713371720844;2920.8685609147215;3005.278733104083;944.9539943789807;953.7091187187974;956.1729104324849;982.1700662939804;990.5443495991781;19181.904090479456;19257.711134332996;19655.213791448183;19733.802661973485;20230.494237644176;1027.9897201028043;1031.2111234905303;1038.2939601071344;1053.3206082077018;1053.4469403563037;10618.469076546142;10653.84019239712;10704.571817127227;11029;11190.720231994264;454304;462894;464774;466233;472667;111887;120321;123102;123450;124480;1225.2648410953357;1252.7325540771233;1288.9871101288868;1292.0438875232448;1299.5581502289267;19828.603427931073;21114.89442552839;21216.681749773456;21287.04208310599;21432.142714291254;45024.860720062876;53560;54816;56029.719851400485;58598;63165.36834631779;63390.68304658447;65742.34257657554;69388.30611693818;69851.65074174597;20249.493762656053;21361.89319053457;21543.56912861765;21564.35306940794;21806.45483862916;20370.388888333375;22989.88505057531;23574.0570377183;24289.75710242875;24412.51174976455;18296.451106466826;18318.542036449195;18715.25138994425;19006;19032.714509282094;15680.215989200266;16135.112568808829;16598.75101873449;16918.915405423388;17103.48689539316;18469.815301847346;18965.146568404733;19219.23123075117;19408.126634301774;19412.223511059965;21166.894165529073;21379.358619241448;21384.786152138902;21435.249766258105;21639;18233;19003.14485848168;19177.32879349216;19263.614727705648;19388.61222775565 08:20:32 INFO - PID 11445 | |3;mootools.html;1301.6225294664548;1330.7005923667175;1348.3999620169025;1352.3643887372937;1355.4103964775318;12942.223466591999;13451.529196478125;13469.663258418545;13492.98802589806;14192;14204.928975355135;14493.710125797477;14502.709945801103;14505.129692218474;14519;2573.648834361961;2608.8695565221756;2614.516314481827;2615.215435369391;2615.856127912964;2519.760622740846;2605.895764169431;2639.326971622243;2644.114221735721;2645.828021178627;2470.6911636045493;2486.45298034433;2583.522048421048;2617.319496930802;2620.2270330252527;2408.3617841272076;2451.1421002649017;2463.644995252622;2467.8272520923542;2472.2830379190013;2450.130203777651;2468.9629655555;2483.801295896324;2483.8882250298598;2487.5646761816793;13414.26221557814;13525.729485410237;13536.59390218295;13578.253196074213;13603;7438.962805185994;7655.578943158124;7694.769156925301;7705.653245603905;7722.922770772277;4790.377250957354;4863.489333619955;4962.1316269653025;5007.298978143063;5035.219540971156;1766.6132086312184;1775.254393154878;1791.8208179182109;1800.4778614201996;1817.3275887921554;22381;22602.660960085614;22613.434664133365;22651;22763.20328788501;6854.0404343391965;7042.859142817218;7060.505764596532;7070.434365250768;7101.822454438577;15201.771973420407;15318.234088295541;15336.616584585252;15337.693246135015;15357.539273821803;7487.251274872469;7498.925010749932;7500.062492188476;7729.227077292226;7992.680292788224;6090.756369745161;6108.17539632144;6260.060990851409;6266.49868010558;7085.82285442868;4807.134715751198;5128.640995130305;5214.504622060898;5280;5284.207368894697;1530.7933428987167;1533.087812751411;1534.2252162657787;1566.428253687396;1569.9058056516647;790.5730905311068;805.3758337288648;814.4583851738646;827.0736774812128;833.7165363776223;6627.879078694771;6816.727330906709;6928.099347084847;7943.340232923583;8231.135730748305;939.4363381970763;967.7145242153582;972.7179118055684;976.9218462522981;979.5787811241235;4917;4972.229304457815;4996.725180115056;5038.420581633159;5212.739363031833;19280.61438771245;19437.125329360213;19500.1224944875;19527.414177574694;19673.803261967485;18232.179551920195;19174;19198.328058518164;19625.607487850164;19708.70436943447;10731.302465339728;10937.83593246102;10949.507272172772;10949.945250273699;10957.506912188812;7324.19433862264;7410.333070023724;7595.734149304748;7785.987821583158;8045.718399855977;16442.342306307615;16658.333666653198;16753.66492670164;16903.32386704518;17269.740953885954;16896.40862569804;17178.484645460656;17210.483685489457;17412.042337671042;17423;11336.09311255081;11617.128715346214;11624.535018599161;11633.127515436207;11635.127365447795;13092.934535327644;13124.803127953279;13253;13286.402111904794;13333.20000799955;10004.749881253027;10310.587576497157;10427.739306517398;10587.735306617396;10743.409112498888;9443.480608566595;9964.950175249078;10001;10087.495625218562;10213.489325533843;8376;8379.287760540423;8402.159784021549;8413.032501262433;8447.070822209675;6622.139121914121;6685.699143538455;6777.728890844311;6821.386075253251;6888.173419189729;6266.154069200599;6468.417842394207;6560.770373036921;6614.404703576702;6677.899831502628 08:20:32 INFO - PID 11445 | |4;prototype.html;498.7381923732956;499.4450610432851;521.6087934049463;523.1420470428496;526.0557299647134;6185.226846644169;6217.471514921226;6221.78223762169;6285.308616052242;6316.684165791709;5908.202392676987;6091.695415229243;6133.631982081079;6139;6152.938470615292;4827.203511420629;4844.539768721966;4889.731064791435;4905.533974272456;4925.729084900338;4860.951390486085;4874;4940.456549779521;4947.901041979158;4957.0085982803585;4597.954020459802;4777.689450185744;4799.712017278957;4834.250691142878;4841.104395686809;4779.450363208241;4811.391456407694;4823.1800593899125;4884.804607815683;4890.437599676047;4324.767441279252;4331.501877284121;4352.39066530686;4378.64970802335;4394.868488782938;5989.2812862456785;6000.249968753906;6031.306399763996;6031.487323577458;6044.365341639153;5584.329880414376;5658.292713410824;5664.008798460253;5668.121441176624;5683.175939488751;6522.967385163091;6530.44491218247;6574.342565743435;6678.131842860445;6687.02122237268;4795.017021510582;4801.831935882262;4803.255495398219;4819.2530157825595;4836.322914791932;6812.795616131524;6922.861542769167;6930;6962;6990.755323563752;4927.531884470969;4942.827001054946;4957.90084198314;4993.450720420751;5018;4960;4991.326170966946;5005.27423523587;5010.5240002199735;5010.624203184703;5623.240862483594;5628;5660.235868157828;5662.603617746719;5679.659220446786;6638.087815016949;6654.201495820533;6698.799036028927;6722.092517510074;6744.763933262312;1653.3138747419687;1724.6895558799536;1733.4886208568503;1737.409280844519;1748.7321691773616;1146.2950285574311;1150.6260465348796;1197.9041676665845;1198.406788639629;1207.5833837326109;5684.147377893267;5705.885882282331;5785.450382213683;5793.565482588822;5804.535637149018;6656.334366563402;6662.367075127855;6666.666666666647;6687.465002799764;6708.563943343667;5569.303837020372;5756.884862302731;5820.272465941757;5826.796062137805;5887.558433117533;3502.8598856045983;3503.8423270952867;3550.6804387604725;3571.2143328467696;3582.749207555446;6521.282658907517;6522.64125473094;6555.541112122201;6562.146920900253;6594;6805.183377994672;6901.930980690129;6938.618375989268;6957.61733104674;6975.372216500539;6530.249021362604;6547.148870646785;6563.967180164069;6574.868502629921;6595.307492713196;6621.470282377302;6688.548832701333;6690.665466726547;6706.5640733352175;6712.731490740316;6662.666866656551;6679.298673639198;6696;6700.262971073275;6732.831679208059;6582;6587.83783783796;6616.305287944697;6623.735050597922;6663;4903.705777653352;4915.483874193301;4922.286268490977;4938.38270216223;4941.77762000718;6698.430633396216;6745.763898263537;6824.317568243136;6827.761028363983;6841.863162736817;6573.1454910861285;6586.934130658824;6606.372394622503;6610.10763546915;6624.310800745779;6537.803865884031;6538;6555.573887697285;6585.407313341822;6618.867622647424;6146.262448506208;6360.745570177326;6427.6786160690845;6436.935630643634;6493.740250389931;6100.511959043355;6384.201974753156;6427.357264273723;6479.611223326616;6491.805245842444;6223.96888015557;6393.392627700361;6394.1687580614225;6396.456301214449;6456.7740129095255 08:20:32 INFO - PID 11445 | |5;yui.html;873.7335112790596;895.9372843900927;906.4878343735788;916.074764487867;920.972370828875;17054.317827286908;17786.822131778677;17831;17848.732269015974;22138.114475421004;20382;20833.68749468759;21146.25988090417;21287;21312.4671883203;1026.266219652948;1057.8148823955814;1058.5236643510414;1058.7353161709573;1058.7776566920957;1007.2999265510473;1045.1690905729924;1049.6536143072806;1051.4532443129567;1052.9105026072793;1111.0667039686662;1113.332000799522;1114.4539175803839;1114.5374669512144;1114.8494953181298;1099.6151347028556;1105.1324710102572;1105.6793529876327;1109.2290857853795;1110.4780753046055;812.2324403438753;814.0313027497259;814.8125931035836;816.3020617372121;816.6610856494548;18859.434216973514;19385.51536211592;19579.80420195794;19585.608287834308;19620.70568941467;20194.899025504925;20222.49443763903;20824.895875520677;20835.479113022146;20988;15042.623934401618;15101.093934363973;15114.168720720356;15215.087094774239;16043.518694439186;3577.338192434408;3608.2963822054708;3609.6570825771773;3609.9097522561883;3611.422172452395;111501.44249278783;112667;114424;115316.42341788237;117574;16168.838311616968;16785.748213776802;16790.66418671644;16876.324947002227;16878.156092195342;29650.703492964793;30087;30304.696953030187;30338.54492182619;30359.544606830914;8475.02537208229;8492.575371231538;8509.446885952393;8617.267532259702;8684.43551169172;4296.957030429656;4343.109662519176;4345.478542574911;4395.3187255974735;4400.647948164139;4881.243407271879;4974.17926042199;4989.451160372356;5010.849674509771;5011.599072074226;1037.9325343852624;1038.2991480750463;1067.7330667333167;1068.4444089073638;1069.3209811769582;648.3451713769127;648.6626953983902;671.2917871645363;676.2628734679223;684.6747794797432;11229.38238396896;12668.429920653592;13070.411831467607;13309.600711978655;13512.391942362618;638.4222278837659;653.6404977262487;665.4609766089483;669.8024082895557;683.4190937702913;5196.220566914993;5274.683518988873;5280.973595132076;5395.676259424447;5469.972650136803;98711;102140;102386.48806755918;102636.48681756544;104045.47977260065;84114;89871;92766;92800.99999999865;92940.0705992945;73990.26009739834;78965.60517197377;80699.59650201829;81589.59205204055;81960.18039819645;10364.326318789255;10950.307057585094;11445.370504622326;12395.62813115608;12520.561780337644;33406.83296583501;34640;35567.46648800218;36336.45495317625;37239.069023274635;65015.59063111878;65436;66589.33410665831;66993.99509007466;69993;18280.72578911291;18760.437186884414;18862.339818106302;18902.905485472485;18974;20342.79657203409;20491;20636.380908572766;20741.170353185702;20879.8956005219;18363;18823.247070117042;18922.053897304806;19285.517862053563;19399.709004364664;14884.404623814926;14938.850611494181;14950.775738364151;18799.812001880353;18887.150078246235;17408;17542.473725788248;17738.201780920146;17919.28322867071;17934.5516362092;12421.378931053592;12651.810222846849;12745.49018039268;12773.552925647558;13794.786975409717;13852.445902163801;13933.581992539834;14115.858841411866;14543.200123993282;14657.780133298222 08:20:32 INFO - PID 11445 | __end_tp_report 08:20:32 INFO - PID 11445 | __start_cc_report 08:20:32 INFO - PID 11445 | _x_x_mozilla_cycle_collect,372 08:20:32 INFO - PID 11445 | __end_cc_report 08:20:32 INFO - PID 11445 | __startTimestamp1501168832754__endTimestamp 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | ------- Summary: start ------- 08:20:32 INFO - PID 11445 | Number of tests: 6 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#0] dojo.html Cycles:165 Average:6146.48 Median:6410.26 stddev:732.68 (11.4%) stddev-sans-first:695.35 08:20:32 INFO - PID 11445 | Values: 3118.3 3128.8 3135.5 3163.3 3209.9 6146.8 6166.8 6206.2 6212.8 6268.1 6125.3 6161.8 6197.3 6221.0 6263.2 5562.6 5575.7 5678.9 5711.6 5757.0 5593.3 5671.3 5680.1 5681.2 5691.8 5570.2 5644.3 5645.7 5653.2 5667.9 5644.6 5646.2 5728.4 5735.8 5742.3 5494.3 5601.3 5653.7 5681.3 5721.9 6064.6 6102.1 6114.4 6135.8 6147.4 6615.6 6665.2 6709.6 6731.0 6739.2 6710.6 6717.8 6815.5 6816.5 6828.2 6123.4 6208.0 6236.9 6245.0 6334.8 6814.5 6947.4 6952.9 6955.4 6961.5 6507.6 6519.1 6575.5 6601.8 6603.8 6617.7 6663.9 6700.3 6720.4 6740.8 6568.3 6569.4 6646.6 6648.8 6651.5 6674.2 6694.9 6696.0 6698.4 6715.8 5329.2 5389.9 5392.1 5434.0 5439.1 4620.6 4636.7 4647.1 4662.2 4670.3 5810.2 5813.9 5857.0 5900.8 5906.7 6561.1 6641.8 6642.9 6648.1 6649.5 5735.9 5778.4 5787.2 5805.6 5812.4 5896.6 5899.2 5899.6 5906.5 5917.8 6465.7 6475.8 6499.7 6515.2 6529.3 6433.6 6673.5 6735.2 6743.1 6764.8 6409.9 6478.4 6479.2 6486.9 6496.1 6579.9 6596.5 6604.6 6674.9 6695.7 6636.5 6646.2 6720.5 6747.5 6777.7 6549.2 6568.8 6570.5 6571.5 6574.9 6553.0 6564.9 6575.5 6585.2 6587.4 6335.2 6410.3 6473.6 6508.6 6531.4 6547.6 6548.0 6589.7 6665.7 6671.8 6251.4 6319.3 6324.5 6331.6 6332.7 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#1] ext.html Cycles:180 Average:37433.44 Median:35923.55 stddev:52162.79 (145.2%) stddev-sans-first:52236.59 08:20:32 INFO - PID 11445 | Values: 800.7 841.1 843.1 864.1 1184.4 30706.2 31156.5 31202.8 41429.2 42141.2 41626.2 41974.2 42118.4 42205.0 42431.2 7818.4 8016.7 8036.8 8037.6 8058.0 7656.2 7696.3 7734.6 7756.5 7757.1 7708.0 7784.6 7806.9 7810.1 7820.0 7696.4 7751.7 7754.1 7766.7 7777.5 7732.0 7810.1 7812.3 7835.2 7840.1 39034.4 39233.4 39249.2 39287.4 39381.4 3565.1 3601.9 3603.8 3606.0 3608.0 31031.0 31194.8 31324.3 31329.7 31412.2 4728.6 4799.3 4860.8 4882.1 4905.8 170295.0 172808.1 172961.0 173380.1 173748.0 46052.8 46196.0 46243.0 48573.0 49135.8 51484.5 51589.5 51635.2 51718.2 51732.5 16282.0 16441.8 16587.8 16725.6 16800.7 13717.5 13792.4 13796.2 13803.0 13824.1 14329.4 14371.1 14385.9 14531.9 14633.1 5795.5 5891.9 5986.6 5997.1 6012.6 962.7 967.8 978.8 992.3 999.0 22306.0 22347.3 22455.8 22658.5 22660.4 1046.7 1079.6 1101.7 1113.5 1113.5 11889.0 11890.7 11905.4 11973.9 12055.5 203587.0 209619.0 225959.0 227575.0 228512.0 52564.0 52581.0 52581.7 52623.5 52825.7 1436.6 1436.7 1452.6 1455.7 1458.5 25610.2 26518.3 26570.3 26577.6 26693.9 47308.0 47731.8 47927.3 47947.8 48033.0 208444.0 208791.0 209132.0 210167.0 210684.0 35297.8 35697.8 35815.0 36050.6 36322.0 43461.8 44792.8 44967.6 45270.1 45304.3 29867.7 30979.2 30990.4 31295.5 31405.2 29814.7 30744.2 30936.5 30965.8 31099.2 34902.7 35858.0 35880.0 35967.1 36001.1 30200.8 33436.0 33761.5 34035.7 34322.3 24404.8 24504.1 24815.5 24831.3 25021.9 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#2] jquery.html Cycles:180 Average:34812.24 Median:22576.59 stddev:78184.40 (346.3%) stddev-sans-first:78361.45 08:20:32 INFO - PID 11445 | Values: 568.2 570.2 573.3 578.5 594.4 20594.5 21299.6 22252.4 22279.8 22333.6 25370.0 25722.1 25830.0 25860.0 25933.4 6463.9 6653.5 6657.8 6657.9 6658.0 6342.8 6571.2 7007.6 7019.3 7045.2 7016.4 7023.8 7024.1 7027.6 7028.0 6954.8 6986.2 6990.9 7002.7 7018.2 6823.0 6830.8 6842.2 6856.5 6866.1 30076.0 30917.2 31001.2 31215.4 31405.2 1857.6 1877.7 1890.1 1892.8 1894.3 19104.5 19627.6 19728.9 19767.5 19826.9 2334.5 2336.7 2417.7 2420.2 2502.7 123803.0 129121.4 130114.3 130289.3 130402.0 20205.6 21580.8 21727.0 21764.0 21893.7 22819.6 24063.5 42075.0 42144.6 42164.8 10412.7 10452.0 10698.7 10724.5 10829.5 9739.0 9757.2 9785.5 9928.1 9953.6 8904.8 9365.0 9374.4 9477.7 9497.8 2871.5 2893.7 2902.1 2920.9 3005.3 945.0 953.7 956.2 982.2 990.5 19181.9 19257.7 19655.2 19733.8 20230.5 1028.0 1031.2 1038.3 1053.3 1053.4 10618.5 10653.8 10704.6 11029.0 11190.7 454304.0 462894.0 464774.0 466233.0 472667.0 111887.0 120321.0 123102.0 123450.0 124480.0 1225.3 1252.7 1289.0 1292.0 1299.6 19828.6 21114.9 21216.7 21287.0 21432.1 45024.9 53560.0 54816.0 56029.7 58598.0 63165.4 63390.7 65742.3 69388.3 69851.7 20249.5 21361.9 21543.6 21564.4 21806.5 20370.4 22989.9 23574.1 24289.8 24412.5 18296.5 18318.5 18715.3 19006.0 19032.7 15680.2 16135.1 16598.8 16918.9 17103.5 18469.8 18965.1 19219.2 19408.1 19412.2 21166.9 21379.4 21384.8 21435.2 21639.0 18233.0 19003.1 19177.3 19263.6 19388.6 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#3] mootools.html Cycles:180 Average:8547.31 Median:2478.04 stddev:5902.29 (238.2%) stddev-sans-first:5893.74 08:20:32 INFO - PID 11445 | Values: 1301.6 1330.7 1348.4 1352.4 1355.4 12942.2 13451.5 13469.7 13493.0 14192.0 14204.9 14493.7 14502.7 14505.1 14519.0 2573.6 2608.9 2614.5 2615.2 2615.9 2519.8 2605.9 2639.3 2644.1 2645.8 2470.7 2486.5 2583.5 2617.3 2620.2 2408.4 2451.1 2463.6 2467.8 2472.3 2450.1 2469.0 2483.8 2483.9 2487.6 13414.3 13525.7 13536.6 13578.3 13603.0 7439.0 7655.6 7694.8 7705.7 7722.9 4790.4 4863.5 4962.1 5007.3 5035.2 1766.6 1775.3 1791.8 1800.5 1817.3 22381.0 22602.7 22613.4 22651.0 22763.2 6854.0 7042.9 7060.5 7070.4 7101.8 15201.8 15318.2 15336.6 15337.7 15357.5 7487.3 7498.9 7500.1 7729.2 7992.7 6090.8 6108.2 6260.1 6266.5 7085.8 4807.1 5128.6 5214.5 5280.0 5284.2 1530.8 1533.1 1534.2 1566.4 1569.9 790.6 805.4 814.5 827.1 833.7 6627.9 6816.7 6928.1 7943.3 8231.1 939.4 967.7 972.7 976.9 979.6 4917.0 4972.2 4996.7 5038.4 5212.7 19280.6 19437.1 19500.1 19527.4 19673.8 18232.2 19174.0 19198.3 19625.6 19708.7 10731.3 10937.8 10949.5 10949.9 10957.5 7324.2 7410.3 7595.7 7786.0 8045.7 16442.3 16658.3 16753.7 16903.3 17269.7 16896.4 17178.5 17210.5 17412.0 17423.0 11336.1 11617.1 11624.5 11633.1 11635.1 13092.9 13124.8 13253.0 13286.4 13333.2 10004.7 10310.6 10427.7 10587.7 10743.4 9443.5 9965.0 10001.0 10087.5 10213.5 8376.0 8379.3 8402.2 8413.0 8447.1 6622.1 6685.7 6777.7 6821.4 6888.2 6266.2 6468.4 6560.8 6614.4 6677.9 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#4] prototype.html Cycles:180 Average:5488.40 Median:6068.03 stddev:1568.72 (25.9%) stddev-sans-first:1527.76 08:20:32 INFO - PID 11445 | Values: 498.7 499.4 521.6 523.1 526.1 6185.2 6217.5 6221.8 6285.3 6316.7 5908.2 6091.7 6133.6 6139.0 6152.9 4827.2 4844.5 4889.7 4905.5 4925.7 4861.0 4874.0 4940.5 4947.9 4957.0 4598.0 4777.7 4799.7 4834.3 4841.1 4779.5 4811.4 4823.2 4884.8 4890.4 4324.8 4331.5 4352.4 4378.6 4394.9 5989.3 6000.2 6031.3 6031.5 6044.4 5584.3 5658.3 5664.0 5668.1 5683.2 6523.0 6530.4 6574.3 6678.1 6687.0 4795.0 4801.8 4803.3 4819.3 4836.3 6812.8 6922.9 6930.0 6962.0 6990.8 4927.5 4942.8 4957.9 4993.5 5018.0 4960.0 4991.3 5005.3 5010.5 5010.6 5623.2 5628.0 5660.2 5662.6 5679.7 6638.1 6654.2 6698.8 6722.1 6744.8 1653.3 1724.7 1733.5 1737.4 1748.7 1146.3 1150.6 1197.9 1198.4 1207.6 5684.1 5705.9 5785.5 5793.6 5804.5 6656.3 6662.4 6666.7 6687.5 6708.6 5569.3 5756.9 5820.3 5826.8 5887.6 3502.9 3503.8 3550.7 3571.2 3582.7 6521.3 6522.6 6555.5 6562.1 6594.0 6805.2 6901.9 6938.6 6957.6 6975.4 6530.2 6547.1 6564.0 6574.9 6595.3 6621.5 6688.5 6690.7 6706.6 6712.7 6662.7 6679.3 6696.0 6700.3 6732.8 6582.0 6587.8 6616.3 6623.7 6663.0 4903.7 4915.5 4922.3 4938.4 4941.8 6698.4 6745.8 6824.3 6827.8 6841.9 6573.1 6586.9 6606.4 6610.1 6624.3 6537.8 6538.0 6555.6 6585.4 6618.9 6146.3 6360.7 6427.7 6436.9 6493.7 6100.5 6384.2 6427.4 6479.6 6491.8 6224.0 6393.4 6394.2 6396.5 6456.8 08:20:32 INFO - PID 11445 | 08:20:32 INFO - PID 11445 | [#5] yui.html Cycles:180 Average:22480.84 Median:19582.71 stddev:29470.13 (150.5%) stddev-sans-first:29508.14 08:20:32 INFO - PID 11445 | Values: 873.7 895.9 906.5 916.1 921.0 17054.3 17786.8 17831.0 17848.7 22138.1 20382.0 20833.7 21146.3 21287.0 21312.5 1026.3 1057.8 1058.5 1058.7 1058.8 1007.3 1045.2 1049.7 1051.5 1052.9 1111.1 1113.3 1114.5 1114.5 1114.8 1099.6 1105.1 1105.7 1109.2 1110.5 812.2 814.0 814.8 816.3 816.7 18859.4 19385.5 19579.8 19585.6 19620.7 20194.9 20222.5 20824.9 20835.5 20988.0 15042.6 15101.1 15114.2 15215.1 16043.5 3577.3 3608.3 3609.7 3609.9 3611.4 111501.4 112667.0 114424.0 115316.4 117574.0 16168.8 16785.7 16790.7 16876.3 16878.2 29650.7 30087.0 30304.7 30338.5 30359.5 8475.0 8492.6 8509.4 8617.3 8684.4 4297.0 4343.1 4345.5 4395.3 4400.6 4881.2 4974.2 4989.5 5010.8 5011.6 1037.9 1038.3 1067.7 1068.4 1069.3 648.3 648.7 671.3 676.3 684.7 11229.4 12668.4 13070.4 13309.6 13512.4 638.4 653.6 665.5 669.8 683.4 5196.2 5274.7 5281.0 5395.7 5470.0 98711.0 102140.0 102386.5 102636.5 104045.5 84114.0 89871.0 92766.0 92801.0 92940.1 73990.3 78965.6 80699.6 81589.6 81960.2 10364.3 10950.3 11445.4 12395.6 12520.6 33406.8 34640.0 35567.5 36336.5 37239.1 65015.6 65436.0 66589.3 66994.0 69993.0 18280.7 18760.4 18862.3 18902.9 18974.0 20342.8 20491.0 20636.4 20741.2 20879.9 18363.0 18823.2 18922.1 19285.5 19399.7 14884.4 14938.9 14950.8 18799.8 18887.2 17408.0 17542.5 17738.2 17919.3 17934.6 12421.4 12651.8 12745.5 12773.6 13794.8 13852.4 13933.6 14115.9 14543.2 14657.8 08:20:32 INFO - PID 11445 | -------- Summary: end -------- 08:20:32 INFO - PID 11445 | 08:20:33 INFO - TEST-INFO | 11445: exit 0 08:20:33 INFO - TEST-OK | dromaeo_css | took 1112095ms 08:20:33 INFO - TEST-START | kraken 08:20:33 INFO - Initialising browser for kraken test... 08:20:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40160/getInfo.html -profile /tmp/tmp_OfcMd/profile 08:20:33 INFO - TEST-INFO | started process 11808 (/builds/slave/test/build/application/firefox/firefox http://localhost:40160/getInfo.html) 08:20:39 INFO - TEST-INFO | 11808: exit 0 08:20:39 INFO - Browser initialized. 08:20:39 INFO - Running cycle 1/1 for kraken test... 08:20:39 INFO - TEST-INFO | started process 12019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_OfcMd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:40 INFO - PID 12019 | 08:20:40 INFO - PID 12019 | (/builds/slave/test/build/application/firefox/firefox:12068): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:20:40 INFO - PID 12019 | 08:20:50 INFO - PID 12019 | RSS: Main: 171528192 08:20:50 INFO - PID 12019 | 08:20:53 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40160/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:54 INFO - PID 12019 | RSS: Main: 177864704 08:20:54 INFO - PID 12019 | 08:20:56 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40160/tests/kraken/driver.html?testName=audio-dft) 08:20:57 INFO - PID 12019 | RSS: Main: 178327552 08:20:57 INFO - PID 12019 | 08:21:00 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40160/tests/kraken/driver.html?testName=audio-fft) 08:21:01 INFO - PID 12019 | RSS: Main: 171532288 08:21:01 INFO - PID 12019 | 08:21:03 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40160/tests/kraken/driver.html?testName=audio-oscillator) 08:21:03 INFO - PID 12019 | RSS: Main: 172306432 08:21:03 INFO - PID 12019 | 08:21:05 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:06 INFO - PID 12019 | RSS: Main: 172322816 08:21:06 INFO - PID 12019 | 08:21:09 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40160/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:10 INFO - PID 12019 | RSS: Main: 174850048 08:21:10 INFO - PID 12019 | 08:21:13 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40160/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:14 INFO - PID 12019 | RSS: Main: 175456256 08:21:14 INFO - PID 12019 | 08:21:17 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40160/tests/kraken/driver.html?testName=json-parse-financial) 08:21:17 INFO - PID 12019 | RSS: Main: 175792128 08:21:17 INFO - PID 12019 | 08:21:19 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:20 INFO - PID 12019 | RSS: Main: 175767552 08:21:20 INFO - PID 12019 | 08:21:21 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:22 INFO - PID 12019 | RSS: Main: 175894528 08:21:22 INFO - PID 12019 | 08:21:24 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:25 INFO - PID 12019 | RSS: Main: 172797952 08:21:25 INFO - PID 12019 | 08:21:28 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:28 INFO - PID 12019 | RSS: Main: 173002752 08:21:28 INFO - PID 12019 | 08:21:31 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:32 INFO - PID 12019 | RSS: Main: 173285376 08:21:32 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | Cycle 1(1): loaded http://localhost:40160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40160/tests/kraken/driver.html?testName=ai-astar) 08:21:34 INFO - PID 12019 | RSS: Main: 175222784 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | __start_tp_report 08:21:34 INFO - PID 12019 | _x_x_mozilla_page_load 08:21:34 INFO - PID 12019 | _x_x_mozilla_page_load_details 08:21:34 INFO - PID 12019 | |i|pagename|runs| 08:21:34 INFO - PID 12019 | |0;ai-astar;101;108;104;109;110;109;110;100;107;110 08:21:34 INFO - PID 12019 | |1;audio-beat-detection;154;118;151;182;121;148;150;122;171;122 08:21:34 INFO - PID 12019 | |2;audio-dft;163;165;163;164;165;164;167;168;163;162 08:21:34 INFO - PID 12019 | |3;audio-fft;76;77;75;169;76;76;75;73;156;77 08:21:34 INFO - PID 12019 | |4;audio-oscillator;79;79;129;80;78;80;131;79;80;132 08:21:34 INFO - PID 12019 | |5;imaging-gaussian-blur;114;114;114;114;113;115;115;115;113;115 08:21:34 INFO - PID 12019 | |6;imaging-darkroom;152;152;151;151;152;151;151;149;150;151 08:21:34 INFO - PID 12019 | |7;imaging-desaturate;94;94;94;94;94;95;99;95;95;94 08:21:34 INFO - PID 12019 | |8;json-parse-financial;56;56;56;57;57;57;56;56;57;56 08:21:34 INFO - PID 12019 | |9;json-stringify-tinderbox;54;54;61;54;54;56;53;54;54;54 08:21:34 INFO - PID 12019 | |10;stanford-crypto-aes;84;84;82;81;84;81;82;83;82;81 08:21:34 INFO - PID 12019 | |11;stanford-crypto-ccm;131;129;147;131;125;132;125;139;125;161 08:21:34 INFO - PID 12019 | |12;stanford-crypto-pbkdf2;182;182;177;181;178;182;178;177;179;184 08:21:34 INFO - PID 12019 | |13;stanford-crypto-sha256-iterative;69;70;69;75;68;69;70;72;68;71 08:21:34 INFO - PID 12019 | __end_tp_report 08:21:34 INFO - PID 12019 | __start_cc_report 08:21:34 INFO - PID 12019 | _x_x_mozilla_cycle_collect,949 08:21:34 INFO - PID 12019 | __end_cc_report 08:21:34 INFO - PID 12019 | __startTimestamp1501168894517__endTimestamp 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | ------- Summary: start ------- 08:21:34 INFO - PID 12019 | Number of tests: 14 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.79 (3.5%) stddev-sans-first:3.40 08:21:34 INFO - PID 12019 | Values: 101.0 108.0 104.0 109.0 110.0 109.0 110.0 100.0 107.0 110.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:150.50 stddev:22.48 (14.9%) stddev-sans-first:23.54 08:21:34 INFO - PID 12019 | Values: 154.0 118.0 151.0 182.0 121.0 148.0 150.0 122.0 171.0 122.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:1.90 (1.2%) stddev-sans-first:1.94 08:21:34 INFO - PID 12019 | Values: 163.0 165.0 163.0 164.0 165.0 164.0 167.0 168.0 163.0 162.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:36.78 (48.4%) stddev-sans-first:38.49 08:21:34 INFO - PID 12019 | Values: 76.0 77.0 75.0 169.0 76.0 76.0 75.0 73.0 156.0 77.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:24.84 (31.4%) stddev-sans-first:25.69 08:21:34 INFO - PID 12019 | Values: 79.0 79.0 129.0 80.0 78.0 80.0 131.0 79.0 80.0 132.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 08:21:34 INFO - PID 12019 | Values: 114.0 114.0 114.0 114.0 113.0 115.0 115.0 115.0 113.0 115.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:21:34 INFO - PID 12019 | Values: 152.0 152.0 151.0 151.0 152.0 151.0 151.0 149.0 150.0 151.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.62 08:21:34 INFO - PID 12019 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 99.0 95.0 95.0 94.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:21:34 INFO - PID 12019 | Values: 56.0 56.0 56.0 57.0 57.0 57.0 56.0 56.0 57.0 56.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.00 stddev:2.30 (4.3%) stddev-sans-first:2.42 08:21:34 INFO - PID 12019 | Values: 54.0 54.0 61.0 54.0 54.0 56.0 53.0 54.0 54.0 54.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.26 (1.5%) stddev-sans-first:1.20 08:21:34 INFO - PID 12019 | Values: 84.0 84.0 82.0 81.0 84.0 81.0 82.0 83.0 82.0 81.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:131.50 stddev:11.60 (8.8%) stddev-sans-first:12.23 08:21:34 INFO - PID 12019 | Values: 131.0 129.0 147.0 131.0 125.0 132.0 125.0 139.0 125.0 161.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:181.50 stddev:2.49 (1.4%) stddev-sans-first:2.54 08:21:34 INFO - PID 12019 | Values: 182.0 182.0 177.0 181.0 178.0 182.0 178.0 177.0 179.0 184.0 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.13 (3.0%) stddev-sans-first:2.22 08:21:34 INFO - PID 12019 | Values: 69.0 70.0 69.0 75.0 68.0 69.0 70.0 72.0 68.0 71.0 08:21:34 INFO - PID 12019 | -------- Summary: end -------- 08:21:34 INFO - PID 12019 | 08:21:34 INFO - PID 12019 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:21:35 INFO - TEST-INFO | 12019: exit 0 08:21:35 INFO - TEST-OK | kraken | took 61689ms 08:21:35 INFO - SUITE-END | took 1173s 08:21:35 INFO - Completed test suite (00:19:33) 08:21:35 INFO - javascript benchmark 08:21:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8494.044314674913, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.251619611294, 3128.780985331027, 3135.529670549418, 3163.2566346908457, 3209.8716051357947, 6146.754129834807, 6166.753329866806, 6206.162168107304, 6212.751489940397, 6268.122462855193, 6125.326214116443, 6161.784337548187, 6197.349278325779, 6221.0, 6263.154474145989, 5562.610617256793, 5575.721213939307, 5678.914816277759, 5711.600187986832, 5756.971215143939, 5593.328800543941, 5671.319441666985, 5680.062789639725, 5681.176229446728, 5691.800786972436, 5570.248016517779, 5644.322681278252, 5645.689487078209, 5653.236813030229, 5667.943320566804, 5644.604877658566, 5646.153077038436, 5728.42715728428, 5735.799247026334, 5742.310922689262, 5494.340679118492, 5601.271834661508, 5653.689047102449, 5681.261436013333, 5721.856953576153, 6064.636121832704, 6102.145699602059, 6114.357992410822, 6135.754569817202, 6147.385261473862, 6615.6030638161865, 6665.233498147727, 6709.597424154517, 6730.966345168292, 6739.157605299338, 6710.563813352116, 6717.798466045978, 6815.522913396064, 6816.488763342769, 6828.2147553031045, 6123.448889599868, 6208.037754148114, 6236.937630623681, 6245.0320200368105, 6334.778282760081, 6814.48891333152, 6947.40947019509, 6952.895706564405, 6955.374016338554, 6961.477889158334, 6507.577007494592, 6519.119918810899, 6575.539712220098, 6601.801945941629, 6603.80188594343, 6617.702203400859, 6663.900041499382, 6700.262971073178, 6720.361565651256, 6740.83147921296, 6568.277489476154, 6569.441597464269, 6646.60120392778, 6648.833779155463, 6651.534392592472, 6674.199096108498, 6694.933050669431, 6695.966520167465, 6698.363655452724, 6715.7985260442265, 5329.173978033411, 5389.9191512127345, 5392.05639013179, 5434.049041417815, 5439.075357189287, 4620.630349572026, 4636.721796692209, 4647.117047760915, 4662.230731929261, 4670.346151538787, 5810.1575271586225, 5813.912791308134, 5856.9750293698435, 5900.822975310747, 5906.675132867734, 6561.1470508833545, 6641.833954151185, 6642.86714265712, 6648.13574235356, 6649.468042556584, 5735.913961290584, 5778.393268706809, 5787.160861675117, 5805.622634528742, 5812.38969908162, 5896.616719913192, 5899.233099697012, 5899.587028907935, 5906.468417842415, 5917.822465326047, 6465.741370345228, 6475.7733479328, 6499.6750162492635, 6515.218173819172, 6529.314421985718, 6433.581817181868, 6673.466122710269, 6735.191776986695, 6743.089682892747, 6764.797056088325, 6409.935900640934, 6478.384553467413, 6479.157709497735, 6486.870262594627, 6496.123023391781, 6579.934200657932, 6596.472282217507, 6604.636744979072, 6674.8998765017595, 6695.665216739046, 6636.469082473487, 6646.2356828965285, 6720.462363011045, 6747.493937954771, 6777.695003724943, 6549.214094308713, 6568.770093046721, 6570.507211959027, 6571.507136964842, 6574.901376479261, 6553.049807777941, 6564.901526477202, 6575.473962082926, 6585.176852893388, 6587.374199451045, 6335.208098987627, 6410.262819775786, 6473.611583305017, 6508.642024688687, 6531.379518945692, 6547.639879806466, 6548.0, 6589.7364105435245, 6665.700043497957, 6671.833204169935, 6251.4061164189325, 6319.273283572448, 6324.462420694293, 6331.620102793847, 6332.651704156316], "value": 6091.120081888164, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6557180412424, 841.1336323586706, 843.0599881132537, 864.0668078475244, 1184.4196343791546, 30706.232344191405, 31156.53265201024, 31202.843985780095, 41429.17141657165, 42141.15717685652, 41626.16747665045, 41974.16051678965, 42118.36822447658, 42205.0, 42431.15137697244, 7818.413618978571, 8016.67933282668, 8036.799080022988, 8037.6383062762025, 8057.9524661793885, 7656.234376562327, 7696.268854458845, 7734.5745983970855, 7756.495827771205, 7757.10793258774, 7708.03649543807, 7784.649690763929, 7806.921930780704, 7810.062792464883, 7820.0, 7696.384289256874, 7751.6511756970785, 7754.108277548098, 7766.689332426753, 7777.494462859896, 7732.0, 7810.101838288612, 7812.257835505618, 7835.177306382805, 7840.098388685317, 39034.41448378276, 39233.41149882754, 39249.21501569981, 39287.41068883969, 39381.40927886084, 3565.144365352297, 3601.891943241707, 3603.8378272977516, 3606.0, 3607.981960090183, 31031.0, 31194.844025779727, 31324.277164755928, 31329.686703132906, 31412.21469463259, 4728.598069164125, 4799.3041009053495, 4860.829870954535, 4882.09681208974, 4905.828296009622, 170295.0, 172808.13595932064, 172961.0, 173380.1330993337, 173748.0, 46052.7697361511, 46196.0, 46243.0, 48573.0, 49135.75432122817, 51484.485155148715, 51589.484105159216, 51635.22547161795, 51718.22422663663, 51732.48267517277, 16282.0, 16441.753373699405, 16587.83412165887, 16725.58186045334, 16800.663986720443, 13717.519886803913, 13792.379342929593, 13796.241206733726, 13803.0, 13824.101433406797, 14329.426822926966, 14371.06588071772, 14385.928070359581, 14531.92734036323, 14633.122012679274, 5795.507381872588, 5891.852703682356, 5986.551008674367, 5997.100434934795, 6012.609180403259, 962.7496850818837, 967.8451447768323, 978.8384916488842, 992.2805965674972, 999.0309399882103, 22306.0, 22347.329580112622, 22455.775442245696, 22658.546829063656, 22660.433489162904, 1046.7121541575975, 1079.5951518180682, 1101.6750058732694, 1113.493360520961, 1113.5156207049959, 11889.0, 11890.702732431586, 11905.404729763477, 11973.940130299292, 12055.457504412323, 203587.0, 209619.0, 225959.0, 227575.0, 228512.0, 52564.0, 52581.0, 52581.737091315066, 52623.47376526262, 52825.735871321165, 1436.5690292912084, 1436.719839631262, 1452.6005348529238, 1455.745244582194, 1458.48223880523, 25610.231693049238, 26518.337041574116, 26570.335741606614, 26577.601335980362, 26693.866530667223, 47308.0, 47731.76134119446, 47927.28109078437, 47947.76026119847, 48033.0, 208444.0, 208791.0, 209132.0, 210167.0, 210684.0, 35297.823510882285, 35697.82151089228, 35815.0, 36050.63949360473, 36322.0, 43461.78269108761, 44792.776036120915, 44967.55032449633, 45270.09459810719, 45304.32043519416, 29867.701322986493, 30979.225519362197, 30990.380192395576, 31295.530567041056, 31405.214869628442, 29814.701852981194, 30744.231394215323, 30936.53595196029, 30965.845170774002, 31099.22251943629, 34902.65097348994, 35858.0, 35880.0, 35967.100822479646, 36001.099972500895, 30200.84899575488, 33436.0, 33761.49357759685, 34035.65964340325, 34322.313553729284, 24404.75595244096, 24504.142355017488, 24815.503689926463, 24831.25506234816, 25021.87489062543], "value": 17324.377377575864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.173307837097, 570.2244946872256, 573.3349314794839, 578.4880380862937, 594.4234092929859, 20594.48513787156, 21299.57400851984, 22252.443688907784, 22279.77720222797, 22333.553328933413, 25370.0, 25722.09972650953, 25830.0, 25859.96560137597, 25933.351666208353, 6463.935360646392, 6653.500987425939, 6657.800265992028, 6657.9334206657795, 6658.0, 6342.809715708536, 6571.211454625428, 7007.614581198032, 7019.298070192991, 7045.154581450208, 7016.438684905221, 7023.789286321418, 7024.121984751906, 7027.648617569101, 7028.0, 6954.79135625932, 6986.196587392438, 6990.895136572955, 7002.719891204346, 7018.227994920555, 6823.044773731682, 6830.795076147723, 6842.213145488233, 6856.4514838813275, 6866.107406037183, 30076.0, 30917.22706932322, 31001.224969375948, 31215.375692486024, 31405.214869628442, 1857.6377606366764, 1877.727729479218, 1890.0738638067248, 1892.8485721142276, 1894.2991093295432, 19104.522386940298, 19627.607447851107, 19728.901355493275, 19767.505812354662, 19826.900865495725, 2334.48641298914, 2336.719593648756, 2417.721961974378, 2420.189236605739, 2502.7121880983736, 123803.0, 129121.35439322838, 130114.3494282532, 130289.34855325663, 130402.0, 20205.57357225325, 21580.784192158193, 21727.0, 21764.0, 21893.67159492609, 22819.630822150724, 24063.51872962531, 42075.0, 42144.57855421468, 42164.78917605392, 10412.68761937143, 10452.0, 10698.679039628823, 10724.517396717167, 10829.512671929782, 9739.0, 9757.219422446187, 9785.483250096104, 9928.106470417697, 9953.601855925826, 8904.777380565409, 9364.971166715652, 9374.437533747861, 9477.715668529956, 9497.762555936019, 2871.5118429866975, 2893.696161903012, 2902.0713371720844, 2920.8685609147215, 3005.278733104083, 944.9539943789807, 953.7091187187974, 956.1729104324849, 982.1700662939804, 990.5443495991781, 19181.904090479456, 19257.711134332996, 19655.213791448183, 19733.802661973485, 20230.494237644176, 1027.9897201028043, 1031.2111234905303, 1038.2939601071344, 1053.3206082077018, 1053.4469403563037, 10618.469076546142, 10653.84019239712, 10704.571817127227, 11029.0, 11190.720231994264, 454304.0, 462894.0, 464774.0, 466233.0, 472667.0, 111887.0, 120321.0, 123102.0, 123450.0, 124480.0, 1225.2648410953357, 1252.7325540771233, 1288.9871101288868, 1292.0438875232448, 1299.5581502289267, 19828.603427931073, 21114.89442552839, 21216.681749773456, 21287.04208310599, 21432.142714291254, 45024.860720062876, 53560.0, 54816.0, 56029.719851400485, 58598.0, 63165.36834631779, 63390.68304658447, 65742.34257657554, 69388.30611693818, 69851.65074174597, 20249.493762656053, 21361.89319053457, 21543.56912861765, 21564.35306940794, 21806.45483862916, 20370.388888333375, 22989.88505057531, 23574.0570377183, 24289.75710242875, 24412.51174976455, 18296.451106466826, 18318.542036449195, 18715.25138994425, 19006.0, 19032.714509282094, 15680.215989200266, 16135.112568808829, 16598.75101873449, 16918.915405423388, 17103.48689539316, 18469.815301847346, 18965.146568404733, 19219.23123075117, 19408.126634301774, 19412.223511059965, 21166.894165529073, 21379.358619241448, 21384.786152138902, 21435.249766258105, 21639.0, 18233.0, 19003.14485848168, 19177.32879349216, 19263.614727705648, 19388.61222775565], "value": 12661.503736302288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.6225294664548, 1330.7005923667175, 1348.3999620169025, 1352.3643887372937, 1355.4103964775318, 12942.223466591999, 13451.529196478125, 13469.663258418545, 13492.98802589806, 14192.0, 14204.928975355135, 14493.710125797477, 14502.709945801103, 14505.129692218474, 14519.0, 2573.648834361961, 2608.8695565221756, 2614.516314481827, 2615.215435369391, 2615.856127912964, 2519.760622740846, 2605.895764169431, 2639.326971622243, 2644.114221735721, 2645.828021178627, 2470.6911636045493, 2486.45298034433, 2583.522048421048, 2617.319496930802, 2620.2270330252527, 2408.3617841272076, 2451.1421002649017, 2463.644995252622, 2467.8272520923542, 2472.2830379190013, 2450.130203777651, 2468.9629655555, 2483.801295896324, 2483.8882250298598, 2487.5646761816793, 13414.26221557814, 13525.729485410237, 13536.59390218295, 13578.253196074213, 13603.0, 7438.962805185994, 7655.578943158124, 7694.769156925301, 7705.653245603905, 7722.922770772277, 4790.377250957354, 4863.489333619955, 4962.1316269653025, 5007.298978143063, 5035.219540971156, 1766.6132086312184, 1775.254393154878, 1791.8208179182109, 1800.4778614201996, 1817.3275887921554, 22381.0, 22602.660960085614, 22613.434664133365, 22651.0, 22763.20328788501, 6854.0404343391965, 7042.859142817218, 7060.505764596532, 7070.434365250768, 7101.822454438577, 15201.771973420407, 15318.234088295541, 15336.616584585252, 15337.693246135015, 15357.539273821803, 7487.251274872469, 7498.925010749932, 7500.062492188476, 7729.227077292226, 7992.680292788224, 6090.756369745161, 6108.17539632144, 6260.060990851409, 6266.49868010558, 7085.82285442868, 4807.134715751198, 5128.640995130305, 5214.504622060898, 5280.0, 5284.207368894697, 1530.7933428987167, 1533.087812751411, 1534.2252162657787, 1566.428253687396, 1569.9058056516647, 790.5730905311068, 805.3758337288648, 814.4583851738646, 827.0736774812128, 833.7165363776223, 6627.879078694771, 6816.727330906709, 6928.099347084847, 7943.340232923583, 8231.135730748305, 939.4363381970763, 967.7145242153582, 972.7179118055684, 976.9218462522981, 979.5787811241235, 4917.0, 4972.229304457815, 4996.725180115056, 5038.420581633159, 5212.739363031833, 19280.61438771245, 19437.125329360213, 19500.1224944875, 19527.414177574694, 19673.803261967485, 18232.179551920195, 19174.0, 19198.328058518164, 19625.607487850164, 19708.70436943447, 10731.302465339728, 10937.83593246102, 10949.507272172772, 10949.945250273699, 10957.506912188812, 7324.19433862264, 7410.333070023724, 7595.734149304748, 7785.987821583158, 8045.718399855977, 16442.342306307615, 16658.333666653198, 16753.66492670164, 16903.32386704518, 17269.740953885954, 16896.40862569804, 17178.484645460656, 17210.483685489457, 17412.042337671042, 17423.0, 11336.09311255081, 11617.128715346214, 11624.535018599161, 11633.127515436207, 11635.127365447795, 13092.934535327644, 13124.803127953279, 13253.0, 13286.402111904794, 13333.20000799955, 10004.749881253027, 10310.587576497157, 10427.739306517398, 10587.735306617396, 10743.409112498888, 9443.480608566595, 9964.950175249078, 10001.0, 10087.495625218562, 10213.489325533843, 8376.0, 8379.287760540423, 8402.159784021549, 8413.032501262433, 8447.070822209675, 6622.139121914121, 6685.699143538455, 6777.728890844311, 6821.386075253251, 6888.173419189729, 6266.154069200599, 6468.417842394207, 6560.770373036921, 6614.404703576702, 6677.899831502628], "value": 6213.277006887321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.7381923732956, 499.4450610432851, 521.6087934049463, 523.1420470428496, 526.0557299647134, 6185.226846644169, 6217.471514921226, 6221.78223762169, 6285.308616052242, 6316.684165791709, 5908.202392676987, 6091.695415229243, 6133.631982081079, 6139.0, 6152.938470615292, 4827.203511420629, 4844.539768721966, 4889.731064791435, 4905.533974272456, 4925.729084900338, 4860.951390486085, 4874.0, 4940.456549779521, 4947.901041979158, 4957.0085982803585, 4597.954020459802, 4777.689450185744, 4799.712017278957, 4834.250691142878, 4841.104395686809, 4779.450363208241, 4811.391456407694, 4823.1800593899125, 4884.804607815683, 4890.437599676047, 4324.767441279252, 4331.501877284121, 4352.39066530686, 4378.64970802335, 4394.868488782938, 5989.2812862456785, 6000.249968753906, 6031.306399763996, 6031.487323577458, 6044.365341639153, 5584.329880414376, 5658.292713410824, 5664.008798460253, 5668.121441176624, 5683.175939488751, 6522.967385163091, 6530.44491218247, 6574.342565743435, 6678.131842860445, 6687.02122237268, 4795.017021510582, 4801.831935882262, 4803.255495398219, 4819.2530157825595, 4836.322914791932, 6812.795616131524, 6922.861542769167, 6930.0, 6962.0, 6990.755323563752, 4927.531884470969, 4942.827001054946, 4957.90084198314, 4993.450720420751, 5018.0, 4960.0, 4991.326170966946, 5005.27423523587, 5010.5240002199735, 5010.624203184703, 5623.240862483594, 5628.0, 5660.235868157828, 5662.603617746719, 5679.659220446786, 6638.087815016949, 6654.201495820533, 6698.799036028927, 6722.092517510074, 6744.763933262312, 1653.3138747419687, 1724.6895558799536, 1733.4886208568503, 1737.409280844519, 1748.7321691773616, 1146.2950285574311, 1150.6260465348796, 1197.9041676665845, 1198.406788639629, 1207.5833837326109, 5684.147377893267, 5705.885882282331, 5785.450382213683, 5793.565482588822, 5804.535637149018, 6656.334366563402, 6662.367075127855, 6666.666666666647, 6687.465002799764, 6708.563943343667, 5569.303837020372, 5756.884862302731, 5820.272465941757, 5826.796062137805, 5887.558433117533, 3502.8598856045983, 3503.8423270952867, 3550.6804387604725, 3571.2143328467696, 3582.749207555446, 6521.282658907517, 6522.64125473094, 6555.541112122201, 6562.146920900253, 6594.0, 6805.183377994672, 6901.930980690129, 6938.618375989268, 6957.61733104674, 6975.372216500539, 6530.249021362604, 6547.148870646785, 6563.967180164069, 6574.868502629921, 6595.307492713196, 6621.470282377302, 6688.548832701333, 6690.665466726547, 6706.5640733352175, 6712.731490740316, 6662.666866656551, 6679.298673639198, 6696.0, 6700.262971073275, 6732.831679208059, 6582.0, 6587.83783783796, 6616.305287944697, 6623.735050597922, 6663.0, 4903.705777653352, 4915.483874193301, 4922.286268490977, 4938.38270216223, 4941.77762000718, 6698.430633396216, 6745.763898263537, 6824.317568243136, 6827.761028363983, 6841.863162736817, 6573.1454910861285, 6586.934130658824, 6606.372394622503, 6610.10763546915, 6624.310800745779, 6537.803865884031, 6538.0, 6555.573887697285, 6585.407313341822, 6618.867622647424, 6146.262448506208, 6360.745570177326, 6427.6786160690845, 6436.935630643634, 6493.740250389931, 6100.511959043355, 6384.201974753156, 6427.357264273723, 6479.611223326616, 6491.805245842444, 6223.96888015557, 6393.392627700361, 6394.1687580614225, 6396.456301214449, 6456.7740129095255], "value": 5025.064462232004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.7335112790596, 895.9372843900927, 906.4878343735788, 916.074764487867, 920.972370828875, 17054.317827286908, 17786.822131778677, 17831.0, 17848.732269015974, 22138.114475421004, 20382.0, 20833.68749468759, 21146.25988090417, 21287.0, 21312.4671883203, 1026.266219652948, 1057.8148823955814, 1058.5236643510414, 1058.7353161709573, 1058.7776566920957, 1007.2999265510473, 1045.1690905729924, 1049.6536143072806, 1051.4532443129567, 1052.9105026072793, 1111.0667039686662, 1113.332000799522, 1114.4539175803839, 1114.5374669512144, 1114.8494953181298, 1099.6151347028556, 1105.1324710102572, 1105.6793529876327, 1109.2290857853795, 1110.4780753046055, 812.2324403438753, 814.0313027497259, 814.8125931035836, 816.3020617372121, 816.6610856494548, 18859.434216973514, 19385.51536211592, 19579.80420195794, 19585.608287834308, 19620.70568941467, 20194.899025504925, 20222.49443763903, 20824.895875520677, 20835.479113022146, 20988.0, 15042.623934401618, 15101.093934363973, 15114.168720720356, 15215.087094774239, 16043.518694439186, 3577.338192434408, 3608.2963822054708, 3609.6570825771773, 3609.9097522561883, 3611.422172452395, 111501.44249278783, 112667.0, 114424.0, 115316.42341788237, 117574.0, 16168.838311616968, 16785.748213776802, 16790.66418671644, 16876.324947002227, 16878.156092195342, 29650.703492964793, 30087.0, 30304.696953030187, 30338.54492182619, 30359.544606830914, 8475.02537208229, 8492.575371231538, 8509.446885952393, 8617.267532259702, 8684.43551169172, 4296.957030429656, 4343.109662519176, 4345.478542574911, 4395.3187255974735, 4400.647948164139, 4881.243407271879, 4974.17926042199, 4989.451160372356, 5010.849674509771, 5011.599072074226, 1037.9325343852624, 1038.2991480750463, 1067.7330667333167, 1068.4444089073638, 1069.3209811769582, 648.3451713769127, 648.6626953983902, 671.2917871645363, 676.2628734679223, 684.6747794797432, 11229.38238396896, 12668.429920653592, 13070.411831467607, 13309.600711978655, 13512.391942362618, 638.4222278837659, 653.6404977262487, 665.4609766089483, 669.8024082895557, 683.4190937702913, 5196.220566914993, 5274.683518988873, 5280.973595132076, 5395.676259424447, 5469.972650136803, 98711.0, 102140.0, 102386.48806755918, 102636.48681756544, 104045.47977260065, 84114.0, 89871.0, 92766.0, 92800.99999999865, 92940.0705992945, 73990.26009739834, 78965.60517197377, 80699.59650201829, 81589.59205204055, 81960.18039819645, 10364.326318789255, 10950.307057585094, 11445.370504622326, 12395.62813115608, 12520.561780337644, 33406.83296583501, 34640.0, 35567.46648800218, 36336.45495317625, 37239.069023274635, 65015.59063111878, 65436.0, 66589.33410665831, 66993.99509007466, 69993.0, 18280.72578911291, 18760.437186884414, 18862.339818106302, 18902.905485472485, 18974.0, 20342.79657203409, 20491.0, 20636.380908572766, 20741.170353185702, 20879.8956005219, 18363.0, 18823.247070117042, 18922.053897304806, 19285.517862053563, 19399.709004364664, 14884.404623814926, 14938.850611494181, 14950.775738364151, 18799.812001880353, 18887.150078246235, 17408.0, 17542.473725788248, 17738.201780920146, 17919.28322867071, 17934.5516362092, 12421.378931053592, 12651.810222846849, 12745.49018039268, 12773.552925647558, 13794.786975409717, 13852.445902163801, 13933.581992539834, 14115.858841411866, 14543.200123993282, 14657.780133298222], "value": 9002.357284589876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 104.0, 109.0, 110.0, 109.0, 110.0, 100.0, 107.0, 110.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 118.0, 151.0, 182.0, 121.0, 148.0, 150.0, 122.0, 171.0, 122.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 164.0, 165.0, 164.0, 167.0, 168.0, 163.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 169.0, 76.0, 76.0, 75.0, 73.0, 156.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 80.0, 78.0, 80.0, 131.0, 79.0, 80.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 115.0, 115.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 151.0, 152.0, 151.0, 151.0, 149.0, 150.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 99.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 61.0, 54.0, 54.0, 56.0, 53.0, 54.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 81.0, 84.0, 81.0, 82.0, 83.0, 82.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 147.0, 131.0, 125.0, 132.0, 125.0, 139.0, 125.0, 161.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 177.0, 181.0, 178.0, 182.0, 178.0, 177.0, 179.0, 184.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 75.0, 68.0, 69.0, 70.0, 72.0, 68.0, 71.0], "value": 70.1, "unit": "score"}]}]} 08:21:35 INFO - Return code: 0 08:21:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:21:35 INFO - # TBPL SUCCESS # 08:21:35 INFO - Running post-action listener: _package_coverage_data 08:21:35 INFO - Running post-action listener: _resource_record_post_action 08:21:35 INFO - [mozharness: 2017-07-27 15:21:35.308168Z] Finished run-tests step (success) 08:21:35 INFO - Running post-run listener: _resource_record_post_run 08:21:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434012160; Read time: 24; Write time: 275112 08:21:35 INFO - TinderboxPrint: CPU usage
13.1% 08:21:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 08:21:35 INFO - TinderboxPrint: I/O write bytes / time
434,012,160 / 275,112 08:21:35 INFO - TinderboxPrint: CPU idle
8,258.3 (86.9%) 08:21:35 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 08:21:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:21:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112660480; Read time: 0; Write time: 98292 08:21:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:21:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 321351680; Read time: 0; Write time: 176820 08:21:35 INFO - Running post-run listener: _upload_blobber_files 08:21:35 INFO - Blob upload gear active. 08:21:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:35 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 08:21:35 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:35 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:37 INFO - (blobuploader) - INFO - Done attempting. 08:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:37 INFO - (blobuploader) - INFO - Done attempting. 08:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:42 INFO - (blobuploader) - INFO - Done attempting. 08:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:42 INFO - (blobuploader) - INFO - Done attempting. 08:21:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:42 INFO - Return code: 0 08:21:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/695d5c6b00b102e263ad4da5d6b355bdcfe3e3016e885a0e57efb314077e52bfb58bacb929f17a5eff1a3dec387b3678fd6c2f91a1e784938d43c6af5dccb870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/559ab695347af71ed58cd683a3f4a498e974db414e67f12491983cd116065ad0837ca2516c0f8b56b3f768e83bdb43b35e2a0f11d8843046ac86114922c0b38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7de4e612de129277582dd695d7f9b5f2f849880e7fd3309fcb6ec8e843ffffb6ffa5cec6ad2deee85d1bbc3f0b7b5d57638dfd894759dd723c8846b5954cee50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/79e57ed81c18aa83ce8bb16861e3c76dfa9fd451106ae2cf790dfd2d4ae4048fb5b8900cb9b5c65b0d98cb3991be75795ddcb38b55f2951e628a6eb3d79f41de"} 08:21:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:42 INFO - Contents: 08:21:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/695d5c6b00b102e263ad4da5d6b355bdcfe3e3016e885a0e57efb314077e52bfb58bacb929f17a5eff1a3dec387b3678fd6c2f91a1e784938d43c6af5dccb870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/559ab695347af71ed58cd683a3f4a498e974db414e67f12491983cd116065ad0837ca2516c0f8b56b3f768e83bdb43b35e2a0f11d8843046ac86114922c0b38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7de4e612de129277582dd695d7f9b5f2f849880e7fd3309fcb6ec8e843ffffb6ffa5cec6ad2deee85d1bbc3f0b7b5d57638dfd894759dd723c8846b5954cee50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/79e57ed81c18aa83ce8bb16861e3c76dfa9fd451106ae2cf790dfd2d4ae4048fb5b8900cb9b5c65b0d98cb3991be75795ddcb38b55f2951e628a6eb3d79f41de"} 08:21:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:42 INFO - Copying logs to upload dir... 08:21:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.468213 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-27 08:21:43.085604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 08:21:43.090258) ========= 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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 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/Cedar/sha512/695d5c6b00b102e263ad4da5d6b355bdcfe3e3016e885a0e57efb314077e52bfb58bacb929f17a5eff1a3dec387b3678fd6c2f91a1e784938d43c6af5dccb870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/559ab695347af71ed58cd683a3f4a498e974db414e67f12491983cd116065ad0837ca2516c0f8b56b3f768e83bdb43b35e2a0f11d8843046ac86114922c0b38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7de4e612de129277582dd695d7f9b5f2f849880e7fd3309fcb6ec8e843ffffb6ffa5cec6ad2deee85d1bbc3f0b7b5d57638dfd894759dd723c8846b5954cee50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/79e57ed81c18aa83ce8bb16861e3c76dfa9fd451106ae2cf790dfd2d4ae4048fb5b8900cb9b5c65b0d98cb3991be75795ddcb38b55f2951e628a6eb3d79f41de"} build_url:https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/SKzf4K0JRlKy-0Xf39aB4g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/695d5c6b00b102e263ad4da5d6b355bdcfe3e3016e885a0e57efb314077e52bfb58bacb929f17a5eff1a3dec387b3678fd6c2f91a1e784938d43c6af5dccb870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/559ab695347af71ed58cd683a3f4a498e974db414e67f12491983cd116065ad0837ca2516c0f8b56b3f768e83bdb43b35e2a0f11d8843046ac86114922c0b38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7de4e612de129277582dd695d7f9b5f2f849880e7fd3309fcb6ec8e843ffffb6ffa5cec6ad2deee85d1bbc3f0b7b5d57638dfd894759dd723c8846b5954cee50", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/79e57ed81c18aa83ce8bb16861e3c76dfa9fd451106ae2cf790dfd2d4ae4048fb5b8900cb9b5c65b0d98cb3991be75795ddcb38b55f2951e628a6eb3d79f41de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 08:21:43.123488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:21:43.123917) ========= 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=41bf3e9aed84707956354da8000001c5-1501166308.292655-610450852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 08:21:43.205770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 08:21:43.206139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 08:21:43.206474) ========= ========= Total master_lag: 0.35 =========