builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1498131925.45 results: success (0) revision: 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:25.454128) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:25.454660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:25.454953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:26.366251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:26.366720) ========= 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=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-22 04:45:26-- 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% 45.5M=0s 2017-06-22 04:45:26 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.384683 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:26.994368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:26.994742) ========= 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=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015319 ========= master_lag: 0.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:27.512325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-06-22 04:45:27.514916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb --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=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-22 04:45:27,715 truncating revision to first 12 chars 2017-06-22 04:45:27,715 Setting DEBUG logging. 2017-06-22 04:45:27,715 attempt 1/10 2017-06-22 04:45:27,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a9536f89bc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-22 04:45:30,622 unpacking tar archive at: mozilla-central-7a9536f89bc7/testing/mozharness/ program finished with exit code 0 elapsedTime=4.744609 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-06-22 04:45:32.497499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:32.498022) ========= script_repo_revision: 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:32.498513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:32.498793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 04:45:33.288910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-06-22 04:45:33.289327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:33 INFO - MultiFileLogger online at 20170622 04:45:33 in /builds/slave/test 04:45:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:45:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:33 INFO - {'append_to_log': False, 04:45:33 INFO - 'base_work_dir': '/builds/slave/test', 04:45:33 INFO - 'blob_upload_branch': 'Firefox', 04:45:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:33 INFO - 'branch': 'Firefox', 04:45:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:33 INFO - 'config_files': ('talos/linux_config.py',), 04:45:33 INFO - 'default_actions': ('clobber', 04:45:33 INFO - 'read-buildbot-config', 04:45:33 INFO - 'download-and-extract', 04:45:33 INFO - 'populate-webroot', 04:45:33 INFO - 'create-virtualenv', 04:45:33 INFO - 'install', 04:45:33 INFO - 'setup-mitmproxy', 04:45:33 INFO - 'run-tests'), 04:45:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:33 INFO - 'download_minidump_stackwalk': True, 04:45:33 INFO - 'download_symbols': 'ondemand', 04:45:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:33 INFO - 'gecko_profile': False, 04:45:33 INFO - 'gecko_profile_interval': 0, 04:45:33 INFO - 'installer_path': 'installer.exe', 04:45:33 INFO - 'log_level': 'info', 04:45:33 INFO - 'log_name': 'talos', 04:45:33 INFO - 'log_to_console': True, 04:45:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:33 INFO - 'opt_config_files': (), 04:45:33 INFO - 'pip_index': False, 04:45:33 INFO - 'suite': 'dromaeojs-e10s', 04:45:33 INFO - 'system_bits': '32', 04:45:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:33 INFO - 'title': 'talos-linux64-ix-047', 04:45:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:33 INFO - 'use_talos_json': True, 04:45:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:33 INFO - 'work_dir': 'build'} 04:45:33 INFO - [mozharness: 2017-06-22 11:45:33.567301Z] Running clobber step. 04:45:33 INFO - Running pre-action listener: _resource_record_pre_action 04:45:33 INFO - Running main action method: clobber 04:45:33 INFO - rmtree: /builds/slave/test/build 04:45:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:35 INFO - Running post-action listener: _resource_record_post_action 04:45:35 INFO - [mozharness: 2017-06-22 11:45:35.118918Z] Finished clobber step (success) 04:45:35 INFO - [mozharness: 2017-06-22 11:45:35.119017Z] Running read-buildbot-config step. 04:45:35 INFO - Running pre-action listener: _resource_record_pre_action 04:45:35 INFO - Running main action method: read_buildbot_config 04:45:35 INFO - Using buildbot properties: 04:45:35 INFO - { 04:45:35 INFO - "project": "", 04:45:35 INFO - "product": "firefox", 04:45:35 INFO - "who": "florian@queze.net", 04:45:35 INFO - "installer_path": "public/build/target.tar.bz2", 04:45:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:45:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:45:35 INFO - "stage_platform": "linux64-stylosequential", 04:45:35 INFO - "basedir": "/builds/slave/test", 04:45:35 INFO - "buildnumber": 70, 04:45:35 INFO - "platform": "ubuntu64_hw_styloseq", 04:45:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:45:35 INFO - "slavebuilddir": "test", 04:45:35 INFO - "taskId": "enSvul4lQkehWFr0kj6-Fg", 04:45:35 INFO - "branch": "mozilla-central", 04:45:35 INFO - "script_repo_revision": "production", 04:45:35 INFO - "revision": "7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb", 04:45:35 INFO - "slavename": "talos-linux64-ix-047", 04:45:35 INFO - "repo_path": "mozilla-central" 04:45:35 INFO - } 04:45:35 INFO - Finding installer, test and symbols from parent task. 04:45:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/enSvul4lQkehWFr0kj6-Fg'}, attempt #1 04:45:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/enSvul4lQkehWFr0kj6-Fg'}, attempt #1 04:45:36 INFO - Task dependencies: LLAAmFyCSMaggt_GUQ17-g 04:45:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g'}, attempt #1 04:45:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 04:45:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/test_packages.json 04:45:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.crashreporter-symbols.zip 04:45:36 INFO - Running post-action listener: _resource_record_post_action 04:45:36 INFO - [mozharness: 2017-06-22 11:45:36.645392Z] Finished read-buildbot-config step (success) 04:45:36 INFO - [mozharness: 2017-06-22 11:45:36.645627Z] Running download-and-extract step. 04:45:36 INFO - Running pre-action listener: _resource_record_pre_action 04:45:36 INFO - Running main action method: download_and_extract 04:45:36 INFO - mkdir: /builds/slave/test/build/tests 04:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:36 INFO - trying https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.test_packages.json 04:45:36 INFO - Downloading https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:45:38 INFO - Downloaded 989 bytes. 04:45:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:45:38 INFO - Using the following test package requirements: 04:45:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:45:38 INFO - u'common': [u'target.common.tests.zip'], 04:45:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:45:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:45:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:45:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:45:38 INFO - u'mozbase': [u'target.common.tests.zip'], 04:45:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:45:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:45:38 INFO - u'web-platform': [u'target.common.tests.zip', 04:45:38 INFO - u'target.web-platform.tests.tar.gz'], 04:45:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:45:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:45:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip 04:45:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:45:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip into memory 04:45:39 INFO - Content-Length response header: 67969289 04:45:39 INFO - Bytes received: 67969289 04:45:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:45:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip 04:45:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:45:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.common.tests.zip into memory 04:45:52 INFO - Content-Length response header: 67969289 04:45:52 INFO - Bytes received: 67969289 04:46:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.talos.tests.zip 04:46:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:46:04 INFO - Fetch https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.talos.tests.zip into memory 04:46:15 INFO - Content-Length response header: 14441306 04:46:15 INFO - Bytes received: 14441306 04:46:15 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')]} 04:46:15 INFO - trying https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 04:46:15 INFO - Downloading https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:46:16 INFO - Downloaded 61594286 bytes. 04:46:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 04:46:16 INFO - mkdir: /builds/slave/test/properties 04:46:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:16 INFO - Contents: 04:46:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 04:46:16 INFO - Running post-action listener: _resource_record_post_action 04:46:16 INFO - Running post-action listener: set_extra_try_arguments 04:46:16 INFO - [mozharness: 2017-06-22 11:46:16.798915Z] Finished download-and-extract step (success) 04:46:16 INFO - [mozharness: 2017-06-22 11:46:16.799012Z] Running populate-webroot step. 04:46:16 INFO - Running pre-action listener: _resource_record_pre_action 04:46:16 INFO - Running main action method: populate_webroot 04:46:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:16 INFO - '--tppagecycles', 04:46:16 INFO - '7'], 04:46:16 INFO - 'tests': ['tsvgm']}}, 04:46:16 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['damp', 'tps']}, 04:46:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'tests': ['damp', 'tps']}, 04:46:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['dromaeo_dom']}, 04:46:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:46:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:46:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:46:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['a11yr', 04:46:16 INFO - 'ts_paint', 04:46:16 INFO - 'tpaint', 04:46:16 INFO - 'sessionrestore', 04:46:16 INFO - 'sessionrestore_no_auto_restore', 04:46:16 INFO - 'tabpaint']}, 04:46:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:46:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:46:16 INFO - 'bloom_basic_ref']}, 04:46:16 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:46:16 INFO - 'talos_options': ['--mitmproxy', 04:46:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:46:16 INFO - '--firstNonBlankPaint'], 04:46:16 INFO - 'tests': ['quantum_pageload_google', 04:46:16 INFO - 'quantum_pageload_youtube', 04:46:16 INFO - 'quantum_pageload_amazon', 04:46:16 INFO - 'quantum_pageload_facebook']}, 04:46:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['tsvgx', 04:46:16 INFO - 'tsvgr_opacity', 04:46:16 INFO - 'tart', 04:46:16 INFO - 'tscrollx', 04:46:16 INFO - 'cart', 04:46:16 INFO - 'tsvg_static']}, 04:46:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:16 INFO - 'tsvgr_opacity', 04:46:16 INFO - 'tart', 04:46:16 INFO - 'tscrollx', 04:46:16 INFO - 'cart', 04:46:16 INFO - 'tsvg_static']}, 04:46:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'talos_options': ['--disable-e10s'], 04:46:16 INFO - 'tests': ['tp5o']}, 04:46:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'talos_options': ['--disable-e10s', 04:46:16 INFO - '--xperf_path', 04:46:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:16 INFO - 'tests': ['tp5n']}, 04:46:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:16 INFO - 'talos_options': ['--xperf_path', 04:46:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:16 INFO - 'tests': ['tp5n']}}, 04:46:16 INFO - 'talos.zip': {'path': '', 04:46:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:16 INFO - Running post-action listener: _resource_record_post_action 04:46:16 INFO - [mozharness: 2017-06-22 11:46:16.813831Z] Finished populate-webroot step (success) 04:46:16 INFO - [mozharness: 2017-06-22 11:46:16.813920Z] Running create-virtualenv step. 04:46:16 INFO - Running pre-action listener: _resource_record_pre_action 04:46:16 INFO - Running main action method: create_virtualenv 04:46:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:16 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 04:46:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:46:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:16 INFO - Using real prefix '/usr' 04:46:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:19 INFO - Installing pip.................done. 04:46:19 INFO - Return code: 0 04:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:19 INFO - Reading from file tmpfile_stdout 04:46:19 INFO - Output received: 04:46:19 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) 04:46:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:19 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')]} 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:19 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')]} 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:19 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:19 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 04:46:19 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 04:46:19 INFO - Using env: {'DISPLAY': ':0', 04:46:19 INFO - 'HOME': '/home/cltbld', 04:46:19 INFO - 'LANG': 'en_US.UTF-8', 04:46:19 INFO - 'LANGUAGE': 'en_US:en', 04:46:19 INFO - 'LOGNAME': 'cltbld', 04:46:19 INFO - 'MAIL': '/var/mail/cltbld', 04:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:19 INFO - 'MOZ_NO_REMOTE': '1', 04:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:19 INFO - 'NO_EM_RESTART': '1', 04:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:19 INFO - 'PWD': '/builds/slave/test', 04:46:19 INFO - 'SHELL': '/bin/bash', 04:46:19 INFO - 'SHLVL': '1', 04:46:19 INFO - 'TERM': 'linux', 04:46:19 INFO - 'TMOUT': '86400', 04:46:19 INFO - 'USER': 'cltbld', 04:46:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:19 INFO - '_': '/tools/buildbot/bin/python'} 04:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:20 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 04:46:20 INFO - Cleaning up... 04:46:20 INFO - Return code: 0 04:46:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46: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')]} 04:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:20 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:20 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 04:46:20 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 04:46:20 INFO - Using env: {'DISPLAY': ':0', 04:46:20 INFO - 'HOME': '/home/cltbld', 04:46:20 INFO - 'LANG': 'en_US.UTF-8', 04:46:20 INFO - 'LANGUAGE': 'en_US:en', 04:46:20 INFO - 'LOGNAME': 'cltbld', 04:46:20 INFO - 'MAIL': '/var/mail/cltbld', 04:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:20 INFO - 'MOZ_NO_REMOTE': '1', 04:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:20 INFO - 'NO_EM_RESTART': '1', 04:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:20 INFO - 'PWD': '/builds/slave/test', 04:46:20 INFO - 'SHELL': '/bin/bash', 04:46:20 INFO - 'SHLVL': '1', 04:46:20 INFO - 'TERM': 'linux', 04:46:20 INFO - 'TMOUT': '86400', 04:46:20 INFO - 'USER': 'cltbld', 04:46:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:20 INFO - '_': '/tools/buildbot/bin/python'} 04:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:20 INFO - Downloading/unpacking psutil>=3.1.1 04:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:21 INFO - Installing collected packages: psutil 04:46:21 INFO - Running setup.py install for psutil 04:46:22 INFO - building 'psutil._psutil_linux' extension 04:46:22 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 04:46:22 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 04:46:22 INFO - building 'psutil._psutil_posix' extension 04:46:22 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 04:46:22 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 04:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:22 INFO - Successfully installed psutil 04:46:22 INFO - Cleaning up... 04:46:22 INFO - Return code: 0 04:46:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:46:22 INFO - Using env: {'DISPLAY': ':0', 04:46:22 INFO - 'HOME': '/home/cltbld', 04:46:22 INFO - 'LANG': 'en_US.UTF-8', 04:46:22 INFO - 'LANGUAGE': 'en_US:en', 04:46:22 INFO - 'LOGNAME': 'cltbld', 04:46:22 INFO - 'MAIL': '/var/mail/cltbld', 04:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:22 INFO - 'MOZ_NO_REMOTE': '1', 04:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:22 INFO - 'NO_EM_RESTART': '1', 04:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:22 INFO - 'PWD': '/builds/slave/test', 04:46:22 INFO - 'SHELL': '/bin/bash', 04:46:22 INFO - 'SHLVL': '1', 04:46:22 INFO - 'TERM': 'linux', 04:46:22 INFO - 'TMOUT': '86400', 04:46:22 INFO - 'USER': 'cltbld', 04:46:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:22 INFO - '_': '/tools/buildbot/bin/python'} 04:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:25 INFO - Installing collected packages: mozsystemmonitor 04:46:25 INFO - Running setup.py install for mozsystemmonitor 04:46:25 INFO - Successfully installed mozsystemmonitor 04:46:25 INFO - Cleaning up... 04:46:25 INFO - Return code: 0 04:46:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:25 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')]} 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:25 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')]} 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:25 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:25 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 04:46:25 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 04:46:25 INFO - Using env: {'DISPLAY': ':0', 04:46:25 INFO - 'HOME': '/home/cltbld', 04:46:25 INFO - 'LANG': 'en_US.UTF-8', 04:46:25 INFO - 'LANGUAGE': 'en_US:en', 04:46:25 INFO - 'LOGNAME': 'cltbld', 04:46:25 INFO - 'MAIL': '/var/mail/cltbld', 04:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:25 INFO - 'MOZ_NO_REMOTE': '1', 04:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:25 INFO - 'NO_EM_RESTART': '1', 04:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:25 INFO - 'PWD': '/builds/slave/test', 04:46:25 INFO - 'SHELL': '/bin/bash', 04:46:25 INFO - 'SHLVL': '1', 04:46:25 INFO - 'TERM': 'linux', 04:46:25 INFO - 'TMOUT': '86400', 04:46:25 INFO - 'USER': 'cltbld', 04:46:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:25 INFO - '_': '/tools/buildbot/bin/python'} 04:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:25 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 04:46:25 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 04:46:25 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 04:46:25 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 04:46:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46: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 04:46: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 04:46: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 04:46: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 04:46:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:29 INFO - warning: no files found matching '*.txt' 04:46:29 INFO - no previously-included directories found matching 'build' 04:46:29 INFO - no previously-included directories found matching 'dist' 04:46:29 INFO - no previously-included directories found matching '.git*' 04:46:30 INFO - Installing collected packages: jsonschema, functools32 04:46:30 INFO - Running setup.py install for functools32 04:46:30 INFO - warning: no files found matching '*.txt' 04:46:30 INFO - no previously-included directories found matching 'build' 04:46:30 INFO - no previously-included directories found matching 'dist' 04:46:30 INFO - no previously-included directories found matching '.git*' 04:46:30 INFO - Successfully installed jsonschema functools32 04:46:30 INFO - Cleaning up... 04:46:30 INFO - Return code: 0 04:46:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46:30 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')]} 04:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:30 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')]} 04:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:30 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:30 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 04:46:30 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 04:46:30 INFO - Using env: {'DISPLAY': ':0', 04:46:30 INFO - 'HOME': '/home/cltbld', 04:46:30 INFO - 'LANG': 'en_US.UTF-8', 04:46:30 INFO - 'LANGUAGE': 'en_US:en', 04:46:30 INFO - 'LOGNAME': 'cltbld', 04:46:30 INFO - 'MAIL': '/var/mail/cltbld', 04:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:30 INFO - 'MOZ_NO_REMOTE': '1', 04:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:30 INFO - 'NO_EM_RESTART': '1', 04:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:30 INFO - 'PWD': '/builds/slave/test', 04:46:30 INFO - 'SHELL': '/bin/bash', 04:46:30 INFO - 'SHLVL': '1', 04:46:30 INFO - 'TERM': 'linux', 04:46:30 INFO - 'TMOUT': '86400', 04:46:30 INFO - 'USER': 'cltbld', 04:46:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:30 INFO - '_': '/tools/buildbot/bin/python'} 04:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:30 INFO - Cleaning up... 04:46:30 INFO - Return code: 0 04:46:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:30 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')]} 04:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:30 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')]} 04:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:30 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:30 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 04:46:30 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 04:46:30 INFO - Using env: {'DISPLAY': ':0', 04:46:30 INFO - 'HOME': '/home/cltbld', 04:46:30 INFO - 'LANG': 'en_US.UTF-8', 04:46:30 INFO - 'LANGUAGE': 'en_US:en', 04:46:30 INFO - 'LOGNAME': 'cltbld', 04:46:30 INFO - 'MAIL': '/var/mail/cltbld', 04:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:30 INFO - 'MOZ_NO_REMOTE': '1', 04:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:30 INFO - 'NO_EM_RESTART': '1', 04:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:30 INFO - 'PWD': '/builds/slave/test', 04:46:30 INFO - 'SHELL': '/bin/bash', 04:46:30 INFO - 'SHLVL': '1', 04:46:30 INFO - 'TERM': 'linux', 04:46:30 INFO - 'TMOUT': '86400', 04:46:30 INFO - 'USER': 'cltbld', 04:46:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:30 INFO - '_': '/tools/buildbot/bin/python'} 04:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:46: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 04:46: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 04:46: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 04:46: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 04:46:31 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 INFO - Downloading docopt-0.6.1.tar.gz 04:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:32 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:32 INFO - Running setup.py install for blobuploader 04:46:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:32 INFO - Running setup.py install for requests 04:46:33 INFO - Running setup.py install for docopt 04:46:33 INFO - Successfully installed blobuploader requests docopt 04:46:33 INFO - Cleaning up... 04:46:33 INFO - Return code: 0 04:46:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:33 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:33 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 04:46:33 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 04:46:33 INFO - Using env: {'DISPLAY': ':0', 04:46:33 INFO - 'HOME': '/home/cltbld', 04:46:33 INFO - 'LANG': 'en_US.UTF-8', 04:46:33 INFO - 'LANGUAGE': 'en_US:en', 04:46:33 INFO - 'LOGNAME': 'cltbld', 04:46:33 INFO - 'MAIL': '/var/mail/cltbld', 04:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:33 INFO - 'MOZ_NO_REMOTE': '1', 04:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:33 INFO - 'NO_EM_RESTART': '1', 04:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:33 INFO - 'PWD': '/builds/slave/test', 04:46:33 INFO - 'SHELL': '/bin/bash', 04:46:33 INFO - 'SHLVL': '1', 04:46:33 INFO - 'TERM': 'linux', 04:46:33 INFO - 'TMOUT': '86400', 04:46:33 INFO - 'USER': 'cltbld', 04:46:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:33 INFO - '_': '/tools/buildbot/bin/python'} 04:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:33 INFO - Running setup.py (path:/tmp/pip-jUuyNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:33 INFO - Running setup.py (path:/tmp/pip-BK8nI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:33 INFO - Running setup.py (path:/tmp/pip-VTXSTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:33 INFO - Running setup.py (path:/tmp/pip-SIrqcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:33 INFO - Running setup.py (path:/tmp/pip-S03_DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:33 INFO - Running setup.py (path:/tmp/pip-1ksCws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:34 INFO - Running setup.py (path:/tmp/pip-QrlcK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:34 INFO - Running setup.py (path:/tmp/pip-nVaRVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:34 INFO - Running setup.py (path:/tmp/pip-bND2KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:34 INFO - Running setup.py (path:/tmp/pip-R0xbkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:34 INFO - Running setup.py (path:/tmp/pip-86dMmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:34 INFO - Running setup.py (path:/tmp/pip-GsEpjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:34 INFO - Running setup.py (path:/tmp/pip-3Ad0zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:34 INFO - Running setup.py (path:/tmp/pip-9LGm28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:34 INFO - Running setup.py (path:/tmp/pip-isAfuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:34 INFO - Running setup.py (path:/tmp/pip-6wNbQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:34 INFO - Running setup.py (path:/tmp/pip-UDs8tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:34 INFO - Running setup.py install for manifestparser 04:46:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Running setup.py install for mozcrash 04:46:35 INFO - Running setup.py install for mozdebug 04:46:35 INFO - Running setup.py install for mozdevice 04:46:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozfile 04:46:35 INFO - Running setup.py install for mozhttpd 04:46:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozinfo 04:46:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozInstall 04:46:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozleak 04:46:35 INFO - Running setup.py install for mozlog 04:46:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for moznetwork 04:46:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozprocess 04:46:36 INFO - Running setup.py install for mozprofile 04:46:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:36 INFO - Running setup.py install for mozrunner 04:46:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:36 INFO - Running setup.py install for mozscreenshot 04:46:36 INFO - Running setup.py install for moztest 04:46:36 INFO - Running setup.py install for mozversion 04:46:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:36 INFO - Cleaning up... 04:46:36 INFO - Return code: 0 04:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:36 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:36 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 04:46:36 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 04:46:36 INFO - Using env: {'DISPLAY': ':0', 04:46:36 INFO - 'HOME': '/home/cltbld', 04:46:36 INFO - 'LANG': 'en_US.UTF-8', 04:46:36 INFO - 'LANGUAGE': 'en_US:en', 04:46:36 INFO - 'LOGNAME': 'cltbld', 04:46:36 INFO - 'MAIL': '/var/mail/cltbld', 04:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:36 INFO - 'MOZ_NO_REMOTE': '1', 04:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:36 INFO - 'NO_EM_RESTART': '1', 04:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:36 INFO - 'PWD': '/builds/slave/test', 04:46:36 INFO - 'SHELL': '/bin/bash', 04:46:36 INFO - 'SHLVL': '1', 04:46:36 INFO - 'TERM': 'linux', 04:46:36 INFO - 'TMOUT': '86400', 04:46:36 INFO - 'USER': 'cltbld', 04:46:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:36 INFO - '_': '/tools/buildbot/bin/python'} 04:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:36 INFO - Running setup.py (path:/tmp/pip-QoR1nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:37 INFO - Running setup.py (path:/tmp/pip-aNSHi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:37 INFO - Running setup.py (path:/tmp/pip-_HlXoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:37 INFO - Running setup.py (path:/tmp/pip-MpARdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:37 INFO - Running setup.py (path:/tmp/pip-ESEji9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:37 INFO - Running setup.py (path:/tmp/pip-jaB5ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:37 INFO - Running setup.py (path:/tmp/pip-7ugWNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:37 INFO - Running setup.py (path:/tmp/pip-NrtoPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:37 INFO - Running setup.py (path:/tmp/pip-juFe7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:37 INFO - Running setup.py (path:/tmp/pip-3_ED1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:37 INFO - Running setup.py (path:/tmp/pip-JbyEgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:37 INFO - Running setup.py (path:/tmp/pip-FcqRiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:37 INFO - Running setup.py (path:/tmp/pip-otVErg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:37 INFO - Running setup.py (path:/tmp/pip-8Ghrua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:37 INFO - Running setup.py (path:/tmp/pip-AZJxQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:38 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)) 04:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:38 INFO - Running setup.py (path:/tmp/pip-kmMxgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:38 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)) 04:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:38 INFO - Running setup.py (path:/tmp/pip-ju5xhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:38 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)) 04:46:38 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)) 04:46:38 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)) 04:46:38 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)) 04:46:38 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)) 04:46:38 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)) 04:46:38 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)) 04:46:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:40 INFO - Downloading blessings-1.6.tar.gz 04:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:41 INFO - Installing collected packages: blessings 04:46:41 INFO - Running setup.py install for blessings 04:46:41 INFO - Successfully installed blessings 04:46:41 INFO - Cleaning up... 04:46:41 INFO - Return code: 0 04:46:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:41 INFO - Reading from file tmpfile_stdout 04:46:41 INFO - Current package versions: 04:46:41 INFO - argparse == 1.2.1 04:46:41 INFO - blessings == 1.6 04:46:41 INFO - blobuploader == 1.2.4 04:46:41 INFO - docopt == 0.6.1 04:46:41 INFO - functools32 == 3.2.3-2 04:46:41 INFO - jsonschema == 2.5.1 04:46:41 INFO - manifestparser == 1.1 04:46:41 INFO - mozInstall == 1.13 04:46:41 INFO - mozcrash == 1.0 04:46:41 INFO - mozdebug == 0.1 04:46:41 INFO - mozdevice == 0.51 04:46:41 INFO - mozfile == 1.2 04:46:41 INFO - mozhttpd == 0.7 04:46:41 INFO - mozinfo == 0.10 04:46:41 INFO - mozleak == 0.1 04:46:41 INFO - mozlog == 3.4 04:46:41 INFO - moznetwork == 0.27 04:46:41 INFO - mozprocess == 0.25 04:46:41 INFO - mozprofile == 0.28 04:46:41 INFO - mozrunner == 6.13 04:46:41 INFO - mozscreenshot == 0.1 04:46:41 INFO - mozsystemmonitor == 0.3 04:46:41 INFO - moztest == 0.8 04:46:41 INFO - mozversion == 1.4 04:46:41 INFO - psutil == 3.1.1 04:46:41 INFO - requests == 1.2.3 04:46:41 INFO - wsgiref == 0.1.2 04:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:41 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:41 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 04:46:41 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 04:46:41 INFO - Using env: {'DISPLAY': ':0', 04:46:41 INFO - 'HOME': '/home/cltbld', 04:46:41 INFO - 'LANG': 'en_US.UTF-8', 04:46:41 INFO - 'LANGUAGE': 'en_US:en', 04:46:41 INFO - 'LOGNAME': 'cltbld', 04:46:41 INFO - 'MAIL': '/var/mail/cltbld', 04:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:41 INFO - 'MOZ_NO_REMOTE': '1', 04:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:41 INFO - 'NO_EM_RESTART': '1', 04:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:41 INFO - 'PWD': '/builds/slave/test', 04:46:41 INFO - 'SHELL': '/bin/bash', 04:46:41 INFO - 'SHLVL': '1', 04:46:41 INFO - 'TERM': 'linux', 04:46:41 INFO - 'TMOUT': '86400', 04:46:41 INFO - 'USER': 'cltbld', 04:46:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:41 INFO - '_': '/tools/buildbot/bin/python'} 04:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 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)) 04:46:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:46:43 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)) 04:46:43 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)) 04:46:43 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)) 04:46:43 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)) 04:46:43 INFO - Installing collected packages: marionette-driver 04:46:43 INFO - Running setup.py install for marionette-driver 04:46:43 INFO - Successfully installed marionette-driver 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:43 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 0xc3d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', '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 04:46:43 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 04:46:43 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 04:46:43 INFO - Using env: {'DISPLAY': ':0', 04:46:43 INFO - 'HOME': '/home/cltbld', 04:46:43 INFO - 'LANG': 'en_US.UTF-8', 04:46:43 INFO - 'LANGUAGE': 'en_US:en', 04:46:43 INFO - 'LOGNAME': 'cltbld', 04:46:43 INFO - 'MAIL': '/var/mail/cltbld', 04:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:43 INFO - 'MOZ_NO_REMOTE': '1', 04:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:43 INFO - 'NO_EM_RESTART': '1', 04:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:43 INFO - 'PWD': '/builds/slave/test', 04:46:43 INFO - 'SHELL': '/bin/bash', 04:46:43 INFO - 'SHLVL': '1', 04:46:43 INFO - 'TERM': 'linux', 04:46:43 INFO - 'TMOUT': '86400', 04:46:43 INFO - 'USER': 'cltbld', 04:46:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:43 INFO - '_': '/tools/buildbot/bin/python'} 04:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - Running post-action listener: _start_resource_monitoring 04:46:43 INFO - Starting resource monitoring. 04:46:43 INFO - [mozharness: 2017-06-22 11:46:43.668782Z] Finished create-virtualenv step (success) 04:46:43 INFO - [mozharness: 2017-06-22 11:46:43.669289Z] Running install step. 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: install 04:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:43 INFO - Reading from file tmpfile_stdout 04:46:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:44 INFO - Reading from file tmpfile_stdout 04:46:44 INFO - Output received: 04:46:44 INFO - Usage: mozinstall [options] installer 04:46:44 INFO - Options: 04:46:44 INFO - -h, --help show this help message and exit 04:46:44 INFO - -d DEST, --destination=DEST 04:46:44 INFO - Directory to install application into. [default: 04:46:44 INFO - "/builds/slave/test"] 04:46:44 INFO - --app=APP Application being installed. [default: firefox] 04:46:44 INFO - mkdir: /builds/slave/test/build/application 04:46:44 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'] 04:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:47:01 INFO - Reading from file tmpfile_stdout 04:47:01 INFO - Output received: 04:47:01 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:01 INFO - Running post-action listener: _resource_record_post_action 04:47:01 INFO - [mozharness: 2017-06-22 11:47:01.793217Z] Finished install step (success) 04:47:01 INFO - [mozharness: 2017-06-22 11:47:01.793552Z] Running setup-mitmproxy step. 04:47:01 INFO - Running pre-action listener: _resource_record_pre_action 04:47:01 INFO - Running main action method: setup_mitmproxy 04:47:01 INFO - Skipping: mitmproxy is not required 04:47:01 INFO - Running post-action listener: _resource_record_post_action 04:47:01 INFO - [mozharness: 2017-06-22 11:47:01.794677Z] Finished setup-mitmproxy step (success) 04:47:01 INFO - [mozharness: 2017-06-22 11:47:01.794906Z] Running run-tests step. 04:47:01 INFO - Running pre-action listener: _resource_record_pre_action 04:47:01 INFO - Running main action method: run_tests 04:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:01 INFO - Python 2.7.3 04:47:01 INFO - Return code: 0 04:47:01 INFO - grabbing minidump binary from tooltool 04:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:01 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 0xfb9140>, '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 0xfb9a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb9ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:01 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 04:47:01 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 04:47:01 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 04:47:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:01 INFO - Return code: 0 04:47:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:01 INFO - ENV: RUST_BACKTRACE is now 1 04:47:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 04:47:01 INFO - Using env: {'DISPLAY': ':0', 04:47:01 INFO - 'HOME': '/home/cltbld', 04:47:01 INFO - 'LANG': 'en_US.UTF-8', 04:47:01 INFO - 'LANGUAGE': 'en_US:en', 04:47:01 INFO - 'LOGNAME': 'cltbld', 04:47:01 INFO - 'MAIL': '/var/mail/cltbld', 04:47:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:01 INFO - 'MOZ_NO_REMOTE': '1', 04:47:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:01 INFO - 'NO_EM_RESTART': '1', 04:47:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:01 INFO - 'PWD': '/builds/slave/test', 04:47:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:01 INFO - 'RUST_BACKTRACE': '1', 04:47:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:47:01 INFO - 'SHELL': '/bin/bash', 04:47:01 INFO - 'SHLVL': '1', 04:47:01 INFO - 'TERM': 'linux', 04:47:01 INFO - 'TMOUT': '86400', 04:47:01 INFO - 'USER': 'cltbld', 04:47:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457', 04:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:01 INFO - '_': '/tools/buildbot/bin/python'} 04:47:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:47:02 INFO - mozversion application_buildid: 20170622105226 04:47:02 INFO - mozversion application_changeset: 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb 04:47:02 INFO - mozversion application_display_name: Nightly 04:47:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:02 INFO - mozversion application_name: Firefox 04:47:02 INFO - mozversion application_remotingname: firefox 04:47:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:02 INFO - mozversion application_vendor: Mozilla 04:47:02 INFO - mozversion application_version: 56.0a1 04:47:02 INFO - mozversion platform_buildid: 20170622105226 04:47:02 INFO - mozversion platform_changeset: 7a9536f89bc75b0672060f16ffbe6eb2c1ff3deb 04:47:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:02 INFO - mozversion platform_version: 56.0a1 04:47:02 INFO - using testdate: 1498132022 04:47:02 INFO - actual date: 1498132022 04:47:02 INFO - starting webserver on 'localhost:59462' 04:47:02 INFO - SUITE-START | Running 2 tests 04:47:02 INFO - TEST-START | dromaeo_css 04:47:02 INFO - operating with platform_type : linux_ 04:47:02 INFO - Initialising browser for dromaeo_css test... 04:47:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59462/getInfo.html -profile /tmp/tmp1LtAp7/profile 04:47:02 INFO - TEST-INFO | started process 31890 (/builds/slave/test/build/application/firefox/firefox http://localhost:59462/getInfo.html) 04:47:08 INFO - TEST-INFO | 31890: exit 0 04:47:08 INFO - Browser initialized. 04:47:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:08 INFO - TEST-INFO | started process 32118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1LtAp7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:20 INFO - PID 32118 | RSS: Main: 178888704 04:47:20 INFO - PID 32118 | 04:50:23 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59462/tests/dromaeo/cssquery-ext.html) 04:50:25 INFO - PID 32118 | RSS: Main: 184049664 04:50:25 INFO - PID 32118 | 04:53:26 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-ext.html (next: http://localhost:59462/tests/dromaeo/cssquery-jquery.html) 04:53:27 INFO - PID 32118 | RSS: Main: 181047296 04:53:27 INFO - PID 32118 | 04:56:29 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59462/tests/dromaeo/cssquery-mootools.html) 04:56:29 INFO - PID 32118 | RSS: Main: 184160256 04:56:29 INFO - PID 32118 | 04:59:31 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59462/tests/dromaeo/cssquery-prototype.html) 04:59:32 INFO - PID 32118 | RSS: Main: 182747136 04:59:32 INFO - PID 32118 | 05:02:34 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59462/tests/dromaeo/cssquery-yui.html) 05:02:35 INFO - PID 32118 | RSS: Main: 184066048 05:02:35 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | Cycle 1(1): loaded http://localhost:59462/tests/dromaeo/cssquery-yui.html (next: http://localhost:59462/tests/dromaeo/cssquery-dojo.html) 05:05:37 INFO - PID 32118 | RSS: Main: 182128640 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | __start_tp_report 05:05:37 INFO - PID 32118 | _x_x_mozilla_page_load 05:05:37 INFO - PID 32118 | _x_x_mozilla_page_load_details 05:05:37 INFO - PID 32118 | |i|pagename|runs| 05:05:37 INFO - PID 32118 | |0;dojo.html;2970.673225945144;2974.6727859935418;2995.296105415228;3022.4257391095675;3038.650555186153;5933.406659334069;5973.6714480703595;6054.969725151368;6060.969695151518;6088.634681919077;6048.2742070951435;6075.453209211159;6083.270007599094;6089;6090;5549.805756798512;5555.138953462219;5582.106862901936;5650.74571644275;5691.004074287004;5428.240046393508;5503.752331145088;5583.776648934058;5598.692071936042;5601.523870471015;5492.890142197134;5533.6403133796175;5572.944270557324;5574.916376254359;5623.128415095667;5487.039768040577;5535.972320138373;5551.694656793875;5555.2500412444615;5595.272614560122;5409.2967914171295;5425.348958125051;5467.316585426822;5492.725363731797;5503.422140675211;5872.17789509469;5952.9702351488395;5958.97020514899;5969.701514924236;5997.940020599782;6372.522060845455;6428.774992875274;6431.742730290783;6451.967740161269;6468.15913931186;6566.901496477557;6570.70431830564;6575.342465753434;6582.275949645536;6607.768728094542;6006.97881360161;6093;6108.17539632144;6118.174046503754;6124.601900876429;6433.935660643428;6509.349065093547;6534.705938232791;6540.313267106885;6544.901826472606;6259.4679452246155;6324.683765811691;6361.363863613602;6394.520410969196;6404.551681382259;6439.839004024937;6478;6482.740690372427;6486.059521369375;6496;6253.030780229072;6336.20797400325;6340.429361357407;6476.449501792306;6480.611163330215;6390.584612000205;6425.807225783234;6456.9354306456335;6465.2564955030775;6494.090827284184;5313.6811791291875;5339.46605339463;5341.599380046512;5355.036093503207;5360.490753378501;4467.910641787146;4519.502854685982;4522.570355816192;4527.4340707411575;4553.317002449659;5598.664080155204;5604.103343465026;5604.719764011783;5604.8038318658655;5606.411326810708;6211.2857021442205;6272.090546870678;6323.241211054703;6338.968305158444;6473.838154046187;5528.9723551381985;5555.194496798023;5595.272614560081;5604.131359639263;5608.10270356741;5613.550915926716;5701.00232459318;5705.71471426427;5743.6266642668925;5751.539876809845;6301.117843501914;6324.494040476751;6342.365763423621;6348.047792830927;6357.809265722036;6531.444827189552;6550.312217217123;6557.049227861838;6560.606363618198;6578.210614726264;6133.51829027926;6239.656818875005;6252.374762523711;6260.029695397221;6272;6347.5556711029785;6353.078803573549;6395.072714456471;6436.324185960594;6453.290138084901;6572.934270657232;6582.703778330082;6599.142111525471;6599.307072757291;6602.3397660233595;6073.119397687222;6355.936440635534;6364.077208804605;6376.298607153117;6389.52078594098;6229.657368844757;6230;6242.5942313749465;6248.343923887926;6259.906101408392;6218.9378106220165;6258.186435763321;6268.27914789805;6278.654673992792;6294.968525157345;6347;6441.742330306735;6444.742210311535;6453.967730161319;6455.838604034937;6214.9067763982675;6237.25152981627;6239.937600624117;6241.531885108544;6247.156633854554 05:05:37 INFO - PID 32118 | |1;ext.html;728.5774250934455;769.8575763483755;773.501091795792;808.4825711544612;812.9471584347017;39822;40212.19575608486;40275;40340.1931961361;40598.594014059854;36399.45400818983;36423;36754;36819.447708284395;36832.63167368325;6753.932460675392;6839;6847.760328388507;6848.315168483136;6883.105196324471;6751.493637977147;6779.457643388541;6845.178578570579;6845.657717114149;6855.383015528601;6792.898106528406;6809.455243580502;6824;6824.21521525026;6826.829329266759;6769.5599786014;6790.932090679079;6803.115594972646;6803.693833777467;6809.829754256134;6045.304789949124;6056.939430605682;6067.544934129958;6074.696265186723;6132.865419897334;31798.682013179805;32489.6751032489;32527.512087318708;32544.511832322532;32633.673663263537;3369.9553138527135;3402.8808991685173;3490.232148927257;3585.0678823505814;3588.2105936693883;29768.40463190746;30016.69983300183;30021;30028.399432011236;30045.69954300473;3722.813859307024;3744.6629803317833;3770.170562476251;3770.9434358484646;3852.3836186210074;177803;178973;179910;180990;182409;44838.32742508865;45166.09667806626;45299.54700453019;45535;45580.54419455829;47015;47483.76258118756;47672.76163619159;47695.28457073147;47852.521474785506;14688.779668304984;14831.035982661308;14866.554003379915;14883.627909302137;14955.177465239516;11979.401029948467;12013;12034.518619255132;12055.397230138458;12117.515299387926;13363.933180334036;13380.397882095329;13521.391537380841;13541.729165416637;13671.931640341734;5405.7567409466665;5469.425710300441;5558;5572.58205634579;5615.9157612635845;988.7577543501889;992.4045572656348;1003.4882210072915;1026.414943482208;1026.7535791410157;22223;22822;23226.883865580563;23230.419239519146;23929.64105538418;1065.79217052674;1073.7906108308805;1106.3859557945418;1108.14672702019;1122.1303489795473;12275.93862030684;12526.561570344995;12559;12765.361731913366;12876.420561074587;227289;227543;228619;229278;229409;43915.34126988098;44051.33922991158;44265.11469770651;44295.11409771851;44409;1394.5607133752835;1462.4004158295047;1466.3181620546497;1467.8458761830068;1470.6176394137601;21559.46101347479;23201.3039608812;23481.647775283043;23629.527409452057;23906;36306.27387452289;36344.273114537034;36590.26819463649;36631.81684091563;36746;172538;173336;173519;173657;174224;29447.85276073606;30104.24739381533;30214.54678179785;32479.837600811843;32754.83622581872;38938.6106138935;39024;40666.59333406747;41408;42241.57758422376;29193.270168245963;29990.70009299879;30489.847550762104;30593;31637.20906977344;29800.552991705576;30224;30344.089677309716;31001;31139.221519462193;32227.194320141247;33028.33943321168;33650.15874603154;33667.663323366454;33985.830070849486;28957.420851583272;29040;29206.415871682024;29829.403411932075;30655.846720766254;22946;23807.928643211442;24025.27924162278;24220.87889560541;24482.265532034067 05:05:37 INFO - PID 32118 | |2;jquery.html;561.2423228641335;561.8988582055233;567.3957235544144;569.5500554561896;585.4496773033349;21594.56810863784;22514.43713907153;22553.097876084958;22584.774152258473;22601.54796904061;24247.515049698995;25144.371390715194;26650.73349266507;26678.466430671375;26779.330516737093;6411.551191416591;6530.804075877708;6536.803895883131;6606.504512161583;6615.073889655452;6519.67401629919;6570.375814297658;6574.8685026299445;6580.374864387875;6580.506462015344;3961.5444223914333;4596.977015114937;5785.247917770684;6449.580777249464;6541.574797638138;6516.609003459807;6529.183852018497;6543.247526534462;6556.934430655704;6568.967155164193;6079.574429789916;6142.570020098595;6144.354842741493;6145.078238264251;6147.231596050494;26730.19809405721;29398;29407;29652.258693532618;29780.553291700642;1953.9706904396446;1982.9107690153978;1988.5724569217687;2000.9799902000939;2008.7790343062252;17708.380206692833;18210.817891821178;18245.817541824676;18249.452516424528;18275.543111422186;2303.8502497337618;2329.9301020969397;2363.1374548289923;2376.940576485584;2391.091385273585;115726;119880;120035.79964200333;120129;120465;13491;14536.927315363568;14733.705325893423;14733.778993315109;15121.546353609408;23403.180888668816;23576.64635030476;23586.88206558956;23593.29220123399;23619.527609447716;9713.660021899199;9871.30900836949;9971.850422243671;10012.098911098035;10029.398236105711;9009.594568244445;9010.098990100938;9012;9054.954725226464;9187.586558604879;8996.82006359869;9022;9166.495842728715;9199.908000919904;9347.953260233655;2482.3049546127113;2736.58951157328;2746.244782684778;2765.727765227977;2895.840728759896;939.43633819709;944.8299306124826;957.7222605444343;986.2159583131428;997.8303688372994;19638.803611963984;19654.64171692983;19823;20311;20342.49143771388;972.9610815567439;985.6156099121205;1016.4612755239734;1042.0985847242082;1042.9269951103502;10529.684109476728;10839.620613278497;10847.728806779736;11003.724906877393;11234.303767095838;450971;453558;456239;460173;475580;101242;101851.49074254581;102060;102580;102586;1179.8761130081389;1201.0931746531487;1210.878912108782;1223.4127618742875;1271.1038717703996;18991.715124272872;19880.403587892386;20146.496337591678;20351.59296814085;20671.483212919797;48303;48834.26748598845;49185.508144918094;50621.49378506168;51636.22545661893;58048.12927806171;59565.106523401315;59577;59686.40313596808;60105;12339.197952133083;12389.442475088823;12542.874571254535;12659.303738294482;13239.470421183045;19126.33057842969;19379.806201938365;19416.70874936849;19457.8054219456;19601.60796784085;14044.578662640137;14638.92680536633;14906.776398353817;15013.924930375279;15543.300551475437;13172.209667419986;13172.736545269232;13816;14109.788353174916;14876.776848347066;15346.386144554093;16835.831641683915;16842.66314673675;16860.409885653942;16898;13024.47902083906;13168.209907405586;13250.337483125997;13261.867381326063;13329.3335333231;14499.565013049625;15168.696626067638;15249.542513724606;15342.309596068428;15396.923015384851 05:05:37 INFO - PID 32118 | |3;mootools.html;1331.4740677432412;1376.834779826421;1392.206442327873;1397.3641992893236;1399.9370028348724;12488.937555312223;12950.740985180302;12993.675158121052;13007.674808129801;13024.218546887194;12714.745705085892;13164.868351316483;13183;13189.142705724122;13197.670058248548;2482.9006839726435;2537.9873100634472;2555.501677172952;2559.104313490282;2566.345581876619;2387.832851700373;2513.924582262535;2519.533886231044;2527;2528.570143075672;2331.895064722083;2346.2374728213313;2464.2607217834666;2497.3881399057254;2512.648229247907;2568.6660734104635;2589.8057645676554;2591.157873691058;2601.8178727489085;2607.7001144868395;2426.8786560672074;2427.6237183236626;2445.5475736988715;2449.2407353720405;2457.6436416719653;12465.875341246652;12658.367081645882;12668.683282918;12710.300933448656;12795.808062879065;6839;7041.929580704179;7052.541584796972;7077.292270772933;7092.680829362691;4203.159368126387;4325.567443255649;4330.133973205371;4385.736855788663;4392.934105988381;1523.3068953626073;1551.736204845179;1559.6724687815458;1559.8440155984424;1584.9445269415514;19580.608387832304;19937.800621993738;19980.40058798224;20019.799802002086;20038.098285577038;6159.353267906805;6186;6282.560220784592;6364.204474440695;6392.872142557123;16383.508494745176;16459.177041147894;16527.173641317888;16549.669006620043;16582.336706531845;7113.857722845514;7248.4563657725885;7259.20148783644;7280.854382912312;7282.8179295516975;6651.66741662915;6667.299933506912;6678.098456708282;6744.898826517606;6771.864562708718;4722.504137065627;4839.830605928775;4879.682820616648;4886.780094895738;4961.181405068123;1561;1581.3753567341066;1619.5789094835427;1628.7475441306617;1632.1431248594583;888.5379602606738;906.2025417632573;915.7802127489488;935.1396715022196;950.1401231885155;6831.316868313228;6875.5874647521305;7108.2891710829535;7289.343959043712;7304.2695730427595;669.8794217040979;706.3572149344175;710.9644517774091;747.6299231880254;753.4311594745932;4409.977950110229;4425.668074894395;4593.977030114828;4618.261078227468;5130.51260130287;15936.920315398349;15966.361345546047;16357.672846543002;16697.833021669627;17033.7444938326;16511.256993435323;17006.404775833034;17086.743698844526;17231.65536689259;17599.560010999572;9894.109530142321;9926;10093.495325233856;10177.033181847713;10208.591656333663;7187.389071928736;7598.886016709865;7717.961410192913;7936.444448888522;8104.959475202586;14398.136111833324;14611.269436527919;14808.703825923636;14913.701725965202;14934.402623894923;14586.343614537584;14619.707605848036;15029.24853757286;15161.469348573188;15446.84553154499;10774.676759697222;10997.175211859303;11015.118790496581;11029.117670586495;11059.50232239535;11759.941200293944;12032.217905836093;12218.144729868824;12431.191972521758;12435.626931192079;9970.202383809423;10060.597576097167;10117.797644047225;10319.432431216355;10346.637867674595;9733.318667693193;9890;9989.450580218157;10053.849192261976;10345.534450949575;8945.686900958435;8981;8994.775130621787;9068.047854975133;9068.501232432016;6652.234992975869;6904.240533541407;6914.239433662193;6969.756058537927;7049.083619129686;6876.862462750617;6887.552309099892;6918.515703900679;7120.715171393086;7205.963970180115 05:05:37 INFO - PID 32118 | |4;prototype.html;466.83194050141964;495.91640817586693;504.15805604640246;508.63886640485254;517.9067767801794;6132.877342453154;6142.539309551779;6160.9691951540235;6171.50627949764;6194.81415557534;5845.912311315334;5971.701414929247;6030.427109424609;6045.909311360333;6048.516118710503;4929.496503566411;4939.110960027194;4972.502749725026;4979.609787302097;4981.103401387749;4960.677555958851;4975.2039673652225;4975.552200301972;4980.7509624518625;4989.950100499003;4733.171694953387;4953.529414705597;4953.727544985024;4962.503749625027;4974.030064137494;4906.5093490650825;4907.509249075082;4918.926216106761;4940.975295123538;4942.456329803718;4388.407564978751;4420.58004489573;4436.511983681792;4454.57681520255;4464.6428285737065;5970.194023806774;5986.700664966777;6010.639361638316;6022.126791615235;6025.969870150665;5627.184058311522;5631.465010823965;5636.49271565557;5652.208690783294;5656.717164141817;6456.322086180978;6468.159139311906;6483.541203229236;6489.415952564244;6504.739810407578;4816.314289998508;4818.867566121959;4822.300766388854;4831.396075490564;4868.172410690191;6764.255931847493;6808.6936087876165;6820.181578210647;6844.657767111625;6850.143732033496;4968;4981.800727970841;4994.076095922266;4996.175631020914;5010;5019.222020586815;5021.5229553192385;5072.82245121419;5083.440821509631;5096.770645320969;5594.776208951596;5649.519790817744;5667.404922483162;5671.688057156814;5680.715964201773;6457.160569125984;6548.461111638761;6555.115059466911;6573;6581.539292249497;1713.1583547686287;1731.195463349382;1753.6931037068462;1755.6313174233298;1764.289707650375;1218.7867123253395;1219.5792451604182;1225.2464734188588;1228.4901765767106;1240.683625675447;5475.315585551806;5543.473370029841;5629.54963602919;5638.746256418471;5681.261436013292;6587.341265873374;6660;6661.733530658817;6672.899906501407;6702.966485167543;5581.190727344512;5616.1014237721765;5626.381098079208;5644.774209031592;5665.093585026376;3366.9494957575657;3509.8245087746022;3524.4713293006253;3530.6292839252023;3538.097785064792;6381.585196962183;6385.138006369174;6407.539928438684;6408.359164083648;6459.257185423737;6771.559848609824;6790.490713196431;6809.557378770364;6826.761063362857;6829.643772898342;6401.263854656681;6411.455026322815;6432.807015789534;6434.678266086677;6443.613383197023;6628.1383420157;6639.634820084942;6654.168228971379;6663.800085997428;6707.1616047994;6596.868062638816;6645.800625981228;6654.600723956578;6662.833429164116;6690.397864192246;6470.6441145737435;6471;6471.158749362741;6474.449671777952;6501.707423165874;4922.4585295616735;4973.626977976739;4999.125153098121;4999.950000499948;5002.424721156968;6651.667416629052;6673.566218195801;6677.799666010027;6688.899666504909;6719.496037797283;6249.375062493714;6403.583767055126;6450.290468048417;6473.643949582818;6480.967595161994;6393.744250229939;6421.261554921057;6425.742970281323;6441.613503189824;6461.224653041665;6405.551611387158;6416.7754128605275;6420.6789660517725;6429.196350456193;6450.322716114741;6507.479401647952;6518.706658200487;6533.085368048382;6543.607383557001;6544.738210471718;6055.72749226277;6222.439980401605;6275.086098739928;6304.779332723333;6336.493080553452 05:05:37 INFO - PID 32118 | |5;yui.html;868.0349586744177;877.1141147441084;882.6513527156774;885.0529932971715;885.1900511032408;17188.65622687547;18254.543636409097;18281.54296142597;18314.26742930281;18378.632427351444;19021.904890475562;20030.59938801223;20563.38309850703;20852;20891.37325880222;1048.2924026282267;1074.1245884604023;1074.2587614545978;1074.7205726511124;1077.2297807067944;1086.5273605981383;1087.8748943871437;1090.7164137324314;1092.7650555130645;1093.0162853431896;1033.912117470016;1066.786642671465;1148.7759886822032;1149.4597539156625;1152.6657269391867;1135.7274254178978;1139.5954436175164;1141.5833220874363;1141.8173092305274;1143.519721716881;811.6307080278459;812.4475356757403;812.8577498937663;815.135955886756;815.1929589706208;18863.434096976976;19002.904985474983;19130.617387652168;19280.035998200034;19723.704144437703;18100.547486312815;18301.63396732071;18357;18430.90784546082;18506;15756.684866302725;16062.277197526138;16086;16089;16198.109103999275;3325.334933013407;3435.7423193260356;3485.442329227337;3496.9825150874335;3514.209302906851;95420.52289738576;96100.51949740277;97138.51430742872;97745;102510.97489025089;15566.688666226612;15860.20698965047;15999.200039998186;16014.599635008984;16021.279042443119;28659.713402865706;28970.27574310659;28991.710082899324;28998.13005609835;29003.854980724962;7459.179490256068;8007.759767206993;8071.4753541019645;8136.674533018731;8153.6738530458115;3952.3676211806546;4030.6372426481757;4038.2327357801923;4054.432379466877;4071.877843664695;4624.421947256593;4659.324397962344;4673.95326046742;4674.205385084544;4730.668853180313;841.3101256969348;878.6441491196076;943.0428115462811;952.0859974424629;955.1356022799378;642.8200103970896;707.1302298173275;709.482078082992;728.8688036153543;730.932838056433;11450.370229637283;11564.537418503165;11748.236364636443;12278.263304201599;12342.259464432163;698.1900994845954;708.5075872268724;713.1762813949896;716.2837162837163;725.9637018149177;5757.740901659436;5760.107183386582;5811.506021988093;6099.329073801879;6257.530685198628;90815;93640;94551;95446;95872;78889.60555197188;80297;80819.59590202011;81847.590762047;83533.16466835375;69526;70727;71245.2875471249;71466;76866.61566692131;11859.644210673694;11997.520099196283;12065.612454567838;12415.44130514111;12881.677958051123;31286.217844554067;31616.367672646877;32205;32945.34109317848;33856.322873542886;41739.58260417357;41854.372184417865;57901;59636.70181649064;60289.69855150696;18325;18347.266109355478;18367.632647346712;18408.26366945307;18634.906825465787;17503.124843757505;17516.649667006335;18190.727139092658;19262.94053826997;20831.68752468684;17042.914785425994;17996.55008624795;18612.906935465777;19142.330018449287;19151.425457236306;17005.404810831562;17479.213435395184;17648.911755441655;17722.645547089243;17787.377441789475;17013;18197.727034094765;18267.817321826613;18497;18939.526511837314;12933.611991640266;13108.606741797761;13343;14064.81000519457;14190.361433735301;14117.223552704289;14637.487687930872;14770.884123588066;14838.851611483748;14971.92514037423 05:05:37 INFO - PID 32118 | __end_tp_report 05:05:37 INFO - PID 32118 | __start_cc_report 05:05:37 INFO - PID 32118 | _x_x_mozilla_cycle_collect,355 05:05:37 INFO - PID 32118 | __end_cc_report 05:05:37 INFO - PID 32118 | __startTimestamp1498133137508__endTimestamp 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | ------- Summary: start ------- 05:05:37 INFO - PID 32118 | Number of tests: 6 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#0] dojo.html Cycles:165 Average:5960.26 Median:6237.25 stddev:702.10 (11.3%) stddev-sans-first:663.93 05:05:37 INFO - PID 32118 | Values: 2970.7 2974.7 2995.3 3022.4 3038.7 5933.4 5973.7 6055.0 6061.0 6088.6 6048.3 6075.5 6083.3 6089.0 6090.0 5549.8 5555.1 5582.1 5650.7 5691.0 5428.2 5503.8 5583.8 5598.7 5601.5 5492.9 5533.6 5572.9 5574.9 5623.1 5487.0 5536.0 5551.7 5555.3 5595.3 5409.3 5425.3 5467.3 5492.7 5503.4 5872.2 5953.0 5959.0 5969.7 5997.9 6372.5 6428.8 6431.7 6452.0 6468.2 6566.9 6570.7 6575.3 6582.3 6607.8 6007.0 6093.0 6108.2 6118.2 6124.6 6433.9 6509.3 6534.7 6540.3 6544.9 6259.5 6324.7 6361.4 6394.5 6404.6 6439.8 6478.0 6482.7 6486.1 6496.0 6253.0 6336.2 6340.4 6476.4 6480.6 6390.6 6425.8 6456.9 6465.3 6494.1 5313.7 5339.5 5341.6 5355.0 5360.5 4467.9 4519.5 4522.6 4527.4 4553.3 5598.7 5604.1 5604.7 5604.8 5606.4 6211.3 6272.1 6323.2 6339.0 6473.8 5529.0 5555.2 5595.3 5604.1 5608.1 5613.6 5701.0 5705.7 5743.6 5751.5 6301.1 6324.5 6342.4 6348.0 6357.8 6531.4 6550.3 6557.0 6560.6 6578.2 6133.5 6239.7 6252.4 6260.0 6272.0 6347.6 6353.1 6395.1 6436.3 6453.3 6572.9 6582.7 6599.1 6599.3 6602.3 6073.1 6355.9 6364.1 6376.3 6389.5 6229.7 6230.0 6242.6 6248.3 6259.9 6218.9 6258.2 6268.3 6278.7 6295.0 6347.0 6441.7 6444.7 6454.0 6455.8 6214.9 6237.3 6239.9 6241.5 6247.2 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#1] ext.html Cycles:180 Average:35096.40 Median:32536.01 stddev:50669.29 (155.7%) stddev-sans-first:50745.72 05:05:37 INFO - PID 32118 | Values: 728.6 769.9 773.5 808.5 812.9 39822.0 40212.2 40275.0 40340.2 40598.6 36399.5 36423.0 36754.0 36819.4 36832.6 6753.9 6839.0 6847.8 6848.3 6883.1 6751.5 6779.5 6845.2 6845.7 6855.4 6792.9 6809.5 6824.0 6824.2 6826.8 6769.6 6790.9 6803.1 6803.7 6809.8 6045.3 6056.9 6067.5 6074.7 6132.9 31798.7 32489.7 32527.5 32544.5 32633.7 3370.0 3402.9 3490.2 3585.1 3588.2 29768.4 30016.7 30021.0 30028.4 30045.7 3722.8 3744.7 3770.2 3770.9 3852.4 177803.0 178973.0 179910.0 180990.0 182409.0 44838.3 45166.1 45299.5 45535.0 45580.5 47015.0 47483.8 47672.8 47695.3 47852.5 14688.8 14831.0 14866.6 14883.6 14955.2 11979.4 12013.0 12034.5 12055.4 12117.5 13363.9 13380.4 13521.4 13541.7 13671.9 5405.8 5469.4 5558.0 5572.6 5615.9 988.8 992.4 1003.5 1026.4 1026.8 22223.0 22822.0 23226.9 23230.4 23929.6 1065.8 1073.8 1106.4 1108.1 1122.1 12275.9 12526.6 12559.0 12765.4 12876.4 227289.0 227543.0 228619.0 229278.0 229409.0 43915.3 44051.3 44265.1 44295.1 44409.0 1394.6 1462.4 1466.3 1467.8 1470.6 21559.5 23201.3 23481.6 23629.5 23906.0 36306.3 36344.3 36590.3 36631.8 36746.0 172538.0 173336.0 173519.0 173657.0 174224.0 29447.9 30104.2 30214.5 32479.8 32754.8 38938.6 39024.0 40666.6 41408.0 42241.6 29193.3 29990.7 30489.8 30593.0 31637.2 29800.6 30224.0 30344.1 31001.0 31139.2 32227.2 33028.3 33650.2 33667.7 33985.8 28957.4 29040.0 29206.4 29829.4 30655.8 22946.0 23807.9 24025.3 24220.9 24482.3 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#2] jquery.html Cycles:180 Average:31940.09 Median:2316.89 stddev:76787.19 (3314.2%) stddev-sans-first:76966.45 05:05:37 INFO - PID 32118 | Values: 561.2 561.9 567.4 569.6 585.4 21594.6 22514.4 22553.1 22584.8 22601.5 24247.5 25144.4 26650.7 26678.5 26779.3 6411.6 6530.8 6536.8 6606.5 6615.1 6519.7 6570.4 6574.9 6580.4 6580.5 3961.5 4597.0 5785.2 6449.6 6541.6 6516.6 6529.2 6543.2 6556.9 6569.0 6079.6 6142.6 6144.4 6145.1 6147.2 26730.2 29398.0 29407.0 29652.3 29780.6 1954.0 1982.9 1988.6 2001.0 2008.8 17708.4 18210.8 18245.8 18249.5 18275.5 2303.9 2329.9 2363.1 2376.9 2391.1 115726.0 119880.0 120035.8 120129.0 120465.0 13491.0 14536.9 14733.7 14733.8 15121.5 23403.2 23576.6 23586.9 23593.3 23619.5 9713.7 9871.3 9971.9 10012.1 10029.4 9009.6 9010.1 9012.0 9055.0 9187.6 8996.8 9022.0 9166.5 9199.9 9348.0 2482.3 2736.6 2746.2 2765.7 2895.8 939.4 944.8 957.7 986.2 997.8 19638.8 19654.6 19823.0 20311.0 20342.5 973.0 985.6 1016.5 1042.1 1042.9 10529.7 10839.6 10847.7 11003.7 11234.3 450971.0 453558.0 456239.0 460173.0 475580.0 101242.0 101851.5 102060.0 102580.0 102586.0 1179.9 1201.1 1210.9 1223.4 1271.1 18991.7 19880.4 20146.5 20351.6 20671.5 48303.0 48834.3 49185.5 50621.5 51636.2 58048.1 59565.1 59577.0 59686.4 60105.0 12339.2 12389.4 12542.9 12659.3 13239.5 19126.3 19379.8 19416.7 19457.8 19601.6 14044.6 14638.9 14906.8 15013.9 15543.3 13172.2 13172.7 13816.0 14109.8 14876.8 15346.4 16835.8 16842.7 16860.4 16898.0 13024.5 13168.2 13250.3 13261.9 13329.3 14499.6 15168.7 15249.5 15342.3 15396.9 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#3] mootools.html Cycles:180 Average:8029.31 Median:2513.29 stddev:5281.60 (210.1%) stddev-sans-first:5272.44 05:05:37 INFO - PID 32118 | Values: 1331.5 1376.8 1392.2 1397.4 1399.9 12488.9 12950.7 12993.7 13007.7 13024.2 12714.7 13164.9 13183.0 13189.1 13197.7 2482.9 2538.0 2555.5 2559.1 2566.3 2387.8 2513.9 2519.5 2527.0 2528.6 2331.9 2346.2 2464.3 2497.4 2512.6 2568.7 2589.8 2591.2 2601.8 2607.7 2426.9 2427.6 2445.5 2449.2 2457.6 12465.9 12658.4 12668.7 12710.3 12795.8 6839.0 7041.9 7052.5 7077.3 7092.7 4203.2 4325.6 4330.1 4385.7 4392.9 1523.3 1551.7 1559.7 1559.8 1584.9 19580.6 19937.8 19980.4 20019.8 20038.1 6159.4 6186.0 6282.6 6364.2 6392.9 16383.5 16459.2 16527.2 16549.7 16582.3 7113.9 7248.5 7259.2 7280.9 7282.8 6651.7 6667.3 6678.1 6744.9 6771.9 4722.5 4839.8 4879.7 4886.8 4961.2 1561.0 1581.4 1619.6 1628.7 1632.1 888.5 906.2 915.8 935.1 950.1 6831.3 6875.6 7108.3 7289.3 7304.3 669.9 706.4 711.0 747.6 753.4 4410.0 4425.7 4594.0 4618.3 5130.5 15936.9 15966.4 16357.7 16697.8 17033.7 16511.3 17006.4 17086.7 17231.7 17599.6 9894.1 9926.0 10093.5 10177.0 10208.6 7187.4 7598.9 7718.0 7936.4 8105.0 14398.1 14611.3 14808.7 14913.7 14934.4 14586.3 14619.7 15029.2 15161.5 15446.8 10774.7 10997.2 11015.1 11029.1 11059.5 11759.9 12032.2 12218.1 12431.2 12435.6 9970.2 10060.6 10117.8 10319.4 10346.6 9733.3 9890.0 9989.5 10053.8 10345.5 8945.7 8981.0 8994.8 9068.0 9068.5 6652.2 6904.2 6914.2 6969.8 7049.1 6876.9 6887.6 6918.5 7120.7 7206.0 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#4] prototype.html Cycles:180 Average:5453.77 Median:6024.05 stddev:1528.32 (25.4%) stddev-sans-first:1486.06 05:05:37 INFO - PID 32118 | Values: 466.8 495.9 504.2 508.6 517.9 6132.9 6142.5 6161.0 6171.5 6194.8 5845.9 5971.7 6030.4 6045.9 6048.5 4929.5 4939.1 4972.5 4979.6 4981.1 4960.7 4975.2 4975.6 4980.8 4990.0 4733.2 4953.5 4953.7 4962.5 4974.0 4906.5 4907.5 4918.9 4941.0 4942.5 4388.4 4420.6 4436.5 4454.6 4464.6 5970.2 5986.7 6010.6 6022.1 6026.0 5627.2 5631.5 5636.5 5652.2 5656.7 6456.3 6468.2 6483.5 6489.4 6504.7 4816.3 4818.9 4822.3 4831.4 4868.2 6764.3 6808.7 6820.2 6844.7 6850.1 4968.0 4981.8 4994.1 4996.2 5010.0 5019.2 5021.5 5072.8 5083.4 5096.8 5594.8 5649.5 5667.4 5671.7 5680.7 6457.2 6548.5 6555.1 6573.0 6581.5 1713.2 1731.2 1753.7 1755.6 1764.3 1218.8 1219.6 1225.2 1228.5 1240.7 5475.3 5543.5 5629.5 5638.7 5681.3 6587.3 6660.0 6661.7 6672.9 6703.0 5581.2 5616.1 5626.4 5644.8 5665.1 3366.9 3509.8 3524.5 3530.6 3538.1 6381.6 6385.1 6407.5 6408.4 6459.3 6771.6 6790.5 6809.6 6826.8 6829.6 6401.3 6411.5 6432.8 6434.7 6443.6 6628.1 6639.6 6654.2 6663.8 6707.2 6596.9 6645.8 6654.6 6662.8 6690.4 6470.6 6471.0 6471.2 6474.4 6501.7 4922.5 4973.6 4999.1 5000.0 5002.4 6651.7 6673.6 6677.8 6688.9 6719.5 6249.4 6403.6 6450.3 6473.6 6481.0 6393.7 6421.3 6425.7 6441.6 6461.2 6405.6 6416.8 6420.7 6429.2 6450.3 6507.5 6518.7 6533.1 6543.6 6544.7 6055.7 6222.4 6275.1 6304.8 6336.5 05:05:37 INFO - PID 32118 | 05:05:37 INFO - PID 32118 | [#5] yui.html Cycles:180 Average:20674.81 Median:19877.15 stddev:25866.40 (130.1%) stddev-sans-first:25896.20 05:05:37 INFO - PID 32118 | Values: 868.0 877.1 882.7 885.1 885.2 17188.7 18254.5 18281.5 18314.3 18378.6 19021.9 20030.6 20563.4 20852.0 20891.4 1048.3 1074.1 1074.3 1074.7 1077.2 1086.5 1087.9 1090.7 1092.8 1093.0 1033.9 1066.8 1148.8 1149.5 1152.7 1135.7 1139.6 1141.6 1141.8 1143.5 811.6 812.4 812.9 815.1 815.2 18863.4 19002.9 19130.6 19280.0 19723.7 18100.5 18301.6 18357.0 18430.9 18506.0 15756.7 16062.3 16086.0 16089.0 16198.1 3325.3 3435.7 3485.4 3497.0 3514.2 95420.5 96100.5 97138.5 97745.0 102511.0 15566.7 15860.2 15999.2 16014.6 16021.3 28659.7 28970.3 28991.7 28998.1 29003.9 7459.2 8007.8 8071.5 8136.7 8153.7 3952.4 4030.6 4038.2 4054.4 4071.9 4624.4 4659.3 4674.0 4674.2 4730.7 841.3 878.6 943.0 952.1 955.1 642.8 707.1 709.5 728.9 730.9 11450.4 11564.5 11748.2 12278.3 12342.3 698.2 708.5 713.2 716.3 726.0 5757.7 5760.1 5811.5 6099.3 6257.5 90815.0 93640.0 94551.0 95446.0 95872.0 78889.6 80297.0 80819.6 81847.6 83533.2 69526.0 70727.0 71245.3 71466.0 76866.6 11859.6 11997.5 12065.6 12415.4 12881.7 31286.2 31616.4 32205.0 32945.3 33856.3 41739.6 41854.4 57901.0 59636.7 60289.7 18325.0 18347.3 18367.6 18408.3 18634.9 17503.1 17516.6 18190.7 19262.9 20831.7 17042.9 17996.6 18612.9 19142.3 19151.4 17005.4 17479.2 17648.9 17722.6 17787.4 17013.0 18197.7 18267.8 18497.0 18939.5 12933.6 13108.6 13343.0 14064.8 14190.4 14117.2 14637.5 14770.9 14838.9 14971.9 05:05:37 INFO - PID 32118 | -------- Summary: end -------- 05:05:37 INFO - PID 32118 | 05:05:38 INFO - TEST-INFO | 32118: exit 0 05:05:38 INFO - TEST-OK | dromaeo_css | took 1115927ms 05:05:38 INFO - TEST-START | kraken 05:05:38 INFO - operating with platform_type : linux_ 05:05:38 INFO - Initialising browser for kraken test... 05:05:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59462/getInfo.html -profile /tmp/tmprlpwSF/profile 05:05:38 INFO - TEST-INFO | started process 32541 (/builds/slave/test/build/application/firefox/firefox http://localhost:59462/getInfo.html) 05:05:44 INFO - TEST-INFO | 32541: exit 0 05:05:44 INFO - Browser initialized. 05:05:44 INFO - Running cycle 1/1 for kraken test... 05:05:44 INFO - TEST-INFO | started process 307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprlpwSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:55 INFO - PID 307 | RSS: Main: 172560384 05:05:55 INFO - PID 307 | 05:05:58 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59462/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:59 INFO - PID 307 | RSS: Main: 177201152 05:05:59 INFO - PID 307 | 05:06:01 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59462/tests/kraken/driver.html?testName=audio-dft) 05:06:02 INFO - PID 307 | RSS: Main: 177606656 05:06:02 INFO - PID 307 | 05:06:05 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59462/tests/kraken/driver.html?testName=audio-fft) 05:06:06 INFO - PID 307 | RSS: Main: 172388352 05:06:06 INFO - PID 307 | 05:06:08 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59462/tests/kraken/driver.html?testName=audio-oscillator) 05:06:08 INFO - PID 307 | RSS: Main: 173117440 05:06:08 INFO - PID 307 | 05:06:11 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:11 INFO - PID 307 | RSS: Main: 173359104 05:06:11 INFO - PID 307 | 05:06:14 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59462/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:15 INFO - PID 307 | RSS: Main: 176680960 05:06:15 INFO - PID 307 | 05:06:18 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59462/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:19 INFO - PID 307 | RSS: Main: 178151424 05:06:19 INFO - PID 307 | 05:06:22 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59462/tests/kraken/driver.html?testName=json-parse-financial) 05:06:22 INFO - PID 307 | RSS: Main: 177115136 05:06:22 INFO - PID 307 | 05:06:24 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:24 INFO - PID 307 | RSS: Main: 177033216 05:06:24 INFO - PID 307 | 05:06:26 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:27 INFO - PID 307 | RSS: Main: 177262592 05:06:27 INFO - PID 307 | 05:06:29 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:30 INFO - PID 307 | RSS: Main: 177307648 05:06:30 INFO - PID 307 | 05:06:32 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:33 INFO - PID 307 | RSS: Main: 177315840 05:06:33 INFO - PID 307 | 05:06:36 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:37 INFO - PID 307 | RSS: Main: 177594368 05:06:37 INFO - PID 307 | 05:06:38 INFO - PID 307 | Cycle 1(1): loaded http://localhost:59462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59462/tests/kraken/driver.html?testName=ai-astar) 05:06:39 INFO - PID 307 | RSS: Main: 178749440 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | __start_tp_report 05:06:39 INFO - PID 307 | _x_x_mozilla_page_load 05:06:39 INFO - PID 307 | _x_x_mozilla_page_load_details 05:06:39 INFO - PID 307 | |i|pagename|runs| 05:06:39 INFO - PID 307 | |0;ai-astar;100;109;108;106;108;108;107;108;108;109 05:06:39 INFO - PID 307 | |1;audio-beat-detection;154;117;149;184;124;153;157;121;170;123 05:06:39 INFO - PID 307 | |2;audio-dft;163;163;164;163;162;172;163;163;165;166 05:06:39 INFO - PID 307 | |3;audio-fft;75;77;75;175;74;74;76;75;92;74 05:06:39 INFO - PID 307 | |4;audio-oscillator;82;82;139;82;84;83;138;82;82;131 05:06:39 INFO - PID 307 | |5;imaging-gaussian-blur;113;114;113;114;114;114;115;114;115;113 05:06:39 INFO - PID 307 | |6;imaging-darkroom;150;150;149;149;153;151;150;151;149;150 05:06:39 INFO - PID 307 | |7;imaging-desaturate;94;94;93;94;93;94;94;94;95;94 05:06:39 INFO - PID 307 | |8;json-parse-financial;56;60;55;55;59;57;58;56;57;57 05:06:39 INFO - PID 307 | |9;json-stringify-tinderbox;54;53;54;53;54;53;55;55;54;53 05:06:39 INFO - PID 307 | |10;stanford-crypto-aes;80;78;76;82;76;79;77;77;75;77 05:06:39 INFO - PID 307 | |11;stanford-crypto-ccm;126;126;128;137;127;130;128;124;125;154 05:06:39 INFO - PID 307 | |12;stanford-crypto-pbkdf2;183;182;182;185;183;179;180;185;182;195 05:06:39 INFO - PID 307 | |13;stanford-crypto-sha256-iterative;71;70;72;68;68;69;66;67;69;68 05:06:39 INFO - PID 307 | __end_tp_report 05:06:39 INFO - PID 307 | __start_cc_report 05:06:39 INFO - PID 307 | _x_x_mozilla_cycle_collect,935 05:06:39 INFO - PID 307 | __end_cc_report 05:06:39 INFO - PID 307 | __startTimestamp1498133199105__endTimestamp 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | ------- Summary: start ------- 05:06:39 INFO - PID 307 | Number of tests: 14 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#0] ai-astar Cycles:10 Average:107.10 Median:108.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 05:06:39 INFO - PID 307 | Values: 100.0 109.0 108.0 106.0 108.0 108.0 107.0 108.0 108.0 109.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.50 stddev:22.94 (14.9%) stddev-sans-first:24.11 05:06:39 INFO - PID 307 | Values: 154.0 117.0 149.0 184.0 124.0 153.0 157.0 121.0 170.0 123.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:2.91 (1.8%) stddev-sans-first:3.05 05:06:39 INFO - PID 307 | Values: 163.0 163.0 164.0 163.0 162.0 172.0 163.0 163.0 165.0 166.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:31.50 (42.0%) stddev-sans-first:33.12 05:06:39 INFO - PID 307 | Values: 75.0 77.0 75.0 175.0 74.0 74.0 76.0 75.0 92.0 74.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:82.00 stddev:25.97 (31.7%) stddev-sans-first:26.85 05:06:39 INFO - PID 307 | Values: 82.0 82.0 139.0 82.0 84.0 83.0 138.0 82.0 82.0 131.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 05:06:39 INFO - PID 307 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 115.0 114.0 115.0 113.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 05:06:39 INFO - PID 307 | Values: 150.0 150.0 149.0 149.0 153.0 151.0 150.0 151.0 149.0 150.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:06:39 INFO - PID 307 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 95.0 94.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.63 (2.9%) stddev-sans-first:1.69 05:06:39 INFO - PID 307 | Values: 56.0 60.0 55.0 55.0 59.0 57.0 58.0 56.0 57.0 57.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 05:06:39 INFO - PID 307 | Values: 54.0 53.0 54.0 53.0 54.0 53.0 55.0 55.0 54.0 53.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.11 (2.7%) stddev-sans-first:2.07 05:06:39 INFO - PID 307 | Values: 80.0 78.0 76.0 82.0 76.0 79.0 77.0 77.0 75.0 77.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:128.00 stddev:9.02 (7.0%) stddev-sans-first:9.42 05:06:39 INFO - PID 307 | Values: 126.0 126.0 128.0 137.0 127.0 130.0 128.0 124.0 125.0 154.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:183.00 stddev:4.43 (2.4%) stddev-sans-first:4.69 05:06:39 INFO - PID 307 | Values: 183.0 182.0 182.0 185.0 183.0 179.0 180.0 185.0 182.0 195.0 05:06:39 INFO - PID 307 | 05:06:39 INFO - PID 307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.81 (2.6%) stddev-sans-first:1.74 05:06:39 INFO - PID 307 | Values: 71.0 70.0 72.0 68.0 68.0 69.0 66.0 67.0 69.0 68.0 05:06:39 INFO - PID 307 | -------- Summary: end -------- 05:06:39 INFO - PID 307 | 05:06:39 INFO - TEST-INFO | 307: exit 0 05:06:39 INFO - TEST-OK | kraken | took 61832ms 05:06:39 INFO - SUITE-END | took 1177s 05:06:40 INFO - Completed test suite (00:19:38) 05:06:40 INFO - javascript benchmark 05:06:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8065.253143853236, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2970.673225945144, 2974.6727859935418, 2995.296105415228, 3022.4257391095675, 3038.650555186153, 5933.406659334069, 5973.6714480703595, 6054.969725151368, 6060.969695151518, 6088.634681919077, 6048.2742070951435, 6075.453209211159, 6083.270007599094, 6089.0, 6090.0, 5549.805756798512, 5555.138953462219, 5582.106862901936, 5650.74571644275, 5691.004074287004, 5428.240046393508, 5503.752331145088, 5583.776648934058, 5598.692071936042, 5601.523870471015, 5492.890142197134, 5533.6403133796175, 5572.944270557324, 5574.916376254359, 5623.128415095667, 5487.039768040577, 5535.972320138373, 5551.694656793875, 5555.2500412444615, 5595.272614560122, 5409.2967914171295, 5425.348958125051, 5467.316585426822, 5492.725363731797, 5503.422140675211, 5872.17789509469, 5952.9702351488395, 5958.97020514899, 5969.701514924236, 5997.940020599782, 6372.522060845455, 6428.774992875274, 6431.742730290783, 6451.967740161269, 6468.15913931186, 6566.901496477557, 6570.70431830564, 6575.342465753434, 6582.275949645536, 6607.768728094542, 6006.97881360161, 6093.0, 6108.17539632144, 6118.174046503754, 6124.601900876429, 6433.935660643428, 6509.349065093547, 6534.705938232791, 6540.313267106885, 6544.901826472606, 6259.4679452246155, 6324.683765811691, 6361.363863613602, 6394.520410969196, 6404.551681382259, 6439.839004024937, 6478.0, 6482.740690372427, 6486.059521369375, 6496.0, 6253.030780229072, 6336.20797400325, 6340.429361357407, 6476.449501792306, 6480.611163330215, 6390.584612000205, 6425.807225783234, 6456.9354306456335, 6465.2564955030775, 6494.090827284184, 5313.6811791291875, 5339.46605339463, 5341.599380046512, 5355.036093503207, 5360.490753378501, 4467.910641787146, 4519.502854685982, 4522.570355816192, 4527.4340707411575, 4553.317002449659, 5598.664080155204, 5604.103343465026, 5604.719764011783, 5604.8038318658655, 5606.411326810708, 6211.2857021442205, 6272.090546870678, 6323.241211054703, 6338.968305158444, 6473.838154046187, 5528.9723551381985, 5555.194496798023, 5595.272614560081, 5604.131359639263, 5608.10270356741, 5613.550915926716, 5701.00232459318, 5705.71471426427, 5743.6266642668925, 5751.539876809845, 6301.117843501914, 6324.494040476751, 6342.365763423621, 6348.047792830927, 6357.809265722036, 6531.444827189552, 6550.312217217123, 6557.049227861838, 6560.606363618198, 6578.210614726264, 6133.51829027926, 6239.656818875005, 6252.374762523711, 6260.029695397221, 6272.0, 6347.5556711029785, 6353.078803573549, 6395.072714456471, 6436.324185960594, 6453.290138084901, 6572.934270657232, 6582.703778330082, 6599.142111525471, 6599.307072757291, 6602.3397660233595, 6073.119397687222, 6355.936440635534, 6364.077208804605, 6376.298607153117, 6389.52078594098, 6229.657368844757, 6230.0, 6242.5942313749465, 6248.343923887926, 6259.906101408392, 6218.9378106220165, 6258.186435763321, 6268.27914789805, 6278.654673992792, 6294.968525157345, 6347.0, 6441.742330306735, 6444.742210311535, 6453.967730161319, 6455.838604034937, 6214.9067763982675, 6237.25152981627, 6239.937600624117, 6241.531885108544, 6247.156633854554], "value": 5906.794824563206, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5774250934455, 769.8575763483755, 773.501091795792, 808.4825711544612, 812.9471584347017, 39822.0, 40212.19575608486, 40275.0, 40340.1931961361, 40598.594014059854, 36399.45400818983, 36423.0, 36754.0, 36819.447708284395, 36832.63167368325, 6753.932460675392, 6839.0, 6847.760328388507, 6848.315168483136, 6883.105196324471, 6751.493637977147, 6779.457643388541, 6845.178578570579, 6845.657717114149, 6855.383015528601, 6792.898106528406, 6809.455243580502, 6824.0, 6824.21521525026, 6826.829329266759, 6769.5599786014, 6790.932090679079, 6803.115594972646, 6803.693833777467, 6809.829754256134, 6045.304789949124, 6056.939430605682, 6067.544934129958, 6074.696265186723, 6132.865419897334, 31798.682013179805, 32489.6751032489, 32527.512087318708, 32544.511832322532, 32633.673663263537, 3369.9553138527135, 3402.8808991685173, 3490.232148927257, 3585.0678823505814, 3588.2105936693883, 29768.40463190746, 30016.69983300183, 30021.0, 30028.399432011236, 30045.69954300473, 3722.813859307024, 3744.6629803317833, 3770.170562476251, 3770.9434358484646, 3852.3836186210074, 177803.0, 178973.0, 179910.0, 180990.0, 182409.0, 44838.32742508865, 45166.09667806626, 45299.54700453019, 45535.0, 45580.54419455829, 47015.0, 47483.76258118756, 47672.76163619159, 47695.28457073147, 47852.521474785506, 14688.779668304984, 14831.035982661308, 14866.554003379915, 14883.627909302137, 14955.177465239516, 11979.401029948467, 12013.0, 12034.518619255132, 12055.397230138458, 12117.515299387926, 13363.933180334036, 13380.397882095329, 13521.391537380841, 13541.729165416637, 13671.931640341734, 5405.7567409466665, 5469.425710300441, 5558.0, 5572.58205634579, 5615.9157612635845, 988.7577543501889, 992.4045572656348, 1003.4882210072915, 1026.414943482208, 1026.7535791410157, 22223.0, 22822.0, 23226.883865580563, 23230.419239519146, 23929.64105538418, 1065.79217052674, 1073.7906108308805, 1106.3859557945418, 1108.14672702019, 1122.1303489795473, 12275.93862030684, 12526.561570344995, 12559.0, 12765.361731913366, 12876.420561074587, 227289.0, 227543.0, 228619.0, 229278.0, 229409.0, 43915.34126988098, 44051.33922991158, 44265.11469770651, 44295.11409771851, 44409.0, 1394.5607133752835, 1462.4004158295047, 1466.3181620546497, 1467.8458761830068, 1470.6176394137601, 21559.46101347479, 23201.3039608812, 23481.647775283043, 23629.527409452057, 23906.0, 36306.27387452289, 36344.273114537034, 36590.26819463649, 36631.81684091563, 36746.0, 172538.0, 173336.0, 173519.0, 173657.0, 174224.0, 29447.85276073606, 30104.24739381533, 30214.54678179785, 32479.837600811843, 32754.83622581872, 38938.6106138935, 39024.0, 40666.59333406747, 41408.0, 42241.57758422376, 29193.270168245963, 29990.70009299879, 30489.847550762104, 30593.0, 31637.20906977344, 29800.552991705576, 30224.0, 30344.089677309716, 31001.0, 31139.221519462193, 32227.194320141247, 33028.33943321168, 33650.15874603154, 33667.663323366454, 33985.830070849486, 28957.420851583272, 29040.0, 29206.415871682024, 29829.403411932075, 30655.846720766254, 22946.0, 23807.928643211442, 24025.27924162278, 24220.87889560541, 24482.265532034067], "value": 15924.54382507176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2423228641335, 561.8988582055233, 567.3957235544144, 569.5500554561896, 585.4496773033349, 21594.56810863784, 22514.43713907153, 22553.097876084958, 22584.774152258473, 22601.54796904061, 24247.515049698995, 25144.371390715194, 26650.73349266507, 26678.466430671375, 26779.330516737093, 6411.551191416591, 6530.804075877708, 6536.803895883131, 6606.504512161583, 6615.073889655452, 6519.67401629919, 6570.375814297658, 6574.8685026299445, 6580.374864387875, 6580.506462015344, 3961.5444223914333, 4596.977015114937, 5785.247917770684, 6449.580777249464, 6541.574797638138, 6516.609003459807, 6529.183852018497, 6543.247526534462, 6556.934430655704, 6568.967155164193, 6079.574429789916, 6142.570020098595, 6144.354842741493, 6145.078238264251, 6147.231596050494, 26730.19809405721, 29398.0, 29407.0, 29652.258693532618, 29780.553291700642, 1953.9706904396446, 1982.9107690153978, 1988.5724569217687, 2000.9799902000939, 2008.7790343062252, 17708.380206692833, 18210.817891821178, 18245.817541824676, 18249.452516424528, 18275.543111422186, 2303.8502497337618, 2329.9301020969397, 2363.1374548289923, 2376.940576485584, 2391.091385273585, 115726.0, 119880.0, 120035.79964200333, 120129.0, 120465.0, 13491.0, 14536.927315363568, 14733.705325893423, 14733.778993315109, 15121.546353609408, 23403.180888668816, 23576.64635030476, 23586.88206558956, 23593.29220123399, 23619.527609447716, 9713.660021899199, 9871.30900836949, 9971.850422243671, 10012.098911098035, 10029.398236105711, 9009.594568244445, 9010.098990100938, 9012.0, 9054.954725226464, 9187.586558604879, 8996.82006359869, 9022.0, 9166.495842728715, 9199.908000919904, 9347.953260233655, 2482.3049546127113, 2736.58951157328, 2746.244782684778, 2765.727765227977, 2895.840728759896, 939.43633819709, 944.8299306124826, 957.7222605444343, 986.2159583131428, 997.8303688372994, 19638.803611963984, 19654.64171692983, 19823.0, 20311.0, 20342.49143771388, 972.9610815567439, 985.6156099121205, 1016.4612755239734, 1042.0985847242082, 1042.9269951103502, 10529.684109476728, 10839.620613278497, 10847.728806779736, 11003.724906877393, 11234.303767095838, 450971.0, 453558.0, 456239.0, 460173.0, 475580.0, 101242.0, 101851.49074254581, 102060.0, 102580.0, 102586.0, 1179.8761130081389, 1201.0931746531487, 1210.878912108782, 1223.4127618742875, 1271.1038717703996, 18991.715124272872, 19880.403587892386, 20146.496337591678, 20351.59296814085, 20671.483212919797, 48303.0, 48834.26748598845, 49185.508144918094, 50621.49378506168, 51636.22545661893, 58048.12927806171, 59565.106523401315, 59577.0, 59686.40313596808, 60105.0, 12339.197952133083, 12389.442475088823, 12542.874571254535, 12659.303738294482, 13239.470421183045, 19126.33057842969, 19379.806201938365, 19416.70874936849, 19457.8054219456, 19601.60796784085, 14044.578662640137, 14638.92680536633, 14906.776398353817, 15013.924930375279, 15543.300551475437, 13172.209667419986, 13172.736545269232, 13816.0, 14109.788353174916, 14876.776848347066, 15346.386144554093, 16835.831641683915, 16842.66314673675, 16860.409885653942, 16898.0, 13024.47902083906, 13168.209907405586, 13250.337483125997, 13261.867381326063, 13329.3335333231, 14499.565013049625, 15168.696626067638, 15249.542513724606, 15342.309596068428, 15396.923015384851], "value": 11307.485353336475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.4740677432412, 1376.834779826421, 1392.206442327873, 1397.3641992893236, 1399.9370028348724, 12488.937555312223, 12950.740985180302, 12993.675158121052, 13007.674808129801, 13024.218546887194, 12714.745705085892, 13164.868351316483, 13183.0, 13189.142705724122, 13197.670058248548, 2482.9006839726435, 2537.9873100634472, 2555.501677172952, 2559.104313490282, 2566.345581876619, 2387.832851700373, 2513.924582262535, 2519.533886231044, 2527.0, 2528.570143075672, 2331.895064722083, 2346.2374728213313, 2464.2607217834666, 2497.3881399057254, 2512.648229247907, 2568.6660734104635, 2589.8057645676554, 2591.157873691058, 2601.8178727489085, 2607.7001144868395, 2426.8786560672074, 2427.6237183236626, 2445.5475736988715, 2449.2407353720405, 2457.6436416719653, 12465.875341246652, 12658.367081645882, 12668.683282918, 12710.300933448656, 12795.808062879065, 6839.0, 7041.929580704179, 7052.541584796972, 7077.292270772933, 7092.680829362691, 4203.159368126387, 4325.567443255649, 4330.133973205371, 4385.736855788663, 4392.934105988381, 1523.3068953626073, 1551.736204845179, 1559.6724687815458, 1559.8440155984424, 1584.9445269415514, 19580.608387832304, 19937.800621993738, 19980.40058798224, 20019.799802002086, 20038.098285577038, 6159.353267906805, 6186.0, 6282.560220784592, 6364.204474440695, 6392.872142557123, 16383.508494745176, 16459.177041147894, 16527.173641317888, 16549.669006620043, 16582.336706531845, 7113.857722845514, 7248.4563657725885, 7259.20148783644, 7280.854382912312, 7282.8179295516975, 6651.66741662915, 6667.299933506912, 6678.098456708282, 6744.898826517606, 6771.864562708718, 4722.504137065627, 4839.830605928775, 4879.682820616648, 4886.780094895738, 4961.181405068123, 1561.0, 1581.3753567341066, 1619.5789094835427, 1628.7475441306617, 1632.1431248594583, 888.5379602606738, 906.2025417632573, 915.7802127489488, 935.1396715022196, 950.1401231885155, 6831.316868313228, 6875.5874647521305, 7108.2891710829535, 7289.343959043712, 7304.2695730427595, 669.8794217040979, 706.3572149344175, 710.9644517774091, 747.6299231880254, 753.4311594745932, 4409.977950110229, 4425.668074894395, 4593.977030114828, 4618.261078227468, 5130.51260130287, 15936.920315398349, 15966.361345546047, 16357.672846543002, 16697.833021669627, 17033.7444938326, 16511.256993435323, 17006.404775833034, 17086.743698844526, 17231.65536689259, 17599.560010999572, 9894.109530142321, 9926.0, 10093.495325233856, 10177.033181847713, 10208.591656333663, 7187.389071928736, 7598.886016709865, 7717.961410192913, 7936.444448888522, 8104.959475202586, 14398.136111833324, 14611.269436527919, 14808.703825923636, 14913.701725965202, 14934.402623894923, 14586.343614537584, 14619.707605848036, 15029.24853757286, 15161.469348573188, 15446.84553154499, 10774.676759697222, 10997.175211859303, 11015.118790496581, 11029.117670586495, 11059.50232239535, 11759.941200293944, 12032.217905836093, 12218.144729868824, 12431.191972521758, 12435.626931192079, 9970.202383809423, 10060.597576097167, 10117.797644047225, 10319.432431216355, 10346.637867674595, 9733.318667693193, 9890.0, 9989.450580218157, 10053.849192261976, 10345.534450949575, 8945.686900958435, 8981.0, 8994.775130621787, 9068.047854975133, 9068.501232432016, 6652.234992975869, 6904.240533541407, 6914.239433662193, 6969.756058537927, 7049.083619129686, 6876.862462750617, 6887.552309099892, 6918.515703900679, 7120.715171393086, 7205.963970180115], "value": 5924.07423585484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.83194050141964, 495.91640817586693, 504.15805604640246, 508.63886640485254, 517.9067767801794, 6132.877342453154, 6142.539309551779, 6160.9691951540235, 6171.50627949764, 6194.81415557534, 5845.912311315334, 5971.701414929247, 6030.427109424609, 6045.909311360333, 6048.516118710503, 4929.496503566411, 4939.110960027194, 4972.502749725026, 4979.609787302097, 4981.103401387749, 4960.677555958851, 4975.2039673652225, 4975.552200301972, 4980.7509624518625, 4989.950100499003, 4733.171694953387, 4953.529414705597, 4953.727544985024, 4962.503749625027, 4974.030064137494, 4906.5093490650825, 4907.509249075082, 4918.926216106761, 4940.975295123538, 4942.456329803718, 4388.407564978751, 4420.58004489573, 4436.511983681792, 4454.57681520255, 4464.6428285737065, 5970.194023806774, 5986.700664966777, 6010.639361638316, 6022.126791615235, 6025.969870150665, 5627.184058311522, 5631.465010823965, 5636.49271565557, 5652.208690783294, 5656.717164141817, 6456.322086180978, 6468.159139311906, 6483.541203229236, 6489.415952564244, 6504.739810407578, 4816.314289998508, 4818.867566121959, 4822.300766388854, 4831.396075490564, 4868.172410690191, 6764.255931847493, 6808.6936087876165, 6820.181578210647, 6844.657767111625, 6850.143732033496, 4968.0, 4981.800727970841, 4994.076095922266, 4996.175631020914, 5010.0, 5019.222020586815, 5021.5229553192385, 5072.82245121419, 5083.440821509631, 5096.770645320969, 5594.776208951596, 5649.519790817744, 5667.404922483162, 5671.688057156814, 5680.715964201773, 6457.160569125984, 6548.461111638761, 6555.115059466911, 6573.0, 6581.539292249497, 1713.1583547686287, 1731.195463349382, 1753.6931037068462, 1755.6313174233298, 1764.289707650375, 1218.7867123253395, 1219.5792451604182, 1225.2464734188588, 1228.4901765767106, 1240.683625675447, 5475.315585551806, 5543.473370029841, 5629.54963602919, 5638.746256418471, 5681.261436013292, 6587.341265873374, 6660.0, 6661.733530658817, 6672.899906501407, 6702.966485167543, 5581.190727344512, 5616.1014237721765, 5626.381098079208, 5644.774209031592, 5665.093585026376, 3366.9494957575657, 3509.8245087746022, 3524.4713293006253, 3530.6292839252023, 3538.097785064792, 6381.585196962183, 6385.138006369174, 6407.539928438684, 6408.359164083648, 6459.257185423737, 6771.559848609824, 6790.490713196431, 6809.557378770364, 6826.761063362857, 6829.643772898342, 6401.263854656681, 6411.455026322815, 6432.807015789534, 6434.678266086677, 6443.613383197023, 6628.1383420157, 6639.634820084942, 6654.168228971379, 6663.800085997428, 6707.1616047994, 6596.868062638816, 6645.800625981228, 6654.600723956578, 6662.833429164116, 6690.397864192246, 6470.6441145737435, 6471.0, 6471.158749362741, 6474.449671777952, 6501.707423165874, 4922.4585295616735, 4973.626977976739, 4999.125153098121, 4999.950000499948, 5002.424721156968, 6651.667416629052, 6673.566218195801, 6677.799666010027, 6688.899666504909, 6719.496037797283, 6249.375062493714, 6403.583767055126, 6450.290468048417, 6473.643949582818, 6480.967595161994, 6393.744250229939, 6421.261554921057, 6425.742970281323, 6441.613503189824, 6461.224653041665, 6405.551611387158, 6416.7754128605275, 6420.6789660517725, 6429.196350456193, 6450.322716114741, 6507.479401647952, 6518.706658200487, 6533.085368048382, 6543.607383557001, 6544.738210471718, 6055.72749226277, 6222.439980401605, 6275.086098739928, 6304.779332723333, 6336.493080553452], "value": 5003.098049367822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.0349586744177, 877.1141147441084, 882.6513527156774, 885.0529932971715, 885.1900511032408, 17188.65622687547, 18254.543636409097, 18281.54296142597, 18314.26742930281, 18378.632427351444, 19021.904890475562, 20030.59938801223, 20563.38309850703, 20852.0, 20891.37325880222, 1048.2924026282267, 1074.1245884604023, 1074.2587614545978, 1074.7205726511124, 1077.2297807067944, 1086.5273605981383, 1087.8748943871437, 1090.7164137324314, 1092.7650555130645, 1093.0162853431896, 1033.912117470016, 1066.786642671465, 1148.7759886822032, 1149.4597539156625, 1152.6657269391867, 1135.7274254178978, 1139.5954436175164, 1141.5833220874363, 1141.8173092305274, 1143.519721716881, 811.6307080278459, 812.4475356757403, 812.8577498937663, 815.135955886756, 815.1929589706208, 18863.434096976976, 19002.904985474983, 19130.617387652168, 19280.035998200034, 19723.704144437703, 18100.547486312815, 18301.63396732071, 18357.0, 18430.90784546082, 18506.0, 15756.684866302725, 16062.277197526138, 16086.0, 16089.0, 16198.109103999275, 3325.334933013407, 3435.7423193260356, 3485.442329227337, 3496.9825150874335, 3514.209302906851, 95420.52289738576, 96100.51949740277, 97138.51430742872, 97745.0, 102510.97489025089, 15566.688666226612, 15860.20698965047, 15999.200039998186, 16014.599635008984, 16021.279042443119, 28659.713402865706, 28970.27574310659, 28991.710082899324, 28998.13005609835, 29003.854980724962, 7459.179490256068, 8007.759767206993, 8071.4753541019645, 8136.674533018731, 8153.6738530458115, 3952.3676211806546, 4030.6372426481757, 4038.2327357801923, 4054.432379466877, 4071.877843664695, 4624.421947256593, 4659.324397962344, 4673.95326046742, 4674.205385084544, 4730.668853180313, 841.3101256969348, 878.6441491196076, 943.0428115462811, 952.0859974424629, 955.1356022799378, 642.8200103970896, 707.1302298173275, 709.482078082992, 728.8688036153543, 730.932838056433, 11450.370229637283, 11564.537418503165, 11748.236364636443, 12278.263304201599, 12342.259464432163, 698.1900994845954, 708.5075872268724, 713.1762813949896, 716.2837162837163, 725.9637018149177, 5757.740901659436, 5760.107183386582, 5811.506021988093, 6099.329073801879, 6257.530685198628, 90815.0, 93640.0, 94551.0, 95446.0, 95872.0, 78889.60555197188, 80297.0, 80819.59590202011, 81847.590762047, 83533.16466835375, 69526.0, 70727.0, 71245.2875471249, 71466.0, 76866.61566692131, 11859.644210673694, 11997.520099196283, 12065.612454567838, 12415.44130514111, 12881.677958051123, 31286.217844554067, 31616.367672646877, 32205.0, 32945.34109317848, 33856.322873542886, 41739.58260417357, 41854.372184417865, 57901.0, 59636.70181649064, 60289.69855150696, 18325.0, 18347.266109355478, 18367.632647346712, 18408.26366945307, 18634.906825465787, 17503.124843757505, 17516.649667006335, 18190.727139092658, 19262.94053826997, 20831.68752468684, 17042.914785425994, 17996.55008624795, 18612.906935465777, 19142.330018449287, 19151.425457236306, 17005.404810831562, 17479.213435395184, 17648.911755441655, 17722.645547089243, 17787.377441789475, 17013.0, 18197.727034094765, 18267.817321826613, 18497.0, 18939.526511837314, 12933.611991640266, 13108.606741797761, 13343.0, 14064.81000519457, 14190.361433735301, 14117.223552704289, 14637.487687930872, 14770.884123588066, 14838.851611483748, 14971.92514037423], "value": 8730.46992091882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 108.0, 106.0, 108.0, 108.0, 107.0, 108.0, 108.0, 109.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 149.0, 184.0, 124.0, 153.0, 157.0, 121.0, 170.0, 123.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 172.0, 163.0, 163.0, 165.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 175.0, 74.0, 74.0, 76.0, 75.0, 92.0, 74.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 139.0, 82.0, 84.0, 83.0, 138.0, 82.0, 82.0, 131.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 153.0, 151.0, 150.0, 151.0, 149.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 55.0, 55.0, 59.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 55.0, 55.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 76.0, 82.0, 76.0, 79.0, 77.0, 77.0, 75.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 128.0, 137.0, 127.0, 130.0, 128.0, 124.0, 125.0, 154.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 182.0, 185.0, 183.0, 179.0, 180.0, 185.0, 182.0, 195.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 68.0, 68.0, 69.0, 66.0, 67.0, 69.0, 68.0], "value": 68.8, "unit": "score"}]}]} 05:06:40 INFO - Return code: 0 05:06:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:40 INFO - # TBPL SUCCESS # 05:06:40 INFO - Running post-action listener: _resource_record_post_action 05:06:40 INFO - [mozharness: 2017-06-22 12:06:40.480308Z] Finished run-tests step (success) 05:06:40 INFO - Running post-run listener: _resource_record_post_run 05:06:40 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433995776; Read time: 12; Write time: 317200 05:06:40 INFO - TinderboxPrint: CPU usage
13.2% 05:06:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:06:40 INFO - TinderboxPrint: I/O write bytes / time
433,995,776 / 317,200 05:06:40 INFO - TinderboxPrint: CPU idle
8,278.2 (86.8%) 05:06:40 INFO - TinderboxPrint: CPU user
1,209.2 (12.7%) 05:06:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:06:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105971712; Read time: 0; Write time: 114096 05:06:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:06:40 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 328024064; Read time: 0; Write time: 203104 05:06:41 INFO - Running post-run listener: _upload_blobber_files 05:06:41 INFO - Blob upload gear active. 05:06:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:48 INFO - (blobuploader) - INFO - Done attempting. 05:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:49 INFO - (blobuploader) - INFO - Done attempting. 05:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:50 INFO - (blobuploader) - INFO - Done attempting. 05:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:50 INFO - (blobuploader) - INFO - Done attempting. 05:06:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:50 INFO - Return code: 0 05:06:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d770c8b86395cfe813179c7de09f1f48104b91da53f11a77746976a8ba31c8ca386d9246ff5435523b51c33755a0db9ab6284b3c252f6a4942eec094971c134a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792e5cd465c43f3afd34109d9a6cdbb945278f62a3e79ec1ab79d66cc7f25b3ca7626c043bddca75635934e1f4cf887a8ff5081ca10c486c8b7572b858643cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2dac10f6c766b3932d6fdac26e5f859dbdc69d574eca7ea0f76cce310486e85db8e6af9ff2175599948f247e4293501062462a434709fba7c8608dd2db9303b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd0ed627c4f519be056c4701c7aac43c0da86b91cff36743ddcf0eceeaf4278ef2390a59997657348ec72e13922163068b937daa5fda401c349cad543ff1af3"} 05:06:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:50 INFO - Contents: 05:06:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d770c8b86395cfe813179c7de09f1f48104b91da53f11a77746976a8ba31c8ca386d9246ff5435523b51c33755a0db9ab6284b3c252f6a4942eec094971c134a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792e5cd465c43f3afd34109d9a6cdbb945278f62a3e79ec1ab79d66cc7f25b3ca7626c043bddca75635934e1f4cf887a8ff5081ca10c486c8b7572b858643cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2dac10f6c766b3932d6fdac26e5f859dbdc69d574eca7ea0f76cce310486e85db8e6af9ff2175599948f247e4293501062462a434709fba7c8608dd2db9303b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd0ed627c4f519be056c4701c7aac43c0da86b91cff36743ddcf0eceeaf4278ef2390a59997657348ec72e13922163068b937daa5fda401c349cad543ff1af3"} 05:06:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:50 INFO - Copying logs to upload dir... 05:06:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.585190 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-06-22 05:06:50.875044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 05:06:50.882841) ========= 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=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d770c8b86395cfe813179c7de09f1f48104b91da53f11a77746976a8ba31c8ca386d9246ff5435523b51c33755a0db9ab6284b3c252f6a4942eec094971c134a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792e5cd465c43f3afd34109d9a6cdbb945278f62a3e79ec1ab79d66cc7f25b3ca7626c043bddca75635934e1f4cf887a8ff5081ca10c486c8b7572b858643cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2dac10f6c766b3932d6fdac26e5f859dbdc69d574eca7ea0f76cce310486e85db8e6af9ff2175599948f247e4293501062462a434709fba7c8608dd2db9303b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd0ed627c4f519be056c4701c7aac43c0da86b91cff36743ddcf0eceeaf4278ef2390a59997657348ec72e13922163068b937daa5fda401c349cad543ff1af3"} build_url:https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/LLAAmFyCSMaggt_GUQ17-g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d770c8b86395cfe813179c7de09f1f48104b91da53f11a77746976a8ba31c8ca386d9246ff5435523b51c33755a0db9ab6284b3c252f6a4942eec094971c134a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792e5cd465c43f3afd34109d9a6cdbb945278f62a3e79ec1ab79d66cc7f25b3ca7626c043bddca75635934e1f4cf887a8ff5081ca10c486c8b7572b858643cfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2dac10f6c766b3932d6fdac26e5f859dbdc69d574eca7ea0f76cce310486e85db8e6af9ff2175599948f247e4293501062462a434709fba7c8608dd2db9303b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd0ed627c4f519be056c4701c7aac43c0da86b91cff36743ddcf0eceeaf4278ef2390a59997657348ec72e13922163068b937daa5fda401c349cad543ff1af3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 05:06:50.909973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 05:06:50.910321) ========= 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=03627c79f6bb3d1578c4a402000001ba-1498131921.622706-876580457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 05:06:50.990290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 05:06:50.990625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 05:06:50.990917) ========= ========= Total master_lag: 1.08 =========